Daily Usenet Report

Nov 20 00:01:02 -- Nov 21 00:01:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Nov 20 00:05:59 www innd: message repeated 2 times: [ ctlinnd command s]
Nov 20 13:53:20 www nnrpd[3790036]: unable to get certificates from '/news/etc/cert.pem'
Nov 20 13:53:20 www nnrpd[3790036]: error initializing TLS: [CA_file: ] [CA_path: /news/etc] [cert_file: /news/etc/cert.pem] [key_file: /news/etc/key.pem]

Log entries by program:

Program nameLines%LinesSize%Size
inn 12332 65.6%3.2 MB 76.8%
innd 4019 21.4%584.0 KB 13.5%
innfeed 2314 12.3%412.3 KB 9.5%
nnrpd 135 0.7%10.6 KB 0.2%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 18801 100.0%4.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 85985 57.4%
Negative hits 51824 34.6%
Do not exist 11988 8.0%
Cache misses 45 0.0%
TOTAL: 4 149842 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.068 0.0%41 0.000 1.659 6.000
article cleanup00:00:00.258 0.0%12034 0.000 0.021 0.143
article logging00:00:00.682 0.0%12293 0.000 0.055 0.188
article parse00:00:00.626 0.0%26733 0.000 0.023 0.111
article write00:00:08.461 0.0%10158 0.437 0.833 3.135
artlog/artcncl00:00:00.005 0.0%41 0.000 0.122 1.000
data move00:00:00.244 0.0%161819 0.000 0.002 0.008
hisgrep/artcncl00:00:00.009 0.0%39 0.000 0.231 1.000
hishave/artcncl00:00:00.005 0.0%41 0.000 0.122 0.625
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.361 0.0%150339 0.004 0.042 0.091
history sync00:00:00.069 0.0%388 0.000 0.178 1.333
history write00:00:07.069 0.0%12027 0.088 0.588 1.038
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle23:58:29.022 99.8%158055 140.223 546.070 2886.841
nntp read00:00:08.442 0.0%159139 0.031 0.053 0.126
overview write00:00:06.591 0.0%10158 0.250 0.649 5.216
perl filter00:00:37.369 0.0%12027 2.044 3.107 6.647
python filter00:00:02.351 0.0%12027 0.025 0.195 0.647
site send00:00:03.964 0.0%20316 0.030 0.195 0.564
TOTAL: 24:01:04.08023:59:51.596 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.177 0.0%10243 0.000 0.017 0.200
article prepare00:00:00.003 0.0%31076 0.000 0.000 0.011
article read00:00:01.409 0.0%4984 0.071 0.283 2.261
backlog stats00:00:00.529 0.0%214132 0.000 0.002 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:05.984 0.0%143629 0.019 0.042 0.084
data write00:00:21.236 0.0%134801 0.109 0.158 0.267
idle23:57:15.209100.0%214132 174.975 402.720 1921.585
status file00:00:00.212 0.0%188 0.000 1.128 5.000
TOTAL: 23:57:55.38623:57:44.759100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:29.942 96.8%8 106.667 3742.750 10043.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.001 0.0%25 0.000 0.040 0.500
TOTAL: 00:00:30.93000:00:29.943 96.8%----

Control commands to INND:

CommandNumber
flush 4
flushlogs 2
go 2
logmode 2
lowmark 1
mode 146
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 167

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 4 21579 5984 15211 384 27%53:27:39
2usenet.blueworldhosting.com 5 11339 3263 7562 514 28%23:39:21
3newsfeed.xs3.de 2 9393 547 8838 8 5%23:59:52
4outgoing.news.lysator.liu.se 2 11560 413 10589 558 3%23:59:43
5news.samoylyk.net 1 9625 38 9586 1 0%23:59:51
6glockenspiel.complete.org 1 9793 18 9775 0 0%23:59:52
7news.netfront.net 1 11137 7 10759 371 0%21:49:34
8news.furie.org.uk 2 5636 6 5630 0 0%23:58:45
9news.bbs.nz 3 8290 2 8288 0 0%20:11:31
10news.nk.ca 2 0 0 0 0 0%00:20:01
11localhost 25 0 0 0 0 0%00:00:00
12eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:03
TOTAL: 12 49 98352 10278 86238 1836 10%239:36:12
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net20.8 MB8.9 KB1.0 MB21.8 MB 95%3.5 KB
2usenet.blueworldhosting.com17.1 MB0.0 KB1.6 MB18.7 MB 91%5.1 KB
3newsfeed.xs3.de2.2 MB5.3 KB20.1 KB2.2 MB 98%4.1 KB
4outgoing.news.lysator.liu.se738.3 KB0.0 KB2.2 MB2.9 MB 24%3.1 KB
5news.samoylyk.net424.0 KB3.1 KB3.1 KB430.2 KB 98%11.0 KB
6glockenspiel.complete.org357.4 KB0.0 KB0.0 KB357.4 KB100%19.9 KB
7news.furie.org.uk27.9 KB0.0 KB0.0 KB27.9 KB100%4.6 KB
8news.netfront.net14.2 KB0.0 KB90.4 MB90.5 MB 0%245.1 KB
9news.bbs.nz2.0 KB0.0 KB0.0 KB2.0 KB100%1.0 KB
10news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
11localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
12eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1241.6 MB17.3 KB95.3 MB136.9 MB 30%11.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 20 00:01:02 - 00:59:59 211 2.1% 0.06816.5 KB 1.9% 0.23
Nov 20 01:00:00 - 01:59:59 275 2.7% 0.081.2 MB 2.9% 0.33
Nov 20 02:00:00 - 02:59:59 367 3.6% 0.10994.8 KB 2.4% 0.28
Nov 20 03:00:00 - 03:59:59 510 5.0% 0.142.2 MB 5.4% 0.63
Nov 20 04:00:00 - 04:59:59 499 4.9% 0.142.0 MB 4.8% 0.56
Nov 20 05:00:00 - 05:59:59 454 4.5% 0.131.7 MB 4.0% 0.47
Nov 20 06:00:00 - 06:59:59 493 4.9% 0.141.5 MB 3.7% 0.43
Nov 20 07:00:00 - 07:59:59 490 4.8% 0.141.7 MB 4.0% 0.47
Nov 20 08:00:00 - 08:59:59 557 5.5% 0.152.0 MB 4.9% 0.57
Nov 20 09:00:00 - 09:59:59 551 5.4% 0.152.0 MB 4.8% 0.56
Nov 20 10:00:00 - 10:59:59 596 5.9% 0.172.6 MB 6.4% 0.74
Nov 20 11:00:00 - 11:59:59 526 5.2% 0.151.9 MB 4.8% 0.55
Nov 20 12:00:00 - 12:59:59 601 5.9% 0.172.4 MB 5.9% 0.69
Nov 20 13:00:00 - 13:59:59 541 5.3% 0.152.6 MB 6.2% 0.73
Nov 20 14:00:00 - 14:59:59 603 5.9% 0.172.1 MB 5.1% 0.59
Nov 20 15:00:00 - 15:59:59 573 5.6% 0.161.9 MB 4.7% 0.55
Nov 20 16:00:00 - 16:59:59 453 4.5% 0.131.9 MB 4.6% 0.54
Nov 20 17:00:00 - 17:59:59 449 4.4% 0.122.8 MB 6.8% 0.79
Nov 20 18:00:00 - 18:59:59 307 3.0% 0.091.9 MB 4.7% 0.54
Nov 20 19:00:00 - 19:59:59 273 2.7% 0.08999.6 KB 2.4% 0.28
Nov 20 20:00:00 - 20:59:59 241 2.4% 0.07907.6 KB 2.2% 0.25
Nov 20 21:00:00 - 21:59:59 205 2.0% 0.06606.8 KB 1.4% 0.17
Nov 20 22:00:00 - 22:59:59 152 1.5% 0.041.4 MB 3.5% 0.41
Nov 20 23:00:00 - 23:59:59 220 2.2% 0.06933.5 KB 2.2% 0.26
Nov 21 00:00:00 - 00:01:02 7 0.1% 0.11106.4 KB 0.3% 1.72
TOTAL: 24:00:00 10154 100.0% 0.1240.9 MB 100.0% 0.48
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1endofthelinebbs-out.news.weretis.net 593 0 0 2 0 0 0 0 591
2usenet.blueworldhosting.com 570 15 0 0 0 0 0 0 555
3outgoing.news.lysator.liu.se 540 0 0 0 0 0 0 0 540
4news.netfront.net 399 0 0 0 0 0 0 0 399
5newsfeed.xs3.de 26 0 0 1 0 0 0 0 25
6news.samoylyk.net 6 0 0 1 0 0 0 0 5
7glockenspiel.complete.org 3 0 0 3 0 0 0 0 0
TOTAL: 7 2137 15 0 7 0 0 0 0 2115

Unwanted newsgroups [Top 20]:

NewsgroupCount
rocksolid.feeds.news 5
man.politics 4
a.b.sounds.lossless.country 2
clari.local.texas.briefs 1
clari.web.local.alabama 1
gun.general 1
clari.local.georgia.briefs 1
TOTAL: 7 15

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 737
EMP (md5) 490
EMP (phl) 186
Too many newsgroups (low_xpost) 150
EMP (phn nph) 149
Binary: misplaced binary 87
Too many newsgroups 49
Scoring filter 8
HTML post 1
TOTAL: 9 1857

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 214
usenet.blueworldhosting.com 19
newsfeed.xs3.de 18
news.samoylyk.net 5
outgoing.news.lysator.liu.se 2
TOTAL: 5 258
TOTAL: 1 258

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 12880 4809 5335 3 0 0 37%23:59:55
2nyheter.lysator.liu.se 10349 2565 7163 13 0 0 24%23:59:55
3news.nk.ca 13444 107 10008 15 0 12 0%23:59:55
4news.furie.org.uk 7818 49 5680 3 0 0 0%23:59:55
5news.quux.org 10617 34 10002 99 0 0 0%23:59:55
6news.bbs.nz 19865 32 10070 42 0 84 0%23:59:16
7news.weretis.net 10174 3 10148 0 0 0 0%23:59:55
8news.tnetconsulting.net 11302 2 10148 0 0 2 0%23:59:39
9usenet.blueworldhosting.com 7527 1 6817 0 0 0 0%23:59:55
10news.samoylyk.net 12218 1 10111 0 0 0 0%23:59:55
11peer.alt119.net 0 0 0 0 0 10153 0%23:57:46
12newsfeed.xs3.de 11639 0 9592 0 0 0 0%23:59:55
TOTAL: 12 127833 7603 95074 175 0 10251 5%287:55:56
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net23.0 MB6.3 KB23.1 MB0.3 KB/s4.9 KB23:59:55
2nyheter.lysator.liu.se14.1 MB249.6 KB14.4 MB0.2 KB/s5.7 KB23:59:55
3news.furie.org.uk3.8 MB66.9 KB3.9 MB0.0 KB/s76.6 KB23:59:55
4news.nk.ca553.1 KB36.3 KB589.4 KB0.0 KB/s4.8 KB23:59:55
5news.bbs.nz293.5 KB518.5 KB812.0 KB0.0 KB/s11.0 KB23:59:16
6news.quux.org142.1 KB546.7 KB688.8 KB0.0 KB/s5.2 KB23:59:55
7usenet.blueworldhosting.com7.2 KB0.0 KB7.2 KB0.0 KB/s7.2 KB23:59:55
8news.weretis.net5.6 KB0.0 KB5.6 KB0.0 KB/s1.9 KB23:59:55
9news.tnetconsulting.net2.7 KB0.0 KB2.7 KB0.0 KB/s1.3 KB23:59:39
10news.samoylyk.net1.3 KB0.0 KB1.3 KB0.0 KB/s1.3 KB23:59:55
11peer.alt119.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:46
12newsfeed.xs3.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
TOTAL: 1242.0 MB1.4 MB43.4 MB0.0 KB/s5.7 KB287:55:56
Outgoing feeds (innfeed) by Volume

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
2*.census.shodan.io 1 00.0 KB 0 0 000:00:03
3*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
4unresolved 2 00.0 KB 2 0 000:00:25
TOTAL: 4 5 00.0 KB 2 0 000:00:30

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
137.184.192.220 0.105 0.059 0.00000:00:15
142.93.222.180 0.084 0.037 0.00000:00:10
hat.census.shodan.io 0.074 0.040 0.00000:00:03
principled.monitoring.internet-measurement.com 0.114 0.055 0.00000:00:01
scanner-06.ch1.censys-scanner.com 0.122 0.021 0.00000:00:00
TOTAL: 5 0.499 0.212 0.00000:00:30

Curious NNRP server explorers [Top 20]:

SystemConn
137.184.192.220 1
142.93.222.180 1
hat.census.shodan.io 1
scanner-06.ch1.censys-scanner.com 1
principled.monitoring.internet-measurement.com 1
TOTAL: 5 5

NNRP unrecognized commands (by host):

SystemConn
137.184.192.220 5
scanner-06.ch1.censys-scanner.com 1
TOTAL: 2 6

NNRP unrecognized commands (by command):

CommandCount
Accept: */* 1
GET / HTTP/1.1 1
EHLO www.censys.io 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
Host: 192.138.210.162:119 1
Connection: close 1
TOTAL: 6 6

Newsgroup request counts (by category):

CategoryCountPct
1dfw 1 50.0%
2comp 1 50.0%
TOTAL: 2 2100.0%

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

NewsgroupCount
1comp.sys.acorn.announce 1
2dfw.games 1
TOTAL: 2 2