Daily Usenet Report

Sep 10 00:01:02 -- Sep 11 00:01:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Sep 10 08:13:02 newsfeed innd: message repeated 2 times: [ ctlinnd command s]
Sep 10 10:34:54 newsfeed nnrpd[947577]: 47.186.47.228 auth: program exited with status 8
Sep 11 00:00:01 newsfeed nnrpd[1168395]: localhost auth: program exited with status 8

Log entries by program:

Program nameLines%LinesSize%Size
inn 8655 29.1%3.5 MB 55.5%
nnrpd 8450 28.5%885.3 KB 13.6%
innd 7981 26.9%1.1 MB 17.8%
innfeed 4133 13.9%769.9 KB 11.8%
cnfsstat 432 1.5%75.3 KB 1.2%
nocem 41 0.1%4.7 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 29693 100.0%6.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 114456 58.5%
Negative hits 72672 37.2%
Do not exist 8468 4.3%
Cache misses 19 0.0%
TOTAL: 4 195615 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.082 0.0%28 0.000 2.929 8.000
article cleanup00:00:00.101 0.0%8539 0.000 0.012 0.100
article logging00:00:00.445 0.0%8662 0.000 0.051 0.190
article parse00:00:00.196 0.0%12702 0.000 0.015 0.063
article write00:00:02.567 0.0%7357 0.000 0.349 16.000
artlog/artcncl00:00:00.001 0.0%9 0.000 0.111 0.500
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.508 0.0%194751 0.000 0.003 0.060
hisgrep/artcncl00:00:00.057 0.0%31 0.000 1.839 8.000
hishave/artcncl00:00:00.004 0.0%9 0.000 0.444 2.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:02:48.156 0.2%197345 0.087 0.852 5.280
history sync00:00:00.069 0.0%382 0.000 0.181 1.000
history write00:02:21.382 0.2%8537 3.094 16.561 112.511
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:48:57.620 99.0%193487 115.454 443.118 2173.598
nntp read00:00:04.671 0.0%195263 0.003 0.024 0.827
overview write00:08:22.820 0.6%7357 0.519 68.346 2963.257
perl filter00:00:28.136 0.0%8537 1.591 3.296 19.905
python filter00:00:02.223 0.0%8537 0.000 0.260 4.185
site send00:00:01.251 0.0%14749 0.000 0.085 0.500
TOTAL: 24:04:04.45424:03:10.289 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.021 0.0%7561 0.000 0.003 0.050
article prepare00:00:00.011 0.0%38716 0.000 0.000 0.007
article read00:00:00.533 0.0%3040 0.000 0.175 2.279
backlog stats00:00:00.350 0.0%237198 0.000 0.001 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.241 0.0%171575 0.002 0.013 0.042
data write00:00:02.961 0.0%164289 0.008 0.018 0.038
idle23:58:34.565100.0%237198 164.436 363.892 1228.904
status file00:00:00.330 0.0%285 0.750 1.158 7.000
TOTAL: 23:58:51.47923:58:41.012100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:23:52.484 55.6%8271 0.250 173.194 10051.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.397 0.2%95302 0.000 0.046 0.333
TOTAL: 00:42:54.45400:23:56.881 55.8%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1outgoing.news.lysator.liu.se 1 6832 1725 5035 72 25%23:59:57
2endofthelinebbs-out.news.weretis.net 3 14221 1060 12918 243 7%51:59:42
3usenet.blueworldhosting.com 720 8347 824 7064 459 9%23:52:20
4usenet.goja.nl.eu.org 10 7394 735 6527 132 9%22:25:34
5news.hispagatos.org 5 7661 585 7033 43 7%24:26:22
6nntp.comgw.net 2 7716 558 7077 81 7%23:59:40
7news.corradoroberto.it 6 1385 450 935 0 32%22:06:14
8usenet.network 2 6144 443 5701 0 7%23:59:53
9newsfeed.xs3.de 2 6111 281 5815 15 4%23:59:48
10i2pn.org 2 7663 240 7382 41 3%23:59:28
11newsfeed.bofh.team 1 8351 153 8185 13 1%23:59:57
12endoftheline-out.news.chmurka.net 2 3440 126 3313 1 3%23:59:33
13endofthelinebbs.peers.news.panix.com 24 7797 118 7663 16 1%23:54:31
14news.samoylyk.net 2 6745 95 6648 2 1%23:59:24
15news.nntp4.net 1 6599 32 6565 2 0%23:59:53
16glockenspiel.complete.org 2 5991 21 5969 1 0%23:55:31
17news.bbs.nz 0 5793 12 5781 0 0%20:30:54
18news.netfront.net 1 6443 9 6362 72 0%23:46:51
19news.furie.org.uk 2 3942 9 3931 2 0%23:56:58
20photonic.trudheim.com 3 2197 1 2196 0 0%28:36:12
21eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:04
22localhost 30 0 0 0 0 0%00:00:00
23news.nk.ca 2 0 0 0 0 0%00:20:12
TOTAL: 23 824 130772 7477 122100 1195 5%505:58:58
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.network4.7 MB0.0 KB0.0 KB4.7 MB100%10.9 KB
2outgoing.news.lysator.liu.se4.7 MB0.0 KB102.9 KB4.8 MB 97%2.7 KB
3news.corradoroberto.it3.4 MB0.0 KB0.0 KB3.4 MB100%7.7 KB
4endofthelinebbs-out.news.weretis.net3.1 MB0.0 KB532.5 KB3.6 MB 85%2.8 KB
5usenet.goja.nl.eu.org2.2 MB0.0 KB231.0 KB2.4 MB 90%2.9 KB
6usenet.blueworldhosting.com2.2 MB0.0 KB836.7 KB3.0 MB 72%2.4 KB
7nntp.comgw.net1.7 MB0.0 KB311.3 KB2.0 MB 85%3.3 KB
8news.hispagatos.org1.6 MB0.0 KB44.7 KB1.6 MB 97%2.7 KB
9i2pn.org885.0 KB0.0 KB60.5 KB945.5 KB 93%3.4 KB
10newsfeed.xs3.de823.3 KB0.0 KB25.2 KB848.5 KB 97%2.9 KB
11newsfeed.bofh.team452.9 KB0.0 KB19.7 KB472.6 KB 95%2.8 KB
12news.samoylyk.net432.5 KB4.2 KB1.2 KB437.9 KB 98%4.5 KB
13endoftheline-out.news.chmurka.net386.4 KB0.0 KB1.2 KB387.6 KB 99%3.1 KB
14endofthelinebbs.peers.news.panix.com232.7 KB0.0 KB20.9 KB253.6 KB 91%1.9 KB
15glockenspiel.complete.org102.2 KB0.0 KB0.6 KB102.8 KB 99%4.7 KB
16news.nntp4.net78.1 KB0.0 KB2.5 KB80.6 KB 96%2.4 KB
17news.furie.org.uk35.1 KB4.3 KB7.7 KB47.1 KB 74%4.3 KB
18news.bbs.nz28.0 KB0.0 KB0.0 KB28.0 KB100%2.3 KB
19news.netfront.net15.7 KB0.0 KB396.1 KB411.8 KB 3%5.1 KB
20photonic.trudheim.com4.0 KB0.0 KB0.0 KB4.0 KB100%4.0 KB
21eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
22localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
23news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2326.9 MB8.5 KB2.5 MB29.5 MB 91%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 10 00:01:02 - 00:59:59 178 2.4% 0.05601.8 KB 2.3% 0.17
Sep 10 01:00:00 - 01:59:59 398 5.4% 0.111.4 MB 5.4% 0.39
Sep 10 02:00:00 - 02:59:59 336 4.6% 0.091.1 MB 4.2% 0.31
Sep 10 03:00:00 - 03:59:59 354 4.8% 0.101019.0 KB 3.9% 0.28
Sep 10 04:00:00 - 04:59:59 302 4.1% 0.081.0 MB 4.0% 0.29
Sep 10 05:00:00 - 05:59:59 318 4.3% 0.09987.3 KB 3.8% 0.27
Sep 10 06:00:00 - 06:59:59 370 5.0% 0.101.1 MB 4.5% 0.32
Sep 10 07:00:00 - 07:59:59 359 4.9% 0.101.3 MB 5.0% 0.36
Sep 10 08:00:00 - 08:59:59 409 5.6% 0.111.3 MB 4.9% 0.36
Sep 10 09:00:00 - 09:59:59 451 6.1% 0.131.4 MB 5.6% 0.41
Sep 10 10:00:00 - 10:59:59 439 6.0% 0.121.4 MB 5.6% 0.41
Sep 10 11:00:00 - 11:59:59 419 5.7% 0.121.4 MB 5.4% 0.39
Sep 10 12:00:00 - 12:59:59 442 6.0% 0.121.5 MB 5.8% 0.42
Sep 10 13:00:00 - 13:59:59 388 5.3% 0.111.5 MB 6.0% 0.44
Sep 10 14:00:00 - 14:59:59 472 6.4% 0.131.8 MB 7.2% 0.52
Sep 10 15:00:00 - 15:59:59 389 5.3% 0.111.5 MB 5.8% 0.42
Sep 10 16:00:00 - 16:59:59 308 4.2% 0.091.2 MB 4.7% 0.35
Sep 10 17:00:00 - 17:59:59 197 2.7% 0.051.0 MB 3.9% 0.29
Sep 10 18:00:00 - 18:59:59 147 2.0% 0.04717.9 KB 2.7% 0.20
Sep 10 19:00:00 - 19:59:59 153 2.1% 0.04643.3 KB 2.5% 0.18
Sep 10 20:00:00 - 20:59:59 133 1.8% 0.04421.9 KB 1.6% 0.12
Sep 10 21:00:00 - 21:59:59 105 1.4% 0.03396.4 KB 1.5% 0.11
Sep 10 22:00:00 - 22:59:59 108 1.5% 0.03511.6 KB 1.9% 0.14
Sep 10 23:00:00 - 23:59:59 161 2.2% 0.04468.8 KB 1.8% 0.13
Sep 11 00:00:00 - 00:01:02 7 0.1% 0.1142.0 KB 0.2% 0.68
TOTAL: 24:00:00 7343 100.0% 0.0825.6 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 GB97.3 GB 6.3% 0 0.4739296.08
CYCTXT1TEXT5.0 GB3.9 GB 77.1% 0 0.03 1991.11
TOTAL: 3-3077.0 GB101.2 GB 3.3% 1 0.35-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 496 3 0 0 0 0 0 0 493
2endofthelinebbs-out.news.weretis.net 276 0 0 0 0 0 0 0 276
3usenet.goja.nl.eu.org 157 0 0 0 0 0 0 0 157
4nntp.comgw.net 87 0 0 0 0 0 0 0 87
5news.netfront.net 72 0 0 0 0 0 0 0 72
6outgoing.news.lysator.liu.se 72 0 0 0 0 0 0 0 72
7news.hispagatos.org 43 24 0 0 0 0 0 0 19
8i2pn.org 41 0 0 0 0 0 0 0 41
9newsfeed.xs3.de 20 0 0 0 0 0 0 0 20
10endofthelinebbs.peers.news.panix.com 17 1 0 0 0 0 0 0 16
11newsfeed.bofh.team 13 1 0 0 0 0 0 0 12
12news.nntp4.net 3 0 0 0 0 0 0 0 3
13news.furie.org.uk 2 1 0 1 0 0 0 0 0
14news.samoylyk.net 2 0 0 1 0 0 0 0 1
15endoftheline-out.news.chmurka.net 1 0 0 0 0 0 0 0 1
16glockenspiel.complete.org 1 0 0 0 0 0 0 0 1
TOTAL: 16 1303 30 0 2 0 0 0 0 1271

