Daily Usenet Report

Dec 28 00:01:01 -- Dec 29 00:01:02

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Dec 28 00:06:28 www innd: message repeated 2 times: [ ctlinnd command s]
Dec 28 21:29:51 www nnrpd[2204064]: unable to get certificates from '/news/etc/cert.pem'
Dec 28 21:29:51 www nnrpd[2204064]: error initializing TLS: [CA_file: ] [CA_path: /news/etc] [cert_file: /news/etc/cert.pem] [key_file: /news/etc/key.pem]
Dec 28 21:30:06 www nnrpd[2204217]: unable to get certificates from '/news/etc/cert.pem'
Dec 28 21:30:06 www nnrpd[2204217]: error initializing TLS: [CA_file: ] [CA_path: /news/etc] [cert_file: /news/etc/cert.pem] [key_file: /news/etc/key.pem]
Dec 28 22:27:11 www nnrpd[2205607]: unable to get certificates from '/news/etc/cert.pem'
Dec 28 22:27:11 www nnrpd[2205607]: 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 14221 65.5%3.6 MB 76.1%
innd 5096 23.5%726.6 KB 14.8%
innfeed 2331 10.7%435.7 KB 8.9%
nnrpd 52 0.2%6.0 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 21701 100.0%4.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 90427 55.7%
Negative hits 58071 35.7%
Do not exist 13926 8.6%
Cache misses 33 0.0%
TOTAL: 4 162457 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.096 0.0%60 0.000 1.600 7.000
article cleanup00:00:00.273 0.0%13943 0.000 0.020 0.188
article logging00:00:00.736 0.0%14139 0.000 0.052 0.161
article parse00:00:01.628 0.0%89240 0.000 0.018 0.081
article write00:00:09.133 0.0%10979 0.433 0.832 4.151
artlog/artcncl00:00:00.000 0.0%60 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.485 0.0%238451 0.000 0.002 0.009
hisgrep/artcncl00:00:00.015 0.0%60 0.000 0.250 0.800
hishave/artcncl00:00:00.004 0.0%60 0.000 0.067 1.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:00:07.398 0.0%162606 0.005 0.045 0.092
history sync00:00:00.054 0.0%378 0.000 0.143 1.000
history write00:00:07.931 0.0%13942 0.071 0.569 1.127
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:02.148 99.8%229745 72.827 372.945 1686.480
nntp read00:00:16.138 0.0%230671 0.017 0.070 0.193
overview write00:00:07.742 0.0%10979 0.299 0.705 5.480
perl filter00:00:41.793 0.0%13942 2.202 2.998 5.911
python filter00:00:02.412 0.0%13942 0.050 0.173 0.472
site send00:00:04.618 0.0%21958 0.039 0.210 0.571
TOTAL: 23:50:57.90723:49:42.604 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.120 0.0%11028 0.000 0.011 0.143
article prepare00:00:00.006 0.0%31860 0.000 0.000 0.009
article read00:00:01.456 0.0%5005 0.000 0.291 6.417
backlog stats00:00:00.466 0.0%236666 0.000 0.002 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:05.210 0.0%157537 0.014 0.033 0.068
data write00:00:20.259 0.0%147380 0.101 0.137 0.259
idle23:56:34.427100.0%236666 208.884 364.203 1079.953
status file00:00:00.190 0.0%189 0.000 1.005 8.000
TOTAL: 23:57:12.30623:57:02.134100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:26.322 94.4%20 22.000 1316.100 9770.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.003 0.0%43 0.000 0.070 0.500
TOTAL: 00:00:27.88500:00:26.325 94.4%----

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 25073 6300 18445 328 25%57:48:44
2usenet.blueworldhosting.com 4 11550 3327 7862 361 28%22:36:24
3outgoing.news.lysator.liu.se 1 12138 665 10965 508 5%23:59:58
4newsfeed.xs3.de 2 9755 608 9143 4 6%23:59:55
5news.samoylyk.net 1 10037 53 9983 1 0%23:59:48
6glockenspiel.complete.org 1 10457 33 10422 2 0%23:59:54
7news.furie.org.uk 2 5802 12 5790 0 0%23:59:42
8news.bbs.nz 3 11065 9 11056 0 0%27:16:54
9news.netfront.net 1 11133 4 9418 1711 0%18:33:42
10news.nk.ca 2 0 0 0 0 0%00:20:00
11localhost 25 0 0 0 0 0%00:00:00
12eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:05
TOTAL: 12 47 107010 11011 93084 2915 10%246:45:06
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net24.9 MB0.0 KB742.6 KB25.6 MB 97%4.0 KB
2usenet.blueworldhosting.com19.1 MB0.0 KB1.8 MB20.9 MB 91%5.8 KB
3newsfeed.xs3.de2.6 MB0.0 KB11.2 KB2.6 MB 99%4.4 KB
4outgoing.news.lysator.liu.se1.4 MB0.0 KB1.3 MB2.7 MB 53%2.3 KB
5news.samoylyk.net254.4 KB0.0 KB1.4 KB255.7 KB 99%4.7 KB
6glockenspiel.complete.org180.4 KB0.0 KB3.6 KB184.0 KB 98%5.3 KB
7news.furie.org.uk59.9 KB0.0 KB0.0 KB59.9 KB100%5.0 KB
8news.bbs.nz25.8 KB0.0 KB0.0 KB25.8 KB100%2.9 KB
9news.netfront.net9.4 KB0.0 KB550.3 MB550.3 MB 0%328.6 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: 1248.6 MB0.0 KB554.0 MB602.6 MB 8%44.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 28 00:01:01 - 00:59:59 226 2.1% 0.062.1 MB 4.3% 0.60
Dec 28 01:00:00 - 01:59:59 364 3.3% 0.101.5 MB 3.1% 0.43
Dec 28 02:00:00 - 02:59:59 533 4.8% 0.152.2 MB 4.6% 0.64
Dec 28 03:00:00 - 03:59:59 542 4.9% 0.151.6 MB 3.3% 0.45
Dec 28 04:00:00 - 04:59:59 556 5.1% 0.151.9 MB 4.0% 0.54
Dec 28 05:00:00 - 05:59:59 521 4.7% 0.142.9 MB 6.0% 0.82
Dec 28 06:00:00 - 06:59:59 570 5.2% 0.163.0 MB 6.2% 0.85
Dec 28 07:00:00 - 07:59:59 538 4.9% 0.152.4 MB 5.0% 0.68
Dec 28 08:00:00 - 08:59:59 642 5.8% 0.181.9 MB 4.0% 0.55
Dec 28 09:00:00 - 09:59:59 622 5.7% 0.172.4 MB 5.0% 0.68
Dec 28 10:00:00 - 10:59:59 606 5.5% 0.173.1 MB 6.3% 0.87
Dec 28 11:00:00 - 11:59:59 625 5.7% 0.172.2 MB 4.5% 0.62
Dec 28 12:00:00 - 12:59:59 589 5.4% 0.162.3 MB 4.8% 0.66
Dec 28 13:00:00 - 13:59:59 579 5.3% 0.161.9 MB 3.8% 0.53
Dec 28 14:00:00 - 14:59:59 531 4.8% 0.153.1 MB 6.5% 0.89
Dec 28 15:00:00 - 15:59:59 513 4.7% 0.142.4 MB 4.9% 0.67
Dec 28 16:00:00 - 16:59:59 481 4.4% 0.131.9 MB 4.0% 0.55
Dec 28 17:00:00 - 17:59:59 443 4.0% 0.122.1 MB 4.4% 0.60
Dec 28 18:00:00 - 18:59:59 374 3.4% 0.101.4 MB 2.8% 0.39
Dec 28 19:00:00 - 19:59:59 249 2.3% 0.07905.0 KB 1.8% 0.25
Dec 28 20:00:00 - 20:59:59 268 2.4% 0.072.4 MB 5.0% 0.68
Dec 28 21:00:00 - 21:59:59 200 1.8% 0.061.1 MB 2.2% 0.30
Dec 28 22:00:00 - 22:59:59 194 1.8% 0.05926.7 KB 1.9% 0.26
Dec 28 23:00:00 - 23:59:59 230 2.1% 0.06792.3 KB 1.6% 0.22
Dec 29 00:00:00 - 00:01:02 5 0.0% 0.0815.1 KB 0.0% 0.24
TOTAL: 24:00:01 11001 100.0% 0.1348.2 MB 100.0% 0.57
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.netfront.net 1761 0 0 0 0 0 0 0 1761
2endofthelinebbs-out.news.weretis.net 504 0 0 0 0 0 0 0 504
3outgoing.news.lysator.liu.se 499 0 0 0 0 0 0 0 499
4usenet.blueworldhosting.com 376 19 0 0 0 0 0 0 357
5newsfeed.xs3.de 16 0 0 0 0 0 0 0 16
6news.samoylyk.net 3 0 0 0 0 0 0 0 3
7glockenspiel.complete.org 1 0 0 1 0 0 0 0 0
TOTAL: 7 3160 19 0 1 0 0 0 0 3140

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.culture.underwear 10
rocksolid.feeds.news 5
rocksolid.feeds.tech 2
panix.test 1
de.soc.dateschutz 1
TOTAL: 5 19

