Daily Usenet Report

Sep 16 00:01:01 -- Sep 17 00:01:02

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Sep 16 00:04:58 www innd: message repeated 2 times: [ ctlinnd command s]
Sep 16 17:12:21 www innd: tradspool: could not open /news/spool/articles/us/politics/120: File exists
Sep 16 17:12:21 www innd: tradspool: could not open /news/spool/articles/us/politics/121: File exists
Sep 16 17:12:21 www innd: tradspool: could not open /news/spool/articles/us/politics/122: File exists
Sep 16 20:36:35 www nnrpd[879555]: unable to get certificates from '/news/etc/cert.pem'
Sep 16 20:36:35 www nnrpd[879555]: 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 14104 71.2%3.2 MB 78.5%
innd 3695 18.7%544.2 KB 12.9%
innfeed 1987 10.0%362.8 KB 8.6%
nnrpd 14 0.1%1.5 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 19801 100.0%4.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 85382 53.6%
Negative hits 60145 37.8%
Do not exist 13657 8.6%
Cache misses 74 0.0%
TOTAL: 4 159258 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.106 0.0%94 0.000 1.128 9.000
article cleanup00:00:00.284 0.0%13691 0.000 0.021 0.095
article logging00:00:00.632 0.0%14025 0.000 0.045 0.188
article parse00:00:00.481 0.0%21858 0.000 0.022 0.098
article write00:00:12.611 0.0%11913 0.373 1.059 2.407
artlog/artcncl00:00:00.000 0.0%93 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
artlog/artwrite00:00:00.000 0.0%3 0.000 0.000 0.000
data move00:00:00.226 0.0%166628 0.000 0.001 0.016
hisgrep/artcncl00:00:00.015 0.0%91 0.000 0.165 2.000
hishave/artcncl00:00:00.001 0.0%94 0.000 0.011 0.200
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:04.984 0.0%159606 0.003 0.031 0.074
history sync00:00:00.075 0.0%398 0.000 0.188 1.000
history write00:00:05.532 0.0%13687 0.029 0.404 1.000
hiswrite/artcncl00:00:00.002 0.0%3 0.000 0.667 1.000
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:58:42.048 99.8%162206 276.199 532.175 1947.240
nntp read00:00:06.950 0.0%164573 0.028 0.042 0.096
overview write00:00:07.422 0.0%11910 0.259 0.623 2.886
perl filter00:00:36.470 0.0%13690 2.105 2.664 5.183
python filter00:00:02.267 0.0%13690 0.068 0.166 0.536
site send00:00:04.458 0.0%23820 0.042 0.187 0.511
TOTAL: 24:01:09.90524:00:04.564 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.126 0.0%11984 0.000 0.011 0.106
article prepare00:00:00.001 0.0%12632 0.000 0.000 0.007
article read00:00:00.588 0.0%1730 0.000 0.340 46.000
backlog stats00:00:00.388 0.0%224638 0.000 0.002 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:05.089 0.0%149729 0.011 0.034 0.059
data write00:00:19.890 0.0%138189 0.102 0.144 0.311
idle23:56:40.520100.0%224638 184.808 383.731 1355.185
status file00:00:00.180 0.0%174 0.000 1.034 9.000
TOTAL: 23:57:15.31723:57:06.782100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:08.546 94.6%6 25.000 1424.333 8308.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.001 0.0%12 0.000 0.083 0.167
TOTAL: 00:00:09.03400:00:08.547 94.6%----

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 3 26459 5550 20309 600 20%53:19:58
2usenet.blueworldhosting.com 4 13206 3856 8508 842 29%24:04:28
3peer.alt119.net 3 13173 2262 10567 344 17%24:09:00
4newsfeed.xs3.de 1 10732 263 10464 5 2%23:59:55
5news.bbs.nz 3 11191 19 11172 0 0%24:51:48
6news.samoylyk.net 2 10990 15 10975 0 0%23:59:18
7glockenspiel.complete.org 1 9613 13 9545 55 0%18:53:37
8news.furie.org.uk 1 5750 10 5740 0 0%23:59:55
9news.nk.ca 2 0 0 0 0 0%00:20:00
10eotl-out.news.tnetconsulting.net 2 0 0 0 0 0%00:20:03
11localhost 25 0 0 0 0 0%00:00:00
TOTAL: 11 47 101114 11988 87280 1846 11%217:58:02
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com29.0 MB0.0 KB1.9 MB30.8 MB 93%6.7 KB
2endofthelinebbs-out.news.weretis.net16.3 MB2.8 KB1.2 MB17.4 MB 93%2.9 KB
3peer.alt119.net5.3 MB0.0 KB797.1 KB6.1 MB 87%2.4 KB
4newsfeed.xs3.de1001.0 KB0.0 KB9.1 KB1010.1 KB 99%3.8 KB
5glockenspiel.complete.org86.8 KB0.0 KB110.7 KB197.5 KB 43%2.9 KB
6news.furie.org.uk41.7 KB0.0 KB0.0 KB41.7 KB100%4.2 KB
7news.samoylyk.net39.5 KB0.0 KB0.0 KB39.5 KB100%2.6 KB
8news.bbs.nz39.4 KB0.0 KB0.0 KB39.4 KB100%2.1 KB
9news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
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
TOTAL: 1151.7 MB2.8 KB3.9 MB55.6 MB 92%4.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 16 00:01:01 - 00:59:59 296 2.5% 0.082.2 MB 4.2% 0.63
Sep 16 01:00:00 - 01:59:59 408 3.4% 0.111.2 MB 2.3% 0.34
Sep 16 02:00:00 - 02:59:59 599 5.0% 0.171.5 MB 2.9% 0.43
Sep 16 03:00:00 - 03:59:59 612 5.1% 0.171.7 MB 3.4% 0.49
Sep 16 04:00:00 - 04:59:59 608 5.1% 0.172.0 MB 3.8% 0.56
Sep 16 05:00:00 - 05:59:59 599 5.0% 0.172.1 MB 4.0% 0.59
Sep 16 06:00:00 - 06:59:59 606 5.1% 0.172.7 MB 5.3% 0.78
Sep 16 07:00:00 - 07:59:59 650 5.5% 0.183.1 MB 6.1% 0.89
Sep 16 08:00:00 - 08:59:59 720 6.1% 0.202.8 MB 5.4% 0.80
Sep 16 09:00:00 - 09:59:59 800 6.7% 0.222.6 MB 5.1% 0.75
Sep 16 10:00:00 - 10:59:59 660 5.5% 0.182.2 MB 4.3% 0.63
Sep 16 11:00:00 - 11:59:59 724 6.1% 0.203.4 MB 6.6% 0.97
Sep 16 12:00:00 - 12:59:59 628 5.3% 0.173.1 MB 5.9% 0.88
Sep 16 13:00:00 - 13:59:59 537 4.5% 0.152.0 MB 3.9% 0.57
Sep 16 14:00:00 - 14:59:59 652 5.5% 0.185.0 MB 9.7% 1.43
Sep 16 15:00:00 - 15:59:59 466 3.9% 0.131.8 MB 3.5% 0.52
Sep 16 16:00:00 - 16:59:59 483 4.1% 0.131.5 MB 3.0% 0.44
Sep 16 17:00:00 - 17:59:59 418 3.5% 0.121.9 MB 3.7% 0.54
Sep 16 18:00:00 - 18:59:59 286 2.4% 0.081.4 MB 2.6% 0.39
Sep 16 19:00:00 - 19:59:59 254 2.1% 0.072.2 MB 4.2% 0.62
Sep 16 20:00:00 - 20:59:59 250 2.1% 0.07883.6 KB 1.7% 0.25
Sep 16 21:00:00 - 21:59:59 209 1.8% 0.06881.7 KB 1.7% 0.24
Sep 16 22:00:00 - 22:59:59 227 1.9% 0.061.2 MB 2.3% 0.34
Sep 16 23:00:00 - 23:59:59 199 1.7% 0.062.3 MB 4.4% 0.66
Sep 17 00:00:00 - 00:01:02 3 0.0% 0.0511.2 KB 0.0% 0.18
TOTAL: 24:00:01 11894 100.0% 0.1451.8 MB 100.0% 0.61
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1endofthelinebbs-out.news.weretis.net 890 1 0 1 0 0 0 0 888
2usenet.blueworldhosting.com 860 97 0 0 0 0 0 0 763
3peer.alt119.net 341 7 0 0 0 0 0 0 334
4glockenspiel.complete.org 18 0 0 0 0 0 0 0 18
5newsfeed.xs3.de 8 0 0 0 0 0 0 0 8
TOTAL: 5 2117 105 0 1 0 0 0 0 2011

