Daily Usenet Report

Dec 10 00:01:02 -- Dec 11 00:01:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Dec 10 00:06:22 www innd: message repeated 2 times: [ ctlinnd command s]
Dec 10 15:42:44 www nnrpd[3276305]: unable to get certificates from '/news/etc/cert.pem'
Dec 10 15:42:44 www nnrpd[3276305]: 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 12238 67.0%3.3 MB 77.8%
innd 3674 20.1%527.4 KB 12.1%
innfeed 2340 12.8%438.0 KB 10.1%
nnrpd 17 0.1%2.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 18270 100.0%4.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 87049 56.6%
Negative hits 54658 35.5%
Do not exist 12053 7.8%
Cache misses 22 0.0%
TOTAL: 4 153782 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.081 0.0%52 0.000 1.558 10.000
article cleanup00:00:00.235 0.0%12094 0.000 0.019 0.095
article logging00:00:00.648 0.0%12193 0.000 0.053 0.132
article parse00:00:00.439 0.0%19759 0.000 0.022 0.160
article write00:00:08.922 0.0%10548 0.324 0.846 2.673
artlog/artcncl00:00:00.000 0.0%52 0.000 0.000 0.000
data move00:00:00.198 0.0%156145 0.000 0.001 0.006
hisgrep/artcncl00:00:00.008 0.0%52 0.000 0.154 2.000
hishave/artcncl00:00:00.007 0.0%52 0.000 0.135 0.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.992 0.0%154235 0.002 0.045 0.107
history sync00:00:00.051 0.0%407 0.000 0.125 1.333
history write00:00:06.876 0.0%12093 0.071 0.569 1.022
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:58:33.273 99.8%153695 291.570 561.588 1906.010
nntp read00:00:06.914 0.0%154511 0.016 0.045 0.076
overview write00:00:07.494 0.0%10548 0.189 0.710 3.561
perl filter00:00:36.642 0.0%12093 1.870 3.030 8.571
python filter00:00:02.197 0.0%12093 0.089 0.182 0.559
site send00:00:04.084 0.0%21096 0.046 0.194 0.483
TOTAL: 24:01:08.38223:59:55.061 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.112 0.0%10883 0.000 0.010 0.083
article prepare00:00:00.003 0.0%33764 0.000 0.000 0.005
article read00:00:01.656 0.0%5503 0.086 0.301 2.138
backlog stats00:00:00.496 0.0%226593 0.000 0.002 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:05.855 0.0%150340 0.019 0.039 0.075
data write00:00:21.383 0.0%141576 0.090 0.151 0.313
idle23:55:17.258100.0%226593 212.886 380.053 1064.042
status file00:00:00.224 0.0%197 0.000 1.137 5.000
TOTAL: 23:55:57.71723:55:46.987100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:03.444 76.4%7 22.000 492.000 1716.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.001 0.0%14 0.000 0.071 0.500
TOTAL: 00:00:04.50600:00:03.445 76.5%----

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 5 21472 6065 15144 263 28%52:39:57
2usenet.blueworldhosting.com 4 11408 3295 7681 432 28%23:36:14
3newsfeed.xs3.de 2 9403 603 8799 1 6%23:59:21
4outgoing.news.lysator.liu.se 1 11626 499 10603 524 4%23:59:57
5news.samoylyk.net 1 9652 91 9560 1 0%23:59:49
6glockenspiel.complete.org 2 10261 31 10230 0 0%23:59:46
7news.bbs.nz 3 13285 18 13266 1 0%30:09:56
8news.furie.org.uk 2 5576 10 5563 3 0%23:59:35
9news.netfront.net 2 14533 2 14219 312 0%29:19:28
10news.nk.ca 2 0 0 0 0 0%00:20:02
11eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:04
12localhost 25 0 0 0 0 0%00:00:00
TOTAL: 12 50 107216 10614 95065 1537 9%256:14:09
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com19.8 MB0.0 KB2.1 MB21.8 MB 90%6.0 KB
2endofthelinebbs-out.news.weretis.net18.6 MB0.0 KB459.6 KB19.1 MB 97%3.1 KB
3newsfeed.xs3.de2.8 MB0.0 KB1.2 KB2.8 MB 99%4.7 KB
4news.samoylyk.net1.9 MB0.0 KB1.7 KB1.9 MB 99%21.6 KB
5outgoing.news.lysator.liu.se1.4 MB0.0 KB1.5 MB2.9 MB 47%2.9 KB
6glockenspiel.complete.org313.4 KB0.0 KB0.0 KB313.4 KB100%10.1 KB
7news.bbs.nz50.8 KB2.4 KB2.4 KB55.6 KB 91%2.9 KB
8news.furie.org.uk29.9 KB0.0 KB12.0 KB41.9 KB 71%3.2 KB
9news.netfront.net2.3 KB0.0 KB1012.9 KB1015.3 KB 0%3.2 KB
10news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
11eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
12localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1244.8 MB2.4 KB5.1 MB49.9 MB 89%4.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 10 00:01:02 - 00:59:59 230 2.2% 0.072.2 MB 4.9% 0.63
Dec 10 01:00:00 - 01:59:59 304 2.9% 0.081.2 MB 2.6% 0.33
Dec 10 02:00:00 - 02:59:59 392 3.7% 0.111.3 MB 3.0% 0.38
Dec 10 03:00:00 - 03:59:59 587 5.6% 0.161.8 MB 4.0% 0.51
Dec 10 04:00:00 - 04:59:59 592 5.6% 0.162.0 MB 4.4% 0.56
Dec 10 05:00:00 - 05:59:59 495 4.7% 0.142.9 MB 6.5% 0.82
Dec 10 06:00:00 - 06:59:59 573 5.4% 0.161.7 MB 3.8% 0.49
Dec 10 07:00:00 - 07:59:59 626 5.9% 0.172.2 MB 5.0% 0.63
Dec 10 08:00:00 - 08:59:59 517 4.9% 0.141.8 MB 4.0% 0.50
Dec 10 09:00:00 - 09:59:59 613 5.8% 0.172.2 MB 4.9% 0.62
Dec 10 10:00:00 - 10:59:59 538 5.1% 0.153.0 MB 6.7% 0.85
Dec 10 11:00:00 - 11:59:59 639 6.1% 0.182.9 MB 6.6% 0.84
Dec 10 12:00:00 - 12:59:59 501 4.8% 0.142.0 MB 4.4% 0.56
Dec 10 13:00:00 - 13:59:59 605 5.7% 0.172.9 MB 6.5% 0.83
Dec 10 14:00:00 - 14:59:59 444 4.2% 0.121.6 MB 3.6% 0.46
Dec 10 15:00:00 - 15:59:59 558 5.3% 0.153.1 MB 7.0% 0.89
Dec 10 16:00:00 - 16:59:59 426 4.0% 0.122.1 MB 4.6% 0.58
Dec 10 17:00:00 - 17:59:59 420 4.0% 0.121.9 MB 4.2% 0.54
Dec 10 18:00:00 - 18:59:59 388 3.7% 0.111.4 MB 3.2% 0.41
Dec 10 19:00:00 - 19:59:59 272 2.6% 0.081.6 MB 3.5% 0.45
Dec 10 20:00:00 - 20:59:59 207 2.0% 0.06699.2 KB 1.5% 0.19
Dec 10 21:00:00 - 21:59:59 206 2.0% 0.06767.0 KB 1.7% 0.21
Dec 10 22:00:00 - 22:59:59 198 1.9% 0.06759.4 KB 1.7% 0.21
Dec 10 23:00:00 - 23:59:59 204 1.9% 0.06792.7 KB 1.7% 0.22
Dec 11 00:00:00 - 00:01:02 8 0.1% 0.1336.5 KB 0.1% 0.59
TOTAL: 24:00:00 10543 100.0% 0.1244.8 MB 100.0% 0.53
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1outgoing.news.lysator.liu.se 545 0 0 0 0 0 0 0 545
2usenet.blueworldhosting.com 439 26 0 0 0 0 0 0 413
3endofthelinebbs-out.news.weretis.net 350 0 0 0 0 0 0 0 350
4news.netfront.net 298 0 0 0 0 0 0 0 298
5newsfeed.xs3.de 6 0 0 0 0 0 0 0 6
6news.furie.org.uk 3 0 0 0 0 0 0 0 3
7news.samoylyk.net 1 0 0 0 0 0 0 0 1
8news.bbs.nz 1 0 0 1 0 0 0 0 0
TOTAL: 8 1643 26 0 1 0 0 0 0 1616

