Daily Usenet Report

Feb 19 00:01:01 -- Feb 20 00:01:02

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Feb 19 00:07:15 www innd: message repeated 2 times: [ ctlinnd command s]
Feb 19 10:39:19 www nnrpd[3030953]: unable to get certificates from '/news/etc/cert.pem'
Feb 19 10:39:19 www nnrpd[3030953]: error initializing TLS: [CA_file: ] [CA_path: /news/etc] [cert_file: /news/etc/cert.pem] [key_file: /news/etc/key.pem]
Feb 19 17:23:17 www nnrpd[3044328]: unable to get certificates from '/news/etc/cert.pem'
Feb 19 17:23:17 www nnrpd[3044328]: 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 13153 65.7%3.4 MB 76.4%
innd 4522 22.6%641.3 KB 14.0%
innfeed 2326 11.6%431.9 KB 9.5%
nnrpd 23 0.1%2.6 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 20025 100.0%4.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 87819 57.4%
Negative hits 52310 34.2%
Do not exist 12730 8.3%
Cache misses 25 0.0%
TOTAL: 4 152884 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.098 0.0%69 0.000 1.420 14.000
article cleanup00:00:00.356 0.0%12800 0.000 0.028 0.088
article logging00:00:00.646 0.0%13077 0.000 0.049 0.196
article parse00:00:01.200 0.0%54042 0.000 0.022 0.086
article write00:00:12.654 0.0%10427 0.500 1.214 2.795
artlog/artcncl00:00:00.001 0.0%69 0.000 0.014 1.000
data move00:00:00.383 0.0%194173 0.000 0.002 0.009
hisgrep/artcncl00:00:00.024 0.0%67 0.000 0.358 3.000
hishave/artcncl00:00:00.008 0.0%69 0.000 0.116 0.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:07.519 0.0%153558 0.006 0.049 0.093
history sync00:00:00.059 0.0%349 0.000 0.169 1.000
history write00:00:07.548 0.0%12798 0.080 0.590 1.042
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle23:58:01.359 99.8%187989 146.867 458.970 1916.153
nntp read00:00:11.847 0.0%188761 0.015 0.063 0.141
overview write00:00:06.555 0.0%10427 0.248 0.629 6.775
perl filter00:00:35.875 0.0%12798 2.056 2.803 6.625
python filter00:00:02.536 0.0%12798 0.091 0.198 0.435
site send00:00:03.518 0.0%20854 0.051 0.169 0.407
TOTAL: 24:00:46.26223:59:32.186 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.140 0.0%10679 0.000 0.013 0.103
article prepare00:00:00.007 0.0%36636 0.000 0.000 0.005
article read00:00:01.622 0.0%5344 0.076 0.304 2.741
backlog stats00:00:00.554 0.0%232518 0.000 0.002 0.011
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:05.353 0.0%151046 0.020 0.035 0.059
data write00:00:21.172 0.0%141946 0.092 0.149 0.227
idle23:57:11.083100.0%232518 224.896 370.858 1013.128
status file00:00:00.182 0.0%193 0.000 0.943 4.000
TOTAL: 23:57:50.91623:57:40.113100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:02.411 69.4%9 22.333 267.889 1605.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.001 0.0%18 0.000 0.056 0.500
TOTAL: 00:00:03.47500:00:02.412 69.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 18223 5527 12355 341 30%43:13:19
2usenet.blueworldhosting.com 6 12121 3883 7556 682 32%25:38:33
3outgoing.news.lysator.liu.se 2 11508 583 10636 289 5%23:59:57
4newsfeed.xs3.de 1 9593 355 9235 3 3%23:59:53
5news.samoylyk.net 2 9664 51 9611 2 0%23:59:35
6glockenspiel.complete.org 1 10383 27 10279 77 0%23:59:54
7news.bbs.nz 3 16353 7 16346 0 0%36:43:19
8news.furie.org.uk 1 5546 6 5540 0 0%23:59:55
9news.netfront.net 1 12708 4 11703 1001 0%23:39:27
10localhost 25 0 0 0 0 0%00:00:00
11news.nk.ca 2 0 0 0 0 0%00:21:12
12eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:14
TOTAL: 12 49 106099 10443 93261 2395 9%249:45:18
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com25.3 MB0.0 KB3.1 MB28.4 MB 89%6.4 KB
2endofthelinebbs-out.news.weretis.net15.3 MB0.0 KB583.0 KB15.9 MB 96%2.8 KB
3outgoing.news.lysator.liu.se1.1 MB0.0 KB590.6 KB1.6 MB 64%1.9 KB
4newsfeed.xs3.de1.0 MB0.0 KB8.1 KB1.0 MB 99%3.0 KB
5glockenspiel.complete.org245.4 KB389.0 KB587.1 KB1.2 MB 20%11.7 KB
6news.samoylyk.net230.5 KB0.0 KB2.8 KB233.3 KB 98%4.4 KB
7news.furie.org.uk16.5 KB0.0 KB0.0 KB16.5 KB100%2.7 KB
8news.bbs.nz15.8 KB0.0 KB0.0 KB15.8 KB100%2.3 KB
9news.netfront.net12.4 KB0.0 KB329.4 MB329.5 MB 0%335.7 KB
10localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
11news.nk.ca0.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: 1243.2 MB389.0 KB334.3 MB377.9 MB 11%30.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 19 00:01:01 - 00:59:59 230 2.2% 0.06911.7 KB 2.1% 0.26
Feb 19 01:00:00 - 01:59:59 286 2.7% 0.082.9 MB 6.7% 0.82
Feb 19 02:00:00 - 02:59:59 386 3.7% 0.111.3 MB 3.1% 0.37
Feb 19 03:00:00 - 03:59:59 448 4.3% 0.121.3 MB 3.1% 0.37
Feb 19 04:00:00 - 04:59:59 481 4.6% 0.131.5 MB 3.4% 0.42
Feb 19 05:00:00 - 05:59:59 485 4.6% 0.131.4 MB 3.3% 0.41
Feb 19 06:00:00 - 06:59:59 483 4.6% 0.131.7 MB 4.0% 0.49
Feb 19 07:00:00 - 07:59:59 523 5.0% 0.151.9 MB 4.5% 0.54
Feb 19 08:00:00 - 08:59:59 642 6.2% 0.181.9 MB 4.5% 0.54
Feb 19 09:00:00 - 09:59:59 635 6.1% 0.183.4 MB 7.9% 0.96
Feb 19 10:00:00 - 10:59:59 527 5.0% 0.151.8 MB 4.3% 0.52
Feb 19 11:00:00 - 11:59:59 522 5.0% 0.141.9 MB 4.4% 0.53
Feb 19 12:00:00 - 12:59:59 646 6.2% 0.182.0 MB 4.7% 0.57
Feb 19 13:00:00 - 13:59:59 623 6.0% 0.173.0 MB 7.0% 0.85
Feb 19 14:00:00 - 14:59:59 662 6.3% 0.182.6 MB 6.0% 0.73
Feb 19 15:00:00 - 15:59:59 588 5.6% 0.162.8 MB 6.5% 0.79
Feb 19 16:00:00 - 16:59:59 433 4.1% 0.122.1 MB 5.0% 0.61
Feb 19 17:00:00 - 17:59:59 348 3.3% 0.101.3 MB 3.2% 0.38
Feb 19 18:00:00 - 18:59:59 295 2.8% 0.081.1 MB 2.5% 0.30
Feb 19 19:00:00 - 19:59:59 282 2.7% 0.08984.8 KB 2.3% 0.27
Feb 19 20:00:00 - 20:59:59 189 1.8% 0.05610.3 KB 1.4% 0.17
Feb 19 21:00:00 - 21:59:59 266 2.5% 0.07875.5 KB 2.0% 0.24
Feb 19 22:00:00 - 22:59:59 236 2.3% 0.072.5 MB 5.9% 0.72
Feb 19 23:00:00 - 23:59:59 213 2.0% 0.06967.5 KB 2.2% 0.27
Feb 20 00:00:00 - 00:01:02 8 0.1% 0.1318.0 KB 0.0% 0.29
TOTAL: 24:00:01 10437 100.0% 0.1242.7 MB 100.0% 0.51
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.netfront.net 983 0 0 0 0 0 0 0 983
2usenet.blueworldhosting.com 652 6 0 0 0 0 0 0 646
3endofthelinebbs-out.news.weretis.net 602 0 0 1 0 0 0 0 601
4outgoing.news.lysator.liu.se 298 0 0 0 0 0 0 0 298
5glockenspiel.complete.org 92 0 0 1 0 0 0 0 91
6newsfeed.xs3.de 11 0 0 0 0 0 0 0 11
7news.samoylyk.net 7 0 0 0 0 0 0 0 7
TOTAL: 7 2645 6 0 2 0 0 0 0 2637

