Daily Usenet Report

Mar 16 00:01:01 -- Mar 17 00:01:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

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

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 14297 35.5%1.8 MB 22.8%
innd 9486 23.6%1.4 MB 17.4%
inn 8936 22.2%3.4 MB 44.2%
innfeed 6915 17.2%1.1 MB 14.4%
cnfsstat 576 1.4%86.0 KB 1.1%
nocem 44 0.1%7.2 KB 0.1%
controlchan 5 0.0%0.4 KB 0.0%
TOTAL: 7 40259 100.0%7.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 131728 63.3%
Negative hits 67657 32.5%
Do not exist 8819 4.2%
Cache misses 18 0.0%
TOTAL: 4 208222 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.429 0.0%23 0.000 18.652 37.111
article cleanup00:00:00.098 0.0%8889 0.000 0.011 0.118
article logging00:00:00.428 0.0%8930 0.000 0.048 0.257
article parse00:00:00.236 0.0%13242 0.000 0.018 0.080
article write00:00:02.818 0.0%6699 0.000 0.421 14.522
artlog/artcncl00:00:00.000 0.0%6 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.645 0.0%202936 0.000 0.003 0.577
hisgrep/artcncl00:00:00.266 0.0%29 0.000 9.172 22.111
hishave/artcncl00:00:00.000 0.0%6 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:39.508 0.2%209090 0.091 0.763 5.020
history sync00:00:00.081 0.0%401 0.000 0.202 1.000
history write00:02:08.550 0.1%8857 3.097 14.514 104.845
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:42:21.899 98.6%200910 61.836 424.777 1675.265
nntp read00:00:03.771 0.0%205216 0.000 0.018 0.266
overview write00:13:42.468 1.0%6699 0.773 122.775 27736.083
perl filter00:00:34.293 0.0%8857 1.718 3.872 39.149
python filter00:00:01.254 0.0%8859 0.000 0.142 7.149
site send00:00:01.153 0.0%13434 0.000 0.086 0.455
TOTAL: 2324:01:37.897 99.9%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.018 0.0%7295 0.000 0.002 0.067
article prepare00:00:00.004 0.0%43510 0.000 0.000 0.006
article read00:00:05.458 0.0%4071 0.000 1.341 117.238
backlog stats00:00:00.425 0.0%265683 0.000 0.002 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.155 0.0%179446 0.000 0.012 0.043
data write00:00:03.364 0.0%175367 0.010 0.019 0.038
idle23:37:18.881100.0%265683 167.065 320.076 1658.641
status file00:00:01.295 0.0%1125 1.000 1.151 19.000
TOTAL: 923:37:31.600100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:30:52.871 99.8%8392 21.000 220.790180809.250
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.489 0.2%95696 0.000 0.047 1.000
TOTAL: 300:30:57.360100.0%----

Control commands to innd:

CommandNumber
flush 6
flushlogs 2
go 2
logmode 2
lowmark 1
mode 97
name 2
newgroup 1
pause 2
paused 2
reload 6
reserve 2
TOTAL: 12 125

Newsgroups created:

GroupMode
usenet.discussion.ai.generaly
TOTAL1

Control channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
i@secure.corradoroberto.it200002
TOTAL200002

