Daily Usenet Report

Oct 18 00:01:01 -- Oct 19 00:01:01

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Oct 18 00:05:19 www innd: message repeated 2 times: [ ctlinnd command s]
Oct 18 08:27:35 www nnrpd[2001922]: unable to get certificates from '/news/etc/cert.pem'
Oct 18 08:27:35 www nnrpd[2001922]: 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 14211 68.5%3.6 MB 78.3%
innd 4227 20.4%589.2 KB 12.5%
innfeed 2287 11.0%433.0 KB 9.2%
nnrpd 25 0.1%2.7 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 20751 100.0%4.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 96371 54.9%
Negative hits 65330 37.2%
Do not exist 13907 7.9%
Cache misses 20 0.0%
TOTAL: 4 175628 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.076 0.0%61 0.000 1.246 3.000
article cleanup00:00:00.227 0.0%13939 0.000 0.016 0.154
article logging00:00:00.676 0.0%14104 0.000 0.048 0.152
article parse00:00:00.408 0.0%22186 0.000 0.018 0.082
article write00:00:09.976 0.0%11807 0.363 0.845 2.757
artlog/artcncl00:00:00.001 0.0%61 0.000 0.016 1.000
artlog/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
artlog/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.206 0.0%179981 0.000 0.001 0.006
hisgrep/artcncl00:00:00.012 0.0%60 0.000 0.200 2.000
hishave/artcncl00:00:00.003 0.0%61 0.000 0.049 0.333
hishave/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.697 0.0%175894 0.003 0.038 0.077
history sync00:00:00.061 0.0%387 0.000 0.158 1.500
history write00:00:07.140 0.0%13938 0.098 0.512 0.814
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
hiswrite/artparse00:00:00.001 0.0%1 1.000 1.000 1.000
idle23:48:23.349 99.8%176610 265.374 485.269 2665.742
nntp read00:00:08.556 0.0%178131 0.027 0.048 0.100
overview write00:00:07.513 0.0%11807 0.241 0.636 5.333
perl filter00:00:37.448 0.0%13938 2.121 2.687 5.438
python filter00:00:02.128 0.0%13938 0.066 0.153 0.333
site send00:00:04.646 0.0%23614 0.063 0.197 0.625
TOTAL: 23:51:04.60123:49:49.124 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.143 0.0%12076 0.000 0.012 0.200
article prepare00:00:00.000 0.0%6554 0.000 0.000 0.000
article read00:00:00.456 0.0%1434 0.000 0.318 5.900
backlog stats00:00:00.445 0.0%208503 0.000 0.002 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:06.297 0.0%152705 0.017 0.041 0.071
data write00:00:19.062 0.0%138551 0.090 0.138 0.238
idle23:55:29.840100.0%208503 225.542 413.087 1855.358
status file00:00:00.172 0.0%166 0.000 1.036 2.000
TOTAL: 23:56:05.78623:55:56.415100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:14.481 76.1%9 66.333 1609.000 10029.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.002 0.0%20 0.000 0.100 0.500
TOTAL: 00:00:19.04100:00:14.483 76.1%----

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 23241 5536 17224 481 23%49:38:54
2peer.alt119.net 4 14728 3090 10362 1276 20%26:48:06
3usenet.blueworldhosting.com 5 13109 2964 9701 444 22%23:09:06
4newsfeed.xs3.de 1 10650 221 10422 7 2%23:59:55
5glockenspiel.complete.org 2 10713 57 10654 2 0%23:59:49
6news.samoylyk.net 1 10984 22 10961 1 0%23:59:50
7outgoing.news.lysator.liu.se 1 11064 10 11054 0 0%23:59:59
8news.furie.org.uk 2 6003 8 5995 0 0%23:59:32
9news.bbs.nz 2 11812 7 11805 0 0%26:56:22
10eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:04
11news.nk.ca 2 0 0 0 0 0%00:20:01
12localhost 25 0 0 0 0 0%00:00:00
TOTAL: 12 49 112304 11915 98178 2211 10%247:01:38
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com22.0 MB0.0 KB3.2 MB25.3 MB 87%7.6 KB
2endofthelinebbs-out.news.weretis.net18.9 MB0.0 KB1.0 MB19.9 MB 94%3.4 KB
3peer.alt119.net7.2 MB0.0 KB5.2 MB12.4 MB 58%2.9 KB
4newsfeed.xs3.de833.2 KB0.0 KB11.2 KB844.4 KB 98%3.7 KB
5glockenspiel.complete.org569.1 KB0.0 KB3.2 KB572.3 KB 99%9.7 KB
6news.samoylyk.net125.3 KB4.5 KB4.5 KB134.3 KB 93%5.8 KB
7news.furie.org.uk28.0 KB0.0 KB0.0 KB28.0 KB100%3.5 KB
8news.bbs.nz27.4 KB0.0 KB0.0 KB27.4 KB100%3.9 KB
9outgoing.news.lysator.liu.se27.4 KB0.0 KB0.0 KB27.4 KB100%2.7 KB
10eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
11news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
12localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1249.7 MB4.5 KB9.5 MB59.2 MB 83%4.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 18 00:01:01 - 00:59:59 247 2.1% 0.071.1 MB 2.2% 0.32
Oct 18 01:00:00 - 01:59:59 321 2.7% 0.091009.1 KB 2.0% 0.28
Oct 18 02:00:00 - 02:59:59 442 3.7% 0.121.8 MB 3.6% 0.50
Oct 18 03:00:00 - 03:59:59 594 5.0% 0.171.7 MB 3.5% 0.49
Oct 18 04:00:00 - 04:59:59 650 5.5% 0.181.9 MB 3.9% 0.55
Oct 18 05:00:00 - 05:59:59 537 4.5% 0.152.1 MB 4.2% 0.59
Oct 18 06:00:00 - 06:59:59 509 4.3% 0.142.7 MB 5.5% 0.76
Oct 18 07:00:00 - 07:59:59 547 4.6% 0.152.0 MB 4.0% 0.56
Oct 18 08:00:00 - 08:59:59 658 5.6% 0.182.1 MB 4.4% 0.61
Oct 18 09:00:00 - 09:59:59 734 6.2% 0.202.3 MB 4.7% 0.66
Oct 18 10:00:00 - 10:59:59 759 6.4% 0.212.5 MB 5.2% 0.72
Oct 18 11:00:00 - 11:59:59 746 6.3% 0.212.5 MB 5.0% 0.70
Oct 18 12:00:00 - 12:59:59 570 4.8% 0.161.5 MB 3.0% 0.42
Oct 18 13:00:00 - 13:59:59 682 5.8% 0.193.8 MB 7.7% 1.07
Oct 18 14:00:00 - 14:59:59 733 6.2% 0.202.3 MB 4.6% 0.64
Oct 18 15:00:00 - 15:59:59 603 5.1% 0.172.6 MB 5.3% 0.73
Oct 18 16:00:00 - 16:59:59 556 4.7% 0.152.9 MB 5.9% 0.83
Oct 18 17:00:00 - 17:59:59 385 3.2% 0.111.3 MB 2.6% 0.36
Oct 18 18:00:00 - 18:59:59 329 2.8% 0.092.7 MB 5.4% 0.76
Oct 18 19:00:00 - 19:59:59 275 2.3% 0.082.4 MB 4.9% 0.68
Oct 18 20:00:00 - 20:59:59 290 2.4% 0.081.6 MB 3.4% 0.47
Oct 18 21:00:00 - 21:59:59 192 1.6% 0.05753.9 KB 1.5% 0.21
Oct 18 22:00:00 - 22:59:59 224 1.9% 0.061.1 MB 2.2% 0.31
Oct 18 23:00:00 - 23:59:59 259 2.2% 0.072.4 MB 5.0% 0.69
Oct 19 00:00:00 - 00:01:01 8 0.1% 0.1319.9 KB 0.0% 0.33
TOTAL: 24:00:00 11850 100.0% 0.1449.0 MB 100.0% 0.58
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1peer.alt119.net 1220 18 0 0 0 0 0 0 1202
2endofthelinebbs-out.news.weretis.net 633 0 0 0 0 0 0 0 633
3usenet.blueworldhosting.com 433 42 0 0 0 0 0 0 391
4newsfeed.xs3.de 10 0 0 0 0 0 0 0 10
5glockenspiel.complete.org 2 0 0 0 0 0 0 0 2
6news.samoylyk.net 2 0 0 1 0 0 0 0 1
TOTAL: 6 2300 60 0 1 0 0 0 0 2239

