Daily Usenet Report

May 20 00:01:01 -- May 21 00:01:02

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

May 20 00:02:48 www innd: message repeated 2 times: [ ctlinnd command s]
May 20 16:34:26 www innd: tradspool: could not open /news/spool/articles/us/military/navy/9: File exists
May 20 17:28:52 www innd: tradspool: could not open /news/spool/articles/us/military/navy/11: File exists
May 20 17:28:53 www innd: tradspool: could not open /news/spool/articles/us/military/navy/12: File exists
May 20 17:28:57 www innd: tradspool: could not open /news/spool/articles/us/military/navy/13: File exists
May 20 20:34:35 www nnrpd[1409006]: unable to get certificates from '/news/etc/cert.pem'
May 20 20:34:35 www nnrpd[1409006]: 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 13929 72.6%3.1 MB 79.5%
innd 3335 17.4%489.3 KB 12.2%
innfeed 1841 9.6%327.4 KB 8.2%
nnrpd 73 0.4%6.2 KB 0.2%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 19179 100.0%3.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 76279 51.7%
Negative hits 57682 39.1%
Do not exist 13218 9.0%
Cache misses 299 0.2%
TOTAL: 4 147478 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.516 0.0%314 0.000 1.643 5.000
article cleanup00:00:00.297 0.0%13299 0.000 0.022 0.143
article logging00:00:00.591 0.0%13641 0.000 0.043 0.125
article parse00:00:00.459 0.0%19881 0.000 0.023 0.100
article write00:00:06.973 0.0%11660 0.301 0.598 2.684
artlog/artcncl00:00:00.006 0.0%313 0.000 0.019 0.125
artlog/artwrite00:00:00.000 0.0%4 0.000 0.000 0.000
data move00:00:00.135 0.0%151699 0.000 0.001 0.005
hisgrep/artcncl00:00:00.114 0.0%314 0.000 0.363 1.500
hishave/artcncl00:00:00.058 0.0%314 0.000 0.185 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:02.767 0.0%147873 0.002 0.019 0.085
history sync00:00:00.050 0.0%408 0.000 0.123 1.000
history write00:00:03.443 0.0%13287 0.062 0.259 0.659
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:58:53.512 99.8%149297 207.279 578.267 2076.055
nntp read00:00:05.463 0.0%150284 0.020 0.036 0.083
overview write00:00:06.957 0.0%11656 0.210 0.597 2.232
perl filter00:00:39.866 0.0%13291 1.213 2.999 5.379
python filter00:00:02.343 0.0%13291 0.071 0.176 0.577
site send00:00:04.648 0.0%23312 0.044 0.199 0.618
TOTAL: 24:01:07.62824:00:08.198 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.103 0.0%12227 0.000 0.008 0.105
article prepare00:00:00.000 0.0%4340 0.000 0.000 0.000
article read00:00:00.321 0.0%873 0.000 0.368 46.000
backlog stats00:00:00.345 0.0%191862 0.000 0.002 0.016
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:03.824 0.0%132830 0.013 0.029 0.053
data write00:00:15.809 0.0%121709 0.085 0.130 0.217
idle23:57:38.721100.0%191862 126.573 449.587 1573.665
status file00:00:00.159 0.0%178 0.000 0.893 4.000
TOTAL: 23:58:07.22223:57:59.282100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:10.117 95.0%6 20.667 1686.167 10006.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.500
TOTAL: 00:00:10.64600:00:10.118 95.0%----

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 4 19313 5796 13325 192 30%39:36:00
2usenet.blueworldhosting.com 3 11663 2980 7926 757 25%21:49:44
3peer.alt119.net 2 12978 1964 10387 627 15%23:59:33
4newsfeed.xs3.de 1 10823 383 10357 83 3%23:59:53
5news.samoylyk.net 2 10691 48 10637 6 0%23:59:44
6glockenspiel.complete.org 2 11442 32 11410 0 0%23:59:37
7news.bbs.nz 5 15943 23 15920 0 0%35:36:30
8eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:04
9localhost 25 0 0 0 0 0%00:00:00
10news.nk.ca 2 0 0 0 0 0%00:20:01
TOTAL: 10 47 92853 11226 79962 1665 12%193:31:06
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net21.6 MB11.2 KB2.5 MB24.1 MB 89%4.1 KB
2usenet.blueworldhosting.com12.8 MB0.0 KB1.9 MB14.7 MB 87%4.0 KB
3peer.alt119.net4.5 MB86.4 KB1.9 MB6.5 MB 69%2.6 KB
4newsfeed.xs3.de1.2 MB0.0 KB1.9 MB3.1 MB 37%6.8 KB
5glockenspiel.complete.org216.6 KB0.0 KB0.0 KB216.6 KB100%6.8 KB
6news.samoylyk.net191.8 KB79.7 KB495.8 KB767.3 KB 24%14.2 KB
7news.bbs.nz63.3 KB0.0 KB0.0 KB63.3 KB100%2.8 KB
8eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
10news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1040.7 MB177.3 KB8.7 MB49.5 MB 82%3.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 20 00:01:01 - 00:59:59 304 2.6% 0.091.6 MB 3.7% 0.46
May 20 01:00:00 - 01:59:59 369 3.2% 0.101.0 MB 2.4% 0.30
May 20 02:00:00 - 02:59:59 524 4.5% 0.151.5 MB 3.4% 0.42
May 20 03:00:00 - 03:59:59 546 4.7% 0.151.6 MB 3.8% 0.46
May 20 04:00:00 - 04:59:59 639 5.5% 0.181.9 MB 4.4% 0.53
May 20 05:00:00 - 05:59:59 552 4.7% 0.151.4 MB 3.4% 0.41
May 20 06:00:00 - 06:59:59 477 4.1% 0.131.6 MB 3.8% 0.46
May 20 07:00:00 - 07:59:59 872 7.5% 0.242.2 MB 5.1% 0.62
May 20 08:00:00 - 08:59:59 604 5.2% 0.171.8 MB 4.2% 0.51
May 20 09:00:00 - 09:59:59 631 5.4% 0.182.9 MB 6.8% 0.84
May 20 10:00:00 - 10:59:59 663 5.7% 0.182.4 MB 5.7% 0.69
May 20 11:00:00 - 11:59:59 687 5.9% 0.192.0 MB 4.7% 0.57
May 20 12:00:00 - 12:59:59 546 4.7% 0.151.6 MB 3.7% 0.45
May 20 13:00:00 - 13:59:59 604 5.2% 0.174.8 MB 11.1% 1.36
May 20 14:00:00 - 14:59:59 700 6.0% 0.192.8 MB 6.6% 0.81
May 20 15:00:00 - 15:59:59 507 4.4% 0.141.8 MB 4.3% 0.52
May 20 16:00:00 - 16:59:59 507 4.4% 0.141.9 MB 4.4% 0.54
May 20 17:00:00 - 17:59:59 426 3.7% 0.122.6 MB 6.0% 0.74
May 20 18:00:00 - 18:59:59 257 2.2% 0.07915.7 KB 2.1% 0.25
May 20 19:00:00 - 19:59:59 242 2.1% 0.07978.7 KB 2.2% 0.27
May 20 20:00:00 - 20:59:59 286 2.5% 0.08952.8 KB 2.2% 0.26
May 20 21:00:00 - 21:59:59 205 1.8% 0.06664.2 KB 1.5% 0.18
May 20 22:00:00 - 22:59:59 221 1.9% 0.061.1 MB 2.5% 0.30
May 20 23:00:00 - 23:59:59 258 2.2% 0.07872.5 KB 2.0% 0.24
May 21 00:00:00 - 00:01:02 3 0.0% 0.057.1 KB 0.0% 0.11
TOTAL: 24:00:01 11630 100.0% 0.1342.9 MB 100.0% 0.51
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 798 148 0 0 0 0 0 0 650
2peer.alt119.net 591 32 0 4 0 0 0 0 555
3endofthelinebbs-out.news.weretis.net 490 2 0 3 0 0 0 0 485
4newsfeed.xs3.de 98 1 0 0 0 0 0 0 97
5news.samoylyk.net 7 0 0 1 0 0 0 0 6
6glockenspiel.complete.org 1 0 0 0 0 0 0 0 1
7news.bbs.nz 1 0 0 0 0 0 0 0 1
TOTAL: 7 1986 183 0 8 0 0 0 0 1795

