Daily Usenet Report

Mar 18 00:01:01 -- Mar 19 00:01:01

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Mar 18 14:07:10 www nnrpd[4002434]: unable to get certificates from '/news/etc/cert.pem'
Mar 18 14:07:10 www nnrpd[4002434]: error initializing TLS: [CA_file: ] [CA_path: /news/etc] [cert_file: /news/etc/cert.pem] [key_file: /news/etc/key.pem]
Mar 18 23:06:02 www nnrpd[4020348]: unable to get certificates from '/news/etc/cert.pem'
Mar 18 23:06:02 www nnrpd[4020348]: 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 30012 55.3%6.1 MB 65.4%
innd 21484 39.6%2.7 MB 29.0%
innfeed 2767 5.1%523.1 KB 5.5%
nnrpd 28 0.1%3.2 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 54292 100.0%9.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 111234 48.9%
Negative hits 86382 38.0%
Do not exist 29567 13.0%
Cache misses 106 0.0%
TOTAL: 4 227289 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.060 0.0%72 0.000 0.833 6.000
article cleanup00:00:00.601 0.0%29635 0.000 0.020 0.074
article logging00:00:01.469 0.0%30012 0.000 0.049 0.119
article parse00:00:11.501 0.0%673754 0.000 0.017 0.053
article write00:00:12.801 0.0%10677 0.484 1.199 2.634
artlog/artcncl00:00:00.000 0.0%10 0.000 0.000 0.000
data move00:00:01.853 0.0%884074 0.000 0.002 0.011
hisgrep/artcncl00:00:00.023 0.0%82 0.000 0.280 5.000
hishave/artcncl00:00:00.001 0.0%10 0.000 0.100 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:09.373 0.0%228118 0.004 0.041 0.140
history sync00:00:00.067 0.0%373 0.000 0.180 2.000
history write00:00:15.013 0.0%29631 0.122 0.507 0.811
idle23:55:11.324 99.6%826231 17.574 104.222 1454.034
nntp read00:01:29.582 0.1%836935 0.019 0.107 0.174
overview write00:00:11.106 0.0%10677 0.184 1.040 94.675
perl filter00:01:06.066 0.1%29631 1.308 2.230 6.595
python filter00:00:04.116 0.0%29631 0.086 0.139 0.469
site send00:00:04.431 0.0%21354 0.032 0.208 0.518
TOTAL: 24:00:53.53023:58:59.387 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.100 0.0%10814 0.000 0.009 0.085
article prepare00:00:00.009 0.0%32340 0.000 0.000 0.007
article read00:00:01.328 0.0%5054 0.045 0.263 2.125
backlog stats00:00:00.573 0.0%261068 0.000 0.002 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:05.149 0.0%175888 0.013 0.029 0.047
data write00:00:25.357 0.0%165945 0.101 0.153 0.232
idle23:57:21.226 99.9%261068 197.129 330.340 1073.503
status file00:00:00.246 0.0%252 0.000 0.976 3.000
TOTAL: 23:58:04.50223:57:53.988100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:01.845 65.3%10 19.000 184.500 1654.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.003 0.1%21 0.000 0.143 0.500
TOTAL: 00:00:02.82600:00:01.848 65.4%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 5 23726 6051 17090 585 25%55:44:21
2usenet.blueworldhosting.com 420 13934 3159 9692 1083 22%27:10:56
3outgoing.news.lysator.liu.se 2 12160 521 11168 471 4%23:59:26
4newsfeed.xs3.de 1 9499 318 9173 8 3%23:59:56
5endofthelinebbs.peers.news.panix.com 36 13045 287 10374 2384 2%25:34:51
6usenet.network 2 10940 252 10641 47 2%23:59:53
7news.samoylyk.net 2 9785 112 9665 8 1%23:59:33
8glockenspiel.complete.org 2 11139 43 11059 37 0%23:59:04
9news.furie.org.uk 2 5381 8 5371 2 0%23:59:54
10news.bbs.nz 3 16031 4 16026 1 0%36:25:53
11news.netfront.net 29 26857 3 12335 14519 0%33:24:28
12eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:11:07
13localhost 25 0 0 0 0 0%00:00:00
14news.nk.ca 2 0 0 0 0 0%00:20:00
TOTAL: 14 532 152497 10758 122594 19145 7%322:49:22
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com23.5 MB0.0 KB3.5 MB27.0 MB 86%6.5 KB
2endofthelinebbs-out.news.weretis.net21.4 MB4.2 KB1.1 MB22.5 MB 95%3.5 KB
3endofthelinebbs.peers.news.panix.com5.7 MB0.0 KB113.2 MB118.8 MB 4%45.6 KB
4news.samoylyk.net1.4 MB2.9 KB17.7 KB1.5 MB 98%12.5 KB
5usenet.network1.4 MB0.0 KB354.7 KB1.7 MB 80%6.0 KB
6newsfeed.xs3.de1.2 MB8.3 KB12.8 KB1.2 MB 98%3.7 KB
7outgoing.news.lysator.liu.se1.2 MB4.2 KB1.3 MB2.4 MB 47%2.5 KB
8glockenspiel.complete.org223.7 KB4.3 KB56.0 KB283.9 KB 78%3.5 KB
9news.furie.org.uk28.4 KB0.0 KB5.0 KB33.4 KB 84%3.3 KB
10news.netfront.net13.9 KB0.0 KB4.8 GB4.8 GB 0%348.0 KB
11news.bbs.nz10.0 KB4.2 KB0.0 KB14.2 KB 70%2.8 KB
12eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
13localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
14news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1456.0 MB28.1 KB4.9 GB5.0 GB 1%175.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 18 00:01:01 - 00:59:59 208 1.9% 0.06952.7 KB 1.7% 0.27
Mar 18 01:00:00 - 01:59:59 299 2.8% 0.082.4 MB 4.3% 0.69
Mar 18 02:00:00 - 02:59:59 322 3.0% 0.09881.2 KB 1.5% 0.24
Mar 18 03:00:00 - 03:59:59 511 4.8% 0.142.6 MB 4.6% 0.73
Mar 18 04:00:00 - 04:59:59 485 4.5% 0.131.4 MB 2.5% 0.39
Mar 18 05:00:00 - 05:59:59 541 5.1% 0.153.3 MB 5.8% 0.93
Mar 18 06:00:00 - 06:59:59 530 5.0% 0.151.8 MB 3.2% 0.51
Mar 18 07:00:00 - 07:59:59 506 4.7% 0.141.6 MB 2.8% 0.45
Mar 18 08:00:00 - 08:59:59 564 5.3% 0.162.0 MB 3.6% 0.58
Mar 18 09:00:00 - 09:59:59 596 5.6% 0.172.2 MB 3.9% 0.62
Mar 18 10:00:00 - 10:59:59 523 4.9% 0.154.0 MB 7.1% 1.14
Mar 18 11:00:00 - 11:59:59 513 4.8% 0.142.9 MB 5.2% 0.84
Mar 18 12:00:00 - 12:59:59 587 5.5% 0.162.6 MB 4.5% 0.73
Mar 18 13:00:00 - 13:59:59 611 5.7% 0.173.5 MB 6.2% 0.98
Mar 18 14:00:00 - 14:59:59 616 5.8% 0.175.2 MB 9.3% 1.48
Mar 18 15:00:00 - 15:59:59 614 5.8% 0.174.0 MB 7.0% 1.13
Mar 18 16:00:00 - 16:59:59 525 4.9% 0.153.3 MB 5.8% 0.93
Mar 18 17:00:00 - 17:59:59 446 4.2% 0.121.7 MB 3.1% 0.49
Mar 18 18:00:00 - 18:59:59 420 3.9% 0.122.9 MB 5.1% 0.81
Mar 18 19:00:00 - 19:59:59 374 3.5% 0.101.6 MB 2.8% 0.44
Mar 18 20:00:00 - 20:59:59 263 2.5% 0.071.1 MB 1.9% 0.30
Mar 18 21:00:00 - 21:59:59 223 2.1% 0.061.0 MB 1.8% 0.29
Mar 18 22:00:00 - 22:59:59 195 1.8% 0.052.4 MB 4.2% 0.67
Mar 18 23:00:00 - 23:59:59 193 1.8% 0.051.2 MB 2.2% 0.35
Mar 19 00:00:00 - 00:01:01 2 0.0% 0.034.6 KB 0.0% 0.08
TOTAL: 24:00:00 10667 100.0% 0.1256.3 MB 100.0% 0.67
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.netfront.net 14449 0 0 0 0 0 0 014449
2endofthelinebbs.peers.news.panix.com 2384 2366 0 0 0 0 0 0 18
3usenet.blueworldhosting.com 986 14 0 0 0 0 0 0 972
4endofthelinebbs-out.news.weretis.net 884 0 0 0 0 0 0 0 884
5outgoing.news.lysator.liu.se 475 0 0 0 0 0 0 0 475
6glockenspiel.complete.org 61 0 0 1 0 0 0 0 60
7usenet.network 52 0 0 0 0 0 0 0 52
8news.samoylyk.net 26 0 0 1 0 0 0 0 25
9newsfeed.xs3.de 16 0 0 2 0 0 0 0 14
10news.furie.org.uk 2 0 0 0 0 0 0 0 2
TOTAL: 10 19335 2380 0 4 0 0 0 016951

