Daily Usenet Report

Sep 20 00:01:01 -- Sep 21 00:01:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Sep 20 08:12:13 newsfeed innd: message repeated 2 times: [ ctlinnd command s]
Sep 21 00:00:01 newsfeed nnrpd[3018056]: localhost auth: program exited with status 8

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 8442 29.1%880.6 KB 13.9%
inn 7967 27.5%3.3 MB 53.9%
innd 7954 27.5%1.1 MB 18.4%
innfeed 4120 14.2%798.4 KB 12.6%
cnfsstat 432 1.5%62.2 KB 1.0%
nocem 47 0.2%6.9 KB 0.1%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 7 28963 100.0%6.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 117695 60.2%
Negative hits 69754 35.7%
Do not exist 7922 4.1%
Cache misses 47 0.0%
TOTAL: 4 195418 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.094 0.0%26 0.000 3.615 8.500
article cleanup00:00:00.124 0.0%7884 0.000 0.016 0.462
article logging00:00:00.684 0.0%7942 0.000 0.086 6.481
article parse00:00:00.189 0.0%12257 0.000 0.015 0.105
article write00:00:02.088 0.0%6882 0.000 0.303 3.321
artlog/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.434 0.0%196929 0.000 0.002 0.070
hisgrep/artcncl00:00:00.080 0.0%26 0.000 3.077 7.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:34.268 0.2%195988 0.093 0.787 6.086
history sync00:00:00.079 0.0%406 0.000 0.195 1.000
history write00:01:56.258 0.1%7884 3.034 14.746 126.727
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:34:44.416 98.9%195886 71.494 433.336 2024.824
nntp read00:00:04.243 0.0%197550 0.003 0.021 0.396
overview write00:10:10.905 0.7%6882 0.558 88.769 3008.291
perl filter00:00:30.416 0.0%7884 1.483 3.858 26.885
python filter00:00:02.991 0.0%7884 0.000 0.379 10.984
site send00:00:01.224 0.0%13806 0.000 0.089 0.333
TOTAL: 23:51:05.74623:50:08.493 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.015 0.0%10164 0.000 0.001 0.050
article prepare00:00:00.007 0.0%43432 0.000 0.000 0.009
article read00:00:00.959 0.0%3558 0.000 0.270 4.738
backlog stats00:00:00.336 0.0%242325 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.246 0.0%169073 0.003 0.013 0.049
data write00:00:02.953 0.0%165730 0.008 0.018 0.038
idle23:58:16.986100.0%242325 151.429 356.121 1708.102
status file00:00:00.326 0.0%268 0.750 1.216 20.000
TOTAL: 23:58:36.68923:58:23.828100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:21:55.132 54.2%8285 0.750 158.737 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.983 0.2%95373 0.000 0.052 0.333
TOTAL: 00:40:24.58300:22:00.115 54.4%----

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 13354 1789 11304 261 13%49:51:03
2outgoing.news.lysator.liu.se 1 5732 1505 4182 45 26%23:59:57
3usenet.blueworldhosting.com 720 7631 781 6531 319 10%23:52:42
4nntp.comgw.net 2 7367 564 6690 113 7%23:59:57
5news.corradoroberto.it 11 1457 484 973 0 33%23:23:51
6news.hispagatos.org 6 7187 392 6779 16 5%24:26:11
7usenet.goja.nl.eu.org 10 7219 296 6873 50 4%23:51:48
8i2pn.org 2 7011 291 6682 38 4%23:59:17
9endoftheline-out.news.chmurka.net 1 3613 221 3391 1 6%23:59:55
10usenet.network 1 5649 185 5463 1 3%23:59:57
11newsfeed.bofh.team 1 7691 113 7572 6 1%23:59:56
12endofthelinebbs.peers.news.panix.com 25 7345 112 7222 11 1%23:56:37
13news.nntp4.net 2 6210 40 6169 1 0%23:59:42
14news.netfront.net 1 5136 35 5029 72 0%22:58:35
15news.samoylyk.net 1 6436 34 6402 0 0%23:59:50
16news.bbs.nz 2 6225 21 6203 1 0%23:59:03
17news.furie.org.uk 2 7270 11 7258 1 0%47:59:49
18newsfeed.xs3.de 1 5972 8 5963 1 0%23:59:55
19glockenspiel.complete.org 2 5523 3 5519 1 0%24:01:33
20photonic.trudheim.com 2 1277 1 1276 0 0%17:31:39
21eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:12
22localhost 28 0 0 0 0 0%00:00:01
23news.nk.ca 2 0 0 0 0 0%00:20:03
TOTAL: 23 827 125305 6886 117481 938 5%522:21:33
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net5.2 MB0.0 KB419.7 KB5.6 MB 92%2.8 KB
2outgoing.news.lysator.liu.se4.4 MB0.0 KB44.5 KB4.5 MB 99%3.0 KB
3news.corradoroberto.it3.0 MB0.0 KB0.0 KB3.0 MB100%6.3 KB
4nntp.comgw.net2.2 MB0.0 KB1019.7 KB3.2 MB 69%4.9 KB
5usenet.network2.2 MB0.0 KB0.9 KB2.2 MB 99%12.2 KB
6usenet.blueworldhosting.com1.9 MB0.0 KB618.4 KB2.5 MB 76%2.4 KB
7news.hispagatos.org1.2 MB0.0 KB33.0 KB1.3 MB 97%3.2 KB
8usenet.goja.nl.eu.org1.1 MB0.0 KB63.0 KB1.1 MB 94%3.3 KB
9i2pn.org999.4 KB0.0 KB54.1 KB1.0 MB 94%3.2 KB
10endoftheline-out.news.chmurka.net733.8 KB0.0 KB0.9 KB734.8 KB 99%3.3 KB
11newsfeed.bofh.team260.7 KB0.0 KB32.6 KB293.3 KB 88%2.5 KB
12endofthelinebbs.peers.news.panix.com257.6 KB0.0 KB20.6 KB278.2 KB 92%2.3 KB
13news.netfront.net212.4 KB0.0 KB455.7 KB668.0 KB 31%6.2 KB
14news.samoylyk.net117.3 KB0.0 KB0.0 KB117.3 KB100%3.5 KB
15news.nntp4.net93.4 KB0.0 KB0.8 KB94.2 KB 99%2.3 KB
16news.furie.org.uk69.3 KB0.0 KB0.7 KB69.9 KB 99%5.8 KB
17news.bbs.nz44.8 KB0.0 KB1.2 KB46.0 KB 97%2.1 KB
18newsfeed.xs3.de24.6 KB0.0 KB1.1 KB25.7 KB 95%2.9 KB
19glockenspiel.complete.org7.2 KB0.0 KB0.8 KB8.0 KB 89%2.0 KB
20photonic.trudheim.com5.1 KB0.0 KB0.0 KB5.1 KB100%5.1 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: 2324.0 MB0.0 KB2.7 MB26.7 MB 89%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 20 00:01:01 - 00:59:59 150 2.2% 0.04514.7 KB 2.1% 0.15
Sep 20 01:00:00 - 01:59:59 249 3.6% 0.071.2 MB 4.8% 0.33
Sep 20 02:00:00 - 02:59:59 332 4.8% 0.091.0 MB 4.2% 0.29
Sep 20 03:00:00 - 03:59:59 376 5.4% 0.101.2 MB 5.1% 0.35
Sep 20 04:00:00 - 04:59:59 348 5.0% 0.10945.2 KB 3.8% 0.26
Sep 20 05:00:00 - 05:59:59 280 4.1% 0.08747.1 KB 3.0% 0.21
Sep 20 06:00:00 - 06:59:59 399 5.8% 0.111.5 MB 6.3% 0.44
Sep 20 07:00:00 - 07:59:59 314 4.6% 0.09988.1 KB 4.0% 0.27
Sep 20 08:00:00 - 08:59:59 340 4.9% 0.091.3 MB 5.4% 0.37
Sep 20 09:00:00 - 09:59:59 402 5.8% 0.111.1 MB 4.6% 0.31
Sep 20 10:00:00 - 10:59:59 416 6.0% 0.121.7 MB 7.1% 0.49
Sep 20 11:00:00 - 11:59:59 376 5.4% 0.101.6 MB 6.7% 0.46
Sep 20 12:00:00 - 12:59:59 367 5.3% 0.101.3 MB 5.3% 0.36
Sep 20 13:00:00 - 13:59:59 410 5.9% 0.111.2 MB 5.0% 0.34
Sep 20 14:00:00 - 14:59:59 382 5.5% 0.111.1 MB 4.4% 0.30
Sep 20 15:00:00 - 15:59:59 294 4.3% 0.081.1 MB 4.4% 0.30
Sep 20 16:00:00 - 16:59:59 307 4.4% 0.091.0 MB 4.2% 0.29
Sep 20 17:00:00 - 17:59:59 388 5.6% 0.111.5 MB 6.1% 0.42
Sep 20 18:00:00 - 18:59:59 185 2.7% 0.05606.1 KB 2.4% 0.17
Sep 20 19:00:00 - 19:59:59 118 1.7% 0.03386.6 KB 1.6% 0.11
Sep 20 20:00:00 - 20:59:59 99 1.4% 0.03515.4 KB 2.1% 0.14
Sep 20 21:00:00 - 21:59:59 165 2.4% 0.051.1 MB 4.3% 0.30
Sep 20 22:00:00 - 22:59:59 93 1.3% 0.03331.1 KB 1.3% 0.09
Sep 20 23:00:00 - 23:59:59 108 1.6% 0.03439.9 KB 1.8% 0.12
Sep 21 00:00:00 - 00:01:01 2 0.0% 0.0315.3 KB 0.1% 0.25
TOTAL: 24:00:00 6900 100.0% 0.0824.2 MB 100.0% 0.29
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.7 GB 6.4% 0 0.4541334.54
CYCTXT1TEXT5.0 GB3.9 GB 77.3% 0 0.03 2411.47
TOTAL: 3-3077.0 GB101.6 GB 3.3% 1 0.33-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 333 2 0 0 0 0 0 0 331
2endofthelinebbs-out.news.weretis.net 286 0 0 0 0 0 0 0 286
3news.netfront.net 142 0 0 0 0 0 0 0 142
4nntp.comgw.net 116 0 0 0 0 0 0 0 116
5usenet.goja.nl.eu.org 58 0 0 0 0 0 0 0 58
6outgoing.news.lysator.liu.se 45 0 0 0 0 0 0 0 45
7i2pn.org 38 0 0 0 0 0 0 0 38
8news.hispagatos.org 16 9 0 0 0 0 0 0 7
9endofthelinebbs.peers.news.panix.com 14 1 0 0 0 0 0 0 13
10newsfeed.bofh.team 7 1 0 0 0 0 0 0 6
11news.bbs.nz 2 0 0 0 0 0 0 0 2
12endoftheline-out.news.chmurka.net 1 0 0 0 0 0 0 0 1
13news.corradoroberto.it 1 0 0 0 0 0 0 0 1
14news.furie.org.uk 1 0 0 0 0 0 0 0 1
15news.nntp4.net 1 0 0 0 0 0 0 0 1
16newsfeed.xs3.de 1 0 0 0 0 0 0 0 1
17usenet.network 1 0 0 0 0 0 0 0 1
TOTAL: 17 1063 13 0 0 0 0 0 0 1050

