Daily Usenet Report

Aug 17 00:01:01 -- Aug 18 00:01:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Aug 17 00:04:05 www innd: message repeated 2 times: [ ctlinnd command s]
Aug 17 07:48:38 www nnrpd[2104601]: unable to get certificates from '/news/etc/cert.pem'
Aug 17 07:48:38 www nnrpd[2104601]: 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 13370 70.6%2.9 MB 77.2%
innd 3511 18.5%495.3 KB 12.7%
innfeed 1993 10.5%387.3 KB 9.9%
nnrpd 74 0.4%7.3 KB 0.2%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 18949 100.0%3.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 81618 54.8%
Negative hits 54403 36.5%
Do not exist 12910 8.7%
Cache misses 41 0.0%
TOTAL: 4 148972 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.100 0.0%76 0.000 1.316 5.000
article cleanup00:00:00.320 0.0%12940 0.000 0.025 0.111
article logging00:00:00.575 0.0%13304 0.000 0.043 0.114
article parse00:00:00.473 0.0%19914 0.000 0.024 0.083
article write00:00:07.574 0.0%11297 0.368 0.670 2.713
artlog/artcncl00:00:00.001 0.0%76 0.000 0.013 0.125
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.185 0.0%154558 0.000 0.001 0.006
hisgrep/artcncl00:00:00.012 0.0%74 0.000 0.162 1.000
hishave/artcncl00:00:00.006 0.0%76 0.000 0.079 3.000
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.577 0.0%149296 0.001 0.031 0.076
history sync00:00:00.076 0.0%404 0.000 0.188 1.000
history write00:00:05.206 0.0%12940 0.056 0.402 0.967
hiswrite/artcncl00:00:00.001 0.0%2 0.000 0.500 1.000
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:58:50.870 99.8%151597 282.800 569.476 1450.604
nntp read00:00:05.827 0.0%152902 0.020 0.038 0.075
overview write00:00:07.197 0.0%11297 0.219 0.637 3.977
perl filter00:00:36.749 0.0%12940 2.175 2.840 5.167
python filter00:00:02.133 0.0%12940 0.094 0.165 0.459
site send00:00:04.051 0.0%22594 0.024 0.179 0.617
TOTAL: 24:01:07.28424:00:05.933 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.087 0.0%11293 0.000 0.008 0.079
article prepare00:00:00.000 0.0%13936 0.000 0.000 0.000
article read00:00:00.734 0.0%2217 0.000 0.331 5.222
backlog stats00:00:00.387 0.0%216403 0.000 0.002 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:04.411 0.0%140237 0.012 0.031 0.050
data write00:00:17.815 0.0%129389 0.098 0.138 0.207
idle23:56:09.456100.0%216403 244.550 398.190 1091.131
status file00:00:00.195 0.0%177 0.000 1.102 8.000
TOTAL: 23:56:41.09823:56:33.085100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:20.936 90.6%29 11.333 721.931 9730.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.006 0.0%76 0.000 0.079 0.500
TOTAL: 00:00:23.10700:00:20.942 90.6%----

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
1newsfeed.xs3.de 3 10494 4229 6130 135 40%24:08:36
2usenet.blueworldhosting.com 6 12581 3605 8093 883 28%24:27:14
3peer.alt119.net 3 12505 2142 9908 455 17%24:09:02
4endofthelinebbs-out.news.weretis.net 2 20952 1289 19568 95 6%44:49:26
5glockenspiel.complete.org 2 10628 142 10483 3 1%23:59:41
6news.samoylyk.net 2 10485 49 10435 1 0%23:59:41
7news.bbs.nz 1 10212 20 10192 0 0%23:14:36
8news.furie.org.uk 1 6028 6 6022 0 0%23:59:56
9news.nk.ca 1 0 0 0 0 0%00:10:01
10localhost 25 0 0 0 0 0%00:00:00
11eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:05
TOTAL: 11 47 93885 11482 80831 1572 12%213:08:18
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com20.7 MB0.0 KB2.3 MB23.0 MB 90%5.3 KB
2newsfeed.xs3.de10.7 MB0.0 KB246.9 KB11.0 MB 97%2.6 KB
3endofthelinebbs-out.news.weretis.net8.1 MB0.0 KB298.0 KB8.4 MB 96%6.2 KB
4peer.alt119.net5.6 MB0.0 KB1.3 MB6.9 MB 81%2.7 KB
5glockenspiel.complete.org655.5 KB0.0 KB57.0 KB712.5 KB 92%4.9 KB
6news.samoylyk.net523.6 KB0.0 KB1.3 KB524.9 KB 99%10.5 KB
7news.bbs.nz55.3 KB0.0 KB0.0 KB55.3 KB100%2.8 KB
8news.furie.org.uk28.2 KB0.0 KB0.0 KB28.2 KB100%4.7 KB
9news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
10localhost0.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
TOTAL: 1146.4 MB0.0 KB4.2 MB50.6 MB 91%4.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 17 00:01:01 - 00:59:59 275 2.4% 0.081.6 MB 3.5% 0.45
Aug 17 01:00:00 - 01:59:59 342 3.0% 0.101.2 MB 2.6% 0.33
Aug 17 02:00:00 - 02:59:59 442 3.9% 0.121.4 MB 3.1% 0.39
Aug 17 03:00:00 - 03:59:59 483 4.3% 0.131.4 MB 3.1% 0.39
Aug 17 04:00:00 - 04:59:59 472 4.2% 0.131.4 MB 3.1% 0.40
Aug 17 05:00:00 - 05:59:59 568 5.0% 0.161.7 MB 3.8% 0.49
Aug 17 06:00:00 - 06:59:59 561 5.0% 0.162.7 MB 6.0% 0.77
Aug 17 07:00:00 - 07:59:59 604 5.4% 0.172.4 MB 5.3% 0.67
Aug 17 08:00:00 - 08:59:59 566 5.0% 0.162.2 MB 4.9% 0.63
Aug 17 09:00:00 - 09:59:59 702 6.2% 0.202.0 MB 4.4% 0.57
Aug 17 10:00:00 - 10:59:59 662 5.9% 0.182.4 MB 5.3% 0.67
Aug 17 11:00:00 - 11:59:59 681 6.0% 0.193.6 MB 8.0% 1.02
Aug 17 12:00:00 - 12:59:59 574 5.1% 0.161.7 MB 3.7% 0.48
Aug 17 13:00:00 - 13:59:59 635 5.6% 0.183.0 MB 6.7% 0.86
Aug 17 14:00:00 - 14:59:59 630 5.6% 0.171.9 MB 4.3% 0.54
Aug 17 15:00:00 - 15:59:59 597 5.3% 0.173.2 MB 7.0% 0.90
Aug 17 16:00:00 - 16:59:59 454 4.0% 0.131.5 MB 3.3% 0.42
Aug 17 17:00:00 - 17:59:59 458 4.1% 0.132.0 MB 4.5% 0.57
Aug 17 18:00:00 - 18:59:59 329 2.9% 0.091.2 MB 2.7% 0.35
Aug 17 19:00:00 - 19:59:59 300 2.7% 0.082.2 MB 5.0% 0.64
Aug 17 20:00:00 - 20:59:59 238 2.1% 0.071.1 MB 2.4% 0.31
Aug 17 21:00:00 - 21:59:59 237 2.1% 0.07992.7 KB 2.2% 0.28
Aug 17 22:00:00 - 22:59:59 216 1.9% 0.061.2 MB 2.6% 0.33
Aug 17 23:00:00 - 23:59:59 255 2.3% 0.071.0 MB 2.3% 0.30
Aug 18 00:00:00 - 00:01:02 6 0.1% 0.1030.0 KB 0.1% 0.48
TOTAL: 24:00:01 11287 100.0% 0.1344.8 MB 100.0% 0.53
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 914 121 0 0 0 0 0 0 793
2peer.alt119.net 507 10 0 0 0 0 0 0 497
3newsfeed.xs3.de 389 1 0 0 0 0 0 0 388
4endofthelinebbs-out.news.weretis.net 193 0 0 0 0 0 0 0 193
5news.samoylyk.net 3 0 0 0 0 0 0 0 3
6glockenspiel.complete.org 1 0 0 0 0 0 0 0 1
TOTAL: 6 2007 132 0 0 0 0 0 0 1875