Unwanted newsgroups [Top 20]:

NewsgroupCount
sk.politics 11
rocksolid.feeds.news 5
gun.general 3
alt.alt.alt.alt 2
alt.alt.alt 2
alt.bestjobsusa.pittsburgh.jobs 1
alt.rock-n-roll.psychedelic 1
ee.arvutid 1
TOTAL: 8 26

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 596
EMP (phn path) 519
EMP (phl) 172
Too many newsgroups 162
EMP (phn nph) 58
Scoring filter 7
HTML post 2
HTML Multipart 1
TOTAL: 8 1517

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 87
newsfeed.xs3.de 5
outgoing.news.lysator.liu.se 4
usenet.blueworldhosting.com 3
TOTAL: 4 99
TOTAL: 1 99

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 14160 5120 5404 16 0 49 36%23:59:56
2nyheter.lysator.liu.se 10540 2791 7245 9 0 0 26%23:59:19
3news.nk.ca 13788 190 10249 45 0 27 1%23:59:56
4news.furie.org.uk 8926 55 5895 1 0 0 0%23:59:56
5news.bbs.nz 20716 37 10450 35 0 227 0%23:59:53
6news.quux.org 10804 22 10377 113 0 0 0%23:59:56
7news.tnetconsulting.net 11326 2 10539 0 0 48 0%23:59:48
8usenet.blueworldhosting.com 7459 1 7152 0 0 0 0%23:59:39
9news.weretis.net 10567 1 10538 0 0 0 0%23:58:47
10peer.alt119.net 0 0 0 0 0 10543 0%23:57:47
11news.samoylyk.net 13349 0 10449 0 0 0 0%23:59:25
12newsfeed.xs3.de 12755 0 9924 3 0 0 0%23:59:56
TOTAL: 12 134390 8219 98222 222 0 10894 6%287:54:18
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net25.7 MB96.7 KB25.8 MB0.3 KB/s5.2 KB23:59:56
2nyheter.lysator.liu.se16.6 MB81.0 KB16.6 MB0.2 KB/s6.1 KB23:59:19
3news.furie.org.uk4.1 MB18.1 KB4.1 MB0.0 KB/s75.4 KB23:59:56
4news.bbs.nz945.9 KB306.5 KB1.2 MB0.0 KB/s17.4 KB23:59:53
5news.nk.ca707.2 KB688.0 KB1.4 MB0.0 KB/s5.9 KB23:59:56
6news.quux.org331.7 KB993.0 KB1.3 MB0.0 KB/s9.8 KB23:59:56
7news.tnetconsulting.net5.9 KB0.0 KB5.9 KB0.0 KB/s2.9 KB23:59:48
8news.weretis.net1.7 KB0.0 KB1.7 KB0.0 KB/s1.7 KB23:58:47
9usenet.blueworldhosting.com1.3 KB0.0 KB1.3 KB0.0 KB/s1.3 KB23:59:39
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:25
12newsfeed.xs3.de0.0 KB10.8 KB10.8 KB0.0 KB/s3.6 KB23:59:56
TOTAL: 1248.4 MB2.1 MB50.5 MB0.0 KB/s6.1 KB287:54:18
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1192.241.205.222 1 00.0 KB 0 0 000:00:00
2sweet.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
3splendid.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:02
4scanner-09.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 4 4 00.0 KB 0 0 000:00:04

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 2 00.0 KB 0 0 000:00:04
TOTAL: 3 4 00.0 KB 0 0 000:00:04

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
splendid.monitoring.internet-measurement.com 0.081 0.041 0.00000:00:02
sweet.monitoring.internet-measurement.com 0.081 0.052 0.00000:00:01
192.241.205.222 0.101 0.063 0.00000:00:00
scanner-09.ch1.censys-scanner.com 0.081 0.046 0.00000:00:00
TOTAL: 4 0.344 0.202 0.00000:00:04

NNRP unrecognized commands (by host):

SystemConn
scanner-09.ch1.censys-scanner.com 1
192.241.205.222 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