Daily Usenet Report

Oct 10 00:01:02 -- Oct 11 00:01:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Oct 11 00:00:01 newsfeed nnrpd[3239072]: localhost auth: program exited with status 8

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 22370 51.3%2.7 MB 33.3%
inn 8424 19.3%3.4 MB 41.9%
innd 8206 18.8%1.2 MB 14.3%
innfeed 4104 9.4%793.6 KB 9.6%
cnfsstat 432 1.0%62.4 KB 0.8%
nocem 41 0.1%5.0 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 43578 100.0%8.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 107371 59.3%
Negative hits 63888 35.3%
Do not exist 8288 4.6%
Cache misses 1416 0.8%
TOTAL: 4 180963 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.143 0.0%54 0.000 2.648 11.000
article cleanup00:00:00.113 0.0%8340 0.000 0.014 0.198
article logging00:00:00.405 0.0%8419 0.000 0.048 0.340
article parse00:00:00.190 0.0%12139 0.000 0.016 0.087
article write00:00:02.180 0.0%6898 0.000 0.316 2.093
artlog/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
data move00:00:00.648 0.0%182421 0.000 0.004 0.032
hisgrep/artcncl00:00:00.116 0.0%56 0.000 2.071 8.000
hishave/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
hishave/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:02:33.607 0.2%182155 0.092 0.843 6.795
history sync00:00:00.075 0.0%396 0.000 0.189 1.000
history write00:02:02.411 0.1%8341 3.122 14.676 129.037
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:51:37.135 99.3%187615 79.503 457.837 1594.806
nntp read00:00:02.723 0.0%182628 0.005 0.015 0.123
overview write00:02:53.361 0.2%6898 0.654 25.132 2369.483
perl filter00:00:36.735 0.0%8340 1.750 4.405 43.785
python filter00:00:02.877 0.0%8340 0.031 0.345 10.547
site send00:00:01.015 0.0%13834 0.000 0.073 0.690
TOTAL: 24:01:00.80423:59:53.734 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.024 0.0%11169 0.000 0.002 0.050
article prepare00:00:00.010 0.0%55844 0.000 0.000 0.008
article read00:00:00.741 0.0%5172 0.000 0.143 0.344
backlog stats00:00:00.361 0.0%244943 0.000 0.001 0.010
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.244 0.0%170740 0.000 0.013 0.048
data write00:00:03.098 0.0%166039 0.003 0.019 0.038
idle23:56:06.700100.0%244943 165.237 351.783 1808.392
status file00:00:00.327 0.0%265 0.750 1.234 14.000
TOTAL: 23:56:24.03023:56:13.505100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:51:26.566 72.4%16673 0.250 185.124299974.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.854 0.1%112104 0.000 0.043 0.500
TOTAL: 01:11:01.82800:51:31.420 72.5%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 100
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 122

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 3 11431 1804 9126 501 15%40:56:34
2outgoing.news.lysator.liu.se 1 5814 1366 4432 16 23%23:59:56
3usenet.blueworldhosting.com 721 8043 716 6881 446 8%23:45:21
4news.hispagatos.org 5 7190 464 6706 20 6%24:26:18
5usenet.network 1 5738 461 5264 13 8%23:59:58
6nntp.comgw.net 2 7234 359 6773 102 4%23:59:32
7news.corradoroberto.it 10 1226 336 890 0 27%22:40:10
8usenet.goja.nl.eu.org 11 7133 326 6748 59 4%23:53:49
9i2pn.org 1 7009 314 6645 50 4%23:59:52
10endoftheline-out.news.chmurka.net 1 3498 145 3353 0 4%25:44:40
11endofthelinebbs.peers.news.panix.com 27 7291 138 7141 12 1%23:55:37
12newsfeed.bofh.team 1 7912 131 7774 7 1%23:59:55
13news.samoylyk.net 1 6086 83 5999 4 1%23:59:46
14news.netfront.net 1 3906 49 3775 82 1%23:22:00
15newsfeed.xs3.de 2 5584 45 5538 1 0%23:59:52
16news.furie.org.uk 2 3859 24 3834 1 0%28:26:59
17news.nntp4.net 2 5812 20 5725 67 0%14:40:41
18glockenspiel.complete.org 2 5521 8 5511 2 0%23:59:28
19news.bbs.nz 1 6099 2 6097 0 0%23:59:29
20eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:06
21localhost 28 0 0 0 0 0%00:00:01
22news.nk.ca 2 0 0 0 0 0%00:20:14
TOTAL: 22 826 116386 6791 108212 1383 5%468:20:18
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net5.5 MB0.0 KB1.1 MB6.6 MB 83%2.9 KB
2usenet.network4.7 MB0.0 KB11.7 KB4.7 MB 99%10.1 KB
3outgoing.news.lysator.liu.se4.5 MB0.0 KB16.7 KB4.5 MB 99%3.4 KB
4usenet.blueworldhosting.com2.1 MB0.0 KB1.2 MB3.3 MB 63%2.9 KB
5news.corradoroberto.it1.8 MB0.0 KB0.0 KB1.8 MB100%5.4 KB
6news.hispagatos.org1.4 MB0.0 KB40.6 KB1.5 MB 97%3.1 KB
7nntp.comgw.net1.1 MB0.0 KB204.8 KB1.3 MB 84%2.9 KB
8usenet.goja.nl.eu.org937.3 KB0.0 KB86.6 KB1023.9 KB 91%2.7 KB
9i2pn.org922.6 KB0.0 KB69.6 KB992.2 KB 92%2.7 KB
10endofthelinebbs.peers.news.panix.com390.3 KB0.0 KB9.3 KB399.6 KB 97%2.7 KB
11endoftheline-out.news.chmurka.net366.2 KB0.0 KB0.0 KB366.2 KB100%2.5 KB
12newsfeed.bofh.team354.3 KB0.0 KB25.5 KB379.8 KB 93%2.8 KB
13news.samoylyk.net275.8 KB0.0 KB3.1 KB278.9 KB 98%3.2 KB
14newsfeed.xs3.de137.4 KB0.0 KB2.8 KB140.2 KB 98%3.0 KB
15news.netfront.net109.1 KB0.0 KB537.8 KB646.9 KB 16%4.9 KB
16news.furie.org.uk94.6 KB0.0 KB0.7 KB95.2 KB 99%3.8 KB
17news.nntp4.net58.1 KB0.0 KB66.3 KB124.4 KB 46%1.4 KB
18glockenspiel.complete.org55.2 KB0.0 KB4.9 KB60.1 KB 91%6.0 KB
19news.bbs.nz2.9 KB0.0 KB0.0 KB2.9 KB100%1.5 KB
20eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
21localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
22news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2224.8 MB0.0 KB3.3 MB28.1 MB 88%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 10 00:01:02 - 00:59:59 121 1.8% 0.03434.9 KB 1.7% 0.12
Oct 10 01:00:00 - 01:59:59 240 3.5% 0.07788.0 KB 3.0% 0.22
Oct 10 02:00:00 - 02:59:59 360 5.2% 0.101.2 MB 4.7% 0.34
Oct 10 03:00:00 - 03:59:59 318 4.6% 0.091.1 MB 4.3% 0.31
Oct 10 04:00:00 - 04:59:59 356 5.2% 0.101.1 MB 4.5% 0.32
Oct 10 05:00:00 - 05:59:59 330 4.8% 0.091.1 MB 4.5% 0.33
Oct 10 06:00:00 - 06:59:59 322 4.7% 0.09948.3 KB 3.7% 0.26
Oct 10 07:00:00 - 07:59:59 298 4.3% 0.081002.8 KB 3.9% 0.28
Oct 10 08:00:00 - 08:59:59 395 5.7% 0.111.4 MB 5.6% 0.40
Oct 10 09:00:00 - 09:59:59 364 5.3% 0.101.3 MB 5.0% 0.36
Oct 10 10:00:00 - 10:59:59 510 7.4% 0.142.0 MB 7.8% 0.56
Oct 10 11:00:00 - 11:59:59 377 5.5% 0.101.4 MB 5.7% 0.41
Oct 10 12:00:00 - 12:59:59 363 5.3% 0.101.5 MB 6.1% 0.44
Oct 10 13:00:00 - 13:59:59 407 5.9% 0.111.6 MB 6.4% 0.46
Oct 10 14:00:00 - 14:59:59 430 6.2% 0.121.8 MB 7.2% 0.51
Oct 10 15:00:00 - 15:59:59 344 5.0% 0.101.0 MB 4.1% 0.30
Oct 10 16:00:00 - 16:59:59 310 4.5% 0.091.0 MB 4.0% 0.28
Oct 10 17:00:00 - 17:59:59 237 3.4% 0.071.0 MB 4.0% 0.29
Oct 10 18:00:00 - 18:59:59 182 2.6% 0.05774.7 KB 3.0% 0.22
Oct 10 19:00:00 - 19:59:59 148 2.1% 0.04570.1 KB 2.2% 0.16
Oct 10 20:00:00 - 20:59:59 152 2.2% 0.04634.0 KB 2.5% 0.18
Oct 10 21:00:00 - 21:59:59 108 1.6% 0.03493.5 KB 1.9% 0.14
Oct 10 22:00:00 - 22:59:59 88 1.3% 0.02449.9 KB 1.7% 0.12
Oct 10 23:00:00 - 23:59:59 134 1.9% 0.04644.8 KB 2.5% 0.18
Oct 11 00:00:00 - 00:01:01 4 0.1% 0.075.9 KB 0.0% 0.10
TOTAL: 23:59:59 6898 100.0% 0.0825.3 MB 100.0% 0.30
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
CYCNGS1NGS1536.0 GB48.0 MB 0.0% 1 0.00 0.00
CYCNGS2NGS1536.0 GB98.4 GB 6.4% 0 0.4640776.02
CYCTXT1TEXT5.0 GB3.9 GB 77.8% 0 0.03 1766.73
TOTAL: 3-3077.0 GB102.4 GB 3.3% 1 0.31-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1endofthelinebbs-out.news.weretis.net 568 0 0 0 0 0 0 0 568
2usenet.blueworldhosting.com 463 1 0 0 0 0 0 0 462
3news.netfront.net 119 0 0 0 0 0 0 0 119
4nntp.comgw.net 109 0 0 0 0 0 0 0 109
5news.nntp4.net 67 0 0 0 0 0 0 0 67
6usenet.goja.nl.eu.org 63 0 0 0 0 0 0 0 63
7i2pn.org 50 0 0 0 0 0 0 0 50
8news.hispagatos.org 19 10 0 0 0 0 0 0 9
9outgoing.news.lysator.liu.se 18 0 0 0 0 0 0 0 18
10endofthelinebbs.peers.news.panix.com 14 0 0 0 0 0 0 0 14
11usenet.network 13 0 0 0 0 0 0 0 13
12newsfeed.bofh.team 10 0 0 0 0 0 0 0 10
13news.samoylyk.net 5 0 0 0 0 0 0 0 5
14glockenspiel.complete.org 1 0 0 0 0 0 0 0 1
15news.corradoroberto.it 1 0 0 0 0 0 0 0 1
16news.furie.org.uk 1 0 0 0 0 0 0 0 1
17newsfeed.xs3.de 1 0 0 0 0 0 0 0 1
TOTAL: 17 1522 11 0 0 0 0 0 0 1511

