Daily Usenet Report

Feb 6 00:01:01 -- Feb 7 00:01:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Feb 6 08:15:44 newsfeed innd: message repeated 2 times: [ ctlinnd command s]
Feb 7 00:00:01 newsfeed nnrpd[2060459]: localhost auth: program exited with status 8

Log entries by program:

Program nameLines%LinesSize%Size
inn 9965 41.5%3.7 MB 62.8%
innd 7951 33.1%1.2 MB 19.5%
innfeed 4392 18.3%870.0 KB 14.2%
nnrpd 1247 5.2%145.2 KB 2.4%
cnfsstat 432 1.8%64.8 KB 1.1%
nocem 42 0.2%6.0 KB 0.1%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 7 24030 100.0%6.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 129925 62.2%
Negative hits 61549 29.4%
Do not exist 9886 4.7%
Cache misses 7685 3.7%
TOTAL: 4 209045 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.212 0.0%42 0.000 5.048 77.000
article cleanup00:00:00.453 0.0%9917 0.000 0.046 9.306
article logging00:00:00.459 0.0%9950 0.000 0.046 0.667
article parse00:00:00.256 0.0%14785 0.000 0.017 0.149
article write00:00:02.569 0.0%7446 0.000 0.345 5.286
artlog/artcncl00:00:00.001 0.0%9 0.000 0.111 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:01.103 0.0%195944 0.000 0.006 0.262
hisgrep/artcncl00:00:00.111 0.0%47 0.000 2.362 12.000
hishave/artcncl00:00:00.000 0.0%10 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:46.441 0.2%209339 0.104 0.795 4.920
history sync00:00:00.067 0.0%397 0.000 0.169 1.000
history write00:02:18.336 0.2%9892 2.969 13.985 109.577
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:39:43.544 98.8%188807 73.450 451.167 1770.973
nntp read00:00:02.984 0.0%196901 0.000 0.015 0.446
overview write00:10:47.639 0.8%7446 0.654 86.978 9777.848
perl filter00:00:50.424 0.1%9892 1.283 5.097 224.870
python filter00:00:04.942 0.0%9892 0.000 0.500 22.295
site send00:00:01.074 0.0%14928 0.000 0.072 0.265
TOTAL: 23:57:29.15123:56:40.615 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.243 0.0%74356 0.000 0.003 0.068
article prepare00:00:00.007 0.0%55509 0.000 0.000 0.013
article read00:00:00.786 0.0%4888 0.000 0.161 1.892
backlog stats00:00:00.751 0.0%441852 0.000 0.002 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:04.503 0.0%269231 0.000 0.017 0.053
data write00:00:06.071 0.0%263483 0.008 0.023 0.045
idle23:55:40.921100.0%441852 43.304 194.954 1177.406
status file00:00:00.476 0.0%377 0.500 1.263 11.500
TOTAL: 23:56:07.48423:55:53.758100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:02:34.722 18.9%876 0.000 176.623 10468.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.409 0.5%80599 0.000 0.055 0.333
TOTAL: 00:13:39.23800:02:39.131 19.4%----

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

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 3 14542 2699 11451 392 18%48:48:06
2glockenspiel.complete.org 3 6357 1096 5161 100 17%23:48:07
3usenet.blueworldhosting.com 289 9237 873 7683 681 9%23:47:43
4usenet.network 2 6434 500 5919 15 7%23:58:58
5nntp.comgw.net 2 8471 377 7890 204 4%23:59:51
6newsfeed.bofh.team 1 9093 339 8697 57 3%23:59:57
7news.corradoroberto.it 11 1325 326 999 0 24%24:49:22
8i2pn.org 1 8311 304 7941 66 3%23:59:55
9usenet.goja.nl.eu.org 11 8396 294 7978 124 3%24:04:08
10news.samoylyk.net 3 7439 163 7228 48 2%23:55:49
11194.87.241.33 45 634 150 400 84 23%14:35:36
12endoftheline-out.news.chmurka.net 1 3737 126 3609 2 3%23:59:57
13news.nntp4.net 6 14964 61 14343 560 0%16:50:33
14newsfeed.xs3.de 1 6731 58 6573 100 0%23:59:55
15endofthelinebbs.peers.news.panix.com 23 8103 49 8048 6 0%23:56:44
16news.netfront.net 1 7420 40 7314 66 0%26:02:29
17news.hispagatos.org 5 8599 37 8535 27 0%24:26:21
18news.furie.org.uk 2 4063 35 4027 1 0%23:59:14
19news.bbs.nz 1 7249 25 7220 4 0%23:59:49
20outgoing.news.lysator.liu.se 2 5030 3 5027 0 0%23:58:41
21photonic.trudheim.com 5 1777 1 1776 0 0%24:18:40
22localhost 28 0 0 0 0 0%00:00:00
23news.nk.ca 2 0 0 0 0 0%00:20:11
TOTAL: 23 448 147912 7556 137819 2537 5%515:40:06
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net7.6 MB0.0 KB724.0 KB8.3 MB 91%2.8 KB
2usenet.network4.7 MB0.0 KB18.1 KB4.7 MB 99%9.4 KB
3glockenspiel.complete.org4.2 MB0.0 KB320.0 KB4.5 MB 93%3.9 KB
4usenet.blueworldhosting.com2.4 MB2.2 KB1.6 MB4.0 MB 59%2.6 KB
5news.corradoroberto.it1.8 MB0.0 KB0.0 KB1.8 MB100%5.7 KB
6newsfeed.bofh.team1.2 MB0.0 KB112.6 KB1.3 MB 91%3.3 KB
7nntp.comgw.net988.3 KB1.2 KB394.8 KB1.4 MB 71%2.4 KB
8i2pn.org896.4 KB1.2 KB109.5 KB1007.0 KB 89%2.7 KB
9news.samoylyk.net812.6 KB0.0 KB116.0 KB928.6 KB 87%4.4 KB
10usenet.goja.nl.eu.org805.9 KB1.2 KB226.4 KB1.0 MB 77%2.5 KB
11endoftheline-out.news.chmurka.net477.6 KB0.0 KB1.2 KB478.9 KB 99%3.7 KB
12194.87.241.33386.9 KB0.0 KB220.9 KB607.8 KB 63%2.6 KB
13newsfeed.xs3.de258.3 KB0.0 KB424.1 KB682.4 KB 37%4.3 KB
14news.hispagatos.org168.3 KB1.2 KB67.4 KB236.9 KB 71%3.7 KB
15endofthelinebbs.peers.news.panix.com159.3 KB0.0 KB5.3 KB164.6 KB 96%3.0 KB
16news.furie.org.uk123.0 KB0.0 KB2.6 KB125.6 KB 97%3.5 KB
17news.nntp4.net122.7 KB0.0 KB1.1 MB1.3 MB 9%2.1 KB
18news.netfront.net117.3 KB40.2 KB215.3 KB372.8 KB 31%3.5 KB
19news.bbs.nz58.4 KB0.0 KB8.4 KB66.8 KB 87%2.3 KB
20outgoing.news.lysator.liu.se7.3 KB0.0 KB0.0 KB7.3 KB100%2.4 KB
21photonic.trudheim.com1.7 KB0.0 KB0.0 KB1.7 KB100%1.7 KB
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: 2327.1 MB47.2 KB5.6 MB32.8 MB 82%3.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 6 00:01:01 - 00:59:59 174 2.3% 0.05589.4 KB 2.2% 0.17
Feb 6 01:00:00 - 01:59:59 219 2.9% 0.06671.8 KB 2.5% 0.19
Feb 6 02:00:00 - 02:59:59 364 4.9% 0.101.2 MB 4.6% 0.34
Feb 6 03:00:00 - 03:59:59 395 5.3% 0.111.2 MB 4.4% 0.33
Feb 6 04:00:00 - 04:59:59 353 4.7% 0.101.2 MB 4.5% 0.34
Feb 6 05:00:00 - 05:59:59 335 4.5% 0.091.1 MB 4.3% 0.32
Feb 6 06:00:00 - 06:59:59 318 4.3% 0.09922.0 KB 3.4% 0.26
Feb 6 07:00:00 - 07:59:59 325 4.4% 0.091.2 MB 4.5% 0.34
Feb 6 08:00:00 - 08:59:59 350 4.7% 0.101.0 MB 3.8% 0.29
Feb 6 09:00:00 - 09:59:59 479 6.4% 0.132.0 MB 7.4% 0.56
Feb 6 10:00:00 - 10:59:59 445 6.0% 0.121.5 MB 5.6% 0.42
Feb 6 11:00:00 - 11:59:59 430 5.8% 0.121.7 MB 6.4% 0.48
Feb 6 12:00:00 - 12:59:59 416 5.6% 0.121.3 MB 4.8% 0.36
Feb 6 13:00:00 - 13:59:59 440 5.9% 0.121.6 MB 6.2% 0.47
Feb 6 14:00:00 - 14:59:59 427 5.7% 0.121.6 MB 6.0% 0.45
Feb 6 15:00:00 - 15:59:59 428 5.7% 0.121.5 MB 5.6% 0.42
Feb 6 16:00:00 - 16:59:59 367 4.9% 0.101.4 MB 5.2% 0.39
Feb 6 17:00:00 - 17:59:59 283 3.8% 0.081.3 MB 5.0% 0.38
Feb 6 18:00:00 - 18:59:59 176 2.4% 0.05667.2 KB 2.5% 0.19
Feb 6 19:00:00 - 19:59:59 162 2.2% 0.04953.9 KB 3.5% 0.26
Feb 6 20:00:00 - 20:59:59 140 1.9% 0.04615.9 KB 2.3% 0.17
Feb 6 21:00:00 - 21:59:59 140 1.9% 0.04501.3 KB 1.9% 0.14
Feb 6 22:00:00 - 22:59:59 132 1.8% 0.04438.4 KB 1.6% 0.12
Feb 6 23:00:00 - 23:59:59 152 2.0% 0.04507.1 KB 1.9% 0.14
Feb 7 00:00:00 - 00:01:01 1 0.0% 0.022.2 KB 0.0% 0.04
TOTAL: 24:00:00 7451 100.0% 0.0926.5 MB 100.0% 0.31
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 GB103.2 GB 6.7% 0 0.4838561.73
CYCTXT1TEXT5.0 GB4.0 GB 80.7% 0 0.03 2240.19
TOTAL: 3-3077.0 GB107.3 GB 3.5% 1 0.34-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 690 2 0 2 0 0 0 0 686
2news.nntp4.net 561 0 0 0 0 0 0 0 561
3endofthelinebbs-out.news.weretis.net 394 0 0 0 0 0 0 0 394
4nntp.comgw.net 199 0 0 1 0 0 0 0 198
5usenet.goja.nl.eu.org 125 0 0 1 0 0 0 0 124
6newsfeed.xs3.de 99 0 0 0 0 0 0 0 99
7glockenspiel.complete.org 93 0 0 0 0 0 0 0 93
8194.87.241.33 84 0 0 0 0 0 0 0 84
9i2pn.org 65 0 0 1 0 0 0 0 64
10newsfeed.bofh.team 56 5 0 0 0 0 0 0 51
11news.samoylyk.net 44 0 0 0 0 0 0 0 44
12news.netfront.net 35 0 0 19 0 0 0 0 16
13news.hispagatos.org 29 13 0 1 0 0 0 0 15
14usenet.network 18 0 0 0 0 0 0 0 18
15endofthelinebbs.peers.news.panix.com 6 1 0 0 0 0 0 0 5
16news.bbs.nz 4 0 0 0 0 0 0 0 4
17endoftheline-out.news.chmurka.net 2 0 0 0 0 0 0 0 2
18news.furie.org.uk 1 0 0 0 0 0 0 0 1
TOTAL: 18 2505 21 0 25 0 0 0 0 2459