Unwanted newsgroups [Top 20]:

NewsgroupCount
talk.english.tg 63
talk.generic.ua.ws 15
at.jobs 15
att.jobs 6
aus.jobs 5
news.oriens-occasus.ru 5
rocksolid.feeds.news 4
grisbi.user.french 4
talk.english.tw 4
panix.questions 2
fr.petites-annonces.divers 2
rocksolid.feeds.tech 2
ca.jobs 1
fr.petites-annonces.informatique.materiel 1
talk.from.war.diary 1
grisbi.test 1
talk.from.diary 1
TOTAL: 17 132

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 586
EMP (md5) 417
EMP (phl) 214
Too many newsgroups 152
EMP (phn nph) 128
HTML Multipart 12
MID-Bot 1
Scoring filter 1
TOTAL: 8 1511

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.xs3.de 257
endofthelinebbs-out.news.weretis.net 40
usenet.blueworldhosting.com 33
peer.alt119.net 32
news.samoylyk.net 2
TOTAL: 5 364
TOTAL: 1 364

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1peer.alt119.net 10550 1807 7339 39 0 0 17%23:59:57
2news.bbs.nz 21248 803 10294 170 0 18 3%23:59:32
3news.nk.ca 15501 324 10871 68 0 0 2%23:59:49
4news.quux.org 12675 94 11040 117 0 0 0%23:59:57
5news.furie.org.uk 9358 33 6246 4 0 2 0%23:59:14
6usenet.blueworldhosting.com 8542 15 7662 0 0 0 0%23:59:57
7news.tnetconsulting.net 12471 1 11283 2 0 0 0%23:59:36
8newsfeed.xs3.de 10228 0 7127 5 0 0 0%23:59:04
9news.weretis.net 11418 0 11286 0 0 0 0%23:59:54
10news.samoylyk.net 14383 0 11236 3 0 0 0%23:59:57
TOTAL: 10 126374 3077 94384 408 0 20 2%239:56:57
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1peer.alt119.net9.6 MB156.8 KB9.8 MB0.1 KB/s5.4 KB23:59:57
2news.bbs.nz4.0 MB690.0 KB4.7 MB0.1 KB/s4.9 KB23:59:32
3news.nk.ca3.0 MB407.5 KB3.4 MB0.0 KB/s8.9 KB23:59:49
4news.quux.org1.6 MB413.0 KB2.0 MB0.0 KB/s9.6 KB23:59:57
5news.furie.org.uk495.2 KB143.3 KB638.6 KB0.0 KB/s17.3 KB23:59:14
6usenet.blueworldhosting.com128.3 KB0.0 KB128.3 KB0.0 KB/s8.6 KB23:59:57
7news.tnetconsulting.net3.2 KB11.6 KB14.8 KB0.0 KB/s4.9 KB23:59:36
8newsfeed.xs3.de0.0 KB9.4 KB9.4 KB0.0 KB/s1.9 KB23:59:04
9news.weretis.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
10news.samoylyk.net0.0 KB7.3 KB7.3 KB0.0 KB/s2.4 KB23:59:57
TOTAL: 1018.9 MB1.8 MB20.7 MB0.0 KB/s6.1 KB239:56:57
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1128.14.209.46 8 00.0 KB 0 0 000:00:11
2ns31410046.ip-145-239-154.eu 4 00.0 KB 0 0 000:00:01
3192.241.206.156 1 00.0 KB 0 0 000:00:00
4192.241.205.198 1 00.0 KB 0 0 000:00:09
TOTAL: 4 14 00.0 KB 0 0 000:00:23

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.ip-145-239-154.eu 4 00.0 KB 0 0 000:00:01
2unresolved 10 00.0 KB 0 0 000:00:21
TOTAL: 2 14 00.0 KB 0 0 000:00:23

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
128.14.209.46 0.517 0.149 0.00000:00:11
192.241.205.198 0.099 0.041 0.00000:00:09
ns31410046.ip-145-239-154.eu 0.302 0.083 0.00000:00:01
192.241.206.156 0.060 0.052 0.00000:00:00
TOTAL: 4 0.978 0.325 0.00000:00:23

NNRP unrecognized commands (by host):

SystemConn
128.14.209.46 13
ns31410046.ip-145-239-154.eu 4
192.241.206.156 1
TOTAL: 3 18

NNRP unrecognized commands (by command):

CommandCount
#026#003#001 3
À#007À#021 1
#001 1
GET / HTTP/1.1 1
MGLNDD_192.138.210.162_119 1
#026#003 1
Accept: */* 1
#026#003#001#002 1
À#024 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
Host: 192.138.210.162:119 1
À$À#À 1
Accept-Encoding: gzip 1
À#011À#010À(À'À#024À#023À#022 1
SSH-2.0-Go 1
€.#001 1
TOTAL: 16 18

NNRP client timeouts [Top 20]:

SystemConnPeer
ns31410046.ip-145-239-154.eu 1 1
TOTAL: 1 1 1