Daily Usenet Report

Mar 13 00:01:02 -- Mar 14 00:01:02

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Mar 13 08:18:20 newsfeed innd: message repeated 2 times: [ ctlinnd command s]
Mar 14 00:00:01 newsfeed nnrpd[661011]: localhost auth: program exited with status 8

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 14192 36.6%1.7 MB 21.6%
inn 10012 25.8%4.0 MB 50.3%
innd 9393 24.2%1.3 MB 16.5%
innfeed 4547 11.7%857.5 KB 10.4%
cnfsstat 576 1.5%85.9 KB 1.0%
nocem 77 0.2%8.9 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 38798 100.0%8.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 145451 63.7%
Negative hits 72675 31.8%
Do not exist 9882 4.3%
Cache misses 198 0.1%
TOTAL: 4 228206 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.231 0.0%23 0.000 10.043 43.000
article cleanup00:00:00.133 0.0%9941 0.000 0.013 0.113
article logging00:00:00.496 0.0%10004 0.000 0.050 0.337
article parse00:00:00.283 0.0%17839 0.000 0.016 0.129
article write00:00:02.493 0.0%7815 0.036 0.319 2.692
artlog/artcncl00:00:00.000 0.0%8 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:01.363 0.0%224215 0.000 0.006 0.286
hisgrep/artcncl00:00:00.172 0.0%30 0.000 5.733 11.000
hishave/artcncl00:00:00.000 0.0%8 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:03:04.039 0.2%229789 0.093 0.801 8.908
history sync00:00:00.090 0.0%391 0.000 0.230 1.000
history write00:02:23.052 0.2%9936 3.494 14.397 98.071
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:52:06.424 99.4%220342 78.521 389.968 1538.344
nntp read00:00:02.824 0.0%225118 0.000 0.013 0.052
overview write00:01:49.962 0.1%7815 0.818 14.071 1640.413
perl filter00:00:38.191 0.0%9936 1.701 3.844 23.645
python filter00:00:01.030 0.0%9936 0.000 0.104 0.922
site send00:00:01.306 0.0%15700 0.000 0.083 0.300
TOTAL: 2324:00:12.089 99.9%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.025 0.0%10395 0.000 0.002 0.050
article prepare00:00:00.009 0.0%57338 0.000 0.000 0.005
article read00:00:00.782 0.0%5202 0.000 0.150 1.040
backlog stats00:00:00.463 0.0%311293 0.000 0.001 0.009
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.688 0.0%211341 0.005 0.013 0.051
data write00:00:04.007 0.0%206527 0.007 0.019 0.033
idle23:56:01.053100.0%311293 138.170 276.784 1137.996
status file00:00:00.499 0.0%396 1.000 1.260 5.000
TOTAL: 923:56:09.526100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:29:24.810 99.8%8418 32.500 209.647179502.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:03.888 0.2%95745 0.000 0.041 1.000
TOTAL: 300:29:28.698100.0%----

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 (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 2 15735 3207 11996 532 20%49:18:47
2usenet.blueworldhosting.com 718 9745 762 8326 657 7%23:56:06
3glockenspiel.complete.org 2 6491 572 5882 37 8%24:36:52
4usenet.network 1 6728 510 6190 28 7%23:59:57
5news.corradoroberto.it 4 1685 420 1264 1 24%23:37:44
6i2pn.org 2 8893 314 8471 108 3%23:59:26
7nntp.comgw.net 1 9002 310 8512 180 3%23:59:57
8news.nntp4.net 2 8167 262 7833 72 3%23:59:29
9endoftheline-out.news.chmurka.net 2 3677 260 3417 0 7%23:59:31
10newsfeed.bofh.team 2 9723 232 9396 95 2%23:59:39
11194.87.241.33 39 710 203 355 152 28%16:17:04
12usenet.goja.nl.eu.org 10 8905 198 8632 75 2%24:18:31
13endofthelinebbs.peers.news.panix.com 24 8231 133 8088 10 1%23:56:11
14newsfeed.xs3.de 1 6774 116 6631 27 1%23:59:56
15news.samoylyk.net 3 7571 90 7478 3 1%20:35:29
16news.hispagatos.org 5 9150 88 8966 96 0%24:26:21
17peering.usenet.ovh 1 8906 80 8821 5 0%23:59:57
18news.furie.org.uk 1 4087 34 4052 1 0%23:59:56
19news.bbs.nz 2 7235 13 7222 0 0%23:59:31
20news.netfront.net 1 6451 12 6391 48 0%22:17:53
21photonic.trudheim.com 4 1770 4 1766 0 0%23:44:09
22outgoing.news.lysator.liu.se 2 4980 2 4977 1 0%23:59:28
23localhost 27 0 0 0 0 0%00:00:00
24news.nk.ca 2 0 0 0 0 0%00:20:12
TOTAL: 24 858 154616 7822 144666 2128 5%541:22:06
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net13.7 MB0.0 KB803.3 KB14.5 MB 94%4.0 KB
2glockenspiel.complete.org5.9 MB0.0 KB92.0 KB6.0 MB 98%10.1 KB
3usenet.network5.7 MB17.9 KB47.7 KB5.7 MB 98%10.9 KB
4news.corradoroberto.it2.5 MB0.0 KB1.1 KB2.5 MB 99%6.1 KB
5usenet.blueworldhosting.com2.0 MB0.0 KB1.4 MB3.4 MB 58%2.5 KB
6nntp.comgw.net950.7 KB0.0 KB590.6 KB1.5 MB 61%3.1 KB
7endoftheline-out.news.chmurka.net935.2 KB0.0 KB0.0 KB935.2 KB100%3.6 KB
8endofthelinebbs.peers.news.panix.com931.1 KB18.0 KB12.0 KB961.1 KB 96%6.7 KB
9newsfeed.xs3.de900.1 KB0.0 KB72.9 KB973.1 KB 92%6.8 KB
10newsfeed.bofh.team855.4 KB18.0 KB144.2 KB1017.7 KB 84%3.1 KB
11i2pn.org840.4 KB0.0 KB162.2 KB1002.6 KB 83%2.4 KB
12news.nntp4.net690.9 KB0.0 KB133.9 KB824.7 KB 83%2.5 KB
13194.87.241.33521.7 KB0.0 KB394.7 KB916.3 KB 56%2.6 KB
14usenet.goja.nl.eu.org518.3 KB0.0 KB139.1 KB657.5 KB 78%2.4 KB
15news.hispagatos.org354.5 KB0.0 KB220.3 KB574.7 KB 61%3.1 KB
16news.samoylyk.net347.6 KB0.0 KB4.8 KB352.4 KB 98%3.8 KB
17peering.usenet.ovh314.4 KB18.0 KB6.4 KB338.7 KB 92%4.0 KB
18news.furie.org.uk145.6 KB18.0 KB0.0 KB163.6 KB 88%4.7 KB
19news.netfront.net61.3 KB0.0 KB1.4 MB1.4 MB 4%24.7 KB
20news.bbs.nz54.9 KB0.0 KB0.0 KB54.9 KB100%4.2 KB
21photonic.trudheim.com11.4 KB0.0 KB0.0 KB11.4 KB100%2.8 KB
22outgoing.news.lysator.liu.se4.6 KB0.0 KB2.7 KB7.3 KB 62%2.4 KB
23localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
24news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2438.1 MB89.9 KB5.6 MB43.8 MB 87%4.5 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 13 00:01:02 - 00:59:59 123 1.6% 0.03453.7 KB 1.2% 0.13
Mar 13 01:00:00 - 01:59:59 156 2.0% 0.04436.6 KB 1.1% 0.12
Mar 13 02:00:00 - 02:59:59 232 3.0% 0.06771.9 KB 2.0% 0.21
Mar 13 03:00:00 - 03:59:59 340 4.4% 0.091.0 MB 2.7% 0.30
Mar 13 04:00:00 - 04:59:59 384 4.9% 0.111.2 MB 3.2% 0.34
Mar 13 05:00:00 - 05:59:59 386 4.9% 0.111.3 MB 3.5% 0.38
Mar 13 06:00:00 - 06:59:59 380 4.9% 0.111.4 MB 3.7% 0.40
Mar 13 07:00:00 - 07:59:59 467 6.0% 0.131.6 MB 4.2% 0.46
Mar 13 08:00:00 - 08:59:59 474 6.1% 0.131.6 MB 4.2% 0.46
Mar 13 09:00:00 - 09:59:59 520 6.7% 0.1410.9 MB 28.5% 3.09
Mar 13 10:00:00 - 10:59:59 472 6.0% 0.131.9 MB 4.9% 0.53
Mar 13 11:00:00 - 11:59:59 476 6.1% 0.132.4 MB 6.4% 0.70
Mar 13 12:00:00 - 12:59:59 453 5.8% 0.131.6 MB 4.1% 0.45
Mar 13 13:00:00 - 13:59:59 417 5.3% 0.121.6 MB 4.2% 0.46
Mar 13 14:00:00 - 14:59:59 416 5.3% 0.121.5 MB 4.0% 0.44
Mar 13 15:00:00 - 15:59:59 351 4.5% 0.101.1 MB 2.9% 0.32
Mar 13 16:00:00 - 16:59:59 375 4.8% 0.101.7 MB 4.4% 0.48
Mar 13 17:00:00 - 17:59:59 333 4.3% 0.091.2 MB 3.2% 0.35
Mar 13 18:00:00 - 18:59:59 314 4.0% 0.091.4 MB 3.6% 0.39
Mar 13 19:00:00 - 19:59:59 179 2.3% 0.05716.6 KB 1.8% 0.20
Mar 13 20:00:00 - 20:59:59 160 2.0% 0.04675.1 KB 1.7% 0.19
Mar 13 21:00:00 - 21:59:59 147 1.9% 0.04638.3 KB 1.6% 0.18
Mar 13 22:00:00 - 22:59:59 122 1.6% 0.03530.6 KB 1.4% 0.15
Mar 13 23:00:00 - 23:59:59 132 1.7% 0.04473.4 KB 1.2% 0.13
Mar 14 00:00:00 - 00:01:02 5 0.1% 0.0822.5 KB 0.1% 0.36
TOTAL: 24:00:00 7814 100.0% 0.0938.2 MB 100.0% 0.45
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 GB105.0 GB 6.8% 0 0.5235739.96
CYCNGS3NGS1536.0 GB48.0 MB 0.0% 0 0.00 0.00
CYCTXT1TEXT5.0 GB4.2 GB 83.2% 0 0.27 223.80
TOTAL: 4-4613.0 GB109.3 GB 2.4% 1 0.44-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 681 0 0 0 0 0 0 0 681
2endofthelinebbs-out.news.weretis.net 530 0 0 0 0 0 0 0 530
3nntp.comgw.net 193 0 0 0 0 0 0 0 193
4194.87.241.33 152 0 0 0 0 0 0 0 152
5i2pn.org 109 0 0 0 0 0 0 0 109
6news.hispagatos.org 106 19 0 0 0 0 0 0 87
7newsfeed.bofh.team 97 0 0 1 0 0 0 0 96
8usenet.goja.nl.eu.org 89 0 0 0 0 0 0 0 89
9news.nntp4.net 68 1 0 0 0 0 0 0 67
10news.netfront.net 44 0 0 0 0 0 0 0 44
11glockenspiel.complete.org 37 0 0 0 0 0 0 0 37
12usenet.network 29 0 0 1 0 0 0 0 28
13newsfeed.xs3.de 27 0 0 0 0 0 0 0 27
14endofthelinebbs.peers.news.panix.com 14 0 0 1 0 0 0 0 13
15peering.usenet.ovh 6 0 0 1 0 0 0 0 5
16news.samoylyk.net 4 0 0 0 0 0 0 0 4
17news.bbs.nz 1 0 0 0 0 0 0 0 1
18news.corradoroberto.it 1 0 0 0 0 0 0 0 1
19news.furie.org.uk 1 0 0 1 0 0 0 0 0
20outgoing.news.lysator.liu.se 1 0 0 0 0 0 0 0 1
TOTAL: 20 2190 20 0 5 0 0 0 0 2165

Unwanted newsgroups [Top 20]:

NewsgroupCount
hispagatos.mastodon.tag.hacking 18
hispagatos.mastodon.tag.hackers 1
z-netz.alt.sex 1
TOTAL: 3 20

Perl filter (innd) [Top 20]:

ReasonCount
EMP (phn path) 1286
EMP (phr path) 364
EMP (md5) 178
Too many newsgroups 169
EMP (phl) 45
Angle-bracket bot 35
User-issued cancel 19
Binary: misplaced binary 4
HTML Multipart 2
TOTAL: 9 2102

NoCeM on spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
robot@pasdenom.info (spam)10101
robot@pasdenom.info (spam3)8005252
i2pn2-nocem@i2pn2.org (multipost)27003737
robot@pasdenom.info (spam2)26003131
robot@pasdenom.info (spam4)8002222
i2pn2-nocem@i2pn2.org (rmp)50099
TOTAL: 67501151152

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
usenet.blueworldhosting.com 24
nntp.comgw.net 14
endofthelinebbs-out.news.weretis.net 12
endofthelinebbs.peers.news.panix.com 4
usenet.network 2
usenet.goja.nl.eu.org 2
news.nntp4.net 1
i2pn.org 1
newsfeed.bofh.team 1
peering.usenet.ovh 1
TOTAL: 11 63
TOTAL: 1 63

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nyheter.lysator.liu.se 8259 3462 3856 489 0 18 41%23:59:54
2news.netfront.net 12734 2250 5544 1 0 50 17%23:59:39
3news.furie.org.uk 4842 1089 2674 22 0 18 22%23:59:29
4photonic.trudheim.com 9036 615 5691 1500 0 7 6%23:59:47
5peering.usenet.ovh 8510 531 7161 47 0 0 6%23:59:53
6endofthelinebbs.peers.news.panix.com 8215 514 7240 4 0 0 6%23:59:54
7news.nntp4.net 8509 281 7180 1 0 49 3%23:59:54
8usenet.goja.nl.eu.org 8582 258 6982 72 0 0 3%23:59:54
9news.corradoroberto.it 1344 120 769 0 0 1 8%22:38:42
10newsfeed.bofh.team 8616 117 7444 1 0 24 1%23:59:34
11news.nk.ca 11137 95 7073 542 0 93 0%23:59:54
12news.hispagatos.org 9273 84 7523 110 0 17 0%23:59:54
13news.bbs.nz 14523 80 7126 600 0 133 0%23:59:08
14nntp.comgw.net 8075 60 7369 66 0 28 0%23:59:54
15i2pn.org 8628 56 7335 29 0 57 0%23:59:54
16news.samoylyk.net 9412 52 7554 51 0 1962 0%23:59:54
17usenet.network 9189 42 6854 28 0 0 0%23:59:33
18news.weretis.net 8278 18 7518 272 0 2 0%23:58:03
19news.quux.org 6328 18 5469 384 0 0 0%23:59:54
20news.tnetconsulting.net 10262 16 7419 322 0 39 0%23:59:53
21newsfeed.xs3.de 9528 13 7445 221 0 44 0%23:59:38
22news.chmurka.net 4544 8 3288 11 0 36 0%23:59:52
23ddt.demos.su 63 3 59 0 0 0 4%06:45:09
24usenet.blueworldhosting.com 7569 1 6796 0 0 16 0%23:59:54
25feed.opticnetworks.net 0 0 0 0 0 7809 0%23:59:54
TOTAL: 25 195456 9783 143369 4773 0 10403 5%581:17:08
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nyheter.lysator.liu.se20.0 MB5.6 MB25.7 MB0.3 KB/s6.7 KB23:59:54
2news.netfront.net20.0 MB2.1 KB20.0 MB0.2 KB/s9.1 KB23:59:39
3news.furie.org.uk16.5 MB122.3 KB16.6 MB0.2 KB/s15.3 KB23:59:29
4peering.usenet.ovh4.5 MB159.5 KB4.6 MB0.1 KB/s8.2 KB23:59:53
5endofthelinebbs.peers.news.panix.com3.9 MB7.8 KB3.9 MB0.0 KB/s7.8 KB23:59:54
6photonic.trudheim.com3.2 MB7.3 MB10.5 MB0.1 KB/s5.1 KB23:59:47
7news.hispagatos.org3.1 MB1.9 MB5.1 MB0.1 KB/s26.8 KB23:59:54
8newsfeed.bofh.team2.1 MB1.4 KB2.1 MB0.0 KB/s17.8 KB23:59:34
9news.nntp4.net1.9 MB1.4 KB1.9 MB0.0 KB/s7.1 KB23:59:54
10nntp.comgw.net1.9 MB1.5 MB3.4 MB0.0 KB/s27.5 KB23:59:54
11news.bbs.nz1.7 MB5.7 MB7.4 MB0.1 KB/s11.1 KB23:59:08
12news.nk.ca1014.5 KB4.0 MB5.0 MB0.1 KB/s8.1 KB23:59:54
13usenet.goja.nl.eu.org1012.6 KB1003.2 KB2.0 MB0.0 KB/s6.1 KB23:59:54
14newsfeed.xs3.de477.0 KB2.1 MB2.5 MB0.0 KB/s11.1 KB23:59:38
15news.samoylyk.net431.3 KB576.4 KB1007.6 KB0.0 KB/s9.8 KB23:59:54
16news.quux.org345.3 KB3.6 MB3.9 MB0.0 KB/s9.9 KB23:59:54
17news.corradoroberto.it337.0 KB0.0 KB337.0 KB0.0 KB/s2.8 KB22:38:42
18i2pn.org217.5 KB210.9 KB428.5 KB0.0 KB/s5.0 KB23:59:54
19usenet.network167.6 KB69.0 KB236.6 KB0.0 KB/s3.4 KB23:59:33
20news.tnetconsulting.net141.0 KB3.2 MB3.4 MB0.0 KB/s10.2 KB23:59:53
21ddt.demos.su83.6 KB0.0 KB83.6 KB0.0 KB/s27.9 KB06:45:09
22news.weretis.net69.5 KB3.8 MB3.9 MB0.0 KB/s13.8 KB23:58:03
23news.chmurka.net40.9 KB1.9 MB1.9 MB0.0 KB/s103.0 KB23:59:52
24usenet.blueworldhosting.com1.4 KB0.0 KB1.4 KB0.0 KB/s1.4 KB23:59:54
25feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
TOTAL: 2583.0 MB42.7 MB125.8 MB0.1 KB/s8.8 KB581:17:08
Outgoing feeds (innfeed) by volume

NNRP connection statistics (by domain) [Top 100]:

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved2813 00.0 KB 1 0 000:17:26
2*.stretchoid.com 1 00.0 KB 0 0 000:00:00
3*localhost 1 00.0 KB 0 0 000:12:01
TOTAL: 32815 00.0 KB 1 0 000:29:27

NNRP auth users [Top 20]:

UserConn
getlist 1
TOTAL: 1 1

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
2001:41d0:a:280::1 10.489 33.756 0.00000:17:01
localhost 182.061 370.982 0.08600:12:01
198.235.24.15 0.004 0.011 0.00000:00:10
167.94.138.47 0.019 0.038 0.00000:00:06
167.94.145.110 0.018 0.045 0.00000:00:04
2a06:4882:1000::19 0.008 0.008 0.00000:00:02
205.210.31.183 0.007 0.007 0.00000:00:00
88.214.25.124 0.009 0.009 0.00000:00:00
azpdcg3oqkx2.stretchoid.com 0.000 0.015 0.00000:00:00
TOTAL: 9 192.615 404.871 0.08600:29:27

Curious NNRP explorers [Top 20]:

SystemConn
2001:41d0:a:280::1 2803
167.94.138.47 3
167.94.145.110 3
198.235.24.15 1
205.210.31.183 1
2a06:4882:1000::19 1
88.214.25.124 1
azpdcg3oqkx2.stretchoid.com 1
localhost 1
TOTAL: 9 2815

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

SystemConn
167.94.138.47 1
167.94.145.110 1
88.214.25.124 1
azpdcg3oqkx2.stretchoid.com 1
TOTAL: 4 4

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

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

NNRP client timeouts [Top 20]:

SystemConnPeer
167.94.138.47 1 2
167.94.145.110 1 2
88.214.25.124 1 1
TOTAL: 3 3 6

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

HierarchyCountPct
1comp 1100.0%
TOTAL: 1 1100.0%

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

NewsgroupCount
1comp.sys.cbm 1
TOTAL: 1 1