Daily Usenet Report

Nov 9 00:01:01 -- Nov 10 00:01:01

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Nov 9 08:24:55 newsfeed innd: message repeated 2 times: [ ctlinnd command s]
Nov 9 11:50:07 newsfeed nnrpd[3572514]: 47.186.35.210 auth: program exited with status 8
Nov 9 14:12:01 newsfeed nnrpd[3618025]: 47.186.35.210 auth: program exited with status 8
Nov 9 14:12:01 newsfeed nnrpd[3618024]: 47.186.35.210 auth: program exited with status 8
Nov 9 14:12:01 newsfeed nnrpd[3618026]: 47.186.35.210 auth: program exited with status 8
Nov 9 14:12:01 newsfeed nnrpd[3618027]: 47.186.35.210 auth: program exited with status 8
Nov 10 00:00:01 newsfeed nnrpd[3769444]: localhost auth: program exited with status 8

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 14007 36.3%1.9 MB 23.7%
inn 10969 28.5%3.8 MB 47.9%
innd 8360 21.7%1.2 MB 15.5%
innfeed 4339 11.3%834.4 KB 10.2%
nocem 435 1.1%161.1 KB 2.0%
cnfsstat 432 1.1%63.9 KB 0.8%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 38543 100.0%8.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 124170 66.3%
Negative hits 54215 29.0%
Do not exist 8615 4.6%
Cache misses 212 0.1%
TOTAL: 4 187212 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.533 0.0%2989 0.000 0.847 21.152
article cleanup00:00:00.154 0.0%8668 0.000 0.018 0.378
article logging00:00:00.480 0.0%8719 0.000 0.055 1.235
article parse00:00:00.207 0.0%13163 0.000 0.016 0.087
article write00:00:02.027 0.0%7383 0.000 0.275 3.714
artlog/artcncl00:00:00.071 0.0%2254 0.000 0.031 0.500
artlog/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
data move00:00:02.030 0.0%187341 0.000 0.011 0.705
hisgrep/artcncl00:00:01.638 0.0%2952 0.000 0.555 18.909
hishave/artcncl00:00:00.402 0.0%2975 0.000 0.135 3.122
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:27.556 0.2%185128 0.101 0.797 5.063
history sync00:00:00.095 0.0%409 0.000 0.232 4.000
history write00:01:59.643 0.1%8611 3.116 13.894 147.421
hiswrite/artcncl00:00:00.101 0.0%40 2.000 2.525 2.667
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:46:31.710 99.0%186280 81.810 459.479 2018.377
nntp read00:00:04.160 0.0%188405 0.002 0.022 0.215
overview write00:08:04.482 0.6%7383 0.556 65.621 20190.583
perl filter00:00:47.089 0.1%8610 1.591 5.469 156.433
python filter00:00:02.892 0.0%8610 0.000 0.336 12.983
site send00:00:01.312 0.0%14990 0.000 0.088 3.419
TOTAL: 24:01:08.21624:00:08.582 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.018 0.0%8067 0.000 0.002 0.059
article prepare00:00:00.005 0.0%46384 0.000 0.000 0.004
article read00:00:00.601 0.0%4392 0.000 0.137 0.647
backlog stats00:00:00.424 0.0%281840 0.000 0.002 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.441 0.0%189673 0.003 0.013 0.041
data write00:00:03.343 0.0%185773 0.008 0.018 0.071
idle23:56:26.464100.0%281840 124.239 305.799 1184.768
status file00:00:00.499 0.0%348 0.889 1.434 32.000
TOTAL: 23:56:44.15423:56:33.795100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:01:25.193 82.6%8464 0.750 435.396 19251.833
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.256 0.1%95761 0.000 0.044 1.000
readart00:00:00.165 0.0%237 0.696 0.696 0.696
TOTAL: 01:14:23.00401:01:29.614 82.7%----

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 2 14254 2014 12138 102 14%47:32:05
2usenet.goja.nl.eu.org 12 8222 1082 6894 246 13%25:47:24
3usenet.blueworldhosting.com 718 8409 828 7097 484 9%23:51:20
4glockenspiel.complete.org 2 9841 703 9125 13 7%34:11:39
5nntp.comgw.net 3 8170 478 7571 121 5%23:49:40
6newsfeed.bofh.team 1 8490 438 7958 94 5%23:59:56
7i2pn.org 2 7231 418 6754 59 5%23:58:34
8news.corradoroberto.it 2 1259 345 911 3 27%24:08:06
9newsfeed.xs3.de 2 6560 307 6224 29 4%23:59:43
10194.87.241.33 39 368 261 107 0 70%17:01:23
11news.nntp4.net 2 6831 190 6613 28 2%23:59:11
12usenet.network 1 5350 163 5181 6 3%23:59:58
13endofthelinebbs.peers.news.panix.com 26 7993 95 7847 51 1%23:55:29
14endoftheline-out.news.chmurka.net 3 4482 81 4398 3 1%26:32:05
15news.hispagatos.org 6 8187 61 8089 37 0%24:26:15
16news.samoylyk.net 2 7159 61 7095 3 0%23:59:37
17news.netfront.net 4 6238 46 6146 46 0%22:42:45
18news.bbs.nz 1 7200 7 7193 0 0%23:59:42
19outgoing.news.lysator.liu.se 2 6709 6 6700 3 0%23:59:46
20news.furie.org.uk 1 3721 5 3712 4 0%23:59:57
21eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:03
22localhost 28 0 0 0 0 0%00:00:00
23news.nk.ca 2 0 0 0 0 0%00:20:12
TOTAL: 23 862 136674 7589 127753 1332 5%510:24:50
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net5.9 MB12.9 KB196.4 KB6.1 MB 96%3.0 KB
2glockenspiel.complete.org3.7 MB11.7 KB8.9 KB3.7 MB 99%5.3 KB
3usenet.goja.nl.eu.org2.9 MB13.0 KB338.4 KB3.3 MB 89%2.5 KB
4usenet.blueworldhosting.com2.7 MB0.0 KB1.3 MB4.0 MB 68%3.1 KB
5news.corradoroberto.it2.6 MB9.6 KB0.0 KB2.7 MB 99%7.8 KB
6usenet.network2.2 MB12.8 KB4.7 KB2.3 MB 99%13.7 KB
7nntp.comgw.net1.8 MB12.8 KB270.4 KB2.1 MB 86%3.5 KB
8newsfeed.bofh.team1.2 MB12.9 KB141.3 KB1.4 MB 89%2.7 KB
9i2pn.org1.0 MB12.8 KB71.2 KB1.1 MB 92%2.4 KB
10newsfeed.xs3.de874.6 KB2.0 KB38.4 KB915.1 KB 95%2.7 KB
11news.samoylyk.net653.7 KB3.7 KB1.1 KB658.5 KB 99%10.3 KB
12194.87.241.33646.7 KB0.0 KB0.0 KB646.7 KB100%2.5 KB
13news.nntp4.net516.7 KB13.0 KB22.7 KB552.4 KB 93%2.5 KB
14endofthelinebbs.peers.news.panix.com256.1 KB0.0 KB78.9 KB335.0 KB 76%2.3 KB
15endoftheline-out.news.chmurka.net219.4 KB0.0 KB1.9 KB221.3 KB 99%2.6 KB
16news.hispagatos.org148.5 KB0.0 KB58.5 KB207.1 KB 71%2.1 KB
17news.netfront.net84.5 KB1.3 KB175.1 KB260.8 KB 32%2.8 KB
18news.furie.org.uk39.7 KB11.9 KB0.0 KB51.6 KB 76%5.7 KB
19news.bbs.nz16.8 KB0.0 KB0.0 KB16.8 KB100%2.4 KB
20outgoing.news.lysator.liu.se10.9 KB9.7 KB0.0 KB20.6 KB 52%2.3 KB
21eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
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.6 MB140.2 KB2.6 MB30.3 MB 90%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 9 00:01:01 - 00:59:59 155 2.1% 0.04608.7 KB 2.2% 0.17
Nov 9 01:00:00 - 01:59:59 231 3.1% 0.061.3 MB 4.7% 0.36
Nov 9 02:00:00 - 02:59:59 333 4.5% 0.091.1 MB 4.0% 0.30
Nov 9 03:00:00 - 03:59:59 296 4.0% 0.08716.2 KB 2.6% 0.20
Nov 9 04:00:00 - 04:59:59 333 4.5% 0.09745.7 KB 2.7% 0.21
Nov 9 05:00:00 - 05:59:59 383 5.2% 0.113.0 MB 11.1% 0.84
Nov 9 06:00:00 - 06:59:59 385 5.2% 0.111.1 MB 4.0% 0.31
Nov 9 07:00:00 - 07:59:59 308 4.2% 0.09830.2 KB 3.0% 0.23
Nov 9 08:00:00 - 08:59:59 397 5.4% 0.111.2 MB 4.6% 0.35
Nov 9 09:00:00 - 09:59:59 317 4.3% 0.091.1 MB 4.1% 0.32
Nov 9 10:00:00 - 10:59:59 453 6.1% 0.131.7 MB 6.4% 0.49
Nov 9 11:00:00 - 11:59:59 478 6.5% 0.131.7 MB 6.5% 0.49
Nov 9 12:00:00 - 12:59:59 541 7.3% 0.151.7 MB 6.5% 0.49
Nov 9 13:00:00 - 13:59:59 452 6.1% 0.132.1 MB 7.7% 0.58
Nov 9 14:00:00 - 14:59:59 389 5.3% 0.112.0 MB 7.5% 0.57
Nov 9 15:00:00 - 15:59:59 374 5.1% 0.101.4 MB 5.2% 0.39
Nov 9 16:00:00 - 16:59:59 299 4.1% 0.08848.9 KB 3.1% 0.24
Nov 9 17:00:00 - 17:59:59 217 2.9% 0.06727.7 KB 2.7% 0.20
Nov 9 18:00:00 - 18:59:59 309 4.2% 0.09817.6 KB 3.0% 0.23
Nov 9 19:00:00 - 19:59:59 169 2.3% 0.05574.8 KB 2.1% 0.16
Nov 9 20:00:00 - 20:59:59 164 2.2% 0.05545.8 KB 2.0% 0.15
Nov 9 21:00:00 - 21:59:59 142 1.9% 0.04498.3 KB 1.8% 0.14
Nov 9 22:00:00 - 22:59:59 146 2.0% 0.04401.1 KB 1.5% 0.11
Nov 9 23:00:00 - 23:59:59 99 1.3% 0.03267.0 KB 1.0% 0.07
Nov 10 00:00:00 - 00:01:01 6 0.1% 0.1017.1 KB 0.1% 0.28
TOTAL: 24:00:00 7376 100.0% 0.0926.7 MB 100.0% 0.32
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 GB99.7 GB 6.5% 0 0.4937748.82
CYCTXT1TEXT5.0 GB3.9 GB 78.5% 0 0.03 2370.48
TOTAL: 3-3077.0 GB103.6 GB 3.4% 1 0.38-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 491 44 0 0 0 0 0 0 447
2usenet.goja.nl.eu.org 220 0 0 5 0 0 0 0 215
3nntp.comgw.net 121 0 0 5 0 0 0 0 116
4endofthelinebbs-out.news.weretis.net 118 0 0 5 0 0 0 0 113
5newsfeed.bofh.team 95 0 0 5 0 0 0 0 90
6i2pn.org 57 0 0 5 0 0 0 0 52
7endofthelinebbs.peers.news.panix.com 50 30 0 0 0 0 0 0 20
8news.netfront.net 47 0 0 1 0 0 0 0 46
9news.hispagatos.org 36 26 0 0 0 0 0 0 10
10newsfeed.xs3.de 35 0 0 1 0 0 0 0 34
11news.nntp4.net 29 0 0 5 0 0 0 0 24
12glockenspiel.complete.org 12 0 0 4 0 0 0 0 8
13usenet.network 6 0 0 5 0 0 0 0 1
14news.bbs.nz 5 0 0 5 0 0 0 0 0
15news.furie.org.uk 4 0 0 4 0 0 0 0 0
16endoftheline-out.news.chmurka.net 3 0 0 0 0 0 0 0 3
17news.corradoroberto.it 3 0 0 3 0 0 0 0 0
18news.samoylyk.net 3 0 0 2 0 0 0 0 1
19outgoing.news.lysator.liu.se 3 0 0 3 0 0 0 0 0
TOTAL: 19 1338 100 0 58 0 0 0 0 1180

