Daily Usenet Report

Mar 19 00:01:01 -- Mar 20 00:01:02

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

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

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 14215 35.3%1.8 MB 21.9%
innd 10492 26.0%1.5 MB 18.1%
inn 10296 25.6%3.9 MB 48.2%
innfeed 4643 11.5%874.3 KB 10.7%
cnfsstat 576 1.4%86.3 KB 1.1%
nocem 57 0.1%6.6 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 40280 100.0%8.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 161530 65.0%
Negative hits 76217 30.7%
Do not exist 10266 4.1%
Cache misses 571 0.2%
TOTAL: 4 248584 100.0%

innd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.286 0.0%35 0.000 8.171 16.000
article cleanup00:00:00.139 0.0%10248 0.000 0.014 0.222
article logging00:00:00.496 0.0%10296 0.000 0.048 0.387
article parse00:00:00.275 0.0%16200 0.000 0.017 0.108
article write00:00:02.613 0.0%7195 0.000 0.363 13.259
artlog/artcncl00:00:00.001 0.0%5 0.000 0.200 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.638 0.0%223615 0.000 0.003 0.089
hisgrep/artcncl00:00:00.225 0.0%38 0.000 5.921 10.500
hishave/artcncl00:00:00.000 0.0%5 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:55.815 0.2%249032 0.082 0.706 4.861
history sync00:00:00.066 0.0%355 0.000 0.186 1.500
history write00:02:16.087 0.2%10248 3.031 13.279 154.550
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:48:49.742 99.2%217530 61.908 394.105 1955.709
nntp read00:00:03.300 0.0%224717 0.000 0.015 0.181
overview write00:04:58.454 0.3%7195 0.375 41.481 2450.985
perl filter00:00:33.699 0.0%10248 1.526 3.288 41.516
python filter00:00:02.339 0.0%10248 0.000 0.228 11.016
site send00:00:00.902 0.0%14432 0.000 0.062 0.250
TOTAL: 2323:59:45.077 99.9%----

innfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.022 0.0%9204 0.000 0.002 0.071
article prepare00:00:00.007 0.0%52082 0.000 0.000 0.004
article read00:00:00.672 0.0%4378 0.000 0.153 0.870
backlog stats00:00:00.467 0.0%291612 0.000 0.002 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.472 0.0%199806 0.002 0.012 0.052
data write00:00:03.754 0.0%196512 0.006 0.019 0.037
idle23:56:50.850100.0%291612 111.414 295.635 1386.182
status file00:00:00.485 0.0%373 1.000 1.300 20.000
TOTAL: 923:56:58.729100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:30:20.500 99.7%8396 33.500 216.829163811.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.645 0.3%95706 0.000 0.049 0.333
TOTAL: 300:30:25.145100.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 3 16453 1438 14466 549 8%46:43:07
2news.dne3.net 2 8587 1414 7052 121 16%23:12:13
3usenet.blueworldhosting.com 718 10140 600 8823 717 5%23:55:33
4usenet.network 1 6056 451 5580 25 7%23:59:57
5nntp.comgw.net 1 9408 386 8789 233 4%23:59:57
6newsfeed.bofh.team 1 10102 362 9557 183 3%23:59:56
7news.nntp4.net 4 8753 357 8251 145 4%24:09:28
8usenet.goja.nl.eu.org 11 9316 348 8793 175 3%24:01:01
9news.corradoroberto.it 2 1767 303 1464 0 17%23:57:20
10i2pn.org 1 8975 271 8639 65 3%23:59:54
11endoftheline-out.news.chmurka.net 2 3591 252 3339 0 7%23:59:55
12news.samoylyk.net 2 8159 167 7951 41 2%23:59:21
13glockenspiel.complete.org 2 9851 159 9574 118 1%33:13:18
14194.87.241.33 48 1955 159 1521 275 8%15:52:40
15endofthelinebbs.peers.news.panix.com 25 7910 157 7731 22 1%23:58:31
16newsfeed.xs3.de 2 7697 118 7501 78 1%23:59:30
17news.hispagatos.org 5 9586 92 9401 93 0%24:26:22
18news.furie.org.uk 2 3763 63 3699 1 1%23:59:45
19peering.usenet.ovh 1 9042 31 8983 28 0%23:59:57
20news.bbs.nz 1 6693 17 6675 1 0%23:59:43
21outgoing.news.lysator.liu.se 2 6156 16 6093 47 0%23:56:33
22news.netfront.net 1 7540 10 7427 103 0%22:26:10
23photonic.trudheim.com 6 1839 3 1836 0 0%23:51:04
24eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:05
25localhost 27 0 0 0 0 0%00:00:00
26news.nk.ca 2 0 0 0 0 0%00:20:12
TOTAL: 26 873 173339 7174 163145 3020 4%574:11:32
Articles received by server

