Daily Usenet Report

May 2 00:01:01 -- May 3 00:01:01

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

May 2 00:02:32 www innd: message repeated 2 times: [ ctlinnd command s]
May 2 01:50:16 www nnrpd[563202]: unable to get certificates from '/news/etc/cert.pem'
May 2 01:50:16 www nnrpd[563202]: error initializing TLS: [CA_file: ] [CA_path: /news/etc] [cert_file: /news/etc/cert.pem] [key_file: /news/etc/key.pem]
May 2 01:50:26 www nnrpd[563486]: unable to get certificates from '/news/etc/cert.pem'
May 2 01:50:26 www nnrpd[563486]: 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 19647 65.3%3.9 MB 75.1%
innd 8539 28.4%1.0 MB 19.1%
innfeed 1846 6.1%311.2 KB 5.8%
nnrpd 33 0.1%3.6 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 30066 100.0%5.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 84329 47.7%
Negative hits 73111 41.4%
Do not exist 19196 10.9%
Cache misses 20 0.0%
TOTAL: 4 176656 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.056 0.0%49 0.000 1.143 5.000
article cleanup00:00:00.364 0.0%19230 0.000 0.019 0.083
article logging00:00:00.829 0.0%19587 0.007 0.042 0.091
article parse00:00:00.599 0.0%27171 0.000 0.022 0.091
article write00:00:07.354 0.0%12421 0.310 0.592 2.557
artlog/artcncl00:00:00.002 0.0%49 0.000 0.041 1.000
data move00:00:00.207 0.0%181636 0.000 0.001 0.008
hisgrep/artcncl00:00:00.005 0.0%46 0.000 0.109 1.000
hishave/artcncl00:00:00.000 0.0%49 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:02.681 0.0%177043 0.001 0.015 0.073
history sync00:00:00.060 0.0%331 0.000 0.181 1.000
history write00:00:03.850 0.0%19227 0.016 0.200 0.684
hiswrite/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
idle23:58:01.025 99.8%178062 279.130 484.556 1155.807
nntp read00:00:06.068 0.0%179506 0.017 0.034 0.062
overview write00:00:07.521 0.0%12421 0.310 0.606 1.974
perl filter00:00:50.150 0.1%19227 2.057 2.608 5.780
python filter00:00:02.882 0.0%19227 0.073 0.150 0.442
site send00:00:05.068 0.0%24842 0.023 0.204 0.524
TOTAL: 24:00:38.62323:59:28.721 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.116 0.0%12506 0.000 0.009 0.145
article prepare00:00:00.001 0.0%5776 0.000 0.000 0.013
article read00:00:00.525 0.0%1342 0.000 0.391 6.222
backlog stats00:00:00.338 0.0%194650 0.000 0.002 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:03.591 0.0%141098 0.011 0.025 0.041
data write00:00:17.166 0.0%129266 0.084 0.133 0.196
idle23:56:29.588100.0%194650 289.371 442.793 1244.967
status file00:00:00.155 0.0%181 0.000 0.856 2.000
TOTAL: 23:56:59.02023:56:51.480100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:12.909 93.6%14 82.500 922.071 4945.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.003 0.0%31 0.000 0.097 0.200
TOTAL: 00:00:13.79100:00:12.912 93.6%----

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 24911 10535 13781 595 42%49:17:00
2peer.alt119.net 1 13962 849 12394 719 6%23:59:55
3newsfeed.xs3.de 2 11744 731 10981 32 6%23:59:20
4usenet.blueworldhosting.com 4 18039 191 12477 5371 1%23:44:30
5glockenspiel.complete.org 2 11363 184 11179 0 1%23:59:51
6news.samoylyk.net 2 11820 164 11648 8 1%23:58:39
7news.bbs.nz 2 14228 20 14208 0 0%29:22:04
8news.nk.ca 2 0 0 0 0 0%00:20:00
9eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:05
10localhost 25 0 0 0 0 0%00:00:00
TOTAL: 10 46 106067 12674 86668 6725 11%198:51:24
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net38.0 MB9.5 KB1.2 MB39.3 MB 96%3.6 KB
2newsfeed.xs3.de2.6 MB0.0 KB282.1 KB2.9 MB 90%3.9 KB
3news.samoylyk.net2.3 MB0.0 KB11.2 KB2.3 MB 99%13.7 KB
4peer.alt119.net2.2 MB0.0 KB14.1 MB16.2 MB 13%10.6 KB
5glockenspiel.complete.org1.2 MB0.0 KB0.0 KB1.2 MB100%6.8 KB
6usenet.blueworldhosting.com676.8 KB0.0 KB6.6 MB7.2 MB 9%1.3 KB
7news.bbs.nz47.1 KB0.0 KB0.0 KB47.1 KB100%2.4 KB
8news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
9eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
10localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1047.0 MB9.5 KB22.2 MB69.2 MB 67%3.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 2 00:01:01 - 00:59:59 280 2.3% 0.081.8 MB 4.0% 0.53
May 2 01:00:00 - 01:59:59 478 3.8% 0.131.4 MB 3.2% 0.40
May 2 02:00:00 - 02:59:59 539 4.3% 0.151.5 MB 3.4% 0.43
May 2 03:00:00 - 03:59:59 664 5.3% 0.181.8 MB 4.0% 0.51
May 2 04:00:00 - 04:59:59 612 4.9% 0.171.7 MB 3.7% 0.47
May 2 05:00:00 - 05:59:59 622 5.0% 0.173.0 MB 6.7% 0.86
May 2 06:00:00 - 06:59:59 646 5.2% 0.181.9 MB 4.2% 0.54
May 2 07:00:00 - 07:59:59 511 4.1% 0.141.6 MB 3.5% 0.45
May 2 08:00:00 - 08:59:59 598 4.8% 0.172.1 MB 4.7% 0.61
May 2 09:00:00 - 09:59:59 737 5.9% 0.202.4 MB 5.4% 0.69
May 2 10:00:00 - 10:59:59 681 5.5% 0.192.5 MB 5.5% 0.71
May 2 11:00:00 - 11:59:59 677 5.4% 0.192.4 MB 5.4% 0.70
May 2 12:00:00 - 12:59:59 672 5.4% 0.192.4 MB 5.3% 0.68
May 2 13:00:00 - 13:59:59 635 5.1% 0.182.2 MB 4.8% 0.62
May 2 14:00:00 - 14:59:59 632 5.1% 0.181.8 MB 4.1% 0.52
May 2 15:00:00 - 15:59:59 542 4.4% 0.152.7 MB 5.9% 0.76
May 2 16:00:00 - 16:59:59 498 4.0% 0.141.9 MB 4.2% 0.53
May 2 17:00:00 - 17:59:59 426 3.4% 0.121.5 MB 3.3% 0.42
May 2 18:00:00 - 18:59:59 371 3.0% 0.101.2 MB 2.6% 0.34
May 2 19:00:00 - 19:59:59 299 2.4% 0.081.4 MB 3.1% 0.39
May 2 20:00:00 - 20:59:59 308 2.5% 0.092.3 MB 5.2% 0.67
May 2 21:00:00 - 21:59:59 257 2.1% 0.071.2 MB 2.6% 0.33
May 2 22:00:00 - 22:59:59 335 2.7% 0.091.1 MB 2.4% 0.31
May 2 23:00:00 - 23:59:59 406 3.3% 0.111.3 MB 2.9% 0.37
May 3 00:00:00 - 00:01:01 7 0.1% 0.1118.2 KB 0.0% 0.30
TOTAL: 24:00:00 12433 100.0% 0.1445.1 MB 100.0% 0.53
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 5412 134 0 0 0 0 0 0 5278
2endofthelinebbs-out.news.weretis.net 909 1 0 3 0 0 0 0 905
3peer.alt119.net 766 23 0 0 0 0 0 0 743
4newsfeed.xs3.de 68 0 0 0 0 0 0 0 68
5news.samoylyk.net 9 0 0 0 0 0 0 0 9
6glockenspiel.complete.org 1 0 0 0 0 0 0 0 1
TOTAL: 6 7165 158 0 3 0 0 0 0 7004