Unwanted newsgroups [Top 20]:

NewsgroupCount
hispagatos.mastodon.tag.hacking 7
hispagatos.hacking.news 5
alt.online 2
alt.test.zen123 1
fidonet.apple 1
gmane.comp.web.iphone.devel 1
hispagatos.mastodon.tag.hackers 1
raminmbaneh0933gmail.com 1
sub.sys.apple 1
vmware.for-windowsnt.misc 1
TOTAL: 10 21

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 1475
EMP (phr path) 440
Too many newsgroups 179
EMP (md5) 177
EMP (phn nph) 112
User-issued cancel 26
Binary: misplaced binary 8
Too many newsgroups (meow) 3
Angle-bracket bot 2
HTML post 2
HTML Multipart 1
hierarchy violation - crosspost outside sdnet 1
TOTAL: 12 2426

NoCeM on Spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
robot@pasdenom.info (spam)30303
i2pn2-nocem@i2pn2.org (spam)20202
i2pn2-nocem@i2pn2.org (multipost)20002424
robot@pasdenom.info (spam3)7002020
i2pn2-nocem@i2pn2.org (rmp)30099
robot@pasdenom.info (spam2)10011
TOTAL: 636055459

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 20
usenet.blueworldhosting.com 9
glockenspiel.complete.org 1
news.nntp4.net 1
usenet.network 1
usenet.goja.nl.eu.org 1
TOTAL: 6 33
TOTAL: 1 33

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nyheter.lysator.liu.se 7872 3085 3919 444 0 0 39%23:59:54
2news.netfront.net 11886 2153 5260 2 0 10 18%23:59:54
3endofthelinebbs.peers.news.panix.com 7739 1068 6375 5 0 0 13%23:59:54
4news.furie.org.uk 4967 831 2823 9 0 0 16%23:59:23
5photonic.trudheim.com 8956 700 5429 1318 0 4 7%23:59:33
6usenet.goja.nl.eu.org 8487 229 6642 183 0 0 2%23:59:42
7news.nntp4.net 81367 208 7166 11 0 66778 0%23:59:54
8newsfeed.bofh.team 8049 194 6913 0 0 0 2%23:59:54
9news.corradoroberto.it 1256 152 711 0 0 18 12%22:36:04
10news.bbs.nz 13725 119 6787 515 0 50 0%23:59:26
11news.nk.ca 9908 88 6738 504 0 28 0%23:59:54
12news.hispagatos.org 8439 56 6968 387 0 0 0%23:59:54
13news.quux.org 5708 55 4866 427 0 3 0%23:59:54
14news.weretis.net 7822 49 7127 270 0 0 0%23:59:54
15usenet.network 8664 47 6465 21 0 0 0%23:59:32
16i2pn.org 8064 47 7037 49 0 10 0%23:59:52
17news.chmurka.net 4552 35 3375 0 0 0 0%23:58:30
18nntp.comgw.net 7501 34 6873 159 0 0 0%23:59:13
19newsfeed.xs3.de 9163 17 7120 243 0 0 0%23:59:54
20news.tnetconsulting.net 9855 16 7118 313 0 12 0%23:59:54
21news.samoylyk.net 9228 11 7198 12 0 2 0%23:59:54
22usenet.blueworldhosting.com 7231 5 6442 0 0 0 0%23:59:54
23ddt.demos.su 69 5 64 0 0 0 7%07:34:12
24feed.opticnetworks.net 0 0 0 0 0 7451 0%23:59:54
TOTAL: 24 250508 9204 129416 4872 0 74366 3%558:04:03
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nyheter.lysator.liu.se9.7 MB4.2 MB13.9 MB0.2 KB/s4.0 KB23:59:54
2news.netfront.net9.5 MB4.8 KB9.5 MB0.1 KB/s4.5 KB23:59:54
3news.furie.org.uk5.4 MB42.2 KB5.4 MB0.1 KB/s6.6 KB23:59:23
4endofthelinebbs.peers.news.panix.com4.6 MB10.1 KB4.7 MB0.1 KB/s4.4 KB23:59:54
5photonic.trudheim.com3.7 MB3.9 MB7.6 MB0.1 KB/s3.9 KB23:59:33
6newsfeed.bofh.team1.7 MB0.0 KB1.7 MB0.0 KB/s8.9 KB23:59:54
7news.bbs.nz614.3 KB3.2 MB3.8 MB0.0 KB/s6.1 KB23:59:26
8news.nntp4.net527.2 KB38.2 KB565.4 KB0.0 KB/s2.6 KB23:59:54
9usenet.goja.nl.eu.org521.8 KB1.8 MB2.3 MB0.0 KB/s5.6 KB23:59:42
10news.corradoroberto.it406.3 KB0.0 KB406.3 KB0.0 KB/s2.7 KB22:36:04
11news.weretis.net222.5 KB2.5 MB2.7 MB0.0 KB/s8.6 KB23:59:54
12news.nk.ca217.7 KB3.2 MB3.4 MB0.0 KB/s5.9 KB23:59:54
13news.hispagatos.org211.5 KB3.6 MB3.8 MB0.0 KB/s8.7 KB23:59:54
14news.quux.org176.5 KB2.7 MB2.8 MB0.0 KB/s6.0 KB23:59:54
15usenet.network160.5 KB88.0 KB248.5 KB0.0 KB/s3.7 KB23:59:32
16i2pn.org135.2 KB287.3 KB422.5 KB0.0 KB/s4.4 KB23:59:52
17news.chmurka.net100.8 KB0.0 KB100.8 KB0.0 KB/s2.9 KB23:58:30
18nntp.comgw.net81.8 KB1.6 MB1.6 MB0.0 KB/s8.7 KB23:59:13
19newsfeed.xs3.de68.2 KB2.0 MB2.1 MB0.0 KB/s8.3 KB23:59:54
20news.samoylyk.net57.5 KB41.7 KB99.3 KB0.0 KB/s4.3 KB23:59:54
21news.tnetconsulting.net55.7 KB2.7 MB2.8 MB0.0 KB/s8.7 KB23:59:54
22usenet.blueworldhosting.com15.9 KB0.0 KB15.9 KB0.0 KB/s3.2 KB23:59:54
23ddt.demos.su8.2 KB0.0 KB8.2 KB0.0 KB/s1.6 KB07:34:12
24feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
TOTAL: 2438.1 MB31.7 MB69.8 MB0.0 KB/s5.1 KB558:04:03
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1news.nntp4.net 282 00.0 KB 0 0 000:01:39
2162.142.125.113 4 00.0 KB 0 0 000:00:12
3199.45.155.106 3 00.0 KB 0 0 000:00:05
431.43.185.3 3 00.0 KB 0 0 000:00:00
5185.165.191.26 1 00.0 KB 0 0 000:00:00
6205.210.31.194 1 00.0 KB 0 0 000:00:00
7205.210.31.237 1 00.0 KB 0 0 000:00:04
8205.210.31.88 1 00.0 KB 0 0 000:00:10
92607:ff10:c8:594::d 1 00.0 KB 0 0 000:00:01
1080.66.76.121 1 00.0 KB 0 0 000:00:00
11faulkner.probe.onyphe.net 1 00.0 KB 0 0 000:00:02
12localhost 1 00.0 KB 0 0 000:10:58
13maizie.probe.onyphe.net 1 00.0 KB 0 0 000:00:21
14ruben.probe.onyphe.net 1 00.0 KB 0 0 000:00:03
TOTAL: 14 302 00.0 KB 0 0 000:13:39

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.nntp4.net 282 00.0 KB 0 0 000:01:39
2unresolved 15 00.0 KB 0 0 000:00:33
3*.probe.onyphe.net 3 00.0 KB 0 0 000:00:27
4? 2 00.0 KB 0 0 000:10:59
TOTAL: 4 302 00.0 KB 0 0 000:13:39

