Daily Usenet Report

Oct 11 00:01:01 -- Oct 12 00:01:02

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Oct 11 08:15:35 newsfeed innd: message repeated 2 times: [ ctlinnd command s]
Oct 12 00:00:01 newsfeed nnrpd[3907370]: localhost auth: program exited with status 8

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 22179 50.9%2.7 MB 32.2%
inn 8835 20.3%3.6 MB 43.9%
innd 7991 18.3%1.1 MB 13.7%
innfeed 4127 9.5%799.9 KB 9.4%
cnfsstat 432 1.0%64.0 KB 0.8%
nocem 43 0.1%4.7 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 43608 100.0%8.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 118441 59.4%
Negative hits 72358 36.3%
Do not exist 8681 4.4%
Cache misses 27 0.0%
TOTAL: 4 199507 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.120 0.0%44 0.000 2.727 19.000
article cleanup00:00:00.154 0.0%8762 0.000 0.018 0.885
article logging00:00:00.456 0.0%8835 0.000 0.052 0.418
article parse00:00:00.234 0.0%12201 0.000 0.019 0.108
article write00:00:02.171 0.0%7525 0.000 0.289 2.877
artlog/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:01.267 0.0%200400 0.000 0.006 0.906
hisgrep/artcncl00:00:00.101 0.0%45 0.000 2.244 18.000
hishave/artcncl00:00:00.000 0.0%1 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.748 0.2%201117 0.084 0.764 6.460
history sync00:00:00.077 0.0%386 0.000 0.199 1.000
history write00:02:05.988 0.1%8746 3.141 14.405 127.784
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:48:07.014 99.1%205029 80.320 417.926 2199.952
nntp read00:00:03.874 0.0%201244 0.005 0.019 0.962
overview write00:06:03.985 0.4%7525 0.588 48.370 6468.625
perl filter00:00:49.997 0.1%8746 1.595 5.717 205.250
python filter00:00:04.294 0.0%8746 0.000 0.491 16.169
site send00:00:01.209 0.0%15092 0.000 0.080 2.136
TOTAL: 24:01:03.91723:59:54.689 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.025 0.0%7835 0.000 0.003 0.048
article prepare00:00:00.007 0.0%52856 0.000 0.000 0.005
article read00:00:00.692 0.0%5140 0.000 0.135 0.629
backlog stats00:00:00.370 0.0%269695 0.000 0.001 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.360 0.0%189344 0.002 0.012 0.045
data write00:00:03.365 0.0%184149 0.009 0.018 0.035
idle23:57:08.301100.0%269695 129.732 319.725 2093.476
status file00:00:00.313 0.0%280 0.750 1.118 8.000
TOTAL: 23:57:27.68923:57:15.433100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:22:05.139 80.5%16531 0.750 297.934900188.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.586 0.1%111872 0.000 0.041 0.500
TOTAL: 01:41:59.87701:22:09.725 80.6%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 4 13686 1935 11289 462 14%48:01:36
2outgoing.news.lysator.liu.se 2 6387 1404 4978 5 21%23:59:54
3usenet.blueworldhosting.com 713 8530 943 7277 310 11%23:57:30
4nntp.comgw.net 2 7943 493 7302 148 6%23:59:35
5news.hispagatos.org 6 7991 488 7485 18 6%24:26:19
6i2pn.org 2 7791 394 7353 44 5%23:59:16
7usenet.goja.nl.eu.org 11 7719 323 7319 77 4%22:38:45
8usenet.network 1 6233 308 5915 10 4%23:59:58
9news.corradoroberto.it 11 1227 297 930 0 24%23:43:53
10endoftheline-out.news.chmurka.net 2 3596 206 3390 0 5%22:12:58
11endofthelinebbs.peers.news.panix.com 29 7965 177 7774 14 2%24:21:27
12newsfeed.bofh.team 1 8636 153 8476 7 1%23:59:54
13newsfeed.xs3.de 1 6140 106 6023 11 1%23:59:54
14news.samoylyk.net 2 6585 92 6491 2 1%23:59:39
15news.netfront.net 1 4279 50 4087 142 1%23:22:00
16news.furie.org.uk 2 4005 44 3958 3 1%23:59:19
17news.nntp4.net 2 6418 42 6375 1 0%23:59:34
18glockenspiel.complete.org 2 5600 21 5578 1 0%24:00:11
19news.bbs.nz 2 6062 3 6057 2 0%23:59:32
20eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:05
21localhost 26 0 0 0 0 0%00:00:01
22news.nk.ca 2 0 0 0 0 0%00:20:19
TOTAL: 22 825 126793 7479 118057 1257 5%477:11:39
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net5.7 MB4.9 KB1015.1 KB6.7 MB 85%2.9 KB
2outgoing.news.lysator.liu.se4.3 MB2.4 KB6.5 KB4.3 MB 99%3.1 KB
3usenet.network3.3 MB2.4 KB9.2 KB3.3 MB 99%10.7 KB
4usenet.blueworldhosting.com2.5 MB0.0 KB653.8 KB3.2 MB 79%2.6 KB
5news.corradoroberto.it1.6 MB0.0 KB0.0 KB1.6 MB100%5.5 KB
6news.hispagatos.org1.6 MB0.0 KB28.5 KB1.6 MB 98%3.2 KB
7nntp.comgw.net1.4 MB2.4 KB262.8 KB1.7 MB 84%2.7 KB
8i2pn.org1.0 MB2.4 KB54.5 KB1.1 MB 94%2.6 KB
9usenet.goja.nl.eu.org877.0 KB2.4 KB140.8 KB1020.1 KB 85%2.6 KB
10endoftheline-out.news.chmurka.net797.9 KB0.0 KB0.0 KB797.9 KB100%3.9 KB
11endofthelinebbs.peers.news.panix.com560.7 KB2.4 KB21.6 KB584.6 KB 95%3.1 KB
12newsfeed.bofh.team448.2 KB2.4 KB9.9 KB460.5 KB 97%2.9 KB
13newsfeed.xs3.de443.1 KB2.4 KB32.3 KB477.8 KB 92%4.1 KB
14news.samoylyk.net399.6 KB2.4 KB0.6 KB402.6 KB 99%4.3 KB
15glockenspiel.complete.org263.2 KB2.4 KB0.0 KB265.6 KB 99%12.1 KB
16news.furie.org.uk212.6 KB2.4 KB2.0 KB217.0 KB 97%4.6 KB
17news.netfront.net118.3 KB2.5 KB491.5 KB612.3 KB 19%3.2 KB
18news.nntp4.net76.9 KB2.4 KB0.0 KB79.3 KB 96%1.8 KB
19news.bbs.nz5.9 KB2.4 KB1.1 KB9.4 KB 62%1.9 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: 2225.6 MB38.4 KB2.7 MB28.3 MB 90%3.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 11 00:01:01 - 00:59:59 125 1.7% 0.04458.3 KB 1.7% 0.13
Oct 11 01:00:00 - 01:59:59 251 3.3% 0.07825.3 KB 3.1% 0.23
Oct 11 02:00:00 - 02:59:59 241 3.2% 0.07993.6 KB 3.8% 0.28
Oct 11 03:00:00 - 03:59:59 347 4.6% 0.101.0 MB 3.9% 0.29
Oct 11 04:00:00 - 04:59:59 422 5.6% 0.121.3 MB 4.9% 0.36
Oct 11 05:00:00 - 05:59:59 351 4.7% 0.101.3 MB 5.0% 0.36
Oct 11 06:00:00 - 06:59:59 426 5.7% 0.121.2 MB 4.8% 0.35
Oct 11 07:00:00 - 07:59:59 327 4.3% 0.091.1 MB 4.3% 0.31
Oct 11 08:00:00 - 08:59:59 392 5.2% 0.111.2 MB 4.5% 0.33
Oct 11 09:00:00 - 09:59:59 462 6.1% 0.131.4 MB 5.4% 0.40
Oct 11 10:00:00 - 10:59:59 600 8.0% 0.172.0 MB 7.9% 0.58
Oct 11 11:00:00 - 11:59:59 458 6.1% 0.131.4 MB 5.5% 0.41
Oct 11 12:00:00 - 12:59:59 490 6.5% 0.141.6 MB 6.1% 0.45
Oct 11 13:00:00 - 13:59:59 445 5.9% 0.121.6 MB 6.1% 0.45
Oct 11 14:00:00 - 14:59:59 326 4.3% 0.091.2 MB 4.6% 0.34
Oct 11 15:00:00 - 15:59:59 318 4.2% 0.091.1 MB 4.2% 0.31
Oct 11 16:00:00 - 16:59:59 360 4.8% 0.101.4 MB 5.3% 0.39
Oct 11 17:00:00 - 17:59:59 316 4.2% 0.091.2 MB 4.8% 0.35
Oct 11 18:00:00 - 18:59:59 207 2.8% 0.06809.6 KB 3.1% 0.22
Oct 11 19:00:00 - 19:59:59 163 2.2% 0.05562.7 KB 2.1% 0.16
Oct 11 20:00:00 - 20:59:59 121 1.6% 0.03437.2 KB 1.7% 0.12
Oct 11 21:00:00 - 21:59:59 140 1.9% 0.04684.2 KB 2.6% 0.19
Oct 11 22:00:00 - 22:59:59 100 1.3% 0.03456.3 KB 1.7% 0.13
Oct 11 23:00:00 - 23:59:59 134 1.8% 0.04700.3 KB 2.7% 0.19
Oct 12 00:00:00 - 00:01:02 3 0.0% 0.0510.7 KB 0.0% 0.17
TOTAL: 24:00:01 7525 100.0% 0.0925.7 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.5 GB 6.4% 0 0.4938310.19
CYCTXT1TEXT5.0 GB3.9 GB 77.8% 0 0.02 2626.71
TOTAL: 3-3077.0 GB102.4 GB 3.3% 1 0.34-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1endofthelinebbs-out.news.weretis.net 509 0 0 2 0 0 0 0 507
2usenet.blueworldhosting.com 326 8 0 0 0 0 0 0 318
3nntp.comgw.net 144 0 0 1 0 0 0 0 143
4news.netfront.net 109 0 0 1 0 0 0 0 108
5usenet.goja.nl.eu.org 90 0 0 1 0 0 0 0 89
6i2pn.org 46 0 0 1 0 0 0 0 45
7news.hispagatos.org 18 14 0 0 0 0 0 0 4
8endofthelinebbs.peers.news.panix.com 17 3 0 1 0 0 0 0 13
9usenet.network 16 0 0 1 0 0 0 0 15
10newsfeed.xs3.de 12 0 0 1 0 0 0 0 11
11newsfeed.bofh.team 7 2 0 1 0 0 0 0 4
12outgoing.news.lysator.liu.se 6 0 0 1 0 0 0 0 5
13news.furie.org.uk 3 1 0 1 0 0 0 0 1
14news.bbs.nz 2 0 0 1 0 0 0 0 1
15news.samoylyk.net 2 0 0 1 0 0 0 0 1
16glockenspiel.complete.org 1 0 0 1 0 0 0 0 0
17news.nntp4.net 1 0 0 1 0 0 0 0 0
TOTAL: 17 1309 28 0 16 0 0 0 0 1265

