Daily Usenet Report

Sep 3 00:01:02 -- Sep 4 00:01:01

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Sep 3 00:04:33 www innd: message repeated 2 times: [ ctlinnd command s]
Sep 3 01:51:25 www nnrpd[411535]: unable to get certificates from '/news/etc/cert.pem'
Sep 3 01:51:25 www nnrpd[411535]: error initializing TLS: [CA_file: ] [CA_path: /news/etc] [cert_file: /news/etc/cert.pem] [key_file: /news/etc/key.pem]
Sep 3 23:20:53 www nnrpd[440774]: unable to get certificates from '/news/etc/cert.pem'
Sep 3 23:20:53 www nnrpd[440774]: 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 13344 70.8%3.1 MB 78.3%
innd 3481 18.5%506.4 KB 12.6%
innfeed 1979 10.5%364.7 KB 9.1%
nnrpd 36 0.2%3.8 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 18841 100.0%3.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 81735 54.0%
Negative hits 56698 37.4%
Do not exist 12896 8.5%
Cache misses 111 0.1%
TOTAL: 4 151440 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.087 0.0%62 0.000 1.403 6.000
article cleanup00:00:00.198 0.0%12964 0.000 0.015 0.111
article logging00:00:00.580 0.0%13280 0.000 0.044 0.114
article parse00:00:00.370 0.0%18819 0.000 0.020 0.062
article write00:00:11.173 0.0%11374 0.368 0.982 2.846
artlog/artcncl00:00:00.002 0.0%62 0.000 0.032 0.500
data move00:00:00.195 0.0%152964 0.000 0.001 0.008
hisgrep/artcncl00:00:00.009 0.0%62 0.000 0.145 2.000
hishave/artcncl00:00:00.001 0.0%62 0.000 0.016 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:04.382 0.0%152298 0.003 0.029 0.093
history sync00:00:00.055 0.0%400 0.000 0.138 1.000
history write00:00:04.885 0.0%12963 0.095 0.377 0.882
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:58:50.946 99.9%150944 305.845 571.940 2693.004
nntp read00:00:06.322 0.0%151919 0.026 0.042 0.062
overview write00:00:06.472 0.0%11374 0.231 0.569 4.667
perl filter00:00:30.483 0.0%12963 1.702 2.352 4.449
python filter00:00:01.801 0.0%12963 0.053 0.139 0.387
site send00:00:03.776 0.0%22748 0.036 0.166 0.450
TOTAL: 24:00:59.93624:00:01.737 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.123 0.0%11783 0.000 0.010 0.103
article prepare00:00:00.003 0.0%14544 0.000 0.000 0.005
article read00:00:00.689 0.0%2248 0.000 0.306 9.400
backlog stats00:00:00.312 0.0%222317 0.000 0.001 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:04.977 0.0%150744 0.020 0.033 0.061
data write00:00:17.592 0.0%131346 0.073 0.134 0.238
idle23:57:13.339100.0%222317 208.349 387.885 1416.449
status file00:00:00.180 0.0%168 0.000 1.071 8.000
TOTAL: 23:57:44.93823:57:37.215100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:02.627 72.0%14 25.000 187.643 1734.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.002 0.1%29 0.000 0.069 0.500
TOTAL: 00:00:03.64800:00:02.629 72.1%----

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 5 20027 4963 14781 283 24%43:00:34
2usenet.blueworldhosting.com 4 12521 3075 8574 872 24%23:25:23
3peer.alt119.net 3 11959 2475 9093 391 20%21:22:35
4newsfeed.xs3.de 2 10301 332 9966 3 3%23:59:54
5news.samoylyk.net 2 10510 50 10455 5 0%23:59:41
6glockenspiel.complete.org 2 11325 48 11269 8 0%23:59:51
7news.furie.org.uk 2 5778 41 5737 0 0%23:59:34
8news.bbs.nz 1 11086 26 11060 0 0%23:59:45
9localhost 25 0 0 0 0 0%00:00:00
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
TOTAL: 11 49 93507 11010 80935 1562 11%208:17:22
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net16.9 MB0.0 KB596.3 KB17.5 MB 96%3.4 KB
2usenet.blueworldhosting.com14.7 MB0.0 KB2.1 MB16.8 MB 87%4.4 KB
3peer.alt119.net5.8 MB0.0 KB1.1 MB6.9 MB 84%2.5 KB
4newsfeed.xs3.de1.7 MB1.7 KB4.4 KB1.8 MB 99%5.4 KB
5news.samoylyk.net947.1 KB0.0 KB32.7 KB979.8 KB 96%17.8 KB
6glockenspiel.complete.org252.4 KB16.7 KB19.4 KB288.5 KB 87%5.2 KB
7news.furie.org.uk171.6 KB0.0 KB0.0 KB171.6 KB100%4.2 KB
8news.bbs.nz64.0 KB0.0 KB0.0 KB64.0 KB100%2.5 KB
9localhost0.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
11news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1140.6 MB18.4 KB3.8 MB44.5 MB 91%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 3 00:01:02 - 00:59:59 285 2.5% 0.081.5 MB 3.6% 0.43
Sep 3 01:00:00 - 01:59:59 361 3.2% 0.10914.2 KB 2.2% 0.25
Sep 3 02:00:00 - 02:59:59 514 4.5% 0.141.8 MB 4.3% 0.51
Sep 3 03:00:00 - 03:59:59 578 5.1% 0.161.6 MB 3.7% 0.44
Sep 3 04:00:00 - 04:59:59 572 5.0% 0.161.7 MB 4.0% 0.47
Sep 3 05:00:00 - 05:59:59 538 4.7% 0.151.6 MB 3.8% 0.45
Sep 3 06:00:00 - 06:59:59 538 4.7% 0.151.8 MB 4.4% 0.51
Sep 3 07:00:00 - 07:59:59 607 5.3% 0.171.9 MB 4.6% 0.54
Sep 3 08:00:00 - 08:59:59 557 4.9% 0.153.2 MB 7.6% 0.90
Sep 3 09:00:00 - 09:59:59 673 5.9% 0.192.1 MB 5.0% 0.60
Sep 3 10:00:00 - 10:59:59 638 5.6% 0.182.4 MB 5.7% 0.68
Sep 3 11:00:00 - 11:59:59 617 5.4% 0.173.1 MB 7.4% 0.88
Sep 3 12:00:00 - 12:59:59 635 5.6% 0.181.8 MB 4.4% 0.52
Sep 3 13:00:00 - 13:59:59 621 5.5% 0.171.7 MB 4.1% 0.49
Sep 3 14:00:00 - 14:59:59 594 5.2% 0.171.9 MB 4.5% 0.53
Sep 3 15:00:00 - 15:59:59 552 4.9% 0.152.9 MB 7.1% 0.84
Sep 3 16:00:00 - 16:59:59 422 3.7% 0.121.6 MB 3.8% 0.45
Sep 3 17:00:00 - 17:59:59 443 3.9% 0.121.5 MB 3.7% 0.44
Sep 3 18:00:00 - 18:59:59 270 2.4% 0.07918.8 KB 2.2% 0.26
Sep 3 19:00:00 - 19:59:59 221 1.9% 0.06659.1 KB 1.6% 0.18
Sep 3 20:00:00 - 20:59:59 442 3.9% 0.121.4 MB 3.3% 0.39
Sep 3 21:00:00 - 21:59:59 187 1.6% 0.051.6 MB 3.8% 0.45
Sep 3 22:00:00 - 22:59:59 198 1.7% 0.06606.6 KB 1.4% 0.17
Sep 3 23:00:00 - 23:59:59 305 2.7% 0.081.5 MB 3.6% 0.43
Sep 4 00:00:00 - 00:01:01 6 0.1% 0.1025.8 KB 0.1% 0.42
TOTAL: 23:59:59 11374 100.0% 0.1341.5 MB 100.0% 0.49
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 893 110 0 0 0 0 0 0 783
2endofthelinebbs-out.news.weretis.net 552 0 0 0 0 0 0 0 552
3peer.alt119.net 447 5 0 0 0 0 0 0 442
4newsfeed.xs3.de 10 0 0 1 0 0 0 0 9
5news.samoylyk.net 5 0 0 0 0 0 0 0 5
TOTAL: 5 1907 115 0 1 0 0 0 0 1791