NNRP auth users [Top 20]:

UserConn
getlist 1
TOTAL: 1 1

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
localhost 179.170 368.079 0.07900:10:58
news.nntp4.net 0.994 4.385 0.00000:01:39
maizie.probe.onyphe.net 0.000 0.016 0.00000:00:21
162.142.125.113 0.026 0.050 0.00000:00:12
205.210.31.88 0.000 0.017 0.00000:00:10
199.45.155.106 0.024 0.042 0.00000:00:05
205.210.31.237 0.014 0.025 0.00000:00:04
ruben.probe.onyphe.net 0.003 0.013 0.00000:00:03
faulkner.probe.onyphe.net 0.004 0.013 0.00000:00:02
2607:ff10:c8:594::d 0.007 0.021 0.00000:00:01
31.43.185.3 0.012 0.036 0.00000:00:00
205.210.31.194 0.008 0.008 0.00000:00:00
185.165.191.26 0.004 0.012 0.00000:00:00
80.66.76.121 0.004 0.015 0.00000:00:00
? 0.000 0.015 0.00000:00:00
TOTAL: 15 180.270 372.747 0.07900:13:39

NNRP gethostbyaddr failures [Top 20]:

SystemConn
? (can't getpeername) 1
TOTAL: 1 1

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

SystemConn
maizie.probe.onyphe.net 6
31.43.185.3 3
199.45.155.106 1
80.66.76.121 1
TOTAL: 4 11

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

CommandCount
#003 4
Accept-Language: en-US,en;q=0.5 1
Accept: text/html,application/xhtml+xml,... 1
Connection: close 1
EHLO www.censys.io 1
GET / HTTP/1.1 1
Host: 2602:fe64:8::7:119 1
User-Agent: Mozilla/5.0 (X11; Ubuntu; Li... 1
TOTAL: 8 11

NNRP client timeouts [Top 20]:

SystemConnPeer
31.43.185.3 3 3
162.142.125.113 1 4
199.45.155.106 1 2
80.66.76.121 1 1
TOTAL: 4 6 12