Unwanted newsgroups [Top 20]:

NewsgroupCount
soc.culture.russia 8
hispagatos.hacking.ctf 7
hispagatos.hacking.news 6
msn.forums.comedy.general.jokes 2
soc.culture.kazakh 2
SerpentLord 1
hispagatos.hacking.exploits 1
msn.forums.comedy.puns 1
TOTAL: 8 28

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 607
EMP (phr path) 319
Too many newsgroups 133
EMP (md5) 73
User-issued cancel 42
Too many newsgroups (meow) 9
EMP (phn nph) 7
HTML Multipart 1
Subject (lSdk-v) 1
TOTAL: 9 1192

NoCeM on Spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
i2pn2-nocem@i2pn2.org (multipost)2700136136
i2pn2-nocem@i2pn2.org (rmp)8001212
robot@pasdenom.info (spam3)40066
robot@pasdenom.info (spam2)30033
TOTAL: 44200157157

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 45
usenet.blueworldhosting.com 16
usenet.goja.nl.eu.org 4
endofthelinebbs.peers.news.panix.com 3
nntp.comgw.net 2
i2pn.org 1
outgoing.news.lysator.liu.se 1
newsfeed.xs3.de 1
TOTAL: 8 73
TOTAL: 1 73

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 10101 3981 3484 1 0 45 39%23:59:52
2nyheter.lysator.liu.se 6347 1545 4166 412 0 0 24%23:59:52
3news.furie.org.uk 4583 519 3151 11 0 2 11%23:57:25
4photonic.trudheim.com 8113 462 6024 1039 0 0 5%23:59:47
5endofthelinebbs.peers.news.panix.com 7859 451 7068 4 0 0 5%23:59:29
6usenet.goja.nl.eu.org 8165 334 6558 192 0 0 4%23:59:07
7news.hispagatos.org 8411 268 6589 178 0 0 3%23:59:27
8news.bbs.nz 13635 229 6787 503 0 117 1%23:59:52
9usenet.network 7721 195 6473 26 0 0 2%23:54:42
10news.nk.ca 10857 192 6725 535 0 38 1%23:59:52
11newsfeed.bofh.team 8303 184 7063 0 0 0 2%23:59:52
12i2pn.org 8162 118 6954 52 0 53 1%23:59:17
13news.nntp4.net 8391 92 7282 74 0 0 1%23:59:52
14nntp.comgw.net 7938 92 6847 95 0 0 1%23:59:52
15news.weretis.net 7801 78 7322 124 0 2 0%23:59:52
16news.tnetconsulting.net 8467 64 7285 173 0 20 0%23:59:53
17news.chmurka.net 5008 63 3396 3 0 32 1%23:59:52
18news.quux.org 7985 57 6918 518 0 3 0%23:59:51
19news.corradoroberto.it 856 46 700 0 0 0 5%22:31:36
20newsfeed.xs3.de 8671 45 7136 224 0 0 0%23:59:52
21news.samoylyk.net 8484 30 7356 22 0 1 0%23:59:12
22usenet.blueworldhosting.com 6639 1 6345 0 0 0 0%23:59:53
23feed.opticnetworks.net 0 0 0 0 0 7525 0%23:59:52
TOTAL: 23 172497 9046 131629 4186 0 7838 5%550:18:11
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net14.0 MB1.2 KB14.0 MB0.2 KB/s3.6 KB23:59:52
2nyheter.lysator.liu.se4.6 MB3.3 MB7.8 MB0.1 KB/s4.1 KB23:59:52
3news.furie.org.uk3.1 MB45.9 KB3.1 MB0.0 KB/s6.0 KB23:57:25
4photonic.trudheim.com2.7 MB3.4 MB6.1 MB0.1 KB/s4.2 KB23:59:47
5endofthelinebbs.peers.news.panix.com2.1 MB3.0 KB2.1 MB0.0 KB/s4.6 KB23:59:29
6newsfeed.bofh.team1.5 MB0.0 KB1.5 MB0.0 KB/s8.2 KB23:59:52
7news.hispagatos.org943.9 KB1.6 MB2.5 MB0.0 KB/s5.8 KB23:59:27
8news.bbs.nz771.8 KB3.1 MB3.8 MB0.0 KB/s5.3 KB23:59:52
9usenet.goja.nl.eu.org629.3 KB1.9 MB2.5 MB0.0 KB/s4.9 KB23:59:07
10usenet.network618.4 KB45.3 KB663.8 KB0.0 KB/s3.0 KB23:54:42
11news.nntp4.net580.8 KB873.6 KB1.4 MB0.0 KB/s8.8 KB23:59:52
12news.quux.org553.7 KB2.7 MB3.2 MB0.0 KB/s5.7 KB23:59:51
13news.nk.ca481.0 KB3.4 MB3.8 MB0.0 KB/s5.4 KB23:59:52
14i2pn.org468.9 KB177.9 KB646.8 KB0.0 KB/s3.8 KB23:59:17
15news.samoylyk.net427.5 KB81.0 KB508.4 KB0.0 KB/s9.8 KB23:59:12
16news.weretis.net338.4 KB1.4 MB1.7 MB0.0 KB/s8.9 KB23:59:52
17news.tnetconsulting.net277.4 KB1.3 MB1.6 MB0.0 KB/s7.0 KB23:59:53
18news.chmurka.net249.1 KB6.2 KB255.3 KB0.0 KB/s3.9 KB23:59:52
19nntp.comgw.net238.5 KB1.2 MB1.4 MB0.0 KB/s7.8 KB23:59:52
20newsfeed.xs3.de175.1 KB1.5 MB1.7 MB0.0 KB/s6.4 KB23:59:52
21news.corradoroberto.it135.4 KB0.0 KB135.4 KB0.0 KB/s2.9 KB22:31:36
22usenet.blueworldhosting.com1.1 KB0.0 KB1.1 KB0.0 KB/s1.1 KB23:59:53
23feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:52
TOTAL: 2334.6 MB25.9 MB60.5 MB0.0 KB/s4.7 KB550:18:11
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
12001:470:28:a8:ca7f:54ff:fe03:41e02773 00.0 KB 0 0 000:20:43
2ddt.demos.su2737 00.0 KB 0 0 000:28:37
3167.94.146.57 3 00.0 KB 0 0 000:00:04
469.10.48.174 2 00.0 KB 0 0 000:30:00
5104.152.52.207 1 00.0 KB 0 0 000:00:10
6104.152.52.216 1 00.0 KB 0 0 000:00:00
7194.165.16.73 1 00.0 KB 0 0 000:00:02
8198.235.24.124 1 00.0 KB 0 0 000:00:00
9198.235.24.159 1 00.0 KB 0 0 000:00:10
102001:470:28:a8:3ad5:47ff:fe02:c2fd 1 00.0 KB 0 0 000:09:59
11205.210.31.143 1 00.0 KB 0 0 000:00:05
12206.168.34.194 1 00.0 KB 0 0 000:00:00
1387.251.75.136 1 00.0 KB 0 0 000:00:10
1491.238.181.23 1 00.0 KB 0 0 000:00:00
15azpdsgc46.stretchoid.com 1 00.0 KB 0 0 000:00:00
16localhost 1 00.0 KB 0 0 000:11:48
17server-0-3.survey.inspici.com 1 00.0 KB 0 0 000:00:03
TOTAL: 175528 00.0 KB 0 0 001:41:57

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1?2775 00.0 KB 0 0 000:42:32
2*.demos.su2737 00.0 KB 0 0 000:28:37
3unresolved 14 00.0 KB 0 0 000:30:43
4*.stretchoid.com 1 00.0 KB 0 0 000:00:00
5*.survey.inspici.com 1 00.0 KB 0 0 000:00:03
TOTAL: 55528 00.0 KB 0 0 001:41:57