Unwanted newsgroups [Top 20]:

NewsgroupCount
talk.english.tg 51
talk.generic.ua.ws 10
at.jobs 8
att.jobs 7
talk.english.tw 5
aus.jobs 4
rocksolid.feeds.news 4
fr.petites-annonces.divers 3
biz.marketplace 3
alt.support.chronic.pain 2
trollnet.cinema 2
talk.from.war.diary 1
talk.from.diary 1
alt.christnet.eucharist 1
alt.penthouse.sex.first-time 1
grisbi.test 1
1.test 1
TOTAL: 17 105

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 1175
EMP (md5) 259
EMP (phl) 116
Too many newsgroups 76
EMP (phn nph) 39
HTML Multipart 4
MID-Bot 2
Scoring filter 1
TOTAL: 8 1672

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 305
usenet.blueworldhosting.com 17
peer.alt119.net 11
newsfeed.xs3.de 3
TOTAL: 4 336
TOTAL: 1 336

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1peer.alt119.net 11548 1372 8258 5 0 0 11%23:57:46
2news.bbs.nz 22379 865 10809 201 0 38 3%23:59:57
3news.nk.ca 15860 290 11432 107 0 36 1%23:59:57
4news.quux.org 12631 80 11631 169 0 0 0%23:59:57
5news.furie.org.uk 9202 27 6084 19 0 15 0%23:59:25
6news.tnetconsulting.net 13192 6 11877 1 0 0 0%23:59:57
7news.weretis.net 12040 4 11885 1 0 0 0%23:59:57
8usenet.blueworldhosting.com 8366 2 8011 0 0 0 0%23:58:46
9newsfeed.xs3.de 15005 0 11618 7 0 3 0%23:59:13
10news.samoylyk.net 15257 0 11873 5 0 4 0%23:59:23
TOTAL: 10 135480 2646 103478 515 0 96 1%239:54:18
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1peer.alt119.net7.2 MB21.4 KB7.2 MB0.1 KB/s5.3 KB23:57:46
2news.bbs.nz5.0 MB1.2 MB6.2 MB0.1 KB/s5.9 KB23:59:57
3news.nk.ca2.8 MB438.3 KB3.2 MB0.0 KB/s8.3 KB23:59:57
4news.quux.org1.3 MB510.0 KB1.8 MB0.0 KB/s7.3 KB23:59:57
5news.furie.org.uk211.2 KB216.5 KB427.8 KB0.0 KB/s9.3 KB23:59:25
6news.tnetconsulting.net27.5 KB3.3 KB30.8 KB0.0 KB/s4.4 KB23:59:57
7usenet.blueworldhosting.com10.3 KB0.0 KB10.3 KB0.0 KB/s5.2 KB23:58:46
8news.weretis.net9.1 KB3.9 KB13.1 KB0.0 KB/s2.6 KB23:59:57
9newsfeed.xs3.de0.0 KB13.6 KB13.6 KB0.0 KB/s1.9 KB23:59:13
10news.samoylyk.net0.0 KB7.9 KB7.9 KB0.0 KB/s1.6 KB23:59:23
TOTAL: 1016.5 MB2.3 MB18.9 MB0.0 KB/s6.1 KB239:54:18
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1192.241.213.155 1 00.0 KB 0 0 000:00:00
2stellar.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:08
3scanner-26.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 3 3 00.0 KB 0 0 000:00:09

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 1 00.0 KB 0 0 000:00:00
2*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
3*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:08
TOTAL: 3 3 00.0 KB 0 0 000:00:09

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
stellar.monitoring.internet-measurement.com 0.100 0.029 0.00000:00:08
scanner-26.ch1.censys-scanner.com 0.078 0.033 0.00000:00:00
192.241.213.155 0.079 0.033 0.00000:00:00
TOTAL: 3 0.257 0.095 0.00000:00:09

NNRP unrecognized commands (by host):

SystemConn
scanner-26.ch1.censys-scanner.com 1
192.241.213.155 1
TOTAL: 2 2

NNRP unrecognized commands (by command):

CommandCount
MGLNDD_192.138.210.162_119 1
EHLO www.censys.io 1
TOTAL: 2 2