Unwanted newsgroups [Top 20]:

NewsgroupCount
att.jobs 14
at.jobs 13
aus.jobs 10
panix.questions 6
rocksolid.feeds.news 4
panix.test 3
fr.petites-annonces.informatique.materiel 2
alt.culture.underwear 2
alt.invest.penny-stock 1
alt.personal.bondage 1
grisbi.test 1
panix.chat.politics 1
ee.arvutid 1
mk.comp.games 1
TOTAL: 14 60

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 955
EMP (md5) 772
EMP (phl) 206
Too many newsgroups 89
EMP (phn nph) 18
HTML Multipart 18
Scoring filter 13
Too many newsgroups (meow) 1
Bot - Newsgroup autoposter 1
TOTAL: 9 2073

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Huge articles
usenet.blueworldhosting.com 1
TOTAL: 1 1
Including strange strings
endofthelinebbs-out.news.weretis.net 148
peer.alt119.net 10
newsfeed.xs3.de 3
usenet.blueworldhosting.com 2
news.samoylyk.net 1
glockenspiel.complete.org 1
TOTAL: 6 165
TOTAL: 2 166

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nyheter.lysator.liu.se 15171 652 10742 438 1 210 4%23:59:56
2news.nk.ca 12932 209 11560 36 0 5 1%23:59:56
3peer.alt119.net 10326 117 8703 0 0 0 1%23:59:56
4news.bbs.nz 23263 11 11797 37 0 36 0%23:59:56
5usenet.blueworldhosting.com 9361 11 8490 0 0 0 0%23:59:56
6news.furie.org.uk 7193 11 6230 22 0 0 0%23:59:56
7news.weretis.net 12340 4 11842 1 0 0 0%23:59:56
8news.tnetconsulting.net 12543 3 11834 11 0 0 0%23:59:56
9news.quux.org 12103 1 11719 74 0 0 0%23:59:56
10newsfeed.xs3.de 11817 0 11622 1 0 0 0%23:59:56
11news.samoylyk.net 12162 0 11826 0 0 0 0%23:59:44
12theuse.net 0 0 0 0 0 11847 0%23:59:56
TOTAL: 12 139211 1019 116365 620 1 12098 0%287:59:00
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nyheter.lysator.liu.se5.8 MB2.8 MB8.6 MB0.1 KB/s8.1 KB23:59:56
2peer.alt119.net1.3 MB0.0 KB1.3 MB0.0 KB/s11.6 KB23:59:56
3news.nk.ca449.0 KB116.7 KB565.6 KB0.0 KB/s2.3 KB23:59:56
4news.furie.org.uk103.4 KB172.5 KB275.9 KB0.0 KB/s8.4 KB23:59:56
5usenet.blueworldhosting.com32.0 KB0.0 KB32.0 KB0.0 KB/s2.9 KB23:59:56
6news.bbs.nz30.9 KB367.3 KB398.2 KB0.0 KB/s8.3 KB23:59:56
7news.weretis.net12.1 KB3.0 KB15.1 KB0.0 KB/s3.0 KB23:59:56
8news.tnetconsulting.net8.2 KB15.5 KB23.7 KB0.0 KB/s1.7 KB23:59:56
9news.quux.org1.7 KB154.7 KB156.5 KB0.0 KB/s2.1 KB23:59:56
10newsfeed.xs3.de0.0 KB1.9 KB1.9 KB0.0 KB/s1.9 KB23:59:56
11news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:44
12theuse.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
TOTAL: 127.7 MB3.6 MB11.4 MB0.0 KB/s7.1 KB287:59:00
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1scanner-05.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
2likeable.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
3euphoric.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
427.124.32.147 2 00.0 KB 0 0 000:00:14
TOTAL: 4 5 00.0 KB 0 0 000:00:19

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
2*.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:03
3unresolved 2 00.0 KB 0 0 000:00:14
TOTAL: 3 5 00.0 KB 0 0 000:00:19

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
27.124.32.147 0.122 0.072 0.00000:00:14
euphoric.monitoring.internet-measurement.com 0.060 0.052 0.00000:00:01
likeable.monitoring.internet-measurement.com 0.088 0.037 0.00000:00:01
scanner-05.ch1.censys-scanner.com 0.095 0.052 0.00000:00:00
TOTAL: 4 0.365 0.213 0.00000:00:19

NNRP unrecognized commands (by host):

SystemConn
27.124.32.147 2
scanner-05.ch1.censys-scanner.com 1
TOTAL: 2 3

NNRP unrecognized commands (by command):

CommandCount
EHLO www.censys.io 1
#026#003#001 1
#001 1
TOTAL: 3 3

NNRP client timeouts [Top 20]:

SystemConnPeer
27.124.32.147 1 1
TOTAL: 1 1 1