Unwanted newsgroups [Top 20]:

NewsgroupCount
talk.english.tg 64
talk.generic.ua.ws 28
talk.english.tw 22
at.jobs 16
sk.politics 8
comp.hackers 8
aus.jobs 7
rocksolid.feeds.news 5
att.jobs 5
talk.from.diary 2
talk.from.war.diary 2
grisbi.bugsreports 2
news.oriens-occasus.ru 2
alt.finals.suicide 2
talk.politics 2
panix.questions 1
panix.chat.politics 1
alt.islam 1
grisbi.devel 1
magma.test 1
TOTAL: 23 183

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 816
EMP (md5) 265
EMP (phn nph) 154
EMP (phl) 82
Too many newsgroups 56
Binary Image: misplaced jpg 56
Scoring filter 8
HTML Multipart 4
Binary: misplaced binary 1
MID-Bot 1
TOTAL: 10 1443

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 294
usenet.blueworldhosting.com 22
peer.alt119.net 16
newsfeed.xs3.de 15
news.samoylyk.net 1
TOTAL: 5 348
TOTAL: 1 348

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1peer.alt119.net 11789 753 8946 14 0 0 6%23:59:34
2news.nk.ca 13455 85 11515 17 0 87 0%23:59:57
3news.bbs.nz 22504 21 11552 49 0 292 0%23:59:57
4news.quux.org 12249 12 11452 130 0 74 0%23:59:57
5news.weretis.net 11671 1 11627 0 0 0 0%23:59:19
6usenet.blueworldhosting.com 8764 1 8430 0 0 62 0%23:59:50
7news.tnetconsulting.net 12818 1 11629 0 0 44 0%23:59:49
8newsfeed.xs3.de 13872 0 11243 1 0 18 0%23:59:52
9news.samoylyk.net 14307 0 11584 0 0 19 0%23:59:38
TOTAL: 9 121429 874 97978 211 0 596 0%215:57:53
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1peer.alt119.net3.8 MB54.3 KB3.9 MB0.0 KB/s5.2 KB23:59:34
2news.bbs.nz154.1 KB92.3 KB246.4 KB0.0 KB/s3.5 KB23:59:57
3news.nk.ca148.5 KB38.6 KB187.1 KB0.0 KB/s1.8 KB23:59:57
4news.quux.org41.1 KB464.0 KB505.0 KB0.0 KB/s3.6 KB23:59:57
5usenet.blueworldhosting.com6.3 KB0.0 KB6.3 KB0.0 KB/s6.3 KB23:59:50
6news.weretis.net5.0 KB0.0 KB5.0 KB0.0 KB/s5.0 KB23:59:19
7news.tnetconsulting.net0.8 KB0.0 KB0.8 KB0.0 KB/s0.8 KB23:59:49
8newsfeed.xs3.de0.0 KB1.2 KB1.2 KB0.0 KB/s1.2 KB23:59:52
9news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:38
TOTAL: 94.2 MB650.4 KB4.8 MB0.0 KB/s4.5 KB215:57:53
Outgoing feeds (innfeed) by Volume

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 2 00.0 KB 2 0 000:00:10
2*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 2 3 00.0 KB 2 0 000:00:10

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
185.163.110.106 0.056 0.041 0.00000:00:10
192.241.212.223 0.081 0.049 0.00000:00:00
scanner-27.ch1.censys-scanner.com 0.079 0.017 0.00000:00:00
TOTAL: 3 0.216 0.107 0.00000:00:10

Curious NNRP server explorers [Top 20]:

SystemConn
192.241.212.223 1
scanner-27.ch1.censys-scanner.com 1
185.163.110.106 1
TOTAL: 3 3

NNRP unrecognized commands (by host):

SystemConn
192.241.212.223 1
scanner-27.ch1.censys-scanner.com 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

Newsgroup request counts (by category):

CategoryCountPct
1news 2100.0%
TOTAL: 1 2100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

NewsgroupCount
1news.admin.peering 1
2news.software.nntp 1
TOTAL: 2 2