Incoming volume (innd):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net4.9 MB0.0 KB1.4 MB6.3 MB 77%3.2 KB
2usenet.network4.8 MB0.0 KB37.6 KB4.8 MB 99%10.4 KB
3news.dne3.net3.8 MB0.0 KB308.5 KB4.1 MB 92%2.7 KB
4news.corradoroberto.it2.1 MB0.0 KB0.0 KB2.1 MB100%7.2 KB
5usenet.blueworldhosting.com1.5 MB0.0 KB1.6 MB3.1 MB 48%2.4 KB
6i2pn.org1.4 MB0.0 KB124.5 KB1.5 MB 92%4.6 KB
7nntp.comgw.net1.3 MB0.0 KB664.1 KB2.0 MB 66%3.2 KB
8newsfeed.bofh.team1.0 MB0.0 KB345.6 KB1.4 MB 75%2.6 KB
9endoftheline-out.news.chmurka.net966.0 KB0.0 KB0.0 KB966.0 KB100%3.8 KB
10news.samoylyk.net961.6 KB0.0 KB108.8 KB1.0 MB 89%5.1 KB
11news.nntp4.net951.6 KB0.0 KB346.2 KB1.3 MB 73%2.6 KB
12usenet.goja.nl.eu.org944.2 KB0.0 KB340.9 KB1.3 MB 73%2.5 KB
13glockenspiel.complete.org860.8 KB0.0 KB308.0 KB1.1 MB 73%4.2 KB
14newsfeed.xs3.de623.3 KB0.0 KB209.5 KB832.8 KB 74%4.2 KB
15194.87.241.33442.8 KB0.0 KB615.1 KB1.0 MB 41%2.4 KB
16endofthelinebbs.peers.news.panix.com437.6 KB0.0 KB29.7 KB467.3 KB 93%2.6 KB
17news.hispagatos.org376.8 KB0.0 KB241.5 KB618.3 KB 60%3.3 KB
18news.furie.org.uk229.4 KB0.0 KB0.8 KB230.2 KB 99%3.6 KB
19peering.usenet.ovh112.6 KB0.0 KB73.3 KB185.9 KB 60%3.2 KB
20outgoing.news.lysator.liu.se52.2 KB0.0 KB120.9 KB173.1 KB 30%2.7 KB
21news.netfront.net47.9 KB0.0 KB875.4 KB923.3 KB 5%8.2 KB
22news.bbs.nz33.4 KB0.0 KB6.2 KB39.6 KB 84%2.2 KB
23photonic.trudheim.com14.6 KB0.0 KB0.0 KB14.6 KB100%4.9 KB
24eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
25localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
26news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2627.7 MB0.0 KB7.7 MB35.4 MB 78%3.6 KB
Incoming volume received by server