Unwanted newsgroups [Top 20]:

NewsgroupCount
talk.english.tg 73
talk.generic.ua.ws 22
comp.hackers 11
at.jobs 9
att.jobs 7
panix.chat.politics 6
alt.personals.sex 5
aus.jobs 4
alt.music.pink-floyd.publius 3
rocksolid.feeds.news 3
rec.travel.resorts.all 2
news.oriens-occasus.ru 2
aioe.helpdesk 1
alt.games.red-alert 1
alt.penthouse.sex.first-time 1
alt.sports.hockey.nhl 1
alt.health.policy.drug-approval 1
trollnet.cinema 1
biz.marketplace 1
alt.penthouse.sex.femdom 1
TOTAL: 23 158

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 5675
EMP (md5) 649
EMP (phn nph) 152
EMP (phl) 108
Too many newsgroups 53
User-issued spam cancel 5
HTML Multipart 3
Scoring filter 2
TOTAL: 8 6647

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 334
newsfeed.xs3.de 16
peer.alt119.net 4
news.samoylyk.net 2
glockenspiel.complete.org 1
TOTAL: 5 357
TOTAL: 1 357

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1peer.alt119.net 12265 1258 10326 7 0 1 10%23:59:54
2usenet.blueworldhosting.com 13541 104 12011 1 0 2 0%23:59:57
3news.bbs.nz 24266 21 12379 22 0 61 0%23:59:48
4news.nk.ca 13173 8 12388 8 0 9 0%23:59:57
5news.tnetconsulting.net 14157 3 12426 3 0 2 0%23:59:35
6news.weretis.net 12489 2 12422 8 0 12 0%23:59:57
7news.quux.org 12613 1 12375 1 0 2 0%23:59:57
8news.samoylyk.net 14122 0 12274 0 0 1 0%23:59:28
9newsfeed.xs3.de 11891 0 11695 0 0 6 0%23:59:57
TOTAL: 9 128517 1397 108296 50 0 96 1%215:58:30
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1peer.alt119.net6.8 MB113.0 KB6.9 MB0.1 KB/s5.6 KB23:59:54
2usenet.blueworldhosting.com511.7 KB5.0 KB516.6 KB0.0 KB/s4.9 KB23:59:57
3news.bbs.nz57.1 KB411.8 KB468.8 KB0.0 KB/s10.9 KB23:59:48
4news.nk.ca18.2 KB12.6 KB30.8 KB0.0 KB/s1.9 KB23:59:57
5news.tnetconsulting.net12.3 KB4.0 KB16.3 KB0.0 KB/s2.7 KB23:59:35
6news.weretis.net3.0 KB15.3 KB18.3 KB0.0 KB/s1.8 KB23:59:57
7news.quux.org1.3 KB1.2 KB2.5 KB0.0 KB/s1.3 KB23:59:57
8news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:28
9newsfeed.xs3.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:57
TOTAL: 97.4 MB562.7 KB8.0 MB0.0 KB/s5.6 KB215:58:30
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1li2048-91.members.linode.com 8 00.0 KB 0 0 000:00:13
TOTAL: 1 8 00.0 KB 0 0 000:00:13

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.members.linode.com 8 00.0 KB 0 0 000:00:13
TOTAL: 1 8 00.0 KB 0 0 000:00:13

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
li2048-91.members.linode.com 0.587 0.225 0.00000:00:13
TOTAL: 1 0.587 0.225 0.00000:00:13

NNRP unrecognized commands (by host):

SystemConn
li2048-91.members.linode.com 3
TOTAL: 1 3

NNRP unrecognized commands (by command):

CommandCount
#026#003#001#002 1
#026#003#001 1
À#024 1
TOTAL: 3 3

NNRP client timeouts [Top 20]:

SystemConnPeer
li2048-91.members.linode.com 1 1
TOTAL: 1 1 1