Daily Usenet Report

Aug 1 00:01:01 -- Aug 2 00:01:02

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Aug 1 00:03:56 www innd: message repeated 2 times: [ ctlinnd command s]
Aug 1 10:27:59 www nnrpd[1541714]: unable to get certificates from '/news/etc/cert.pem'
Aug 1 10:27:59 www nnrpd[1541714]: error initializing TLS: [CA_file: ] [CA_path: /news/etc] [cert_file: /news/etc/cert.pem] [key_file: /news/etc/key.pem]
Aug 1 21:51:05 www nnrpd[1558720]: unable to get certificates from '/news/etc/cert.pem'
Aug 1 21:51:05 www nnrpd[1558720]: 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 14217 71.3%3.2 MB 78.2%
innd 3618 18.1%541.2 KB 13.1%
innfeed 2016 10.1%349.4 KB 8.4%
nnrpd 78 0.4%8.2 KB 0.2%
controlchan 13 0.1%2.7 KB 0.1%
TOTAL: 5 19942 100.0%4.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 82734 54.6%
Negative hits 54162 35.8%
Do not exist 13377 8.8%
Cache misses 1171 0.8%
TOTAL: 4 151444 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.371 0.0%339 0.000 1.094 6.500
article cleanup00:00:00.272 0.0%13441 0.000 0.020 0.100
article logging00:00:00.569 0.0%13865 0.000 0.041 0.093
article parse00:00:00.448 0.0%20622 0.000 0.022 0.092
article write00:00:07.982 0.0%11692 0.365 0.683 3.430
artlog/artcncl00:00:00.007 0.0%339 0.000 0.021 0.500
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.201 0.0%152413 0.000 0.001 0.006
hisgrep/artcncl00:00:00.032 0.0%338 0.000 0.095 0.500
hishave/artcncl00:00:00.017 0.0%339 0.000 0.050 0.500
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.547 0.0%151859 0.005 0.030 0.079
history sync00:00:00.057 0.0%391 0.000 0.146 1.000
history write00:00:05.211 0.0%13438 0.050 0.388 0.805
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:58:44.010 99.8%150291 214.544 574.379 1620.468
nntp read00:00:05.613 0.0%151274 0.023 0.037 0.062
overview write00:00:08.067 0.0%11692 0.266 0.690 5.359
perl filter00:00:37.006 0.0%13438 2.012 2.754 4.092
python filter00:00:02.159 0.0%13438 0.058 0.161 0.350
site send00:00:04.136 0.0%23385 0.017 0.177 0.595
TOTAL: 24:01:01.95524:00:00.705 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.115 0.0%16516 0.000 0.007 0.100
article prepare00:00:00.004 0.0%12888 0.000 0.000 0.021
article read00:00:00.818 0.0%2395 0.000 0.342 9.400
backlog stats00:00:00.432 0.0%214121 0.000 0.002 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:04.145 0.0%140679 0.015 0.029 0.061
data write00:00:17.611 0.0%129680 0.066 0.136 0.216
idle23:55:19.084100.0%214121 155.362 402.198 1093.723
status file00:00:00.163 0.0%181 0.000 0.901 5.000
TOTAL: 23:55:50.43823:55:42.372100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:12.996 82.1%45 24.500 288.800 7882.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.011 0.1%94 0.000 0.117 4.500
TOTAL: 00:00:15.83900:00:13.007 82.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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de001011
TOTAL001011

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1usenet.blueworldhosting.com 12 12767 3928 7966 873 30%24:57:58
2endofthelinebbs-out.news.weretis.net 8 23859 3285 20486 88 13%53:46:10
3newsfeed.xs3.de 3 10720 2593 8019 108 24%24:08:20
4peer.alt119.net 4 13356 1595 11123 638 11%20:45:00
5glockenspiel.complete.org 2 15680 136 15542 2 0%34:08:54
6news.samoylyk.net 5 10386 128 10255 3 1%23:59:32
7news.furie.org.uk 1 6140 38 6102 0 0%23:59:51
8news.bbs.nz 2 10157 32 10125 0 0%23:59:11
9localhost 25 0 0 0 0 0%00:00:00
10eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:03
11news.nk.ca 2 0 0 0 0 0%00:20:00
TOTAL: 11 65 103065 11735 89618 1712 11%230:14:59
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com23.4 MB0.0 KB2.3 MB25.7 MB 91%5.5 KB
2endofthelinebbs-out.news.weretis.net11.8 MB4.8 KB287.5 KB12.1 MB 97%3.7 KB
3newsfeed.xs3.de7.0 MB4.8 KB206.0 KB7.2 MB 97%2.7 KB
4peer.alt119.net3.7 MB4.0 KB2.1 MB5.9 MB 63%2.7 KB
5glockenspiel.complete.org1.2 MB4.8 KB6.4 KB1.2 MB 99%8.8 KB
6news.samoylyk.net358.2 KB0.0 KB9.5 KB367.6 KB 97%2.8 KB
7news.furie.org.uk139.0 KB0.0 KB0.0 KB139.0 KB100%3.7 KB
8news.bbs.nz86.3 KB0.0 KB0.0 KB86.3 KB100%2.7 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: 1147.6 MB18.5 KB4.9 MB52.5 MB 90%4.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 1 00:01:01 - 00:59:59 224 1.9% 0.06798.3 KB 1.6% 0.23
Aug 1 01:00:00 - 01:59:59 459 3.9% 0.132.4 MB 5.0% 0.68
Aug 1 02:00:00 - 02:59:59 502 4.3% 0.142.4 MB 4.9% 0.67
Aug 1 03:00:00 - 03:59:59 530 4.5% 0.151.4 MB 2.9% 0.40
Aug 1 04:00:00 - 04:59:59 519 4.4% 0.141.5 MB 3.1% 0.43
Aug 1 05:00:00 - 05:59:59 583 5.0% 0.162.1 MB 4.3% 0.59
Aug 1 06:00:00 - 06:59:59 533 4.6% 0.152.9 MB 6.2% 0.84
Aug 1 07:00:00 - 07:59:59 587 5.0% 0.162.6 MB 5.5% 0.75
Aug 1 08:00:00 - 08:59:59 613 5.2% 0.172.6 MB 5.5% 0.74
Aug 1 09:00:00 - 09:59:59 659 5.6% 0.181.9 MB 3.9% 0.54
Aug 1 10:00:00 - 10:59:59 684 5.9% 0.193.4 MB 7.1% 0.97
Aug 1 11:00:00 - 11:59:59 577 4.9% 0.162.5 MB 5.3% 0.72
Aug 1 12:00:00 - 12:59:59 518 4.4% 0.141.3 MB 2.8% 0.38
Aug 1 13:00:00 - 13:59:59 681 5.8% 0.192.4 MB 5.0% 0.69
Aug 1 14:00:00 - 14:59:59 535 4.6% 0.151.9 MB 4.0% 0.54
Aug 1 15:00:00 - 15:59:59 556 4.8% 0.153.3 MB 7.0% 0.95
Aug 1 16:00:00 - 16:59:59 512 4.4% 0.141.9 MB 3.9% 0.54
Aug 1 17:00:00 - 17:59:59 368 3.1% 0.101.1 MB 2.3% 0.31
Aug 1 18:00:00 - 18:59:59 347 3.0% 0.101.1 MB 2.4% 0.33
Aug 1 19:00:00 - 19:59:59 334 2.9% 0.091.3 MB 2.8% 0.38
Aug 1 20:00:00 - 20:59:59 340 2.9% 0.092.0 MB 4.3% 0.58
Aug 1 21:00:00 - 21:59:59 280 2.4% 0.081.0 MB 2.1% 0.29
Aug 1 22:00:00 - 22:59:59 194 1.7% 0.05685.8 KB 1.4% 0.19
Aug 1 23:00:00 - 23:59:59 547 4.7% 0.153.2 MB 6.6% 0.90
Aug 2 00:00:00 - 00:01:02 9 0.1% 0.1550.1 KB 0.1% 0.81
TOTAL: 24:00:01 11691 100.0% 0.1447.8 MB 100.0% 0.57
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 902 187 0 0 2 0 0 0 713
2peer.alt119.net 642 0 0 0 0 0 0 0 642
3newsfeed.xs3.de 282 0 0 1 0 0 0 0 281
4endofthelinebbs-out.news.weretis.net 275 0 0 1 0 0 0 0 274
5glockenspiel.complete.org 83 0 0 1 0 0 0 0 82
6news.samoylyk.net 3 1 0 0 0 0 0 0 2
TOTAL: 6 2187 188 0 3 2 0 0 0 1994