Unwanted newsgroups [Top 20]:

NewsgroupCount
hispagatos.hacking.ctf 17
hispagatos.hacking.news 5
msn.forums.religion.biblestudy 3
alt.christnet.bible-study 2
hispagatos.hacking.exploits 2
alt.videogames 1
TOTAL: 6 30

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 609
EMP (phr path) 330
Too many newsgroups 100
EMP (md5) 66
User-issued cancel 25
Too many newsgroups (meow) 13
HTML Multipart 6
TOTAL: 7 1149

NoCeM on Spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
i2pn2-nocem@i2pn2.org (spam)30404
nocem@eternal-september.org (bot)10101
nocem@eternal-september.org (spam)10101
i2pn2-nocem@i2pn2.org (multipost)12004343
i2pn2-nocem@i2pn2.org (rmp)6003030
robot@pasdenom.info (spam2)11001313
robot@pasdenom.info (spam3)10022
TOTAL: 735068894

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 47
usenet.blueworldhosting.com 37
usenet.goja.nl.eu.org 24
nntp.comgw.net 7
newsfeed.xs3.de 5
endofthelinebbs.peers.news.panix.com 1
news.nntp4.net 1
TOTAL: 7 122
TOTAL: 1 122

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 11892 1907 5425 0 0 21 16%23:59:32
2nyheter.lysator.liu.se 5873 986 4076 552 0 1 16%23:57:51
3news.furie.org.uk 4347 482 3062 9 0 0 11%23:59:53
4photonic.trudheim.com 7880 457 6131 748 0 0 5%23:59:53
5endofthelinebbs.peers.news.panix.com 7603 401 6932 7 0 0 5%23:59:36
6usenet.network 7555 258 6229 37 0 4 3%23:59:28
7news.hispagatos.org 7866 239 6297 226 0 4 3%23:59:23
8usenet.goja.nl.eu.org 7338 227 6146 201 0 7 3%23:59:00
9newsfeed.bofh.team 7991 193 6914 0 0 1 2%23:57:41
10news.nk.ca 10965 185 6598 497 0 34 1%23:59:53
11i2pn.org 8352 117 6903 77 0 65 1%23:59:53
12news.weretis.net 7629 108 7115 119 0 2 1%23:58:39
13news.nntp4.net 8091 99 7136 40 0 4 1%23:59:53
14news.tnetconsulting.net 8098 87 7019 232 0 7 1%23:59:53
15nntp.comgw.net 7614 87 6607 95 0 3 1%23:59:14
16news.bbs.nz 1871 77 883 96 0 6306 4%23:59:53
17news.quux.org 7785 71 6778 473 0 10 0%23:59:51
18newsfeed.xs3.de 8100 56 6860 140 0 3 0%23:59:00
19news.samoylyk.net 8357 29 7176 37 0 43 0%23:59:53
20news.chmurka.net 3474 26 3014 0 0 3 0%23:59:53
21news.corradoroberto.it 828 26 737 8 0 0 3%22:44:51
22usenet.blueworldhosting.com 6625 2 6255 0 0 3 0%23:59:53
23feed.opticnetworks.net 0 0 0 0 0 7343 0%23:59:53
TOTAL: 23 156134 6120 124293 3594 0 13864 3%550:32:49
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net9.1 MB0.0 KB9.1 MB0.1 KB/s4.9 KB23:59:32
2news.furie.org.uk3.3 MB125.5 KB3.4 MB0.0 KB/s7.1 KB23:59:53
3photonic.trudheim.com3.1 MB2.5 MB5.6 MB0.1 KB/s4.8 KB23:59:53
4nyheter.lysator.liu.se3.0 MB4.5 MB7.5 MB0.1 KB/s5.0 KB23:57:51
5endofthelinebbs.peers.news.panix.com2.3 MB27.2 KB2.4 MB0.0 KB/s5.9 KB23:59:36
6newsfeed.bofh.team1.4 MB0.0 KB1.4 MB0.0 KB/s7.7 KB23:57:41
7usenet.network848.3 KB117.8 KB966.1 KB0.0 KB/s3.3 KB23:59:28
8news.hispagatos.org811.5 KB1.8 MB2.6 MB0.0 KB/s5.7 KB23:59:23
9usenet.goja.nl.eu.org531.5 KB2.0 MB2.5 MB0.0 KB/s6.0 KB23:59:00
10news.weretis.net500.5 KB1.4 MB1.9 MB0.0 KB/s8.5 KB23:58:39
11news.tnetconsulting.net442.0 KB1.8 MB2.2 MB0.0 KB/s7.0 KB23:59:53
12i2pn.org404.4 KB495.0 KB899.4 KB0.0 KB/s4.6 KB23:59:53
13news.nk.ca400.1 KB3.2 MB3.6 MB0.0 KB/s5.4 KB23:59:53
14news.nntp4.net393.6 KB453.2 KB846.9 KB0.0 KB/s6.1 KB23:59:53
15news.quux.org361.2 KB2.8 MB3.2 MB0.0 KB/s6.0 KB23:59:51
16nntp.comgw.net338.9 KB1.0 MB1.4 MB0.0 KB/s7.7 KB23:59:14
17newsfeed.xs3.de309.9 KB1.2 MB1.5 MB0.0 KB/s7.9 KB23:59:00
18news.bbs.nz211.5 KB561.5 KB773.0 KB0.0 KB/s4.5 KB23:59:53
19news.samoylyk.net134.3 KB206.7 KB341.0 KB0.0 KB/s5.2 KB23:59:53
20news.chmurka.net103.9 KB0.0 KB103.9 KB0.0 KB/s4.0 KB23:59:53
21news.corradoroberto.it77.3 KB20.6 KB98.0 KB0.0 KB/s2.9 KB22:44:51
22usenet.blueworldhosting.com3.6 KB0.0 KB3.6 KB0.0 KB/s1.8 KB23:59:53
23feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
TOTAL: 2328.1 MB24.1 MB52.2 MB0.0 KB/s5.5 KB550:32:49
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
147.186.47.228 1 00.0 KB 1 0 000:00:00
TOTAL: 1 1 00.0 KB 1 0 000:42:53

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.demos.su2756 00.0 KB 0 0 000:30:38
2unresolved 10 00.0 KB 1 0 000:00:41
3*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:02
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
6? 1 00.0 KB 0 0 000:11:27
TOTAL: 62770 00.0 KB 1 0 000:42:53

