Daily Usenet Report

Mar 23 00:01:01 -- Mar 24 00:01:04

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Mar 23 08:16:53 newsfeed innd: message repeated 2 times: [ ctlinnd command s]
Mar 24 00:00:01 newsfeed nnrpd[2733477]: localhost auth: program exited with status 8

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 28398 55.4%3.4 MB 38.1%
innd 9197 18.0%1.3 MB 14.3%
inn 8287 16.2%3.3 MB 36.7%
innfeed 4703 9.2%906.2 KB 9.8%
cnfsstat 576 1.1%93.1 KB 1.0%
nocem 62 0.1%6.9 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 51224 100.0%9.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 122288 64.1%
Negative hits 60261 31.6%
Do not exist 8213 4.3%
Cache misses 18 0.0%
TOTAL: 4 190780 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.332 0.0%15 0.000 22.133 30.100
article cleanup00:00:00.142 0.0%8242 0.000 0.017 0.423
article logging00:00:00.664 0.0%8277 0.000 0.080 5.293
article parse00:00:00.194 0.0%12548 0.000 0.015 0.091
article write00:00:02.316 0.0%6306 0.000 0.367 5.906
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:00.392 0.0%191659 0.000 0.002 0.043
hisgrep/artcncl00:00:00.304 0.0%16 0.000 19.000 28.100
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:22.862 0.2%191450 0.103 0.746 4.846
history sync00:00:00.089 0.0%396 0.000 0.225 1.000
history write00:02:04.049 0.1%8242 3.236 15.051 112.305
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:47:39.632 99.1%195013 66.136 439.251 1891.659
nntp read00:00:02.810 0.0%193062 0.000 0.015 0.067
overview write00:07:13.564 0.5%6306 0.650 68.754 7916.348
perl filter00:00:28.848 0.0%8241 1.635 3.501 23.000
python filter00:00:02.726 0.0%8242 0.000 0.331 5.983
site send00:00:01.139 0.0%12666 0.000 0.090 1.609
TOTAL: 2324:00:00.063 99.9%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.015 0.0%6577 0.000 0.002 0.056
article prepare00:00:00.005 0.0%48394 0.000 0.000 0.002
article read00:00:00.644 0.0%4452 0.000 0.145 0.581
backlog stats00:00:00.416 0.0%261554 0.000 0.002 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.299 0.0%176395 0.000 0.013 0.058
data write00:00:03.392 0.0%172977 0.008 0.020 0.039
idle23:58:20.885100.0%261554 182.078 329.954 1263.193
status file00:00:00.491 0.0%393 1.000 1.249 13.000
TOTAL: 923:58:28.147100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:49:43.902 99.9%16740 49.000 178.250178502.750
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.466 0.1%112347 0.000 0.040 1.333
TOTAL: 300:49:48.368100.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 (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 5 13750 1464 12021 265 10%52:25:10
2news.dne3.net 1 6557 1298 5247 12 19%24:23:57
3usenet.blueworldhosting.com 719 8127 767 6521 839 9%23:47:30
4usenet.goja.nl.eu.org 11 7502 540 6805 157 7%23:53:05
5news.corradoroberto.it 2 1909 446 1463 0 23%23:52:25
6news.nntp4.net 2 6599 429 6091 79 6%23:59:43
7newsfeed.bofh.team 2 8065 345 7587 133 4%23:59:14
8nntp.comgw.net 1 7699 265 7225 209 3%23:59:57
9i2pn.org 1 7285 213 6970 102 2%23:59:55
10194.87.241.33 42 322 183 112 27 56%15:42:24
11usenet.network 1 5604 133 5447 24 2%23:59:57
12endofthelinebbs.peers.news.panix.com 24 6813 112 6695 6 1%23:53:10
13newsfeed.xs3.de 1 5582 67 5510 5 1%23:59:55
14peering.usenet.ovh 2 7293 53 7228 12 0%23:59:56
15news.hispagatos.org 5 7855 46 7771 38 0%24:26:21
16glockenspiel.complete.org 2 5346 31 5315 0 0%24:01:39
17news.netfront.net 3 6512 23 6453 36 0%24:00:51
18news.furie.org.uk 2 3379 22 3355 2 0%23:59:22
19news.samoylyk.net 0 4199 17 4179 3 0%16:03:34
20endoftheline-out.news.chmurka.net 1 3109 17 3091 1 0%23:59:57
21outgoing.news.lysator.liu.se 5 3401 11 3387 3 0%26:03:13
22news.bbs.nz 2 6389 10 6379 0 0%23:59:23
23localhost 27 1 1 0 0 100%00:00:01
24eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:04
25news.nk.ca 2 0 0 0 0 0%00:20:12
TOTAL: 25 864 133298 6493 124852 1953 4%543:00:55
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net5.2 MB0.0 KB526.1 KB5.7 MB 91%3.4 KB
2news.dne3.net3.6 MB0.0 KB11.0 KB3.6 MB 99%2.8 KB
3news.corradoroberto.it2.7 MB0.0 KB0.0 KB2.7 MB100%6.2 KB
4usenet.blueworldhosting.com2.0 MB0.0 KB1.8 MB3.8 MB 52%2.4 KB
5nntp.comgw.net2.0 MB0.0 KB599.6 KB2.5 MB 76%5.5 KB
6usenet.goja.nl.eu.org1.5 MB0.0 KB193.8 KB1.7 MB 88%2.5 KB
7usenet.network1.3 MB0.0 KB39.7 KB1.3 MB 97%8.8 KB
8news.nntp4.net1.2 MB0.0 KB104.1 KB1.3 MB 92%2.7 KB
9newsfeed.bofh.team964.5 KB0.0 KB186.3 KB1.1 MB 83%2.4 KB
10194.87.241.33772.8 KB0.0 KB67.7 KB840.5 KB 91%4.0 KB
11i2pn.org544.5 KB0.0 KB137.8 KB682.3 KB 79%2.2 KB
12peering.usenet.ovh277.8 KB0.0 KB15.2 KB293.1 KB 94%4.5 KB
13newsfeed.xs3.de252.3 KB0.0 KB8.7 KB261.0 KB 96%3.6 KB
14glockenspiel.complete.org225.4 KB0.0 KB0.0 KB225.4 KB100%7.3 KB
15endofthelinebbs.peers.news.panix.com213.1 KB0.0 KB6.2 KB219.3 KB 97%1.9 KB
16news.hispagatos.org118.1 KB0.0 KB92.7 KB210.8 KB 56%2.5 KB
17news.samoylyk.net97.7 KB0.0 KB5.3 KB103.0 KB 94%5.2 KB
18news.furie.org.uk76.7 KB0.0 KB1.6 KB78.3 KB 97%3.3 KB
19news.netfront.net61.3 KB0.0 KB585.5 KB646.7 KB 9%11.0 KB
20outgoing.news.lysator.liu.se42.4 KB0.0 KB3.2 KB45.6 KB 93%3.3 KB
21endoftheline-out.news.chmurka.net37.0 KB0.0 KB0.8 KB37.8 KB 97%2.1 KB
22news.bbs.nz21.3 KB0.0 KB0.0 KB21.3 KB100%2.1 KB
23localhost1.5 KB0.0 KB0.0 KB1.5 KB100%1.5 KB
24eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
25news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2523.2 MB0.0 KB4.3 MB27.5 MB 84%3.3 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 23 00:01:01 - 00:59:59 122 1.9% 0.03462.7 KB 2.0% 0.13
Mar 23 01:00:00 - 01:59:59 163 2.6% 0.05841.9 KB 3.6% 0.23
Mar 23 02:00:00 - 02:59:59 277 4.4% 0.081.3 MB 5.6% 0.36
Mar 23 03:00:00 - 03:59:59 265 4.2% 0.07605.4 KB 2.6% 0.17
Mar 23 04:00:00 - 04:59:59 366 5.8% 0.10910.3 KB 3.9% 0.25
Mar 23 05:00:00 - 05:59:59 359 5.7% 0.10987.8 KB 4.2% 0.27
Mar 23 06:00:00 - 06:59:59 394 6.2% 0.111.1 MB 4.9% 0.32
Mar 23 07:00:00 - 07:59:59 304 4.8% 0.08944.5 KB 4.1% 0.26
Mar 23 08:00:00 - 08:59:59 358 5.7% 0.101.5 MB 6.6% 0.43
Mar 23 09:00:00 - 09:59:59 344 5.5% 0.101.0 MB 4.6% 0.30
Mar 23 10:00:00 - 10:59:59 348 5.5% 0.101.0 MB 4.4% 0.29
Mar 23 11:00:00 - 11:59:59 296 4.7% 0.08895.8 KB 3.8% 0.25
Mar 23 12:00:00 - 12:59:59 381 6.0% 0.111.6 MB 6.9% 0.45
Mar 23 13:00:00 - 13:59:59 390 6.2% 0.111.4 MB 6.2% 0.40
Mar 23 14:00:00 - 14:59:59 331 5.2% 0.091014.4 KB 4.4% 0.28
Mar 23 15:00:00 - 15:59:59 314 5.0% 0.091.1 MB 4.8% 0.31
Mar 23 16:00:00 - 16:59:59 287 4.6% 0.081.1 MB 4.8% 0.31
Mar 23 17:00:00 - 17:59:59 224 3.6% 0.061.0 MB 4.5% 0.29
Mar 23 18:00:00 - 18:59:59 235 3.7% 0.07808.1 KB 3.5% 0.22
Mar 23 19:00:00 - 19:59:59 153 2.4% 0.04563.3 KB 2.4% 0.16
Mar 23 20:00:00 - 20:59:59 107 1.7% 0.03350.1 KB 1.5% 0.10
Mar 23 21:00:00 - 21:59:59 77 1.2% 0.021.0 MB 4.5% 0.29
Mar 23 22:00:00 - 22:59:59 100 1.6% 0.031022.5 KB 4.4% 0.28
Mar 23 23:00:00 - 23:59:59 105 1.7% 0.03375.8 KB 1.6% 0.10
Mar 24 00:00:00 - 00:01:04 5 0.1% 0.0858.8 KB 0.3% 0.92
TOTAL: 24:00:03 6305 100.0% 0.0722.8 MB 100.0% 0.27
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.4 GB 6.9% 0 0.4243945.33
CYCNGS3NGS1536.0 GB48.0 MB 0.0% 0 0.00 0.00
CYCTXT1TEXT5.0 GB4.2 GB 83.5% 0 0.03 2133.58
TOTAL: 4-4613.0 GB109.7 GB 2.4% 1 0.32-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 847 1 0 0 0 0 0 0 846
2endofthelinebbs-out.news.weretis.net 269 0 0 0 0 0 0 0 269
3nntp.comgw.net 228 0 0 0 0 0 0 0 228
4usenet.goja.nl.eu.org 165 0 0 0 0 0 0 0 165
5newsfeed.bofh.team 134 1 0 0 0 0 0 0 133
6i2pn.org 102 0 0 0 0 0 0 0 102
7news.nntp4.net 58 0 0 0 0 0 0 0 58
8news.netfront.net 48 0 0 0 0 0 0 0 48
9news.hispagatos.org 34 10 0 0 0 0 0 0 24
10194.87.241.33 27 0 0 0 0 0 0 0 27
11usenet.network 24 0 0 0 0 0 0 0 24
12news.dne3.net 12 0 0 0 0 0 0 0 12
13peering.usenet.ovh 12 0 0 0 0 0 0 0 12
14endofthelinebbs.peers.news.panix.com 7 0 0 0 0 0 0 0 7
15newsfeed.xs3.de 5 0 0 0 0 0 0 0 5
16news.samoylyk.net 3 0 0 0 0 0 0 0 3
17outgoing.news.lysator.liu.se 3 0 0 0 0 0 0 0 3
18news.furie.org.uk 2 0 0 0 0 0 0 0 2
19endoftheline-out.news.chmurka.net 1 0 0 0 0 0 0 0 1
TOTAL: 19 1981 12 0 0 0 0 0 0 1969

Unwanted newsgroups [Top 20]:

NewsgroupCount
hispagatos.mastodon.tag.hacking 10
alt.fan.trainspotting 1
soc.culture.russia 1
TOTAL: 3 12

Perl filter (innd) [Top 20]:

ReasonCount
EMP (phn path) 973
EMP (phr path) 390
Too many newsgroups 283
EMP (md5) 220
Angle-bracket bot 24
Too many newsgroups (meow) 19
User-issued cancel 16
HTML Multipart 8
TOTAL: 8 1933

NoCeM on spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
robot@pasdenom.info (spam2)35003636
robot@pasdenom.info (spam4)8002424
robot@pasdenom.info (spam3)5002222
i2pn2-nocem@i2pn2.org (multipost)70088
i2pn2-nocem@i2pn2.org (rmp)40088
mm+nocem@dorfdsl.de (spam)20022
TOTAL: 66100100100

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
nntp.comgw.net 12
endofthelinebbs-out.news.weretis.net 8
usenet.blueworldhosting.com 7
news.nntp4.net 4
news.netfront.net 2
usenet.goja.nl.eu.org 1
endofthelinebbs.peers.news.panix.com 1
TOTAL: 7 35
TOTAL: 1 35

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nyheter.lysator.liu.se 6576 3477 2599 211 0 0 52%23:59:56
2news.netfront.net 10478 1559 4716 0 0 20 14%23:59:56
3news.furie.org.uk 3766 756 2262 7 0 0 20%23:59:56
4photonic.trudheim.com 7154 543 4405 1345 0 0 7%23:58:39
5news.dne3.net 5362 414 4524 97 0 0 7%23:58:28
6news.nntp4.net 6693 306 5531 4 0 25 4%23:59:56
7usenet.goja.nl.eu.org 6808 299 5233 21 0 0 4%23:59:41
8endofthelinebbs.peers.news.panix.com 6659 278 6004 6 0 0 4%23:59:56
9peering.usenet.ovh 6991 273 5927 85 0 0 3%23:59:56
10i2pn.org 6933 140 5903 26 0 41 2%23:59:56
11news.bbs.nz 11644 103 5802 384 0 81 0%23:59:56
12news.hispagatos.org 7224 98 6104 50 0 0 1%23:58:39
13news.nk.ca 8597 92 5736 351 0 29 1%23:59:56
14newsfeed.bofh.team 6979 80 5855 0 0 8 1%23:59:56
15nntp.comgw.net 6598 77 5940 15 0 0 1%23:59:32
16usenet.network 7904 68 5728 29 0 0 0%23:59:56
17news.samoylyk.net 6209 58 3740 293 0 2241 0%23:59:56
18news.corradoroberto.it 828 48 503 0 0 0 5%21:10:43
19news.weretis.net 6690 32 6164 101 0 1 0%23:59:56
20news.quux.org 6309 27 5663 248 0 0 0%23:59:44
21news.tnetconsulting.net 8316 22 6134 131 0 19 0%23:59:35
22newsfeed.xs3.de 7708 21 6065 130 0 0 0%23:58:46
23news.chmurka.net 3933 21 2773 0 0 0 0%23:59:56
24ddt.demos.su 45 5 40 0 0 0 11%05:38:57
25usenet.blueworldhosting.com 5882 4 5319 0 0 0 0%23:59:56
26feed.opticnetworks.net 0 0 0 0 0 6298 0%23:59:56
TOTAL: 26 162286 8801 118670 3534 0 8763 5%602:41:40
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nyheter.lysator.liu.se13.3 MB1.2 MB14.4 MB0.2 KB/s4.0 KB23:59:56
2news.netfront.net7.6 MB0.0 KB7.6 MB0.1 KB/s5.0 KB23:59:56
3news.furie.org.uk4.2 MB19.5 KB4.2 MB0.0 KB/s5.6 KB23:59:56
4photonic.trudheim.com2.1 MB3.8 MB5.9 MB0.1 KB/s3.2 KB23:58:39
5peering.usenet.ovh1.6 MB245.2 KB1.8 MB0.0 KB/s5.2 KB23:59:56
6endofthelinebbs.peers.news.panix.com1.4 MB19.7 KB1.4 MB0.0 KB/s5.0 KB23:59:56
7news.dne3.net1.3 MB917.4 KB2.2 MB0.0 KB/s4.4 KB23:58:28
8news.nntp4.net1.2 MB18.1 KB1.2 MB0.0 KB/s3.9 KB23:59:56
9news.quux.org1001.3 KB663.8 KB1.6 MB0.0 KB/s6.1 KB23:59:44
10news.samoylyk.net921.6 KB1.1 MB2.0 MB0.0 KB/s5.9 KB23:59:56
11newsfeed.bofh.team723.1 KB0.0 KB723.1 KB0.0 KB/s9.0 KB23:59:56
12usenet.goja.nl.eu.org641.3 KB232.5 KB873.7 KB0.0 KB/s2.7 KB23:59:41
13news.hispagatos.org618.5 KB307.4 KB925.9 KB0.0 KB/s6.3 KB23:58:39
14i2pn.org593.8 KB142.3 KB736.1 KB0.0 KB/s4.4 KB23:59:56
15nntp.comgw.net534.8 KB558.1 KB1.1 MB0.0 KB/s11.9 KB23:59:32
16newsfeed.xs3.de446.7 KB797.7 KB1.2 MB0.0 KB/s8.2 KB23:58:46
17news.bbs.nz372.1 KB1.3 MB1.7 MB0.0 KB/s3.6 KB23:59:56
18news.nk.ca225.5 KB1.4 MB1.6 MB0.0 KB/s3.7 KB23:59:56
19usenet.network215.3 KB71.0 KB286.3 KB0.0 KB/s3.0 KB23:59:56
20news.weretis.net198.4 KB1.4 MB1.6 MB0.0 KB/s12.1 KB23:59:56
21news.corradoroberto.it152.0 KB0.0 KB152.0 KB0.0 KB/s3.2 KB21:10:43
22news.chmurka.net112.0 KB0.0 KB112.0 KB0.0 KB/s5.3 KB23:59:56
23news.tnetconsulting.net101.6 KB789.2 KB890.8 KB0.0 KB/s5.8 KB23:59:35
24ddt.demos.su92.6 KB0.0 KB92.6 KB0.0 KB/s18.5 KB05:38:57
25usenet.blueworldhosting.com12.0 KB0.0 KB12.0 KB0.0 KB/s3.0 KB23:59:56
26feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
TOTAL: 2639.3 MB14.9 MB54.2 MB0.0 KB/s4.5 KB602:41:40
Outgoing feeds (innfeed) by volume

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved5588 00.0 KB 1 0 000:37:45
2*.ip-145-239-154.eu 2 00.0 KB 0 0 000:00:01
3*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
4*.stretchoid.com 1 00.0 KB 0 0 000:00:00
5*localhost 1 00.0 KB 0 0 000:11:57
TOTAL: 55593 00.0 KB 1 0 000:49:46

NNRP auth users [Top 20]:

UserConn
getlist 1
TOTAL: 1 1

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
2a0e:73c2:8000:802c::2 10.445 34.020 0.00000:19:37
2001:41d0:a:280::1 10.486 33.723 0.00000:17:48
localhost 183.975 370.265 0.07600:11:57
206.168.34.41 0.023 0.037 0.00000:00:10
205.210.31.185 0.005 0.010 0.00000:00:03
205.210.31.17 0.005 0.010 0.00000:00:02
162.142.125.126 0.016 0.011 0.00000:00:02
celebrated.monitoring.internet-measurement.com 0.005 0.010 0.00000:00:01
ns31410049.ip-145-239-154.eu 0.022 0.026 0.00000:00:01
2607:ff10:c8:594::4 0.010 0.005 0.00000:00:00
azpdcg81zlf2.stretchoid.com 0.004 0.011 0.00000:00:00
TOTAL: 11 204.996 438.128 0.07600:49:46

Curious NNRP explorers [Top 20]:

SystemConn
2001:41d0:a:280::1 2794
2a0e:73c2:8000:802c::2 2787
206.168.34.41 3
ns31410049.ip-145-239-154.eu 2
162.142.125.126 1
205.210.31.17 1
205.210.31.185 1
2607:ff10:c8:594::4 1
azpdcg81zlf2.stretchoid.com 1
celebrated.monitoring.internet-measurement.com 1
localhost 1
TOTAL: 11 5593

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

SystemConn
162.142.125.126 1
206.168.34.41 1
azpdcg81zlf2.stretchoid.com 1
ns31410049.ip-145-239-154.eu 1
TOTAL: 4 4

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

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

NNRP client timeouts [Top 20]:

SystemConnPeer
206.168.34.41 1 2
ns31410049.ip-145-239-154.eu 1 1
TOTAL: 2 2 5

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

HierarchyCountPct
1soc 2100.0%
TOTAL: 1 2100.0%

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

NewsgroupCount
1soc.genealogy.britain 2
TOTAL: 1 2