Unwanted newsgroups [Top 20]:

NewsgroupCount
talk.english.tg 71
talk.ukrainian.tg 30
talk.generic.ua.ws 18
at.jobs 11
1.test 9
att.jobs 7
a.b.boneless 5
news.oriens-occasus.ru 5
rocksolid.feeds.news 4
talk.english.tw 4
snafu.test 4
aus.jobs 3
ee.arvutid 2
fr.petites-annonces.divers 2
talk.from.diary 2
web 1
panix.chat.politics 1
SWD 1
biz.misc 1
al.christnet.bible 1
TOTAL: 26 188

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
alt.penthouse.sex.spanking 2
TOTAL: 1 2

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 690
EMP (phn path) 535
Too many newsgroups 144
EMP (phn nph) 121
EMP (phl) 61
Scoring filter 8
HTML Multipart 8
MID-Bot 1
Binary: misplaced binary 1
TOTAL: 9 1569

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 186
newsfeed.xs3.de 174
peer.alt119.net 33
usenet.blueworldhosting.com 32
TOTAL: 4 425
TOTAL: 1 425

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1peer.alt119.net 10887 1811 8260 54 0 4270 16%23:59:57
2news.bbs.nz 22137 624 10896 131 0 280 2%23:59:57
3news.nk.ca 15456 266 11219 87 0 80 1%23:59:57
4news.quux.org 12182 67 11387 116 0 103 0%23:59:57
5news.furie.org.uk 9726 41 6471 9 0 64 0%23:59:57
6news.weretis.net 11837 4 11686 0 0 26 0%23:59:57
7news.tnetconsulting.net 12803 3 11684 1 0 10 0%23:59:57
8usenet.blueworldhosting.com 8245 3 7720 1 0 4 0%23:59:57
9newsfeed.xs3.de 12431 2 9093 8 0 3 0%23:59:11
10news.samoylyk.net 14925 1 11537 2 0 7 0%23:59:57
TOTAL: 10 130629 2822 99953 409 0 4847 2%239:58:44
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1peer.alt119.net7.4 MB166.2 KB7.6 MB0.1 KB/s4.2 KB23:59:57
2news.bbs.nz3.0 MB486.1 KB3.4 MB0.0 KB/s4.7 KB23:59:57
3news.nk.ca2.1 MB270.2 KB2.4 MB0.0 KB/s6.9 KB23:59:57
4news.quux.org850.5 KB392.0 KB1.2 MB0.0 KB/s6.8 KB23:59:57
5news.furie.org.uk269.2 KB390.3 KB659.4 KB0.0 KB/s13.2 KB23:59:57
6news.weretis.net26.1 KB0.0 KB26.1 KB0.0 KB/s6.5 KB23:59:57
7usenet.blueworldhosting.com9.9 KB39.3 KB49.1 KB0.0 KB/s12.3 KB23:59:57
8news.tnetconsulting.net7.8 KB3.8 KB11.6 KB0.0 KB/s2.9 KB23:59:57
9newsfeed.xs3.de5.4 KB20.0 KB25.5 KB0.0 KB/s2.5 KB23:59:11
10news.samoylyk.net2.3 KB5.5 KB7.8 KB0.0 KB/s2.6 KB23:59:57
TOTAL: 1013.7 MB1.7 MB15.4 MB0.0 KB/s4.9 KB239:58:44
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1104.156.155.31 6 00.0 KB 0 0 000:00:10
2ns508369.ip-192-95-29.net 10 00.0 KB 0 0 000:00:03
3123.160.221.20 1 00.0 KB 0 0 000:00:01
4192.241.192.65 1 00.0 KB 0 0 000:00:00
5scanner-08.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 5 19 00.0 KB 0 0 000:00:15

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
2unresolved 8 00.0 KB 0 0 000:00:12
3*.ip-192-95-29.net 10 00.0 KB 0 0 000:00:03
TOTAL: 3 19 00.0 KB 0 0 000:00:15

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
104.156.155.31 0.476 0.209 0.00000:00:10
ns508369.ip-192-95-29.net 0.687 0.368 0.00000:00:03
123.160.221.20 0.076 0.047 0.00000:00:01
scanner-08.ch1.censys-scanner.com 0.079 0.040 0.00000:00:00
192.241.192.65 0.067 0.036 0.00000:00:00
TOTAL: 5 1.385 0.700 0.00000:00:15

NNRP unrecognized commands (by host):

SystemConn
123.160.221.20 3
scanner-08.ch1.censys-scanner.com 1
192.241.192.65 1
TOTAL: 3 5

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

SystemConnPeer
123.160.221.20 1 1
TOTAL: 1 1 2