NNRP auth users [Top 20]:

UserConn
getlist 1
TOTAL: 1 1

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
69.10.48.174 0.008 0.024 0.00000:30:00
ddt.demos.su 9.361 36.358 0.00000:28:37
2001:470:28:a8:ca7f:54ff:fe03:41e0 9.818 36.785 0.00000:20:43
localhost 179.980 367.636 0.07600:11:48
2001:470:28:a8:3ad5:47ff:fe02:c2fd 0.011 0.005 0.00000:09:59
104.152.52.207 0.000 0.017 0.00000:00:10
198.235.24.159 0.000 0.016 0.00000:00:10
87.251.75.136 0.005 0.010 0.00000:00:10
205.210.31.143 0.004 0.012 0.00000:00:05
167.94.146.57 0.015 0.047 0.00000:00:04
server-0-3.survey.inspici.com 0.004 0.012 0.00000:00:03
194.165.16.73 0.006 0.012 0.00000:00:02
206.168.34.194 0.008 0.020 0.00000:00:00
198.235.24.124 0.000 0.016 0.00000:00:00
91.238.181.23 0.004 0.012 0.00000:00:00
azpdsgc46.stretchoid.com 0.008 0.008 0.00000:00:00
104.152.52.216 0.000 0.017 0.00000:00:00
TOTAL: 17 199.232 441.007 0.07601:41:57

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

SystemConn
167.94.146.57 1
194.165.16.73 1
206.168.34.194 1
91.238.181.23 1
azpdsgc46.stretchoid.com 1
TOTAL: 5 5

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

CommandCount
#003 2
EHLO www.censys.io 2
MGLNDD_144.172.126.95_119 1
TOTAL: 3 5

NNRP client timeouts [Top 20]:

SystemConnPeer
167.94.146.57 1 2
194.165.16.73 1 1
69.10.48.174 1 0
91.238.181.23 1 1
TOTAL: 4 4 6