Daily Usenet Report

Sep 29 00:01:02 -- Sep 30 00:01:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Sep 29 08:12:10 newsfeed innd: message repeated 2 times: [ ctlinnd command s]
Sep 30 00:00:01 newsfeed nnrpd[331285]: localhost auth: program exited with status 8

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 21539 51.0%2.6 MB 32.9%
inn 8072 19.1%3.3 MB 41.9%
innd 8072 19.1%1.1 MB 14.6%
innfeed 4110 9.7%786.1 KB 9.8%
cnfsstat 432 1.0%63.6 KB 0.8%
nocem 25 0.1%2.6 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 42251 100.0%7.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 115137 58.5%
Negative hits 73724 37.5%
Do not exist 7951 4.0%
Cache misses 11 0.0%
TOTAL: 4 196823 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.113 0.0%46 0.000 2.457 12.000
article cleanup00:00:00.100 0.0%8038 0.000 0.012 0.077
article logging00:00:00.441 0.0%8073 0.000 0.055 0.295
article parse00:00:00.205 0.0%11323 0.000 0.018 0.105
article write00:00:02.910 0.0%6726 0.000 0.433 22.556
artlog/artcncl00:00:00.000 0.0%7 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:01.266 0.0%200444 0.000 0.006 0.200
hisgrep/artcncl00:00:00.083 0.0%52 0.000 1.596 8.000
hishave/artcncl00:00:00.002 0.0%7 0.000 0.286 2.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:22.370 0.2%198404 0.093 0.718 5.542
history sync00:00:00.062 0.0%377 0.000 0.164 1.333
history write00:02:05.521 0.1%8020 3.032 15.651 148.779
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:53:40.495 99.5%205288 70.295 419.023 1253.950
nntp read00:00:02.908 0.0%201569 0.003 0.014 0.106
overview write00:00:58.603 0.1%6726 0.978 8.713 460.455
perl filter00:00:32.207 0.0%8020 1.670 4.016 38.712
python filter00:00:02.433 0.0%8020 0.000 0.303 11.650
site send00:00:01.157 0.0%13475 0.000 0.086 0.261
TOTAL: 24:00:58.83523:59:50.876 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.035 0.0%20372 0.000 0.002 0.056
article prepare00:00:00.007 0.0%34980 0.000 0.000 0.005
article read00:00:00.917 0.0%3525 0.000 0.260 6.239
backlog stats00:00:00.339 0.0%240642 0.000 0.001 0.010
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.269 0.0%170300 0.002 0.013 0.039
data write00:00:02.919 0.0%165084 0.005 0.018 0.039
idle23:59:02.294100.0%240642 79.786 358.800 1365.429
status file00:00:00.321 0.0%268 0.800 1.198 17.000
TOTAL: 23:59:21.42223:59:09.101100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:16:09.058 79.0%16161 0.500 282.721900035.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.325 0.1%111114 0.000 0.039 1.000
TOTAL: 01:36:26.41001:16:13.383 79.0%----

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 3 11490 1762 9373 355 15%41:14:21
2outgoing.news.lysator.liu.se 1 5936 1434 4476 26 24%23:59:56
3usenet.blueworldhosting.com 720 7828 631 6790 407 8%23:48:45
4nntp.comgw.net 1 7345 529 6637 179 7%23:59:57
5news.hispagatos.org 10 7289 505 6761 23 6%24:52:39
6i2pn.org 1 7118 391 6628 99 5%23:59:54
7news.corradoroberto.it 9 1119 234 885 0 20%23:43:06
8usenet.goja.nl.eu.org 10 7184 224 6893 67 3%23:52:25
9newsfeed.xs3.de 1 5863 179 5684 0 3%23:59:56
10endofthelinebbs.peers.news.panix.com 27 7084 149 6928 7 2%23:54:02
11newsfeed.bofh.team 2 7784 125 7654 5 1%23:59:54
12usenet.network 1 5356 99 5223 34 1%23:59:56
13news.samoylyk.net 2 6260 87 6166 7 1%23:58:34
14endoftheline-out.news.chmurka.net 2 3582 55 3527 0 1%23:59:33
15news.netfront.net 1 5644 46 5515 83 0%25:54:54
16news.nntp4.net 2 6106 23 6082 1 0%23:59:51
17news.furie.org.uk 2 6616 21 6593 2 0%47:59:51
18glockenspiel.complete.org 2 5419 9 5410 0 0%23:56:25
19news.bbs.nz 1 5915 6 5909 0 0%22:59:37
20eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:03
21localhost 27 0 0 0 0 0%00:00:01
22news.nk.ca 2 0 0 0 0 0%00:20:12
TOTAL: 22 828 120938 6509 113134 1295 5%498:43:52
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net5.2 MB0.0 KB521.5 KB5.7 MB 91%2.8 KB
2outgoing.news.lysator.liu.se4.4 MB0.0 KB25.6 KB4.4 MB 99%3.1 KB
3news.corradoroberto.it1.6 MB0.0 KB0.0 KB1.6 MB100%6.8 KB
4usenet.blueworldhosting.com1.5 MB0.0 KB1.2 MB2.7 MB 56%2.6 KB
5news.hispagatos.org1.5 MB0.0 KB34.6 KB1.5 MB 97%2.9 KB
6nntp.comgw.net1.5 MB2.9 KB290.2 KB1.8 MB 83%2.5 KB
7i2pn.org1.4 MB0.0 KB119.9 KB1.5 MB 92%3.2 KB
8usenet.network993.4 KB0.0 KB31.1 KB1.0 MB 96%7.7 KB
9usenet.goja.nl.eu.org841.6 KB2.5 KB83.7 KB927.8 KB 90%3.2 KB
10newsfeed.xs3.de772.5 KB0.0 KB0.0 KB772.5 KB100%4.3 KB
11endofthelinebbs.peers.news.panix.com481.3 KB0.0 KB18.8 KB500.1 KB 96%3.2 KB
12news.samoylyk.net388.4 KB0.0 KB8.7 KB397.1 KB 97%4.2 KB
13newsfeed.bofh.team338.2 KB2.5 KB18.7 KB359.4 KB 94%2.8 KB
14glockenspiel.complete.org153.6 KB0.0 KB0.0 KB153.6 KB100%17.1 KB
15endoftheline-out.news.chmurka.net138.8 KB0.0 KB0.0 KB138.8 KB100%2.5 KB
16news.netfront.net82.7 KB7.9 KB243.9 KB334.5 KB 24%2.6 KB
17news.furie.org.uk68.7 KB43.4 KB0.0 KB112.1 KB 61%4.9 KB
18news.nntp4.net42.5 KB0.0 KB1.3 KB43.8 KB 97%1.8 KB
19news.bbs.nz11.6 KB0.0 KB0.0 KB11.6 KB100%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: 2221.2 MB59.2 KB2.5 MB23.8 MB 89%3.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 29 00:01:02 - 00:59:59 122 1.8% 0.03346.7 KB 1.5% 0.10
Sep 29 01:00:00 - 01:59:59 210 3.1% 0.06572.8 KB 2.5% 0.16
Sep 29 02:00:00 - 02:59:59 288 4.3% 0.08787.1 KB 3.5% 0.22
Sep 29 03:00:00 - 03:59:59 300 4.5% 0.08860.8 KB 3.8% 0.24
Sep 29 04:00:00 - 04:59:59 359 5.3% 0.10929.4 KB 4.1% 0.26
Sep 29 05:00:00 - 05:59:59 377 5.6% 0.101.1 MB 4.8% 0.31
Sep 29 06:00:00 - 06:59:59 342 5.1% 0.101.2 MB 5.5% 0.35
Sep 29 07:00:00 - 07:59:59 337 5.0% 0.091.1 MB 5.0% 0.32
Sep 29 08:00:00 - 08:59:59 308 4.6% 0.09872.2 KB 3.8% 0.24
Sep 29 09:00:00 - 09:59:59 396 5.9% 0.111.2 MB 5.5% 0.35
Sep 29 10:00:00 - 10:59:59 356 5.3% 0.101.1 MB 5.0% 0.32
Sep 29 11:00:00 - 11:59:59 323 4.8% 0.091.3 MB 5.8% 0.37
Sep 29 12:00:00 - 12:59:59 376 5.6% 0.101.1 MB 5.0% 0.32
Sep 29 13:00:00 - 13:59:59 335 5.0% 0.091.3 MB 5.8% 0.37
Sep 29 14:00:00 - 14:59:59 411 6.1% 0.111.1 MB 4.9% 0.31
Sep 29 15:00:00 - 15:59:59 329 4.9% 0.091.5 MB 6.7% 0.42
Sep 29 16:00:00 - 16:59:59 334 5.0% 0.091.1 MB 5.1% 0.32
Sep 29 17:00:00 - 17:59:59 251 3.7% 0.07777.8 KB 3.4% 0.22
Sep 29 18:00:00 - 18:59:59 209 3.1% 0.06736.3 KB 3.2% 0.20
Sep 29 19:00:00 - 19:59:59 148 2.2% 0.04556.1 KB 2.4% 0.15
Sep 29 20:00:00 - 20:59:59 116 1.7% 0.03496.0 KB 2.2% 0.14
Sep 29 21:00:00 - 21:59:59 150 2.2% 0.04535.4 KB 2.4% 0.15
Sep 29 22:00:00 - 22:59:59 160 2.4% 0.04726.6 KB 3.2% 0.20
Sep 29 23:00:00 - 23:59:59 181 2.7% 0.051.1 MB 4.8% 0.30
Sep 30 00:00:00 - 00:01:01 5 0.1% 0.0820.0 KB 0.1% 0.33
TOTAL: 23:59:59 6723 100.0% 0.0822.2 MB 100.0% 0.26
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.0 GB 6.4% 0 0.4244911.93
CYCTXT1TEXT5.0 GB3.9 GB 77.5% 0 0.04 1653.87
TOTAL: 3-3077.0 GB101.9 GB 3.3% 1 0.30-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 414 4 0 0 1 0 0 0 409
2endofthelinebbs-out.news.weretis.net 375 0 0 1 0 0 0 0 374
3nntp.comgw.net 182 0 0 2 0 0 0 0 180
4i2pn.org 99 0 0 0 0 0 0 0 99
5news.netfront.net 86 0 0 3 0 0 0 0 83
6usenet.goja.nl.eu.org 64 0 0 1 0 0 0 0 63
7usenet.network 34 0 0 0 0 0 0 0 34
8outgoing.news.lysator.liu.se 28 0 0 1 0 0 0 0 27
9news.hispagatos.org 25 14 0 0 0 0 0 0 11
10news.samoylyk.net 8 0 0 0 0 0 0 0 8
11endofthelinebbs.peers.news.panix.com 7 3 0 0 0 0 0 0 4
12newsfeed.bofh.team 5 0 0 1 0 0 0 0 4
13endoftheline-out.news.chmurka.net 4 0 0 2 0 0 0 0 2
14glockenspiel.complete.org 4 0 0 3 0 0 0 0 1
15news.furie.org.uk 3 0 0 3 0 0 0 0 0
16news.corradoroberto.it 2 0 0 0 0 0 0 0 2
17news.bbs.nz 1 0 0 1 0 0 0 0 0
18news.nntp4.net 1 0 0 0 0 0 0 0 1
TOTAL: 18 1342 21 0 18 1 0 0 0 1302

