Daily Usenet Report

May 9 00:01:02 -- May 10 00:01:01

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

May 9 00:02:39 www innd: message repeated 2 times: [ ctlinnd command s]
May 9 17:34:25 www nnrpd[884615]: unable to get certificates from '/news/etc/cert.pem'
May 9 17:34:25 www nnrpd[884615]: error initializing TLS: [CA_file: ] [CA_path: /news/etc] [cert_file: /news/etc/cert.pem] [key_file: /news/etc/key.pem]

Log entries by program:

Program nameLines%LinesSize%Size
inn 15134 71.1%3.3 MB 79.0%
innd 4319 20.3%578.6 KB 13.4%
innfeed 1828 8.6%325.5 KB 7.5%
nnrpd 16 0.1%1.8 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 21298 100.0%4.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 81753 49.7%
Negative hits 67950 41.3%
Do not exist 14849 9.0%
Cache misses 48 0.0%
TOTAL: 4 164600 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.108 0.0%92 0.000 1.174 4.667
article cleanup00:00:00.297 0.0%14945 0.000 0.020 0.087
article logging00:00:00.641 0.0%15090 0.000 0.042 0.158
article parse00:00:00.522 0.0%22382 0.000 0.023 0.194
article write00:00:07.809 0.0%12342 0.329 0.633 3.167
artlog/artcncl00:00:00.001 0.0%92 0.000 0.011 0.333
data move00:00:00.180 0.0%170561 0.000 0.001 0.010
hisgrep/artcncl00:00:00.004 0.0%91 0.000 0.044 0.667
hishave/artcncl00:00:00.002 0.0%92 0.000 0.022 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:02.752 0.0%165219 0.002 0.017 0.075
history sync00:00:00.060 0.0%389 0.000 0.154 1.667
history write00:00:03.340 0.0%14942 0.069 0.224 0.690
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:58:39.969 99.8%166487 254.072 518.479 2511.063
nntp read00:00:05.797 0.0%168172 0.019 0.034 0.068
overview write00:00:07.975 0.0%12342 0.295 0.646 2.422
perl filter00:00:45.133 0.1%14942 2.024 3.021 5.375
python filter00:00:02.688 0.0%14942 0.084 0.180 0.550
site send00:00:04.491 0.0%24684 0.017 0.182 0.578
TOTAL: 24:01:08.05424:00:01.769 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.139 0.0%12468 0.000 0.011 0.113
article prepare00:00:00.000 0.0%2876 0.000 0.000 0.000
article read00:00:00.301 0.0%597 0.000 0.504 14.667
backlog stats00:00:00.296 0.0%193605 0.000 0.002 0.009
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:03.878 0.0%137659 0.011 0.028 0.094
data write00:00:16.314 0.0%126119 0.066 0.129 0.218
idle23:55:41.892100.0%193605 249.397 444.936 1516.780
status file00:00:00.182 0.0%169 0.000 1.077 12.000
TOTAL: 23:56:11.04123:56:03.002100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:15.403 97.5%6 51.333 2567.167 6496.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.003 0.0%17 0.111 0.176 0.500
TOTAL: 00:00:15.80500:00:15.406 97.5%----

Control commands to INND:

CommandNumber
flush 4
flushlogs 2
go 2
logmode 2
lowmark 1
mode 146
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 167

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 9 23510 7454 15975 81 31%48:23:29
2peer.alt119.net 3 12900 2984 9192 724 23%21:57:36
3usenet.blueworldhosting.com 5 13421 1332 10473 1616 9%23:20:36
4newsfeed.xs3.de 2 11322 343 10979 0 3%23:59:42
5news.samoylyk.net 2 11606 84 11516 6 0%23:59:47
6glockenspiel.complete.org 1 2193 10 2167 16 0%04:56:11
7news.bbs.nz 5 6313 1 6311 1 0%17:46:24
8eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:04
9news.nk.ca 2 0 0 0 0 0%00:20:00
10localhost 25 0 0 0 0 0%00:00:00
TOTAL: 10 55 81265 12208 66613 2444 15%164:53:49
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net30.5 MB0.0 KB473.4 KB30.9 MB 98%4.2 KB
2peer.alt119.net7.3 MB0.0 KB8.2 MB15.5 MB 47%4.3 KB
3usenet.blueworldhosting.com5.8 MB2.9 KB2.6 MB8.4 MB 69%2.9 KB
4newsfeed.xs3.de1.4 MB0.0 KB0.0 KB1.4 MB100%4.2 KB
5news.samoylyk.net1.3 MB1.7 KB14.3 KB1.3 MB 98%14.5 KB
6glockenspiel.complete.org27.6 KB0.0 KB87.8 KB115.4 KB 23%4.4 KB
7news.bbs.nz0.8 KB2.7 KB2.7 KB6.3 KB 13%3.2 KB
8eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
9news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
10localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1046.3 MB7.3 KB11.4 MB57.7 MB 80%4.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 9 00:01:02 - 00:59:59 319 2.6% 0.091.1 MB 2.2% 0.31
May 9 01:00:00 - 01:59:59 425 3.4% 0.122.3 MB 4.8% 0.65
May 9 02:00:00 - 02:59:59 592 4.8% 0.161.6 MB 3.4% 0.46
May 9 03:00:00 - 03:59:59 609 4.9% 0.171.6 MB 3.3% 0.44
May 9 04:00:00 - 04:59:59 550 4.5% 0.151.8 MB 3.7% 0.50
May 9 05:00:00 - 05:59:59 554 4.5% 0.152.3 MB 4.8% 0.65
May 9 06:00:00 - 06:59:59 585 4.7% 0.161.5 MB 3.1% 0.42
May 9 07:00:00 - 07:59:59 659 5.3% 0.181.7 MB 3.6% 0.49
May 9 08:00:00 - 08:59:59 688 5.6% 0.191.9 MB 4.1% 0.55
May 9 09:00:00 - 09:59:59 654 5.3% 0.182.7 MB 5.8% 0.78
May 9 10:00:00 - 10:59:59 775 6.3% 0.222.4 MB 4.9% 0.67
May 9 11:00:00 - 11:59:59 725 5.9% 0.202.1 MB 4.5% 0.61
May 9 12:00:00 - 12:59:59 631 5.1% 0.182.3 MB 4.9% 0.66
May 9 13:00:00 - 13:59:59 697 5.6% 0.193.1 MB 6.6% 0.89
May 9 14:00:00 - 14:59:59 648 5.3% 0.182.8 MB 5.9% 0.80
May 9 15:00:00 - 15:59:59 592 4.8% 0.163.0 MB 6.3% 0.86
May 9 16:00:00 - 16:59:59 458 3.7% 0.131.5 MB 3.2% 0.43
May 9 17:00:00 - 17:59:59 437 3.5% 0.121.7 MB 3.6% 0.49
May 9 18:00:00 - 18:59:59 336 2.7% 0.092.5 MB 5.3% 0.72
May 9 19:00:00 - 19:59:59 286 2.3% 0.082.1 MB 4.5% 0.61
May 9 20:00:00 - 20:59:59 320 2.6% 0.091.0 MB 2.2% 0.30
May 9 21:00:00 - 21:59:59 308 2.5% 0.091.6 MB 3.4% 0.46
May 9 22:00:00 - 22:59:59 191 1.5% 0.05960.3 KB 2.0% 0.27
May 9 23:00:00 - 23:59:59 295 2.4% 0.081.9 MB 3.9% 0.53
May 10 00:00:00 - 00:01:01 7 0.1% 0.1126.2 KB 0.1% 0.43
TOTAL: 23:59:59 12341 100.0% 0.1447.6 MB 100.0% 0.56
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 1565 123 0 1 0 0 0 0 1441
2peer.alt119.net 767 29 0 0 0 0 0 0 738
3endofthelinebbs-out.news.weretis.net 199 1 0 0 0 0 0 0 198
4glockenspiel.complete.org 160 1 0 0 0 0 0 0 159
5news.samoylyk.net 7 0 0 1 0 0 0 0 6
6newsfeed.xs3.de 2 0 0 0 0 0 0 0 2
7news.bbs.nz 1 0 0 1 0 0 0 0 0
TOTAL: 7 2701 154 0 3 0 0 0 0 2544

