Daily Usenet Report

May 25 00:01:02 -- May 26 00:01:01

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

May 25 00:03:08 www innd: message repeated 2 times: [ ctlinnd command s]
May 25 13:15:02 www pgpverify[1635103]: pgpverify: verification failed
May 25 13:15:03 www pgpverify[1635111]: pgpverify: verification failed
May 25 13:15:03 www pgpverify[1635119]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 13540 75.1%3.1 MB 81.1%
innd 2652 14.7%400.4 KB 10.2%
innfeed 1810 10.0%341.7 KB 8.7%
nnrpd 12 0.1%1.3 KB 0.0%
controlchan 4 0.0%0.3 KB 0.0%
pgpverify 3 0.0%0.5 KB 0.0%
TOTAL: 6 18021 100.0%3.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 80924 51.0%
Negative hits 64604 40.7%
Do not exist 13149 8.3%
Cache misses 28 0.0%
TOTAL: 4 158705 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.065 0.0%52 0.000 1.250 3.600
article cleanup00:00:00.280 0.0%13185 0.000 0.021 0.226
article logging00:00:00.639 0.0%13501 0.000 0.047 0.115
article parse00:00:00.434 0.0%20949 0.000 0.021 0.084
article write00:00:07.491 0.0%12193 0.301 0.614 2.485
artlog/artcncl00:00:00.001 0.0%51 0.000 0.020 0.333
artlog/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.216 0.0%161847 0.000 0.001 0.006
hisgrep/artcncl00:00:00.006 0.0%52 0.000 0.115 1.000
hishave/artcncl00:00:00.000 0.0%52 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:03.280 0.0%158925 0.003 0.021 0.080
history sync00:00:00.047 0.0%393 0.000 0.120 0.667
history write00:00:03.483 0.0%13169 0.036 0.264 0.736
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:58:49.171 99.8%158454 305.150 544.822 1571.914
nntp read00:00:05.286 0.0%159378 0.017 0.033 0.064
overview write00:00:07.234 0.0%12193 0.233 0.593 2.701
perl filter00:00:40.550 0.0%13169 2.217 3.079 5.351
python filter00:00:02.253 0.0%13169 0.054 0.171 0.444
site send00:00:04.577 0.0%24389 0.022 0.188 0.628
TOTAL: 24:01:06.99324:00:05.013 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.184 0.0%12627 0.000 0.015 0.188
article prepare00:00:00.001 0.0%4040 0.000 0.000 0.025
article read00:00:00.364 0.0%911 0.000 0.400 53.000
backlog stats00:00:00.334 0.0%191699 0.000 0.002 0.010
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:03.830 0.0%134536 0.015 0.028 0.056
data write00:00:15.331 0.0%123913 0.057 0.124 0.282
idle23:55:41.463100.0%191699 216.239 449.358 1126.073
status file00:00:00.159 0.0%161 0.000 0.988 5.000
TOTAL: 23:56:09.81823:56:01.666100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:10.007 97.1%3 146.000 3335.667 9715.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.001 0.0%13 0.000 0.077 0.091
TOTAL: 00:00:10.30400:00:10.008 97.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.de000300
TOTAL000300

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 9 23592 5892 17490 210 24%49:35:27
2peer.alt119.net 2 12418 3320 9037 61 26%24:09:02
3usenet.blueworldhosting.com 4 12771 2478 9553 740 19%25:20:21
4newsfeed.xs3.de 3 11279 429 10844 6 3%24:02:51
5news.samoylyk.net 2 11464 99 11353 12 0%23:59:43
6glockenspiel.complete.org 1 11673 31 11642 0 0%23:59:54
7news.bbs.nz 3 12099 14 12085 0 0%26:32:40
8news.nk.ca 3 0 0 0 0 0%00:30:00
9eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:09
10localhost 25 0 0 0 0 0%00:00:00
TOTAL: 10 53 95296 12263 82004 1029 12%198:20:07
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net26.1 MB36.4 KB387.7 KB26.5 MB 98%4.4 KB
2usenet.blueworldhosting.com13.7 MB4.4 KB1.7 MB15.3 MB 89%4.9 KB
3peer.alt119.net8.9 MB0.0 KB185.4 KB9.1 MB 98%2.8 KB
4newsfeed.xs3.de1.9 MB0.0 KB15.9 KB1.9 MB 99%4.5 KB
5news.samoylyk.net1.2 MB4.4 KB20.9 KB1.2 MB 98%11.4 KB
6glockenspiel.complete.org263.6 KB0.0 KB0.0 KB263.6 KB100%8.5 KB
7news.bbs.nz30.0 KB0.0 KB0.0 KB30.0 KB100%2.1 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: 1052.1 MB45.2 KB2.3 MB54.4 MB 95%4.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 25 00:01:02 - 00:59:59 290 2.4% 0.08917.9 KB 1.7% 0.26
May 25 01:00:00 - 01:59:59 608 5.0% 0.172.5 MB 4.9% 0.72
May 25 02:00:00 - 02:59:59 555 4.6% 0.152.3 MB 4.4% 0.66
May 25 03:00:00 - 03:59:59 644 5.3% 0.182.0 MB 3.7% 0.56
May 25 04:00:00 - 04:59:59 597 4.9% 0.171.7 MB 3.3% 0.49
May 25 05:00:00 - 05:59:59 579 4.8% 0.161.9 MB 3.7% 0.55
May 25 06:00:00 - 06:59:59 493 4.0% 0.141.4 MB 2.7% 0.40
May 25 07:00:00 - 07:59:59 521 4.3% 0.143.3 MB 6.3% 0.94
May 25 08:00:00 - 08:59:59 724 5.9% 0.202.7 MB 5.2% 0.78
May 25 09:00:00 - 09:59:59 707 5.8% 0.202.2 MB 4.2% 0.62
May 25 10:00:00 - 10:59:59 820 6.7% 0.234.0 MB 7.7% 1.14
May 25 11:00:00 - 11:59:59 679 5.6% 0.193.3 MB 6.3% 0.94
May 25 12:00:00 - 12:59:59 541 4.4% 0.151.6 MB 3.0% 0.44
May 25 13:00:00 - 13:59:59 617 5.1% 0.172.8 MB 5.4% 0.81
May 25 14:00:00 - 14:59:59 674 5.5% 0.193.0 MB 5.7% 0.85
May 25 15:00:00 - 15:59:59 495 4.1% 0.142.1 MB 4.0% 0.59
May 25 16:00:00 - 16:59:59 480 3.9% 0.132.3 MB 4.4% 0.65
May 25 17:00:00 - 17:59:59 428 3.5% 0.121.9 MB 3.6% 0.53
May 25 18:00:00 - 18:59:59 370 3.0% 0.101.7 MB 3.3% 0.49
May 25 19:00:00 - 19:59:59 323 2.7% 0.092.1 MB 4.0% 0.59
May 25 20:00:00 - 20:59:59 266 2.2% 0.071.8 MB 3.5% 0.51
May 25 21:00:00 - 21:59:59 251 2.1% 0.071.3 MB 2.4% 0.36
May 25 22:00:00 - 22:59:59 241 2.0% 0.072.2 MB 4.3% 0.64
May 25 23:00:00 - 23:59:59 269 2.2% 0.071.1 MB 2.1% 0.31
May 26 00:00:00 - 00:01:01 9 0.1% 0.1517.1 KB 0.0% 0.28
TOTAL: 23:59:59 12181 100.0% 0.1452.1 MB 100.0% 0.62
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 733 168 0 1 0 0 0 0 564
2endofthelinebbs-out.news.weretis.net 459 15 0 14 0 0 0 0 430
3peer.alt119.net 72 25 0 0 0 0 0 0 47
4newsfeed.xs3.de 29 2 0 0 0 0 0 0 27
5news.samoylyk.net 14 8 0 1 0 0 0 0 5
6glockenspiel.complete.org 1 1 0 0 0 0 0 0 0
TOTAL: 6 1308 219 0 16 0 0 0 0 1073