Unwanted newsgroups [Top 20]:

NewsgroupCount
talk.english.tg 58
talk.generic.ua.ws 14
att.jobs 11
at.jobs 8
aus.jobs 5
rocksolid.feeds.news 5
rec.food-cooking 3
talk.english.tw 2
al.christnet.bible 2
alt.jobs.search.tw 1
panix.chat.politics 1
talk.from.diary 1
news.oriens-occasus.ru 1
grisbi.test 1
talk.from.war.diary 1
alt.alt.alt 1
TOTAL: 16 115

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 667
EMP (md5) 345
EMP (phl) 199
EMP (phn nph) 135
Too many newsgroups 110
Scoring filter 10
HTML Multipart 6
TOTAL: 7 1472

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 271
peer.alt119.net 30
usenet.blueworldhosting.com 11
newsfeed.xs3.de 7
TOTAL: 4 319
TOTAL: 1 319

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.bbs.nz 20561 1587 9613 149 0 254 7%23:59:43
2peer.alt119.net 10419 1261 7507 16 0 0 12%23:59:49
3news.nk.ca 14740 254 11021 81 0 33 1%23:59:56
4news.quux.org 11945 85 11164 105 0 12 0%23:59:56
5news.furie.org.uk 9625 51 6028 13 0 14 0%23:59:49
6usenet.blueworldhosting.com 9259 19 8105 0 0 43 0%23:59:56
7news.weretis.net 11469 2 11366 3 0 13 0%23:59:56
8news.tnetconsulting.net 12716 1 11365 0 0 26 0%23:59:54
9news.samoylyk.net 14194 1 11322 2 0 18 0%23:59:56
10newsfeed.xs3.de 13749 1 11017 10 0 5 0%23:59:56
TOTAL: 10 128677 3262 98508 379 0 418 2%239:58:51
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1peer.alt119.net6.6 MB222.1 KB6.9 MB0.1 KB/s5.5 KB23:59:49
2news.bbs.nz6.2 MB1.1 MB7.3 MB0.1 KB/s4.3 KB23:59:43
3news.nk.ca2.1 MB320.9 KB2.4 MB0.0 KB/s7.3 KB23:59:56
4news.quux.org1.4 MB304.1 KB1.7 MB0.0 KB/s9.1 KB23:59:56
5news.furie.org.uk1.2 MB50.4 KB1.3 MB0.0 KB/s20.5 KB23:59:49
6usenet.blueworldhosting.com42.3 KB0.0 KB42.3 KB0.0 KB/s2.2 KB23:59:56
7news.weretis.net3.3 KB1.1 MB1.1 MB0.0 KB/s232.3 KB23:59:56
8news.tnetconsulting.net1.8 KB0.0 KB1.8 KB0.0 KB/s1.8 KB23:59:54
9news.samoylyk.net1.7 KB4.7 KB6.3 KB0.0 KB/s2.1 KB23:59:56
10newsfeed.xs3.de1.1 KB29.9 KB31.0 KB0.0 KB/s2.8 KB23:59:56
TOTAL: 1017.6 MB3.1 MB20.7 MB0.0 KB/s5.8 KB239:58:51
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1195.96.137.3 4 00.0 KB 0 0 000:00:01
2192.241.209.26 1 00.0 KB 0 0 000:00:00
3monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
4scanner-06.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 4 7 00.0 KB 0 0 000:00:03

NNRP readership statistics (by domain):

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

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
monitoring.internet-measurement.com 0.061 0.056 0.00000:00:01
195.96.137.3 0.320 0.116 0.00000:00:01
scanner-06.ch1.censys-scanner.com 0.083 0.047 0.00000:00:00
192.241.209.26 0.080 0.053 0.00000:00:00
TOTAL: 4 0.544 0.272 0.00000:00:03

NNRP unrecognized commands (by host):

SystemConn
195.96.137.3 2
scanner-06.ch1.censys-scanner.com 1
192.241.209.26 1
TOTAL: 3 4

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

SystemConnPeer
195.96.137.3 1 1
TOTAL: 1 1 1