INND Perl filter [Top 20]:

ReasonCount
Binary: misplaced binary 1217
EMP (phn path) 594
EMP (md5) 430
Too many newsgroups (low_xpost) 316
Too many newsgroups 197
EMP (phl) 181
Scoring filter 4
Too many newsgroups (meow) 3
HTML Multipart 2
TOTAL: 9 2944

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 176
newsfeed.xs3.de 12
usenet.blueworldhosting.com 5
news.samoylyk.net 2
outgoing.news.lysator.liu.se 1
TOTAL: 5 196
TOTAL: 1 196

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 14652 4702 6301 8 0 0 32%24:07:13
2nyheter.lysator.liu.se 10694 2817 7536 13 0 0 26%24:09:22
3news.nk.ca 14893 101 10837 21 0 5 0%23:59:57
4news.furie.org.uk 8805 70 6135 20 0 0 0%24:09:39
5news.bbs.nz 21546 35 10908 44 0 31 0%23:59:57
6news.quux.org 11688 33 10850 97 0 0 0%23:59:57
7usenet.blueworldhosting.com 8255 6 7439 0 0 0 0%23:59:57
8news.tnetconsulting.net 12079 4 11003 3 0 0 0%24:06:30
9news.weretis.net 11024 1 10996 0 0 0 0%23:59:36
10peer.alt119.net 0 0 0 0 0 11001 0%23:57:47
11news.samoylyk.net 13549 0 10948 0 0 0 0%23:59:57
12newsfeed.xs3.de 12765 0 10384 0 0 0 0%23:59:42
TOTAL: 12 139950 7769 103337 206 0 11037 5%288:29:34
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net21.7 MB29.4 KB21.7 MB0.3 KB/s4.7 KB24:07:13
2nyheter.lysator.liu.se15.1 MB314.7 KB15.4 MB0.2 KB/s5.6 KB24:09:22
3news.furie.org.uk4.4 MB359.4 KB4.8 MB0.1 KB/s54.2 KB24:09:39
4news.nk.ca574.2 KB126.4 KB700.5 KB0.0 KB/s5.7 KB23:59:57
5news.bbs.nz141.6 KB554.9 KB696.5 KB0.0 KB/s8.8 KB23:59:57
6news.quux.org124.8 KB618.6 KB743.3 KB0.0 KB/s5.7 KB23:59:57
7usenet.blueworldhosting.com14.2 KB0.0 KB14.2 KB0.0 KB/s2.4 KB23:59:57
8news.tnetconsulting.net5.6 KB14.8 KB20.4 KB0.0 KB/s2.9 KB24:06:30
9news.weretis.net2.3 KB0.0 KB2.3 KB0.0 KB/s2.3 KB23:59:36
10peer.alt119.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
11news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:57
12newsfeed.xs3.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:42
TOTAL: 1242.0 MB2.0 MB44.0 MB0.0 KB/s5.6 KB288:29:34
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
131.43.185.32 1 00.0 KB 0 0 000:00:00
2139-144-52-241.ip.linodeusercontent.com 8 00.0 KB 0 0 000:00:17
3107.170.227.13 1 00.0 KB 0 0 000:00:09
4scanner-06.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 4 11 00.0 KB 0 0 000:00:27

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.ip.linodeusercontent.com 8 00.0 KB 0 0 000:00:17
2unresolved 2 00.0 KB 0 0 000:00:10
3*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 3 11 00.0 KB 0 0 000:00:27

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
139-144-52-241.ip.linodeusercontent.com 0.743 0.194 0.00000:00:17
107.170.227.13 0.070 0.054 0.00000:00:09
31.43.185.32 0.089 0.028 0.00000:00:00
scanner-06.ch1.censys-scanner.com 0.115 0.060 0.00000:00:00
TOTAL: 4 1.017 0.336 0.00000:00:27

NNRP unrecognized commands (by host):

SystemConn
139-144-52-241.ip.linodeusercontent.com 3
scanner-06.ch1.censys-scanner.com 1
31.43.185.32 1
TOTAL: 3 5

NNRP unrecognized commands (by command):

CommandCount
À#024 1
#003 1
#026#003#001#002 1
EHLO www.censys.io 1
#026#003#001 1
TOTAL: 5 5

NNRP client timeouts [Top 20]:

SystemConnPeer
139-144-52-241.ip.linodeusercontent.com 2 2
31.43.185.32 1 1
TOTAL: 2 3 3