Unwanted newsgroups [Top 20]:

NewsgroupCount
ab.alt.binaries.bitburger 1121
alt.binaries.backup 408
alt.binaries.ftd 214
4u.alt.binaries.4u 208
es.binaries.bd 128
ab.alt.binaries.boneless 99
ab.alt.binaries.moovee 60
alt.binaries.pictures.wallpaper 17
finet.binaries.keskustelu 13
ee.arvutid 9
alt.binaries.pictures.scenic 7
4u.alt.binaries.bloaf 7
harvard.forsale 6
alt.binaries.pictures.nude.celebrities.fake 6
rocksolid.feeds.news 5
alt.binaries.test.yenc 5
alt.binaries.pictures.earlmiller 5
alt.binaries.comics.dcp 5
alt.binaries.pictures.purebeauty 4
alt.binaries.sounds.karaoke 4
TOTAL: 52 2380

INND Perl filter [Top 20]:

ReasonCount
Binary: misplaced binary fx02.ams4.POSTED 1937
Binary: misplaced binary fx05.ams4.POSTED 1730
Binary: misplaced binary fx01.ams4.POSTED 1526
Binary: misplaced binary fx08.ams4.POSTED 1278
Binary: misplaced binary fx14.ams4.POSTED 1065
Binary: misplaced binary fx10.ams4.POSTED 1047
EMP (md5) 1000
Binary: misplaced binary fx12.ams4.POSTED 938
Binary: misplaced binary fx11.ams4.POSTED 935
EMP (phn path) 845
Binary: misplaced binary fx17.iad.POSTED 835
Binary: misplaced binary fx11.iad.POSTED 777
Binary: misplaced binary fx15.ams4.POSTED 673
Binary: misplaced binary fx04.ams4.POSTED 489
Binary: misplaced binary fx13.ams4.POSTED 409
Binary: misplaced binary fx18.iad.POSTED 317
Binary: misplaced binary fx06.ams4.POSTED 221
Too many newsgroups 205
EMP (phl) 106
Binary: misplaced binary news.newsdemon.com 96
TOTAL: 37 16574

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 301
usenet.blueworldhosting.com 31
news.samoylyk.net 18
endofthelinebbs.peers.news.panix.com 15
newsfeed.xs3.de 8
outgoing.news.lysator.liu.se 4
TOTAL: 6 377
TOTAL: 1 377

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 14979 4171 6367 20 0 2 27%23:59:53
2nyheter.lysator.liu.se 10498 2644 7391 109 0 0 25%23:59:56
3news.nk.ca 13680 289 10141 188 0 6 2%23:59:56
4endofthelinebbs.peers.news.panix.com 10866 132 10530 1 0 0 1%23:59:43
5news.furie.org.uk 7897 78 5585 36 0 0 0%23:58:42
6news.bbs.nz 20584 36 10388 131 0 34 0%23:59:46
7usenet.network 12767 25 9741 10 0 0 0%23:59:28
8news.quux.org 11052 15 10388 81 0 0 0%23:59:56
9news.tnetconsulting.net 11458 10 10534 13 0 0 0%23:59:46
10news.weretis.net 10668 7 10518 32 0 0 0%23:59:51
11usenet.blueworldhosting.com 8157 5 7396 0 0 108 0%23:59:56
12news.samoylyk.net 12893 2 10442 3 0 0 0%23:59:50
13newsfeed.xs3.de 12795 2 10187 47 0 0 0%23:59:56
14peer.alt119.net 0 0 0 0 0 10667 0%23:59:54
TOTAL: 14 158294 7416 119608 671 0 10817 4%335:56:33
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nyheter.lysator.liu.se19.0 MB999.3 KB20.0 MB0.2 KB/s7.4 KB23:59:56
2news.netfront.net18.2 MB188.2 KB18.4 MB0.2 KB/s4.5 KB23:59:53
3news.nk.ca3.6 MB3.5 MB7.0 MB0.1 KB/s15.1 KB23:59:56
4news.furie.org.uk1.2 MB376.8 KB1.6 MB0.0 KB/s14.3 KB23:58:42
5endofthelinebbs.peers.news.panix.com592.7 KB1.2 KB593.9 KB0.0 KB/s4.5 KB23:59:43
6news.quux.org227.5 KB682.8 KB910.4 KB0.0 KB/s9.5 KB23:59:56
7news.samoylyk.net168.2 KB2.6 KB170.8 KB0.0 KB/s34.2 KB23:59:50
8news.bbs.nz122.1 KB1.0 MB1.1 MB0.0 KB/s7.0 KB23:59:46
9usenet.network106.7 KB37.6 KB144.3 KB0.0 KB/s4.1 KB23:59:28
10news.tnetconsulting.net23.9 KB87.5 KB111.4 KB0.0 KB/s4.8 KB23:59:46
11news.weretis.net18.8 KB462.2 KB481.1 KB0.0 KB/s12.3 KB23:59:51
12usenet.blueworldhosting.com17.9 KB0.0 KB17.9 KB0.0 KB/s3.6 KB23:59:56
13newsfeed.xs3.de5.0 KB598.5 KB603.5 KB0.0 KB/s12.3 KB23:59:56
14peer.alt119.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
TOTAL: 1443.2 MB7.8 MB51.1 MB0.0 KB/s6.5 KB335:56:33
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1162.243.151.25 1 00.0 KB 0 0 000:00:00
2remarkable.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
3scanner-06.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
4scanner-07.ch1.censys-scanner.com 2 00.0 KB 0 0 000:00:00
TOTAL: 4 5 00.0 KB 0 0 000:00:02

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
2unresolved 1 00.0 KB 0 0 000:00:00
3*.ch1.censys-scanner.com 3 00.0 KB 0 0 000:00:00
TOTAL: 3 5 00.0 KB 0 0 000:00:02

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
remarkable.monitoring.internet-measurement.com 0.065 0.037 0.00000:00:01
scanner-07.ch1.censys-scanner.com 0.168 0.063 0.00000:00:00
162.243.151.25 0.071 0.048 0.00000:00:00
scanner-06.ch1.censys-scanner.com 0.088 0.018 0.00000:00:00
? 0.092 0.042 0.00000:00:00
TOTAL: 5 0.484 0.208 0.00000:00:02

NNRP gethostbyaddr failures [Top 20]:

SystemConn
? (can't getpeername) 1
TOTAL: 1 1

NNRP unrecognized commands (by host) [Top 20]:

SystemConn
scanner-07.ch1.censys-scanner.com 1
scanner-06.ch1.censys-scanner.com 1
162.243.151.25 1
TOTAL: 3 3

NNRP unrecognized commands (by command) [Top 20]:

CommandCount
EHLO www.censys.io 2
MGLNDD_192.138.210.162_119 1
TOTAL: 2 3