Incoming articles (innd):

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 19 00:01:01 - 00:59:59 115 1.6% 0.03447.1 KB 1.6% 0.13
Mar 19 01:00:00 - 01:59:59 204 2.8% 0.06627.9 KB 2.2% 0.17
Mar 19 02:00:00 - 02:59:59 249 3.5% 0.07916.4 KB 3.2% 0.25
Mar 19 03:00:00 - 03:59:59 291 4.0% 0.081.4 MB 5.2% 0.41
Mar 19 04:00:00 - 04:59:59 304 4.2% 0.081.1 MB 3.8% 0.30
Mar 19 05:00:00 - 05:59:59 323 4.5% 0.091.0 MB 3.6% 0.29
Mar 19 06:00:00 - 06:59:59 411 5.7% 0.111.3 MB 4.7% 0.37
Mar 19 07:00:00 - 07:59:59 355 4.9% 0.101.2 MB 4.5% 0.35
Mar 19 08:00:00 - 08:59:59 316 4.4% 0.091.1 MB 4.1% 0.32
Mar 19 09:00:00 - 09:59:59 403 5.6% 0.111.4 MB 4.9% 0.39
Mar 19 10:00:00 - 10:59:59 417 5.8% 0.121.7 MB 6.2% 0.49
Mar 19 11:00:00 - 11:59:59 432 6.0% 0.121.6 MB 5.6% 0.44
Mar 19 12:00:00 - 12:59:59 376 5.2% 0.101.2 MB 4.4% 0.34
Mar 19 13:00:00 - 13:59:59 631 8.8% 0.182.2 MB 7.9% 0.62
Mar 19 14:00:00 - 14:59:59 429 6.0% 0.121.6 MB 5.9% 0.46
Mar 19 15:00:00 - 15:59:59 333 4.6% 0.091.1 MB 4.0% 0.31
Mar 19 16:00:00 - 16:59:59 435 6.0% 0.121.8 MB 6.4% 0.51
Mar 19 17:00:00 - 17:59:59 298 4.1% 0.082.0 MB 7.4% 0.58
Mar 19 18:00:00 - 18:59:59 237 3.3% 0.071.2 MB 4.3% 0.34
Mar 19 19:00:00 - 19:59:59 161 2.2% 0.04660.1 KB 2.3% 0.18
Mar 19 20:00:00 - 20:59:59 164 2.3% 0.05708.0 KB 2.5% 0.20
Mar 19 21:00:00 - 21:59:59 132 1.8% 0.04628.4 KB 2.2% 0.17
Mar 19 22:00:00 - 22:59:59 75 1.0% 0.02422.6 KB 1.5% 0.12
Mar 19 23:00:00 - 23:59:59 97 1.3% 0.03387.6 KB 1.4% 0.11
Mar 20 00:00:00 - 00:01:02 3 0.0% 0.0512.2 KB 0.0% 0.20
TOTAL: 24:00:01 7191 100.0% 0.0827.6 MB 100.0% 0.33
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.3 GB 6.9% 0 0.5037230.97
CYCNGS3NGS1536.0 GB48.0 MB 0.0% 0 0.00 0.00
CYCTXT1TEXT5.0 GB4.2 GB 83.4% 0 0.04 1659.30
TOTAL: 4-4613.0 GB109.5 GB 2.4% 1 0.41-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 725 0 0 0 0 0 0 0 725
2endofthelinebbs-out.news.weretis.net 582 0 0 0 0 0 0 0 582
3194.87.241.33 275 0 0 0 0 0 0 0 275
4nntp.comgw.net 247 0 0 0 0 0 0 0 247
5newsfeed.bofh.team 183 0 0 0 0 0 0 0 183
6usenet.goja.nl.eu.org 178 0 0 0 0 0 0 0 178
7news.nntp4.net 149 1 0 0 0 0 0 0 148
8news.dne3.net 122 0 0 0 0 0 0 0 122
9glockenspiel.complete.org 118 0 0 0 0 0 0 0 118
10news.netfront.net 102 0 0 0 0 0 0 0 102
11news.hispagatos.org 91 19 0 0 0 0 0 0 72
12newsfeed.xs3.de 78 0 0 0 0 0 0 0 78
13i2pn.org 67 0 0 0 0 0 0 0 67
14outgoing.news.lysator.liu.se 47 0 0 0 0 0 0 0 47
15news.samoylyk.net 41 0 0 0 0 0 0 0 41
16usenet.network 29 0 0 0 0 0 0 0 29
17peering.usenet.ovh 28 0 0 0 0 0 0 0 28
18endofthelinebbs.peers.news.panix.com 22 0 0 0 0 0 0 0 22
19news.bbs.nz 15 0 0 0 0 0 0 0 15
20news.furie.org.uk 1 0 0 0 0 0 0 0 1
TOTAL: 20 3100 20 0 0 0 0 0 0 3080

Unwanted newsgroups [Top 20]:

NewsgroupCount
hispagatos.mastodon.tag.hacking 16
hispagatos.mastodon.tag.hackers 2
hispagatos.mastodon.tag.hispagatos 1
kiel.sex 1
TOTAL: 4 20

Perl filter (innd) [Top 20]:

ReasonCount
EMP (phn path) 2195
EMP (phr path) 335
Too many newsgroups 255
EMP (md5) 124
Too many newsgroups (meow) 56
User-issued cancel 38
Angle-bracket bot 28
HTML Multipart 1
TOTAL: 8 3032