Unwanted newsgroups [Top 20]:

NewsgroupCount
hispagatos.hacking.news 6
hispagatos.hacking.ctf 3
alt.christnet.bible-study 1
hispagatos.hacking.exploits 1
TOTAL: 4 11

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 608
EMP (phr path) 381
EMP (md5) 239
Too many newsgroups 125
User-issued cancel 49
Too many newsgroups (meow) 21
Binary: misplaced binary 4
HTML Multipart 4
TOTAL: 8 1431

NoCeM on Spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
i2pn2-nocem@i2pn2.org (spam)10101
robot@pasdenom.info (spam)10101
i2pn2-nocem@i2pn2.org (multipost)12007979
i2pn2-nocem@i2pn2.org (rmp)10001414
robot@pasdenom.info (spam2)9001111
robot@pasdenom.info (spam3)50066
TOTAL: 63802110112

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 46
usenet.blueworldhosting.com 17
nntp.comgw.net 3
newsfeed.bofh.team 3
endofthelinebbs.peers.news.panix.com 3
usenet.goja.nl.eu.org 2
outgoing.news.lysator.liu.se 2
news.samoylyk.net 1
news.hispagatos.org 1
news.corradoroberto.it 1
TOTAL: 10 79
No colon-space in header field
usenet.blueworldhosting.com 1
TOTAL: 1 1
TOTAL: 2 80

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 9097 4107 2739 2 0 12 45%23:59:28
2nyheter.lysator.liu.se 5700 1295 3694 540 0 6 22%23:59:52
3news.furie.org.uk 3882 568 2623 2 0 1 14%23:59:52
4photonic.trudheim.com 7211 509 5308 1075 0 0 7%23:58:37
5endofthelinebbs.peers.news.panix.com 7165 406 6489 0 0 0 5%23:58:03
6usenet.goja.nl.eu.org 7357 332 5883 295 0 1 4%23:59:52
7news.hispagatos.org 7646 311 5887 230 0 0 4%23:59:52
8newsfeed.bofh.team 7686 255 6420 0 0 1 3%23:59:52
9usenet.network 6928 245 5788 27 0 0 3%23:59:22
10news.bbs.nz 12442 199 6048 644 0 59 1%23:59:47
11news.nk.ca 9999 156 6041 619 0 29 1%23:59:52
12i2pn.org 7588 148 6383 36 0 46 1%23:59:15
13nntp.comgw.net 7329 115 6275 147 0 0 1%23:59:52
14news.tnetconsulting.net 7799 89 6582 223 0 8 1%23:59:52
15news.weretis.net 7152 83 6649 165 0 0 1%23:59:52
16news.quux.org 7266 70 6208 589 0 44 0%23:59:52
17news.chmurka.net 3626 49 2945 1 0 0 1%23:59:52
18news.nntp4.net 7213 40 6771 43 0 4055 0%23:59:52
19newsfeed.xs3.de 8042 39 6544 258 0 0 0%23:59:52
20news.corradoroberto.it 848 24 733 10 0 0 2%22:38:52
21news.samoylyk.net 7810 17 6765 22 0 19 0%23:59:52
22usenet.blueworldhosting.com 6324 0 5990 0 0 0 0%23:59:18
23feed.opticnetworks.net 0 0 0 0 0 6898 0%23:59:52
TOTAL: 23 156110 9057 118765 4928 0 11179 5%550:30:42
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net15.7 MB2.5 KB15.7 MB0.2 KB/s3.9 KB23:59:28
2nyheter.lysator.liu.se4.5 MB4.5 MB8.9 MB0.1 KB/s5.0 KB23:59:52
3news.furie.org.uk4.1 MB10.0 KB4.2 MB0.0 KB/s7.5 KB23:59:52
4photonic.trudheim.com4.1 MB3.6 MB7.7 MB0.1 KB/s5.0 KB23:58:37
5endofthelinebbs.peers.news.panix.com2.3 MB0.0 KB2.3 MB0.0 KB/s5.7 KB23:58:03
6newsfeed.bofh.team2.1 MB0.0 KB2.1 MB0.0 KB/s8.4 KB23:59:52
7news.hispagatos.org1.1 MB2.0 MB3.1 MB0.0 KB/s5.8 KB23:59:52
8usenet.goja.nl.eu.org924.2 KB2.9 MB3.8 MB0.0 KB/s6.3 KB23:59:52
9news.quux.org905.8 KB3.7 MB4.5 MB0.1 KB/s7.1 KB23:59:52
10usenet.network873.7 KB72.2 KB946.0 KB0.0 KB/s3.5 KB23:59:22
11news.bbs.nz820.8 KB4.6 MB5.4 MB0.1 KB/s6.6 KB23:59:47
12news.nntp4.net548.6 KB638.6 KB1.2 MB0.0 KB/s14.3 KB23:59:52
13news.tnetconsulting.net525.8 KB1.6 MB2.1 MB0.0 KB/s6.9 KB23:59:52
14i2pn.org522.2 KB146.1 KB668.3 KB0.0 KB/s3.6 KB23:59:15
15nntp.comgw.net478.3 KB1.7 MB2.2 MB0.0 KB/s8.5 KB23:59:52
16news.nk.ca460.9 KB4.4 MB4.8 MB0.1 KB/s6.4 KB23:59:52
17news.samoylyk.net408.4 KB38.6 KB447.0 KB0.0 KB/s11.5 KB23:59:52
18news.weretis.net366.2 KB2.0 MB2.4 MB0.0 KB/s9.9 KB23:59:52
19newsfeed.xs3.de333.6 KB1.8 MB2.1 MB0.0 KB/s7.4 KB23:59:52
20news.chmurka.net180.4 KB168.4 KB348.9 KB0.0 KB/s7.0 KB23:59:52
21news.corradoroberto.it75.2 KB27.2 KB102.4 KB0.0 KB/s3.0 KB22:38:52
22feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:52
23usenet.blueworldhosting.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:18
TOTAL: 2341.0 MB33.9 MB75.0 MB0.0 KB/s5.5 KB550:30:42
Outgoing feeds (innfeed) by Volume

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1?2791 00.0 KB 0 0 000:41:21
2*.demos.su2773 00.0 KB 0 0 000:29:16
3unresolved 3 00.0 KB 2 0 000:00:16
4*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
5*.stretchoid.com 1 00.0 KB 0 0 000:00:00
6*.survey.inspici.com 1 00.0 KB 0 0 000:00:03
TOTAL: 65570 00.0 KB 2 0 001:10:59