Unwanted newsgroups [Top 20]:

NewsgroupCount
rocksolid.feeds.news 5
rocksolid.feeds.tech 1
TOTAL: 2 6

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 602
EMP (md5) 446
Binary: misplaced binary fx12.ams4.POSTED 146
Binary: misplaced binary fx15.ams4.POSTED 141
Binary: misplaced binary fx01.ams4.POSTED 125
EMP (phl) 124
Binary: misplaced binary fx14.ams4.POSTED 117
Binary: misplaced binary fx03.ams4.POSTED 110
Too many newsgroups 107
Binary: misplaced binary fx05.ams4.POSTED 106
EMP (phn nph) 105
Binary: misplaced binary fx02.ams4.POSTED 86
Binary: misplaced binary fx08.ams4.POSTED 40
Binary: misplaced binary fx09.ams4.POSTED 26
Binary: misplaced binary fx06.ams4.POSTED 24
Binary: misplaced binary fx15.iad.POSTED 18
Binary: misplaced binary fx07.ams4.POSTED 9
Binary: misplaced binary fx11.ams4.POSTED 9
HTML Multipart 7
Binary: misplaced binary fx04.ams4.POSTED 5
TOTAL: 23 2362

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 251
usenet.blueworldhosting.com 10
newsfeed.xs3.de 8
news.samoylyk.net 5
outgoing.news.lysator.liu.se 1
TOTAL: 5 275
TOTAL: 1 275

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 14279 5146 5284 3 0 21 36%23:59:52
2nyheter.lysator.liu.se 10069 3337 6477 21 0 0 33%23:59:57
3news.nk.ca 13845 234 10031 156 0 161 1%23:59:57
4news.quux.org 10747 35 10239 139 0 0 0%23:59:57
5news.bbs.nz 20301 28 10349 54 0 75 0%23:59:41
6news.furie.org.uk 8091 14 5758 2 0 0 0%23:59:10
7news.weretis.net 10512 3 10432 0 0 0 0%23:59:57
8usenet.blueworldhosting.com 7548 2 6624 1 0 1 0%23:59:57
9news.tnetconsulting.net 11104 2 10433 0 0 0 0%23:59:57
10newsfeed.xs3.de 13404 0 10074 1 0 0 0%23:59:28
11news.samoylyk.net 13763 0 10380 1 0 0 0%23:59:32
12peer.alt119.net 0 0 0 0 0 10435 0%23:57:48
TOTAL: 12 133663 8801 96081 378 0 10693 6%287:55:13
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net23.7 MB5.3 KB23.7 MB0.3 KB/s4.7 KB23:59:52
2nyheter.lysator.liu.se20.9 MB154.5 KB21.1 MB0.2 KB/s6.4 KB23:59:57
3news.nk.ca1.3 MB697.0 KB2.0 MB0.0 KB/s5.3 KB23:59:57
4news.quux.org238.3 KB716.8 KB955.0 KB0.0 KB/s5.5 KB23:59:57
5news.bbs.nz214.6 KB309.4 KB524.0 KB0.0 KB/s6.4 KB23:59:41
6news.furie.org.uk118.6 KB25.3 KB143.9 KB0.0 KB/s9.0 KB23:59:10
7news.weretis.net46.8 KB0.0 KB46.8 KB0.0 KB/s15.6 KB23:59:57
8news.tnetconsulting.net45.7 KB0.0 KB45.7 KB0.0 KB/s22.9 KB23:59:57
9usenet.blueworldhosting.com2.8 KB2.8 KB5.6 KB0.0 KB/s1.9 KB23:59:57
10newsfeed.xs3.de0.0 KB4.9 KB4.9 KB0.0 KB/s4.9 KB23:59:28
11news.samoylyk.net0.0 KB4.9 KB4.9 KB0.0 KB/s4.9 KB23:59:32
12peer.alt119.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
TOTAL: 1246.6 MB1.9 MB48.5 MB0.0 KB/s5.4 KB287:55:13
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

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

NNRP readership statistics (by domain):

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

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
eloquent.monitoring.internet-measurement.com 0.090 0.046 0.00000:00:01
hat.census.shodan.io 0.117 0.027 0.00000:00:00
scanner-25.ch1.censys-scanner.com 0.219 0.065 0.00000:00:00
scanner-07.ch1.censys-scanner.com 0.101 0.028 0.00000:00:00
TOTAL: 4 0.527 0.166 0.00000:00:03

NNRP unrecognized commands (by host):

SystemConn
scanner-07.ch1.censys-scanner.com 1
scanner-25.ch1.censys-scanner.com 1
TOTAL: 2 2

NNRP unrecognized commands (by command):

CommandCount
EHLO www.censys.io 2
TOTAL: 1 2