Unwanted newsgroups [Top 20]:

NewsgroupCount
talk.english.tg 74
talk.generic.ua.ws 24
at.jobs 10
comp.hackers 9
att.jobs 8
aus.jobs 6
fr.petites-annonces.divers 6
grisbi.bugsreports 3
rocksolid.feeds.news 3
talk.from.diary 2
news.oriens-occasus.ru 2
al.christnet.bible 2
panix.chat.politics 1
grisbi.test 1
alt.christnet.eucharist 1
alt.entrepreneurs 1
ee.arvutid 1
TOTAL: 17 154

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 1407
EMP (md5) 570
Too many newsgroups 164
EMP (phn nph) 149
EMP (phl) 91
Scoring filter 9
HTML Multipart 5
Binary: misplaced binary 2
HTML post 2
TOTAL: 9 2399

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 121
peer.alt119.net 15
usenet.blueworldhosting.com 4
newsfeed.xs3.de 2
glockenspiel.complete.org 2
news.samoylyk.net 1
TOTAL: 6 145
TOTAL: 1 145

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1peer.alt119.net 10511 458 8799 18 0 0 4%23:59:56
2news.bbs.nz 23980 62 12181 76 0 124 0%23:59:56
3news.nk.ca 13787 29 12284 11 0 7 0%23:59:56
4news.quux.org 12997 13 12246 43 0 1 0%23:59:53
5usenet.blueworldhosting.com 11470 7 10788 0 0 8 0%23:59:45
6news.weretis.net 12370 4 12337 0 0 1 0%23:59:56
7news.tnetconsulting.net 13916 1 12340 0 0 1 0%23:59:44
8news.samoylyk.net 13754 0 12261 0 0 4 0%23:59:45
9newsfeed.xs3.de 13323 0 11995 0 0 1 0%23:59:56
TOTAL: 9 126108 574 105231 148 0 147 0%215:58:47
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1peer.alt119.net1.9 MB70.6 KB1.9 MB0.0 KB/s4.2 KB23:59:56
2news.bbs.nz217.9 KB234.9 KB452.8 KB0.0 KB/s3.3 KB23:59:56
3news.nk.ca57.1 KB29.0 KB86.1 KB0.0 KB/s2.2 KB23:59:56
4news.quux.org43.5 KB102.4 KB145.9 KB0.0 KB/s2.6 KB23:59:53
5usenet.blueworldhosting.com27.6 KB0.0 KB27.6 KB0.0 KB/s3.9 KB23:59:45
6news.weretis.net7.1 KB0.0 KB7.1 KB0.0 KB/s1.8 KB23:59:56
7news.tnetconsulting.net2.0 KB0.0 KB2.0 KB0.0 KB/s2.0 KB23:59:44
8news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:45
9newsfeed.xs3.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
TOTAL: 92.2 MB436.9 KB2.6 MB0.0 KB/s3.7 KB215:58:47
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1scanner-26.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
240.113.202.73 1 00.0 KB 0 0 000:00:13
3tor-exit78.stormycloud.org 1 00.0 KB 0 0 000:00:02
TOTAL: 3 3 00.0 KB 0 0 000:00:15

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
2unresolved 1 00.0 KB 0 0 000:00:13
3*.stormycloud.org 1 00.0 KB 0 0 000:00:02
TOTAL: 3 3 00.0 KB 0 0 000:00:15

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
40.113.202.73 0.070 0.032 0.00000:00:13
tor-exit78.stormycloud.org 0.085 0.057 0.00000:00:02
scanner-26.ch1.censys-scanner.com 0.080 0.040 0.00000:00:00
TOTAL: 3 0.235 0.129 0.00000:00:15

NNRP unrecognized commands (by host):

SystemConn
40.113.202.73 3
scanner-26.ch1.censys-scanner.com 1
TOTAL: 2 4

NNRP unrecognized commands (by command):

CommandCount
Connection: Keep-Alive 1
EHLO www.censys.io 1
GET / HTTP/1.1 1
Host: 192.138.210.162:119 1
TOTAL: 4 4