NoCeM on spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
i2pn2-nocem@i2pn2.org (spam)20202
i2pn2-nocem@i2pn2.org (multipost)27002828
robot@pasdenom.info (spam2)20002222
i2pn2-nocem@i2pn2.org (rmp)20055
robot@pasdenom.info (spam4)20022
robot@pasdenom.info (spam3)10011
TOTAL: 654025860

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
nntp.comgw.net 18
endofthelinebbs-out.news.weretis.net 8
usenet.blueworldhosting.com 8
usenet.network 4
news.nntp4.net 4
news.netfront.net 2
newsfeed.bofh.team 1
news.dne3.net 1
usenet.goja.nl.eu.org 1
i2pn.org 1
TOTAL: 10 48
TOTAL: 1 48

Outgoing feeds (innfeed) by articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nyheter.lysator.liu.se 7576 2630 4044 489 0 38 34%23:59:03
2news.netfront.net 11714 1857 5311 0 0 182 15%23:58:53
3news.furie.org.uk 4338 1029 2385 25 0 0 23%23:59:50
4photonic.trudheim.com 8113 621 5134 1422 0 56 7%23:59:21
5peering.usenet.ovh 7779 569 6542 57 0 114 7%23:59:52
6news.dne3.net 6041 451 5020 289 0 1 7%23:58:56
7endofthelinebbs.peers.news.panix.com 7573 404 6756 14 0 0 5%23:59:53
8usenet.goja.nl.eu.org 7848 214 6291 34 0 39 2%23:59:53
9news.nntp4.net 7992 207 6538 3 0 156 2%23:59:53
10i2pn.org 7999 136 6697 59 0 337 1%23:59:53
11newsfeed.bofh.team 7914 113 6702 0 0 128 1%23:58:45
12news.corradoroberto.it 902 88 534 0 0 0 9%21:42:52
13news.bbs.nz 13158 82 6610 470 0 301 0%23:59:53
14news.nk.ca 10143 73 6554 443 0 185 0%23:59:53
15news.hispagatos.org 8630 53 6952 75 0 84 0%23:59:53
16usenet.network 8365 40 6265 25 0 28 0%23:59:52
17nntp.comgw.net 7257 36 6729 38 0 29 0%23:59:53
18news.weretis.net 7579 28 6915 233 0 9 0%23:59:42
19news.samoylyk.net 8663 26 6861 14 0 102 0%23:59:53
20news.tnetconsulting.net 9561 16 6880 276 0 116 0%23:59:53
21news.chmurka.net 4249 13 3058 0 0 2 0%23:59:53
22newsfeed.xs3.de 8802 12 6866 160 0 46 0%23:59:23
23news.quux.org 7203 12 6437 339 0 0 0%23:58:06
24usenet.blueworldhosting.com 7546 6 6391 0 0 78 0%23:58:26
25ddt.demos.su 21 1 20 0 0 0 4%03:14:20
26feed.opticnetworks.net 0 0 0 0 0 7179 0%23:59:53
TOTAL: 26 186966 8717 138492 4465 0 9210 4%600:45:57
Outgoing feeds (innfeed) by articles