Unwanted newsgroups [Top 20]:

NewsgroupCount
talk.english.tg 64
talk.english.tw 31
talk.generic.ua.ws 23
fr.misc.domotique 17
0.0ssptest 11
att.jobs 10
at.jobs 9
panix.chat.politics 9
bofh.transport.public 9
gun.general 5
aus.jobs 4
rocksolid.feeds.news 4
talk.from.war.diary 2
rocksolid.feeds.tech 2
rec.travel.resorts.all 2
al.christnet.bible 2
news.oriens-occasus.ru 2
alt.sex.girl 1
comp.hackers 1
erin.burnetttimewarner.com 1
TOTAL: 30 219

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 662
EMP (md5) 49
Too many newsgroups 21
EMP (phl) 14
HTML Multipart 5
Scoring filter 4
MID-Bot 1
EMP (phn nph) 1
TOTAL: 8 757

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 250
peer.alt119.net 31
newsfeed.xs3.de 23
usenet.blueworldhosting.com 12
TOTAL: 4 316
TOTAL: 1 316

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1peer.alt119.net 10484 814 8080 2 0 10 7%23:59:56
2news.nk.ca 14094 34 12112 10 0 37 0%23:59:56
3news.bbs.nz 23837 20 12119 24 0 271 0%23:59:56
4usenet.blueworldhosting.com 10045 16 9641 4 0 9 0%23:59:56
5news.quux.org 12658 14 12062 51 0 0 0%23:59:41
6news.weretis.net 12264 11 12164 6 0 0 0%23:59:56
7news.tnetconsulting.net 13579 4 12177 0 0 118 0%23:59:56
8news.samoylyk.net 13875 0 12075 0 0 16 0%23:59:56
9newsfeed.xs3.de 13376 0 11739 1 0 8 0%23:59:56
TOTAL: 9 124212 913 102169 98 0 469 0%215:59:09
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1peer.alt119.net4.4 MB4.8 KB4.4 MB0.1 KB/s5.5 KB23:59:56
2news.weretis.net118.3 KB67.1 KB185.4 KB0.0 KB/s10.9 KB23:59:56
3usenet.blueworldhosting.com109.9 KB19.2 KB129.1 KB0.0 KB/s6.5 KB23:59:56
4news.nk.ca70.7 KB37.3 KB108.0 KB0.0 KB/s2.5 KB23:59:56
5news.bbs.nz65.6 KB337.8 KB403.3 KB0.0 KB/s9.2 KB23:59:56
6news.quux.org48.7 KB542.5 KB591.2 KB0.0 KB/s9.1 KB23:59:41
7news.tnetconsulting.net8.0 KB0.0 KB8.0 KB0.0 KB/s2.0 KB23:59:56
8news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
9newsfeed.xs3.de0.0 KB13.6 KB13.6 KB0.0 KB/s13.6 KB23:59:56
TOTAL: 94.8 MB1022.2 KB5.8 MB0.0 KB/s5.9 KB215:59:09
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1192.241.221.76 1 00.0 KB 0 0 000:00:09
2175.198.181.131 1 00.0 KB 0 0 000:00:00
TOTAL: 2 2 00.0 KB 0 0 000:00:10

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 2 00.0 KB 0 0 000:00:10
TOTAL: 1 2 00.0 KB 0 0 000:00:10

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
192.241.221.76 0.068 0.050 0.00000:00:09
175.198.181.131 0.069 0.034 0.00000:00:00
TOTAL: 2 0.137 0.084 0.00000:00:10

NNRP unrecognized commands (by host):

SystemConn
175.198.181.131 4
TOTAL: 1 4

NNRP unrecognized commands (by command):

CommandCount
CONNECT blog.naver.com:80 HTTP/1.1 1
Proxy-Connection: keep-alive 1
Host: blog.naver.com 1
User-Agent: Mozilla/5.0 1
TOTAL: 4 4