Unwanted newsgroups [Top 20]:

NewsgroupCount
hispagatos.hacking.news 7
alt.alt.anonymous 1
alt.magazines 1
hispagatos.hacking.ctf 1
hispagatos.hacking.exploits 1
soc.culture.africa 1
soc.culture.russia 1
TOTAL: 7 13

INND Perl filter [Top 20]:

ReasonCount
EMP (phr path) 324
EMP (phn path) 303
Too many newsgroups 184
EMP (md5) 86
User-issued cancel 68
Binary: misplaced binary 12
Too many newsgroups (meow) 10
HTML Multipart 5
TOTAL: 8 992

NoCeM on Spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
i2pn2-nocem@i2pn2.org (spam)30404
i2pn2-nocem@i2pn2.org (multipost)27009797
i2pn2-nocem@i2pn2.org (rmp)8003737
robot@pasdenom.info (spam2)30033
robot@pasdenom.info (spam3)20022
TOTAL: 54304139143

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 30
usenet.blueworldhosting.com 14
endofthelinebbs.peers.news.panix.com 4
nntp.comgw.net 4
usenet.goja.nl.eu.org 2
news.bbs.nz 1
news.hispagatos.org 1
newsfeed.bofh.team 1
news.corradoroberto.it 1
TOTAL: 9 58
TOTAL: 1 58

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 10846 2166 4682 0 0 28 19%23:59:50
2nyheter.lysator.liu.se 5608 1505 3693 194 0 7 26%23:59:47
3news.furie.org.uk 3745 671 2652 14 0 0 17%23:59:17
4news.hispagatos.org 7479 406 5997 97 0 0 5%23:59:50
5photonic.trudheim.com 7293 403 5403 1091 0 0 5%23:59:49
6usenet.network 7454 371 5954 33 0 1 4%23:58:27
7usenet.goja.nl.eu.org 7648 323 6169 96 0 1 4%23:59:47
8endofthelinebbs.peers.news.panix.com 7173 323 6571 1 0 59 4%23:59:50
9news.bbs.nz 12649 237 6302 339 0 100 1%23:59:50
10newsfeed.bofh.team 7787 204 6522 0 0 1 2%23:59:50
11news.tnetconsulting.net 7724 160 6570 164 0 22 2%23:59:22
12news.nntp4.net 7869 145 6697 10 0 8 1%23:59:41
13nntp.comgw.net 7331 140 6141 53 0 0 1%23:59:50
14i2pn.org 7482 118 6405 18 0 77 1%23:59:50
15news.weretis.net 7153 112 6713 74 0 19 1%23:59:50
16news.quux.org 7310 111 6429 351 0 6 1%23:59:50
17news.corradoroberto.it 1100 102 782 0 0 0 9%22:28:41
18news.nk.ca 8364 73 6542 303 0 2816 0%23:59:50
19newsfeed.xs3.de 8122 73 6640 148 0 0 0%23:59:38
20news.chmurka.net 3577 38 3064 0 0 0 1%23:59:50
21news.samoylyk.net 8675 32 6655 165 0 60 0%23:59:50
22usenet.blueworldhosting.com 6132 6 5879 0 0 0 0%23:58:52
23feed.opticnetworks.net 0 0 0 0 0 6900 0%23:59:50
TOTAL: 23 158521 7719 122462 3151 0 10105 4%550:21:11
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net9.4 MB0.0 KB9.4 MB0.1 KB/s4.4 KB23:59:50
2news.furie.org.uk5.0 MB170.2 KB5.1 MB0.1 KB/s7.7 KB23:59:17
3nyheter.lysator.liu.se4.8 MB2.0 MB6.8 MB0.1 KB/s4.1 KB23:59:47
4photonic.trudheim.com1.9 MB3.5 MB5.4 MB0.1 KB/s3.7 KB23:59:49
5endofthelinebbs.peers.news.panix.com1.8 MB1.3 KB1.8 MB0.0 KB/s5.6 KB23:59:50
6newsfeed.bofh.team1.4 MB0.0 KB1.4 MB0.0 KB/s6.9 KB23:59:50
7news.hispagatos.org1.4 MB1.0 MB2.4 MB0.0 KB/s4.9 KB23:59:50
8usenet.network1.2 MB67.8 KB1.3 MB0.0 KB/s3.2 KB23:58:27
9news.quux.org954.7 KB1.9 MB2.8 MB0.0 KB/s6.2 KB23:59:50
10news.nntp4.net894.1 KB217.0 KB1.1 MB0.0 KB/s7.2 KB23:59:41
11usenet.goja.nl.eu.org845.9 KB950.3 KB1.8 MB0.0 KB/s4.3 KB23:59:47
12news.tnetconsulting.net831.8 KB1013.7 KB1.8 MB0.0 KB/s5.7 KB23:59:22
13news.bbs.nz815.7 KB2.1 MB2.9 MB0.0 KB/s5.1 KB23:59:50
14news.weretis.net565.6 KB1.4 MB1.9 MB0.0 KB/s10.7 KB23:59:50
15nntp.comgw.net491.6 KB1.2 MB1.7 MB0.0 KB/s9.0 KB23:59:50
16news.samoylyk.net470.6 KB1.1 MB1.6 MB0.0 KB/s8.3 KB23:59:50
17i2pn.org431.4 KB100.4 KB531.8 KB0.0 KB/s3.9 KB23:59:50
18newsfeed.xs3.de429.5 KB1.4 MB1.8 MB0.0 KB/s8.5 KB23:59:38
19news.corradoroberto.it321.5 KB0.0 KB321.5 KB0.0 KB/s3.2 KB22:28:41
20news.nk.ca189.2 KB2.1 MB2.3 MB0.0 KB/s6.3 KB23:59:50
21news.chmurka.net174.9 KB0.0 KB174.9 KB0.0 KB/s4.6 KB23:59:50
22usenet.blueworldhosting.com21.8 KB0.0 KB21.8 KB0.0 KB/s3.6 KB23:58:52
23feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:50
TOTAL: 2334.0 MB20.2 MB54.3 MB0.0 KB/s5.1 KB550:21:11
Outgoing feeds (innfeed) by Volume

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.demos.su2760 00.0 KB 0 0 000:28:43
2unresolved 7 00.0 KB 2 0 000:00:24
3*.stretchoid.com 1 00.0 KB 0 0 000:00:00
4*.survey.inspici.com 1 00.0 KB 0 0 000:00:03
5? 1 00.0 KB 0 0 000:11:11
TOTAL: 52770 00.0 KB 2 0 000:40: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.474 37.222 0.00000:28:43
localhost 180.858 369.322 0.07700:11:11
198.235.24.123 0.008 0.008 0.00000:00:10
198.235.24.185 0.004 0.012 0.00000:00:10
167.94.145.108 0.024 0.041 0.00000:00:04
server-0-3.survey.inspici.com 0.000 0.016 0.00000:00:03
91.238.181.71 0.000 0.016 0.00000:00:00
205.210.31.39 0.004 0.012 0.00000:00:00
azpdwgc44.stretchoid.com 0.005 0.015 0.00000:00:00
TOTAL: 9 190.377 406.664 0.07700:40:23

Curious NNRP server explorers [Top 20]:

SystemConn
ddt.demos.su 2760
167.94.145.108 3
198.235.24.123 1
198.235.24.185 1
205.210.31.39 1
91.238.181.71 1
azpdwgc44.stretchoid.com 1
localhost 1
server-0-3.survey.inspici.com 1
TOTAL: 9 2770

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

SystemConn
167.94.145.108 1
91.238.181.71 1
azpdwgc44.stretchoid.com 1
TOTAL: 3 3

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

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

NNRP client timeouts [Top 20]:

SystemConnPeer
167.94.145.108 1 2
91.238.181.71 1 1
TOTAL: 2 2 4

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1comp 2 66.7%
2news 1 33.3%
TOTAL: 2 3100.0%

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

NewsgroupCount
1comp.sys.acorn.misc 2
2news.software.nntp 1
TOTAL: 2 3