Unwanted newsgroups [Top 20]:

NewsgroupCount
de.sci.announce 73
hispagatos.mastodon.tag.hacking 12
hispagatos.hacking.ctf 10
hispagatos.hacking.news 3
atl.binaries.android 1
hispagatos.mastodon.tag.hackers 1
TOTAL: 6 100

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 474
EMP (phr path) 363
EMP (md5) 163
Too many newsgroups 82
User-issued cancel 36
Too many newsgroups (meow) 7
HTML Multipart 3
TOTAL: 7 1128

NoCeM on Spool:

Issuer (type)NoticesBad PGPCancelSkipTotal
i2pn2-nocem@i2pn2.org (spam)1350224502245
nocem@eternal-september.org (bot)7407280728
i2pn2-nocem@i2pn2.org (multipost)9001111
robot@pasdenom.info (spam3)4001010
i2pn2-nocem@i2pn2.org (rmp)30077
TOTAL: 522502973283001

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 17
usenet.goja.nl.eu.org 10
usenet.blueworldhosting.com 7
nntp.comgw.net 6
newsfeed.xs3.de 6
newsfeed.bofh.team 2
glockenspiel.complete.org 1
news.nntp4.net 1
news.hispagatos.org 1
TOTAL: 9 51
No colon-space in header field
usenet.blueworldhosting.com 1
TOTAL: 1 1
TOTAL: 2 52

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 11949 1803 5519 8 0 237 15%23:59:53
2nyheter.lysator.liu.se 7823 1184 5935 251 0 33 15%23:57:52
3photonic.trudheim.com 8635 878 4968 1526 0 0 10%23:59:52
4news.furie.org.uk 4486 804 2558 6 0 4 17%23:57:48
5endofthelinebbs.peers.news.panix.com 7771 473 6890 3 0 0 6%23:59:54
6news.corradoroberto.it 1482 321 693 2 0 5 21%23:51:53
7usenet.goja.nl.eu.org 7887 319 5883 98 0 0 4%23:59:53
8news.bbs.nz 13552 293 6625 446 0 100 2%23:59:47
9news.hispagatos.org 8540 205 6970 136 0 4 2%23:59:34
10news.nk.ca 10232 197 6611 370 0 58 1%23:59:53
11newsfeed.bofh.team 8151 164 6773 2 0 4 2%23:59:53
12usenet.network 8913 158 6538 90 0 4 1%23:59:53
13news.nntp4.net 8513 151 6974 27 0 3 1%23:59:43
14nntp.comgw.net 7792 125 6729 59 0 120 1%23:59:53
15news.tnetconsulting.net 8442 112 7127 126 0 4 1%23:58:54
16news.weretis.net 7713 101 7190 84 0 0 1%23:58:49
17news.quux.org 5750 95 4941 389 0 0 1%23:59:54
18i2pn.org 8150 72 6774 95 0 72 0%23:59:54
19newsfeed.xs3.de 8584 62 6821 182 0 4 0%23:58:50
20news.chmurka.net 5138 34 3897 2 0 3 0%23:59:53
21news.samoylyk.net 9774 24 7142 115 0 43 0%23:59:40
22usenet.blueworldhosting.com 6999 7 6334 1 0 0 0%23:57:47
23ddt.demos.su 67 7 49 0 0 0 10%06:40:50
24feed.opticnetworks.net 0 0 0 0 0 7376 0%23:59:53
TOTAL: 24 176343 7589 129941 4018 0 8074 4%558:20:05
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net8.7 MB32.9 KB8.7 MB0.1 KB/s4.9 KB23:59:53
2nyheter.lysator.liu.se6.0 MB1.6 MB7.6 MB0.1 KB/s5.4 KB23:57:52
3photonic.trudheim.com4.9 MB4.7 MB9.6 MB0.1 KB/s4.1 KB23:59:52
4news.furie.org.uk4.4 MB126.6 KB4.5 MB0.1 KB/s5.7 KB23:57:48
5news.quux.org2.1 MB1.1 MB3.2 MB0.0 KB/s6.8 KB23:59:54
6endofthelinebbs.peers.news.panix.com1.9 MB5.7 KB1.9 MB0.0 KB/s4.2 KB23:59:54
7news.bbs.nz1.4 MB2.5 MB3.9 MB0.0 KB/s5.4 KB23:59:47
8newsfeed.bofh.team1.4 MB8.6 KB1.5 MB0.0 KB/s9.0 KB23:59:53
9news.nntp4.net1.2 MB439.3 KB1.6 MB0.0 KB/s9.5 KB23:59:43
10news.samoylyk.net1.2 MB307.5 KB1.5 MB0.0 KB/s11.0 KB23:59:40
11news.hispagatos.org1.1 MB976.6 KB2.0 MB0.0 KB/s6.1 KB23:59:34
12news.corradoroberto.it932.1 KB3.1 KB935.2 KB0.0 KB/s2.9 KB23:51:53
13ddt.demos.su906.8 KB0.0 KB906.8 KB0.0 KB/s129.5 KB06:40:50
14usenet.goja.nl.eu.org834.0 KB730.3 KB1.5 MB0.0 KB/s3.8 KB23:59:53
15news.nk.ca829.7 KB2.1 MB2.9 MB0.0 KB/s5.2 KB23:59:53
16nntp.comgw.net824.3 KB1.3 MB2.1 MB0.0 KB/s11.5 KB23:59:53
17newsfeed.xs3.de782.6 KB1.5 MB2.2 MB0.0 KB/s9.3 KB23:58:50
18usenet.network684.2 KB124.7 KB808.8 KB0.0 KB/s3.3 KB23:59:53
19news.tnetconsulting.net677.6 KB663.1 KB1.3 MB0.0 KB/s5.6 KB23:58:54
20news.weretis.net595.2 KB1.8 MB2.4 MB0.0 KB/s13.4 KB23:58:49
21i2pn.org308.2 KB401.3 KB709.4 KB0.0 KB/s4.2 KB23:59:54
22news.chmurka.net78.1 KB8.6 KB86.7 KB0.0 KB/s2.4 KB23:59:53
23usenet.blueworldhosting.com45.8 KB1.6 KB47.4 KB0.0 KB/s5.9 KB23:57:47
24feed.opticnetworks.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
TOTAL: 2441.7 MB20.3 MB62.0 MB0.0 KB/s5.5 KB558:20:05
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
12001:470:28:a8:3ad5:47ff:fe02:c2fd2774 00.0 KB 0 0 000:21:26
2162.142.125.42 3 00.0 KB 0 0 000:00:05
3205.210.31.218 1 00.0 KB 0 0 000:00:10
4205.210.31.231 1 00.0 KB 0 0 000:00:10
547.186.35.210 1 00.0 KB 0 0 000:40:27
691.238.181.32 1 00.0 KB 0 0 000:00:00
7azpdwgc16.stretchoid.com 1 00.0 KB 0 0 000:00:00
8localhost 1 00.0 KB 0 0 000:11:59
9server-0-3.survey.inspici.com 1 00.0 KB 0 0 000:00:03
TOTAL: 92784 00.0 KB 0 0 001:14:21

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1?2775 00.0 KB 0 0 000:33:25
2unresolved 6 00.0 KB 0 0 000:00:25
3*.stretchoid.com 1 00.0 KB 0 0 000:00:00
4*.survey.inspici.com 1 00.0 KB 0 0 000:00:03
TOTAL: 42783 00.0 KB 0 0 000:33:54

NNRP auth users [Top 20]:

UserConn
nelgin 5
getlist 1
TOTAL: 2 6

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
47.186.35.210 0.027 0.148 0.47000:40:27
2001:470:28:a8:3ad5:47ff:fe02:c2fd 9.671 38.092 0.00000:21:26
localhost 180.441 370.502 0.07600:11:59
205.210.31.218 0.003 0.013 0.00000:00:10
205.210.31.231 0.003 0.024 0.00000:00:10
162.142.125.42 0.012 0.049 0.00000:00:05
server-0-3.survey.inspici.com 0.000 0.017 0.00000:00:03
91.238.181.32 0.004 0.012 0.00000:00:00
azpdwgc16.stretchoid.com 0.000 0.016 0.00000:00:00
TOTAL: 9 190.161 408.873 0.54601:14:21

NNRP no permission clients [Top 20]:

SystemConn
47.186.35.210 4
TOTAL: 1 4

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

SystemConn
162.142.125.42 1
91.238.181.32 1
azpdwgc16.stretchoid.com 1
TOTAL: 3 3

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

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

NNRP client timeouts [Top 20]:

SystemConnPeer
162.142.125.42 1 2
91.238.181.32 1 1
TOTAL: 2 2 3