NNRP auth users [Top 20]:

UserConn
getlist 1
nelgin 1
TOTAL: 2 2

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
ddt.demos.su 9.627 37.190 0.00000:30:38
localhost 181.258 366.715 0.07300:11:27
152.32.197.166 0.009 0.039 0.00000:00:10
205.210.31.135 0.003 0.013 0.00000:00:10
205.210.31.84 0.005 0.011 0.00000:00:10
87.251.75.136 0.006 0.010 0.00000:00:10
server-0-2.survey.inspici.com 0.003 0.014 0.00000:00:03
cool.monitoring.internet-measurement.com 0.006 0.012 0.00000:00:02
45.135.232.19 0.003 0.013 0.00000:00:00
198.235.24.220 0.004 0.012 0.00000:00:00
91.238.181.35 0.007 0.011 0.00000:00:00
azpdwgb35.stretchoid.com 0.008 0.008 0.00000:00:00
TOTAL: 12 190.939 404.048 0.07300:42:53

Curious NNRP server explorers [Top 20]:

SystemConn
ddt.demos.su 2756
152.32.197.166 3
198.235.24.220 1
205.210.31.135 1
205.210.31.84 1
45.135.232.19 1
87.251.75.136 1
91.238.181.35 1
azpdwgb35.stretchoid.com 1
cool.monitoring.internet-measurement.com 1
localhost 1
server-0-2.survey.inspici.com 1
TOTAL: 12 2769

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

SystemConn
152.32.197.166 3
45.135.232.19 1
91.238.181.35 1
azpdwgb35.stretchoid.com 1
TOTAL: 4 6

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

CommandCount
#003 2
#026#003#001#001#027#001 1
MGLNDD_144.172.126.95_119 1
¢s#002kë|²#016` #020¼·r#025ídBÌAKk„ï 1
À#024 1
TOTAL: 5 6

NNRP client timeouts [Top 20]:

SystemConnPeer
45.135.232.19 1 1
91.238.181.35 1 1
TOTAL: 2 2 3

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1news 1100.0%
TOTAL: 1 1100.0%

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

NewsgroupCount
1news.software.nntp 1
TOTAL: 1 1