NNRP auth users [Top 20]:

UserConn
getlist 1
TOTAL: 1 1

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
ddt.demos.su 9.637 37.078 0.00000:29:16
2001:470:28:a8:ca7f:54ff:fe03:41e0 9.640 37.588 0.00000:20:14
localhost 178.058 370.264 0.07400:11:05
2001:470:28:a8:3ad5:47ff:fe02:c2fd 0.000 0.016 0.00000:10:00
198.235.24.245 0.004 0.012 0.00000:00:10
198.235.24.110 0.008 0.008 0.00000:00:05
server-0-3.survey.inspici.com 0.004 0.015 0.00000:00:03
graceful.monitoring.internet-measurement.com 0.004 0.015 0.00000:00:01
2607:ff10:c8:594::6 0.005 0.014 0.00000:00:01
45.227.254.49 0.005 0.011 0.00000:00:00
azpdsgc73.stretchoid.com 0.004 0.012 0.00000:00:00
TOTAL: 11 197.369 445.033 0.07401:10:59

Curious NNRP server explorers [Top 20]:

SystemConn
2001:470:28:a8:ca7f:54ff:fe03:41e0 2788
ddt.demos.su 2773
198.235.24.110 1
198.235.24.245 1
2001:470:28:a8:3ad5:47ff:fe02:c2fd 1
2607:ff10:c8:594::6 1
45.227.254.49 1
azpdsgc73.stretchoid.com 1
graceful.monitoring.internet-measurement.com 1
localhost 1
server-0-3.survey.inspici.com 1
TOTAL: 11 5570

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

SystemConn
45.227.254.49 1
azpdsgc73.stretchoid.com 1
TOTAL: 2 2

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

CommandCount
#003 1
MGLNDD_144.172.126.95_119 1
TOTAL: 2 2

NNRP client timeouts [Top 20]:

SystemConnPeer
45.227.254.49 1 1
TOTAL: 1 1 2

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1news 4 80.0%
2alt 1 20.0%
TOTAL: 2 5100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

NewsgroupCount
1news.admin.peering 4
2alt.music.lyrics 1
TOTAL: 2 5