Unwanted newsgroups [Top 20]:

NewsgroupCount
hispagatos.hacking.ctf 12
soc.culture.russia 3
hispagatos.hacking.news 2
alt.alt.anonymous 1
hispagatos.hacking.exploits 1
rec.autos.vw 1
soc.culture.africa 1
TOTAL: 7 21

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
rec.arts.movies.reviews 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 537
EMP (phr path) 306
EMP (md5) 243
Too many newsgroups 96
User-issued cancel 78
HTML Multipart 6
EMP (fsl) 3
Subject (LSDQvdCwINGB0LLQvtCx?= =?utf-8?B?0L7QtNC1LCDQsdGL0LTQu9C+IC0g0L3QsCDRhNGA0L7QvdGC0L) 1
Too many newsgroups (meow) 1
TOTAL: 9 1271

NoCeM on Spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
i2pn2-nocem@i2pn2.org (spam)10101
i2pn2-nocem@i2pn2.org (multipost)12006565
i2pn2-nocem@i2pn2.org (rmp)8001212
robot@pasdenom.info (spam3)20022
TOTAL: 423017980

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 15
usenet.blueworldhosting.com 7
nntp.comgw.net 2
news.corradoroberto.it 2
outgoing.news.lysator.liu.se 1
glockenspiel.complete.org 1
usenet.goja.nl.eu.org 1
news.hispagatos.org 1
news.samoylyk.net 1
TOTAL: 9 31
TOTAL: 1 31

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 10283 2389 4288 0 0 18 23%23:59:50
2nyheter.lysator.liu.se 5433 1127 3954 201 0 0 20%23:59:49
3news.furie.org.uk 3672 469 2563 1 0 4 12%23:57:49
4usenet.goja.nl.eu.org 7098 292 6096 44 0 1 4%23:59:50
5endofthelinebbs.peers.news.panix.com 6879 260 6457 3 0 0 3%23:59:50
6photonic.trudheim.com 20272 257 18934 655 4 343 1%23:59:47
7news.hispagatos.org 7096 236 5847 101 0 25 3%23:59:50
8usenet.network 7016 183 6106 23 0 0 2%23:59:49
9news.nk.ca 9920 164 6156 335 0 15 1%23:59:50
10news.bbs.nz 12506 154 6180 379 0 62 1%23:59:50
11i2pn.org 7193 150 6120 44 0 34 2%23:59:50
12newsfeed.bofh.team 7085 125 6337 1 0 0 1%23:59:42
13news.nntp4.net 7374 105 6571 9 0 0 1%23:59:22
14nntp.comgw.net 6830 105 6036 28 0 0 1%23:58:55
15news.corradoroberto.it 935 71 724 3 0 3 7%23:26:33
16news.quux.org 6989 46 6322 335 0 3 0%23:59:50
17news.tnetconsulting.net 7768 42 6573 104 0 12 0%23:57:59
18news.weretis.net 6869 36 6646 40 0 0 0%23:59:50
19news.chmurka.net 3934 19 3345 0 0 0 0%23:59:50
20newsfeed.xs3.de 7413 18 6385 130 0 0 0%23:58:55
21news.samoylyk.net 7522 16 6570 43 0 0 0%23:59:50
22usenet.blueworldhosting.com 6293 1 5964 0 0 0 0%23:59:50
23feed.opticnetworks.net 0 0 0 0 0 6723 0%23:59:50
TOTAL: 23 166380 6265 134174 2479 4 7243 3%551:16:30
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net8.5 MB0.0 KB8.5 MB0.1 KB/s3.7 KB23:59:50
2nyheter.lysator.liu.se3.7 MB962.1 KB4.7 MB0.1 KB/s3.6 KB23:59:49
3news.furie.org.uk3.3 MB31.4 KB3.4 MB0.0 KB/s7.3 KB23:57:49
4photonic.trudheim.com928.3 KB2.1 MB3.0 MB0.0 KB/s3.4 KB23:59:47
5news.quux.org892.5 KB875.5 KB1.7 MB0.0 KB/s4.6 KB23:59:50
6news.hispagatos.org863.4 KB672.9 KB1.5 MB0.0 KB/s4.6 KB23:59:50
7news.nk.ca775.8 KB1.2 MB2.0 MB0.0 KB/s4.0 KB23:59:50
8endofthelinebbs.peers.news.panix.com762.4 KB2.2 KB764.6 KB0.0 KB/s2.9 KB23:59:50
9news.samoylyk.net739.9 KB196.0 KB935.9 KB0.0 KB/s15.9 KB23:59:50
10nntp.comgw.net683.5 KB458.6 KB1.1 MB0.0 KB/s8.6 KB23:58:55
11newsfeed.bofh.team651.3 KB6.6 KB657.9 KB0.0 KB/s5.2 KB23:59:42
12newsfeed.xs3.de553.5 KB623.7 KB1.1 MB0.0 KB/s8.0 KB23:58:55
13usenet.goja.nl.eu.org524.0 KB342.5 KB866.4 KB0.0 KB/s2.6 KB23:59:50
14usenet.network505.8 KB42.2 KB547.9 KB0.0 KB/s2.7 KB23:59:49
15news.nntp4.net474.2 KB82.6 KB556.8 KB0.0 KB/s4.9 KB23:59:22
16news.bbs.nz471.1 KB1.2 MB1.7 MB0.0 KB/s3.3 KB23:59:50
17i2pn.org454.3 KB233.5 KB687.8 KB0.0 KB/s3.5 KB23:59:50
18news.corradoroberto.it258.5 KB9.5 KB268.0 KB0.0 KB/s3.6 KB23:26:33
19news.weretis.net246.8 KB920.6 KB1.1 MB0.0 KB/s15.4 KB23:59:50
20news.tnetconsulting.net170.6 KB390.4 KB561.0 KB0.0 KB/s3.8 KB23:57:59
21news.chmurka.net92.2 KB0.0 KB92.2 KB0.0 KB/s4.9 KB23:59:50
22usenet.blueworldhosting.com1.6 KB0.0 KB1.6 KB0.0 KB/s1.6 KB23:59:50
23feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:50
TOTAL: 2325.4 MB10.2 MB35.6 MB0.0 KB/s4.2 KB551:16:30
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ddt.demos.su2739 00.0 KB 0 0 000:31:59
22001:470:28:a8:ca7f:54ff:fe03:41e02650 00.0 KB 0 0 000:22:18
3ec2-13-58-97-162.us-east-2.compute.amazonaws.com 4 00.0 KB 0 0 000:00:01
4198.235.24.237 1 00.0 KB 0 0 000:00:10
5198.235.24.93 1 00.0 KB 0 0 000:00:10
660.190.226.187 1 00.0 KB 0 0 000:30:00
780.66.76.121 1 00.0 KB 0 0 000:00:00
8azpdwg64.stretchoid.com 1 00.0 KB 0 0 000:00:00
9azpdwsb43.stretchoid.com 1 00.0 KB 0 0 000:00:09
10azpdwsb72.stretchoid.com 1 00.0 KB 0 0 000:00:09
11localhost 1 00.0 KB 0 0 000:11:10
12server-0-3.survey.inspici.com 1 00.0 KB 0 0 000:00:04
13sh-ams-nl-gp1-wk115a.internet-census.org 1 00.0 KB 0 0 000:00:10
TOTAL: 135403 00.0 KB 0 0 001:36:23

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.demos.su2739 00.0 KB 0 0 000:31:59
2?2651 00.0 KB 0 0 000:33:28
3*.us-east-2.compute.amazonaws.com 4 00.0 KB 0 0 000:00:01
4unresolved 4 00.0 KB 0 0 000:30:20
5*.stretchoid.com 3 00.0 KB 0 0 000:00:19
6*.internet-census.org 1 00.0 KB 0 0 000:00:10
7*.survey.inspici.com 1 00.0 KB 0 0 000:00:04
TOTAL: 75403 00.0 KB 0 0 001:36:23

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.451 36.120 0.00000:31:59
60.190.226.187 0.000 0.016 0.00000:30:00
2001:470:28:a8:ca7f:54ff:fe03:41e0 9.534 34.537 0.00000:22:18
localhost 180.710 368.781 0.07200:11:10
sh-ams-nl-gp1-wk115a.internet-census.org 0.000 0.018 0.00000:00:10
198.235.24.93 0.000 0.016 0.00000:00:10
198.235.24.237 0.011 0.005 0.00000:00:10
azpdwsb72.stretchoid.com 0.000 0.016 0.00000:00:09
azpdwsb43.stretchoid.com 0.005 0.011 0.00000:00:09
server-0-3.survey.inspici.com 0.004 0.012 0.00000:00:04
ec2-13-58-97-162.us-east-2.compute.amazonaws.com 0.013 0.051 0.00000:00:01
80.66.76.121 0.003 0.013 0.00000:00:00
azpdwg64.stretchoid.com 0.000 0.016 0.00000:00:00
TOTAL: 13 199.731 439.612 0.07201:36:23

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

SystemConn
ec2-13-58-97-162.us-east-2.compute.amazonaws.com 4
60.190.226.187 1
80.66.76.121 1
azpdwg64.stretchoid.com 1
TOTAL: 4 7

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

CommandCount
#001 2
#026#003#001 2
#003 1
GET / HTTP/1.0 1
MGLNDD_144.172.126.95_119 1
TOTAL: 5 7

NNRP client timeouts [Top 20]:

SystemConnPeer
60.190.226.187 1 0
80.66.76.121 1 1
TOTAL: 2 2 1