Daily Usenet Report

Oct 17 00:01:02 -- Oct 18 00:01:01

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Oct 17 00:05:16 www innd: message repeated 2 times: [ ctlinnd command s]
Oct 17 04:05:15 www nnrpd[1962698]: unable to get certificates from '/news/etc/cert.pem'
Oct 17 04:05:15 www nnrpd[1962698]: error initializing TLS: [CA_file: ] [CA_path: /news/etc] [cert_file: /news/etc/cert.pem] [key_file: /news/etc/key.pem]
Oct 17 04:05:26 www nnrpd[1962836]: unable to get certificates from '/news/etc/cert.pem'
Oct 17 04:05:26 www nnrpd[1962836]: error initializing TLS: [CA_file: ] [CA_path: /news/etc] [cert_file: /news/etc/cert.pem] [key_file: /news/etc/key.pem]
Oct 17 06:08:16 www nnrpd[1966174]: unable to get certificates from '/news/etc/cert.pem'
Oct 17 06:08:16 www nnrpd[1966174]: 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 13693 67.6%3.5 MB 77.7%
innd 4185 20.7%599.1 KB 13.0%
innfeed 2318 11.4%421.1 KB 9.1%
nnrpd 62 0.3%6.3 KB 0.1%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 5 20259 100.0%4.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 93845 54.5%
Negative hits 64851 37.7%
Do not exist 13352 7.8%
Cache misses 22 0.0%
TOTAL: 4 172070 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.068 0.0%47 0.000 1.447 6.000
article cleanup00:00:00.187 0.0%13389 0.000 0.014 0.074
article logging00:00:00.631 0.0%13669 0.000 0.046 0.132
article parse00:00:00.381 0.0%21068 0.000 0.018 0.088
article write00:00:08.761 0.0%11326 0.423 0.774 2.717
artlog/artcncl00:00:00.000 0.0%46 0.000 0.000 0.000
artlog/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.194 0.0%175801 0.000 0.001 0.006
hisgrep/artcncl00:00:00.008 0.0%45 0.000 0.178 1.000
hishave/artcncl00:00:00.002 0.0%47 0.000 0.043 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:05.993 0.0%172606 0.001 0.035 0.087
history sync00:00:00.079 0.0%374 0.000 0.211 1.000
history write00:00:07.110 0.0%13388 0.082 0.531 1.000
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle23:58:18.821 99.8%172643 286.486 499.869 1929.932
nntp read00:00:07.700 0.0%174105 0.019 0.044 0.089
overview write00:00:07.166 0.0%11326 0.260 0.633 3.200
perl filter00:00:36.565 0.0%13388 1.849 2.731 4.800
python filter00:00:02.064 0.0%13388 0.075 0.154 0.542
site send00:00:05.166 0.0%22652 0.050 0.228 0.681
TOTAL: 24:00:54.90023:59:40.896 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.129 0.0%11489 0.000 0.011 0.082
article prepare00:00:00.000 0.0%5120 0.000 0.000 0.000
article read00:00:00.346 0.0%1087 0.000 0.318 22.000
backlog stats00:00:00.396 0.0%193845 0.000 0.002 0.009
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:05.430 0.0%141153 0.015 0.038 0.066
data write00:00:18.018 0.0%131820 0.097 0.137 0.267
idle23:55:28.358100.0%193845 257.744 444.316 1432.726
status file00:00:00.194 0.0%181 0.000 1.072 8.000
TOTAL: 23:56:01.87523:55:52.871100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:12.634 88.4%21 27.500 601.619 10051.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.001 0.0%45 0.000 0.022 0.500
TOTAL: 00:00:14.29100:00:12.635 88.4%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 4 23091 6072 16481 538 26%50:46:58
2usenet.blueworldhosting.com 5 13005 2814 9680 511 21%24:49:26
3peer.alt119.net 3 13366 2150 10213 1003 16%24:08:49
4newsfeed.xs3.de 1 10401 280 10116 5 2%23:59:53
5news.samoylyk.net 1 10631 53 10575 3 0%23:59:49
6glockenspiel.complete.org 2 10369 50 10319 0 0%23:59:52
7outgoing.news.lysator.liu.se 2 10890 19 10869 2 0%23:59:49
8news.furie.org.uk 1 5705 14 5691 0 0%23:59:51
9news.bbs.nz 3 16363 5 16358 0 0%35:17:29
10eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:02
11localhost 25 0 0 0 0 0%00:00:00
12news.nk.ca 2 0 0 0 0 0%00:20:01
TOTAL: 12 50 113821 11457 100302 2062 10%255:31:59
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com20.2 MB6.9 KB1.5 MB21.7 MB 93%6.7 KB
2endofthelinebbs-out.news.weretis.net19.5 MB0.0 KB1.0 MB20.6 MB 94%3.2 KB
3peer.alt119.net5.3 MB0.0 KB3.0 MB8.3 MB 63%2.7 KB
4newsfeed.xs3.de911.1 KB0.0 KB7.5 KB918.6 KB 99%3.2 KB
5glockenspiel.complete.org431.5 KB0.0 KB0.0 KB431.5 KB100%8.6 KB
6news.samoylyk.net313.2 KB0.0 KB4.5 KB317.7 KB 98%5.7 KB
7outgoing.news.lysator.liu.se59.8 KB0.0 KB1.4 KB61.2 KB 97%2.9 KB
8news.furie.org.uk39.4 KB0.0 KB0.0 KB39.4 KB100%2.8 KB
9news.bbs.nz6.1 KB0.0 KB0.0 KB6.1 KB100%1.2 KB
10eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
11localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
12news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1246.7 MB6.9 KB5.5 MB52.2 MB 89%4.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 17 00:01:02 - 00:59:59 280 2.5% 0.081.6 MB 3.3% 0.45
Oct 17 01:00:00 - 01:59:59 350 3.1% 0.101.3 MB 2.7% 0.36
Oct 17 02:00:00 - 02:59:59 481 4.3% 0.131.4 MB 2.9% 0.39
Oct 17 03:00:00 - 03:59:59 563 5.0% 0.161.9 MB 3.9% 0.53
Oct 17 04:00:00 - 04:59:59 666 5.9% 0.182.2 MB 4.6% 0.62
Oct 17 05:00:00 - 05:59:59 581 5.1% 0.161.9 MB 3.9% 0.53
Oct 17 06:00:00 - 06:59:59 624 5.5% 0.172.0 MB 4.1% 0.55
Oct 17 07:00:00 - 07:59:59 623 5.5% 0.172.3 MB 4.8% 0.65
Oct 17 08:00:00 - 08:59:59 557 4.9% 0.153.1 MB 6.5% 0.87
Oct 17 09:00:00 - 09:59:59 679 6.0% 0.192.2 MB 4.7% 0.63
Oct 17 10:00:00 - 10:59:59 696 6.2% 0.193.0 MB 6.3% 0.85
Oct 17 11:00:00 - 11:59:59 709 6.3% 0.202.5 MB 5.2% 0.71
Oct 17 12:00:00 - 12:59:59 580 5.1% 0.162.3 MB 4.9% 0.66
Oct 17 13:00:00 - 13:59:59 523 4.6% 0.152.6 MB 5.6% 0.75
Oct 17 14:00:00 - 14:59:59 496 4.4% 0.141.8 MB 3.7% 0.50
Oct 17 15:00:00 - 15:59:59 492 4.4% 0.141.8 MB 3.8% 0.51
Oct 17 16:00:00 - 16:59:59 478 4.2% 0.132.3 MB 4.8% 0.65
Oct 17 17:00:00 - 17:59:59 390 3.4% 0.111.4 MB 3.0% 0.40
Oct 17 18:00:00 - 18:59:59 350 3.1% 0.101.3 MB 2.8% 0.38
Oct 17 19:00:00 - 19:59:59 269 2.4% 0.071.6 MB 3.4% 0.46
Oct 17 20:00:00 - 20:59:59 218 1.9% 0.061.7 MB 3.6% 0.48
Oct 17 21:00:00 - 21:59:59 199 1.8% 0.061.2 MB 2.5% 0.34
Oct 17 22:00:00 - 22:59:59 175 1.5% 0.05682.1 KB 1.4% 0.19
Oct 17 23:00:00 - 23:59:59 315 2.8% 0.093.2 MB 6.7% 0.90
Oct 18 00:00:00 - 00:01:01 11 0.1% 0.18307.1 KB 0.6% 5.03
TOTAL: 23:59:59 11305 100.0% 0.1347.3 MB 100.0% 0.56
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1peer.alt119.net 1004 14 0 0 0 0 0 0 990
2endofthelinebbs-out.news.weretis.net 780 1 0 0 0 0 0 0 779
3usenet.blueworldhosting.com 538 26 0 1 0 0 0 0 511
4newsfeed.xs3.de 10 1 0 0 0 0 0 0 9
5news.samoylyk.net 5 0 0 0 0 0 0 0 5
6glockenspiel.complete.org 3 0 0 0 0 0 0 0 3
7outgoing.news.lysator.liu.se 2 2 0 0 0 0 0 0 0
TOTAL: 7 2342 44 0 1 0 0 0 0 2297