Incoming feeds (innd):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 5 13383 1141 12174 68 8%43:17:51
2usenet.blueworldhosting.com 719 8697 728 7101 868 8%23:48:24
3usenet.goja.nl.eu.org 12 8213 707 7297 209 8%24:32:25
4glockenspiel.complete.org 2 5430 698 4691 41 12%21:36:21
5news.nntp4.net 2 6843 538 6203 102 7%23:59:35
6nntp.comgw.net 2 8349 434 7639 276 5%23:59:57
7newsfeed.bofh.team 1 8747 406 8187 154 4%23:59:56
8news.corradoroberto.it 3 1857 312 1544 1 16%24:00:08
9194.87.241.33 30 588 220 264 104 37%16:01:29
10i2pn.org 1 8022 214 7708 100 2%23:59:54
11usenet.network 2 5910 204 5684 22 3%23:59:43
12news.samoylyk.net 4 6794 193 6585 16 2%23:45:08
13newsfeed.xs3.de 2 6058 129 5899 30 2%23:59:52
14news.furie.org.uk 1 3470 124 3345 1 3%23:59:57
15news.hispagatos.org 5 8461 120 8283 58 1%24:26:20
16endofthelinebbs.peers.news.panix.com 27 8254 112 8078 64 1%23:57:41
17endoftheline-out.news.chmurka.net 1 3495 107 3386 2 3%23:59:56
18peering.usenet.ovh 1 8040 44 7991 5 0%23:59:58
19news.netfront.net 1 6644 19 6586 39 0%22:26:10
20news.bbs.nz 3 11781 18 11760 3 0%41:41:07
21outgoing.news.lysator.liu.se 1 4996 16 4973 7 0%23:59:57
22photonic.trudheim.com 4 1627 4 1623 0 0%23:51:29
23localhost 28 2 2 0 0 100%00:00:00
24news.nk.ca 2 0 0 0 0 0%00:20:17
TOTAL: 24 859 145661 6490 137001 2170 4%553:43:35
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net3.1 MB8.6 KB175.1 KB3.3 MB 94%2.8 KB
2glockenspiel.complete.org2.6 MB6.4 KB85.6 KB2.7 MB 96%3.7 KB
3usenet.goja.nl.eu.org1.9 MB4.2 KB310.5 KB2.2 MB 85%2.4 KB
4news.corradoroberto.it1.8 MB0.0 KB1.2 KB1.8 MB 99%5.9 KB
5usenet.blueworldhosting.com1.7 MB0.0 KB2.0 MB3.8 MB 46%2.4 KB
6usenet.network1.5 MB2.0 KB38.2 KB1.5 MB 97%6.8 KB
7news.nntp4.net1.4 MB2.0 KB151.1 KB1.5 MB 90%2.5 KB
8nntp.comgw.net1.4 MB3.9 KB626.8 KB2.0 MB 69%2.9 KB
9news.samoylyk.net1.2 MB2.0 KB26.5 KB1.2 MB 97%5.8 KB
10newsfeed.bofh.team1.1 MB5.3 KB224.8 KB1.3 MB 83%2.4 KB
11194.87.241.33754.2 KB0.0 KB251.7 KB1005.9 KB 74%3.1 KB
12newsfeed.xs3.de610.3 KB4.2 KB73.5 KB688.0 KB 88%4.3 KB
13news.hispagatos.org494.3 KB0.0 KB131.9 KB626.3 KB 78%3.5 KB
14news.furie.org.uk464.5 KB0.0 KB1.8 KB466.2 KB 99%3.7 KB
15i2pn.org460.5 KB0.0 KB147.2 KB607.8 KB 75%1.9 KB
16endofthelinebbs.peers.news.panix.com260.4 KB0.0 KB98.6 KB359.0 KB 72%2.0 KB
17endoftheline-out.news.chmurka.net235.9 KB2.5 KB2.3 KB240.7 KB 98%2.2 KB
18peering.usenet.ovh172.1 KB6.1 KB2.7 KB180.8 KB 95%3.7 KB
19news.netfront.net66.7 KB5.5 KB742.8 KB815.0 KB 8%14.1 KB
20outgoing.news.lysator.liu.se36.5 KB8.7 KB3.3 KB48.5 KB 75%2.1 KB
21news.bbs.nz33.3 KB6.4 KB0.0 KB39.7 KB 83%1.9 KB
22photonic.trudheim.com25.1 KB0.0 KB0.0 KB25.1 KB100%6.3 KB
23localhost3.4 KB0.0 KB0.0 KB3.4 KB100%1.7 KB
24news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2421.1 MB67.8 KB5.0 MB26.2 MB 80%3.1 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 16 00:01:01 - 00:59:59 111 1.7% 0.03465.9 KB 2.1% 0.13
Mar 16 01:00:00 - 01:59:59 163 2.4% 0.05628.5 KB 2.8% 0.17
Mar 16 02:00:00 - 02:59:59 264 3.9% 0.07736.2 KB 3.3% 0.20
Mar 16 03:00:00 - 03:59:59 278 4.1% 0.08873.2 KB 3.9% 0.24
Mar 16 04:00:00 - 04:59:59 355 5.3% 0.10970.4 KB 4.3% 0.27
Mar 16 05:00:00 - 05:59:59 340 5.1% 0.09946.9 KB 4.2% 0.26
Mar 16 06:00:00 - 06:59:59 406 6.1% 0.111.3 MB 6.1% 0.38
Mar 16 07:00:00 - 07:59:59 321 4.8% 0.09959.8 KB 4.2% 0.27
Mar 16 08:00:00 - 08:59:59 362 5.4% 0.101.1 MB 5.1% 0.32
Mar 16 09:00:00 - 09:59:59 360 5.4% 0.101.1 MB 4.9% 0.31
Mar 16 10:00:00 - 10:59:59 348 5.2% 0.101.2 MB 5.6% 0.35
Mar 16 11:00:00 - 11:59:59 354 5.3% 0.101.2 MB 5.4% 0.34
Mar 16 12:00:00 - 12:59:59 398 5.9% 0.111.2 MB 5.5% 0.35
Mar 16 13:00:00 - 13:59:59 402 6.0% 0.111.3 MB 6.1% 0.38
Mar 16 14:00:00 - 14:59:59 380 5.7% 0.111.2 MB 5.2% 0.33
Mar 16 15:00:00 - 15:59:59 387 5.8% 0.111.4 MB 6.3% 0.40
Mar 16 16:00:00 - 16:59:59 338 5.0% 0.091.1 MB 5.1% 0.32
Mar 16 17:00:00 - 17:59:59 274 4.1% 0.081008.3 KB 4.5% 0.28
Mar 16 18:00:00 - 18:59:59 214 3.2% 0.06783.4 KB 3.5% 0.22
Mar 16 19:00:00 - 19:59:59 165 2.5% 0.05626.5 KB 2.8% 0.17
Mar 16 20:00:00 - 20:59:59 139 2.1% 0.04583.2 KB 2.6% 0.16
Mar 16 21:00:00 - 21:59:59 107 1.6% 0.03594.3 KB 2.6% 0.17
Mar 16 22:00:00 - 22:59:59 110 1.6% 0.03442.1 KB 2.0% 0.12
Mar 16 23:00:00 - 23:59:59 120 1.8% 0.03434.5 KB 1.9% 0.12
Mar 17 00:00:00 - 00:01:01 8 0.1% 0.1320.0 KB 0.1% 0.33
TOTAL: 24:00:00 6704 100.0% 0.0822.1 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 GB105.1 GB 6.8% 0 0.4145119.07
CYCNGS3NGS1536.0 GB48.0 MB 0.0% 0 0.00 0.00
CYCTXT1TEXT5.0 GB4.2 GB 83.3% 0 0.03 1914.58
TOTAL: 4-4613.0 GB109.4 GB 2.4% 1 0.30-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 871 0 0 0 0 0 0 0 871
2nntp.comgw.net 295 0 0 2 0 0 0 0 293
3usenet.goja.nl.eu.org 202 0 0 2 0 0 0 0 200
4newsfeed.bofh.team 157 0 0 3 0 0 0 0 154
5news.nntp4.net 106 0 0 1 0 0 0 0 105
6194.87.241.33 104 0 0 0 0 0 0 0 104
7i2pn.org 97 0 0 0 0 0 0 0 97
8endofthelinebbs-out.news.weretis.net 86 0 0 4 0 0 0 0 82
9endofthelinebbs.peers.news.panix.com 64 0 0 0 0 0 0 0 64
10news.hispagatos.org 58 0 0 0 0 0 0 0 58
11news.netfront.net 48 0 0 2 0 0 0 0 46
12glockenspiel.complete.org 40 0 0 3 0 0 0 0 37
13newsfeed.xs3.de 30 0 0 2 0 0 0 0 28
14usenet.network 26 0 0 1 0 0 0 0 25
15news.samoylyk.net 20 0 0 1 0 0 0 0 19
16outgoing.news.lysator.liu.se 8 0 0 4 0 0 0 0 4
17peering.usenet.ovh 6 0 0 3 0 0 0 0 3
18news.bbs.nz 3 0 0 3 0 0 0 0 0
19endoftheline-out.news.chmurka.net 2 0 0 1 0 0 0 0 1
20news.corradoroberto.it 2 1 0 0 0 0 0 0 1
21news.furie.org.uk 1 0 0 0 0 0 0 0 1
TOTAL: 21 2226 1 0 32 0 0 0 0 2193