Outgoing feeds (innfeed) by volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net9.9 MB0.0 KB9.9 MB0.1 KB/s5.4 KB23:58:53
2nyheter.lysator.liu.se8.1 MB4.6 MB12.7 MB0.2 KB/s4.2 KB23:59:03
3news.furie.org.uk6.7 MB124.1 KB6.8 MB0.1 KB/s6.6 KB23:59:50
4peering.usenet.ovh4.6 MB189.4 KB4.8 MB0.1 KB/s7.8 KB23:59:52
5endofthelinebbs.peers.news.panix.com3.2 MB39.5 KB3.2 MB0.0 KB/s7.9 KB23:59:53
6photonic.trudheim.com2.5 MB4.0 MB6.5 MB0.1 KB/s3.3 KB23:59:21
7news.dne3.net2.0 MB3.1 MB5.1 MB0.1 KB/s7.1 KB23:58:56
8newsfeed.bofh.team765.9 KB0.0 KB765.9 KB0.0 KB/s6.8 KB23:58:45
9news.samoylyk.net753.0 KB153.2 KB906.2 KB0.0 KB/s22.7 KB23:59:53
10nntp.comgw.net733.5 KB613.3 KB1.3 MB0.0 KB/s18.2 KB23:59:53
11news.quux.org704.3 KB2.4 MB3.1 MB0.0 KB/s9.1 KB23:58:06
12news.nntp4.net507.5 KB11.6 KB519.1 KB0.0 KB/s2.5 KB23:59:53
13i2pn.org440.4 KB291.5 KB731.9 KB0.0 KB/s3.8 KB23:59:53
14usenet.goja.nl.eu.org367.7 KB404.1 KB771.8 KB0.0 KB/s3.1 KB23:59:53
15news.bbs.nz233.5 KB3.7 MB3.9 MB0.0 KB/s7.2 KB23:59:53
16usenet.network215.5 KB78.2 KB293.6 KB0.0 KB/s4.5 KB23:59:52
17news.corradoroberto.it189.3 KB0.0 KB189.3 KB0.0 KB/s2.2 KB21:42:52
18news.hispagatos.org156.2 KB722.1 KB878.3 KB0.0 KB/s6.9 KB23:59:53
19news.nk.ca152.9 KB3.5 MB3.6 MB0.0 KB/s7.2 KB23:59:53
20news.weretis.net149.0 KB3.3 MB3.4 MB0.0 KB/s13.4 KB23:59:42
21news.chmurka.net65.1 KB0.0 KB65.1 KB0.0 KB/s5.0 KB23:59:53
22newsfeed.xs3.de40.9 KB1.2 MB1.2 MB0.0 KB/s7.2 KB23:59:23
23news.tnetconsulting.net38.6 KB2.7 MB2.8 MB0.0 KB/s9.7 KB23:59:53
24usenet.blueworldhosting.com12.5 KB0.0 KB12.5 KB0.0 KB/s2.1 KB23:58:26
25ddt.demos.su1.3 KB0.0 KB1.3 KB0.0 KB/s1.3 KB03:14:20
26feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
TOTAL: 2642.4 MB31.1 MB73.5 MB0.0 KB/s5.7 KB600:45:57
Outgoing feeds (innfeed) by volume

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

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved2806 00.0 KB 1 0 000:19:19
2*.probe.onyphe.net 2 00.0 KB 0 0 000:00:03
3*.ip.linodeusercontent.com 1 00.0 KB 0 0 000:00:01
4*localhost 1 00.0 KB 0 0 000:10:59
TOTAL: 42810 00.0 KB 1 0 000:30:24

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.207 34.619 0.00000:18:51
localhost 180.652 371.843 0.07600:10:59
198.235.24.121 0.010 0.005 0.00000:00:10
206.168.34.124 0.020 0.054 0.00000:00:08
167.94.146.57 0.024 0.031 0.00000:00:03
sam.probe.onyphe.net 0.004 0.026 0.00000:00:03
198.235.24.5 0.006 0.009 0.00000:00:02
2a06:4883:5000::62 0.000 0.017 0.00000:00:01
69-164-217-245.ip.linodeusercontent.com 0.008 0.012 0.00000:00:01
47.236.207.127 0.004 0.011 0.00000:00:01
47.245.107.139 0.004 0.011 0.00000:00:00
20.168.0.45 0.005 0.010 0.00000:00:00
TOTAL: 12 190.944 406.648 0.07600:30:24

Curious NNRP explorers [Top 20]:

SystemConn
2001:41d0:a:280::1 2794
167.94.146.57 3
206.168.34.124 3
sam.probe.onyphe.net 2
198.235.24.121 1
198.235.24.5 1
20.168.0.45 1
2a06:4883:5000::62 1
47.236.207.127 1
47.245.107.139 1
69-164-217-245.ip.linodeusercontent.com 1
localhost 1
TOTAL: 12 2810

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

SystemConn
sam.probe.onyphe.net 2
167.94.146.57 1
20.168.0.45 1
206.168.34.124 1
TOTAL: 4 5

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

CommandCount
EHLO www.censys.io 2
#026#003#003#001?#001 1
?$?,?r?s?#023#002#023#001?#024?#007?#022?#023?'?/?#024?(?0?`?a... 1
MGLNDD_144.172.126.95_119 1
TOTAL: 4 5

NNRP client timeouts [Top 20]:

SystemConnPeer
167.94.146.57 1 2
206.168.34.124 1 2
TOTAL: 2 2 6

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

HierarchyCountPct
1news 2100.0%
TOTAL: 1 2100.0%

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

NewsgroupCount
1news.admin.peering 2
TOTAL: 1 2