Unwanted newsgroups [Top 20]:

NewsgroupCount
at.jobs 10
aus.jobs 8
att.jobs 7
rocksolid.feeds.news 5
grisbi.bugsreports 3
1.test 3
gun.general 1
alt.music.pink-floyd.publius 1
alt.penthouse.sex.first-time 1
fr.petites-annonces.informatique.materiel 1
clari.local.texas.briefs 1
rocksolid.feeds.tech 1
talk.politics 1
grisbi.test 1
TOTAL: 14 44

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 984
EMP (md5) 557
EMP (phl) 278
Too many newsgroups 92
EMP (phn nph) 85
HTML Multipart 10
Scoring filter 6
Binary: misplaced binary 4
U2 violation - invalid distribution 1
Too many newsgroups (meow) 1
TOTAL: 10 2018

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 245
peer.alt119.net 22
newsfeed.xs3.de 5
usenet.blueworldhosting.com 4
news.samoylyk.net 2
glockenspiel.complete.org 1
TOTAL: 6 279
TOTAL: 1 279

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nyheter.lysator.liu.se 14023 571 10362 373 0 123 4%23:59:28
2peer.alt119.net 10497 127 9050 0 0 0 1%23:59:55
3news.nk.ca 12429 47 11197 30 0 11 0%23:59:55
4news.furie.org.uk 6530 17 5826 6 0 5 0%23:59:45
5news.bbs.nz 22265 13 11235 44 0 53 0%23:59:55
6news.quux.org 11508 4 11208 38 0 0 0%23:59:55
7usenet.blueworldhosting.com 8862 4 8315 0 0 0 0%23:59:49
8news.weretis.net 11556 1 11301 2 0 0 0%23:59:55
9news.tnetconsulting.net 12032 1 11297 4 0 0 0%23:59:41
10news.samoylyk.net 11606 0 11254 0 0 0 0%23:59:55
11theuse.net 0 0 0 0 0 11304 0%23:59:56
12newsfeed.xs3.de 11155 0 11024 0 0 0 0%23:59:37
TOTAL: 12 132463 785 112069 497 0 11496 0%287:57:46
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nyheter.lysator.liu.se5.6 MB2.7 MB8.3 MB0.1 KB/s9.0 KB23:59:28
2peer.alt119.net1.2 MB0.0 KB1.2 MB0.0 KB/s9.7 KB23:59:55
3news.furie.org.uk307.4 KB166.0 KB473.4 KB0.0 KB/s20.6 KB23:59:45
4news.nk.ca307.4 KB60.0 KB367.3 KB0.0 KB/s4.8 KB23:59:55
5news.quux.org66.1 KB421.0 KB487.1 KB0.0 KB/s11.6 KB23:59:55
6news.bbs.nz31.1 KB451.8 KB482.9 KB0.0 KB/s8.5 KB23:59:55
7usenet.blueworldhosting.com15.6 KB0.0 KB15.6 KB0.0 KB/s3.9 KB23:59:49
8news.tnetconsulting.net2.7 KB6.5 KB9.3 KB0.0 KB/s1.9 KB23:59:41
9news.weretis.net2.4 KB6.2 KB8.6 KB0.0 KB/s2.9 KB23:59:55
10news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
11theuse.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
12newsfeed.xs3.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:37
TOTAL: 127.6 MB3.8 MB11.3 MB0.0 KB/s9.0 KB287:57:46
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1159.223.128.100 1 00.0 KB 0 0 000:00:10
245.33.65.249 8 00.0 KB 0 0 000:00:03
3scanner-26.ch1.censys-scanner.com 2 00.0 KB 0 0 000:00:00
4192.241.212.184 1 00.0 KB 0 0 000:00:00
TOTAL: 4 12 00.0 KB 0 0 000:00:14

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 10 00.0 KB 0 0 000:00:13
2*.ch1.censys-scanner.com 2 00.0 KB 0 0 000:00:00
TOTAL: 2 12 00.0 KB 0 0 000:00:14

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
159.223.128.100 0.069 0.044 0.00000:00:10
45.33.65.249 0.613 0.194 0.00000:00:03
scanner-26.ch1.censys-scanner.com 0.138 0.068 0.00000:00:00
192.241.212.184 0.086 0.026 0.00000:00:00
TOTAL: 4 0.906 0.332 0.00000:00:14

NNRP unrecognized commands (by host):

SystemConn
45.33.65.249 3
192.241.212.184 1
scanner-26.ch1.censys-scanner.com 1
TOTAL: 3 5

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

SystemConnPeer
45.33.65.249 1 1
TOTAL: 1 1 2