Unwanted newsgroups [Top 20]:

NewsgroupCount
usenet.discussion.ai.general 1
TOTAL: 1 1

Perl filter (innd) [Top 20]:

ReasonCount
EMP (phn path) 1299
EMP (phr path) 328
Too many newsgroups 248
EMP (md5) 198
Angle-bracket bot 34
EMP (phl) 13
Too many newsgroups (meow) 12
User-issued cancel 12
HTML Multipart 5
HTML post 1
Subject (LSDRgdGC0LjQu9C40YHRgtC+0LI) 1
hierarchy violation - crosspost outside sdnet 1
TOTAL: 12 2152

NoCeM on spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
robot@pasdenom.info (spam4)8002525
robot@pasdenom.info (spam2)20002424
robot@pasdenom.info (spam3)6001717
i2pn2-nocem@i2pn2.org (rmp)4001111
i2pn2-nocem@i2pn2.org (multipost)30066
TOTAL: 541008383

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
nntp.comgw.net 20
usenet.network 4
endofthelinebbs-out.news.weretis.net 4
news.nntp4.net 4
usenet.blueworldhosting.com 3
newsfeed.bofh.team 2
news.netfront.net 1
outgoing.news.lysator.liu.se 1
peering.usenet.ovh 1
news.corradoroberto.it 1
TOTAL: 10 41
TOTAL: 1 41

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nyheter.lysator.liu.se 7130 2505 3983 193 0 0 35%23:59:38
2news.netfront.net 10761 1896 4781 1 0 7 17%23:59:38
3news.furie.org.uk 3987 753 2304 12 0 0 18%23:59:38
4photonic.trudheim.com 7800 481 4982 1246 0 11 6%24:09:29
5endofthelinebbs.peers.news.panix.com 7337 317 6370 9 0 0 4%23:59:39
6news.nntp4.net 7089 296 5795 6 0 45 4%23:59:38
7peering.usenet.ovh 7381 292 6352 63 0 0 3%24:09:31
8usenet.goja.nl.eu.org 6887 286 5298 44 0 2 4%23:59:38
9news.bbs.nz 12326 165 6143 376 0 146 1%23:59:38
10news.nk.ca 9175 145 6097 361 0 13 1%23:59:38
11newsfeed.bofh.team 7219 98 6180 3 0 1 1%23:59:38
12i2pn.org 7660 89 6340 49 0 42 1%23:59:39
13news.hispagatos.org 7430 85 6403 86 0 2 1%23:59:38
14usenet.network 7924 75 5951 36 0 2 0%23:59:38
15nntp.comgw.net 6831 58 6164 38 0 0 0%23:59:38
16news.corradoroberto.it 968 50 575 0 0 1 5%21:58:10
17news.weretis.net 7036 49 6511 136 0 6 0%23:59:39
18news.quux.org 5304 33 4603 367 0 0 0%23:59:39
19ddt.demos.su 150 33 113 0 0 0 22%11:52:14
20news.chmurka.net 4205 27 3051 2 0 2 0%23:59:38
21news.tnetconsulting.net 9088 24 6511 160 0 16 0%23:59:39
22newsfeed.xs3.de 8143 17 6376 153 0 2 0%23:59:38
23news.samoylyk.net 7863 17 6295 53 0 116 0%23:59:38
24usenet.blueworldhosting.com 6494 3 5747 0 0 0 0%23:59:39
25news.dne3.net 256 0 0 0 0 508 0%02:08:59
26feed.opticnetworks.net 0 0 0 0 0 6709 0%24:09:32
TOTAL: 26 166444 7794 122925 3394 0 7631 4%588:20:41
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nyheter.lysator.liu.se7.5 MB1.1 MB8.6 MB0.1 KB/s3.3 KB23:59:38
2news.netfront.net6.3 MB1.5 KB6.3 MB0.1 KB/s3.4 KB23:59:38
3news.furie.org.uk3.7 MB34.0 KB3.7 MB0.0 KB/s5.0 KB23:59:38
4photonic.trudheim.com1.7 MB3.7 MB5.4 MB0.1 KB/s3.2 KB24:09:29
5peering.usenet.ovh1.5 MB188.0 KB1.7 MB0.0 KB/s4.9 KB24:09:31
6endofthelinebbs.peers.news.panix.com1.5 MB56.9 KB1.5 MB0.0 KB/s4.8 KB23:59:39
7news.nntp4.net788.2 KB18.9 KB807.0 KB0.0 KB/s2.7 KB23:59:38
8newsfeed.bofh.team543.5 KB8.1 KB551.5 KB0.0 KB/s5.5 KB23:59:38
9news.bbs.nz516.7 KB1.2 MB1.8 MB0.0 KB/s3.3 KB23:59:38
10usenet.goja.nl.eu.org513.5 KB194.7 KB708.2 KB0.0 KB/s2.1 KB23:59:38
11news.nk.ca355.1 KB1.2 MB1.6 MB0.0 KB/s3.2 KB23:59:38
12news.quux.org330.9 KB1011.5 KB1.3 MB0.0 KB/s3.4 KB23:59:39
13ddt.demos.su322.3 KB0.0 KB322.3 KB0.0 KB/s9.8 KB11:52:14
14news.samoylyk.net288.6 KB127.6 KB416.1 KB0.0 KB/s5.9 KB23:59:38
15i2pn.org272.0 KB283.6 KB555.6 KB0.0 KB/s4.0 KB23:59:39
16news.hispagatos.org237.4 KB494.2 KB731.6 KB0.0 KB/s4.3 KB23:59:38
17usenet.network236.0 KB64.8 KB300.8 KB0.0 KB/s2.7 KB23:59:38
18news.corradoroberto.it149.7 KB0.0 KB149.7 KB0.0 KB/s3.0 KB21:58:10
19news.weretis.net128.3 KB1.1 MB1.2 MB0.0 KB/s6.7 KB23:59:39
20nntp.comgw.net122.0 KB400.9 KB522.8 KB0.0 KB/s5.4 KB23:59:38
21news.chmurka.net87.9 KB3.3 KB91.2 KB0.0 KB/s3.1 KB23:59:38
22news.tnetconsulting.net72.1 KB797.7 KB869.8 KB0.0 KB/s4.7 KB23:59:39
23newsfeed.xs3.de62.5 KB674.9 KB737.4 KB0.0 KB/s4.3 KB23:59:38
24usenet.blueworldhosting.com4.9 KB0.0 KB4.9 KB0.0 KB/s1.6 KB23:59:39
25feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s024:09:32
26news.dne3.net0.0 KB0.0 KB0.0 KB0.0 KB/s002:08:59
TOTAL: 2627.1 MB12.6 MB39.7 MB0.0 KB/s3.6 KB588:20:41
Outgoing feeds (innfeed) by volume

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved2792 00.0 KB 5 0 000:16:50
2*.ip.linodeusercontent.com 32 00.0 KB 0 0 000:01:39
3*.dne3.net 1 00.0 KB 0 0 000:00:18
4*.stretchoid.com 1 00.0 KB 0 0 000:00:00
5*localhost 1 00.0 KB 0 0 000:12:07
TOTAL: 52827 00.0 KB 5 0 000:30:56

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.143 34.259 0.00000:16:19
localhost 184.652 370.007 0.07700:12:07
139-144-52-241.ip.linodeusercontent.com 0.372 0.427 0.00000:01:39
news.dne3.net 0.004 0.011 0.00000:00:18
147.185.132.210 0.007 0.007 0.00000:00:10
205.210.31.12 0.004 0.011 0.00000:00:10
167.94.146.52 0.009 0.052 0.00000:00:04
2602:fe64:8::7 0.004 0.012 0.00000:00:02
2607:ff10:c8:594::6 0.003 0.012 0.00000:00:02
2a06:4883:3000::35 0.004 0.011 0.00000:00:01
azpdeg31.stretchoid.com 0.005 0.010 0.00000:00:00
TOTAL: 11 195.207 404.819 0.07700:30:56

Curious NNRP explorers [Top 20]:

SystemConn
2001:41d0:a:280::1 2784
139-144-52-241.ip.linodeusercontent.com 32
167.94.146.52 3
147.185.132.210 1
205.210.31.12 1
2602:fe64:8::7 1
2607:ff10:c8:594::6 1
2a06:4883:3000::35 1
azpdeg31.stretchoid.com 1
localhost 1
news.dne3.net 1
TOTAL: 11 2827

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

SystemConn
167.94.146.52 1
azpdeg31.stretchoid.com 1
TOTAL: 2 2

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

CommandCount
EHLO www.censys.io 1
MGLNDD_144.172.126.95_119 1
TOTAL: 2 2

NNRP client timeouts [Top 20]:

SystemConnPeer
139-144-52-241.ip.linodeusercontent.com 1 2
167.94.146.52 1 2
TOTAL: 2 2 4

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

HierarchyCountPct
1news 4 80.0%
2comp 1 20.0%
TOTAL: 2 5100.0%

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

NewsgroupCount
1news.admin.peering 2
2news.answers 2
3comp.sys.acorn.apps 1
TOTAL: 3 5