Daily Usenet report

Jul 31 15:00:01 -- Aug 1 15:00:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Jul 31 15:01:04 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
Aug 1 00:04:02 colo-sc-1 pgpverify[18432]: pgpverify: verification failed
Aug 1 06:00:03 colo-sc-1 pgpverify[21173]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 12612 75.0%1.5 MB 72.2%
innd 2337 13.9%336.3 KB 15.5%
innfeed 1261 7.5%175.3 KB 8.1%
cnfsstat 576 3.4%86.3 KB 4.0%
controlchan 23 0.1%5.1 KB 0.2%
nnrpd 15 0.1%1.7 KB 0.1%
pgpverify 2 0.0%0.2 KB 0.0%
overchan 1 0.0%0.1 KB 0.0%
TOTAL: 8 16827 100.0%2.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 31603 43.1%
Negative hits 29560 40.3%
Do not exist 12150 16.6%
Cache misses 23 0.0%
TOTAL: 4 73336 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.542 0.0%70 0.000 7.743 76.000
article cleanup00:00:00.076 0.0%12173 0.000 0.006 0.040
article logging00:00:00.369 0.0%12540 0.000 0.029 0.100
article parse00:00:00.192 0.0%22908 0.000 0.008 0.050
article write00:00:01.028 0.0%11247 0.000 0.091 5.802
artlog/artcncl00:00:00.000 0.0%70 0.000 0.000 0.000
data move00:00:00.043 0.0%81633 0.000 0.001 0.006
hisgrep/artcncl00:00:00.002 0.0%69 0.000 0.029 0.500
hishave/artcncl00:00:00.003 0.0%70 0.000 0.043 1.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.879 0.0%73428 0.000 0.012 0.335
history sync00:00:00.600 0.0%348 0.000 1.724 195.000
history write00:00:09.760 0.0%12173 0.000 0.802 89.752
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:59:58.516100.0%82809 519.098 1043.347 6595.956
nntp read00:00:00.586 0.0%82646 0.000 0.007 0.021
overview write00:00:00.041 0.0%11247 0.000 0.004 0.033
perl filter00:00:14.461 0.0%12173 0.852 1.188 4.358
python filter00:00:00.399 0.0%12173 0.000 0.033 0.100
site send00:00:02.059 0.0%33742 0.023 0.061 0.117
TOTAL: 24:00:40.95424:00:29.556100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.023 0.0%11235 0.000 0.002 0.024
article prepare00:00:00.001 0.0%705 0.000 0.001 0.023
article read00:00:00.019 0.0%422 0.000 0.045 1.000
backlog stats00:00:00.047 0.0%66829 0.000 0.001 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.300 0.0%39501 0.000 0.008 0.025
data write00:00:00.740 0.0%28420 0.000 0.026 0.084
idle23:58:12.833100.0%66829 717.553 1291.248 3575.833
status file00:00:00.065 0.0%263 0.000 0.247 1.000
TOTAL: 23:58:17.74723:58:14.028100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:00.000 0.0%0 0.000 0.000 0.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.000 0.0%3 0.000 0.000 0.000
TOTAL: 00:00:00.16300:00:00.000 0.0%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 147
name 2
pause 2
paused 2
reserve 2
TOTAL: 10 167

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de001101
us-control@lists.killfile.org000100
TOTAL001201

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 9 20946 7895 12941 110 37%48:40:01
2news-out.aioe.org 4 10688 3066 7620 2 28%24:15:54
3news.nntp4.net 3 12327 229 11268 830 1%24:31:29
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 17 43961 11190 31829 942 25%97:27:24
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net25.7 MB0.0 KB305.7 KB25.9 MB 98%3.3 KB
2news-out.aioe.org7.9 MB0.0 KB4.0 KB7.9 MB 99%2.6 KB
3news.nntp4.net697.1 KB0.0 KB3.5 MB4.2 MB 16%4.1 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 434.2 MB0.0 KB3.8 MB38.1 MB 89%3.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 31 15:00:01 - 15:59:59 587 5.2% 0.161.7 MB 4.9% 0.48
Jul 31 16:00:00 - 16:59:59 633 5.6% 0.181.8 MB 5.1% 0.50
Jul 31 17:00:00 - 17:59:59 532 4.7% 0.151.4 MB 4.1% 0.40
Jul 31 18:00:00 - 18:59:59 606 5.4% 0.171.6 MB 4.6% 0.45
Jul 31 19:00:00 - 19:59:59 562 5.0% 0.161.5 MB 4.2% 0.41
Jul 31 20:00:00 - 20:59:59 505 4.5% 0.141.6 MB 4.7% 0.46
Jul 31 21:00:00 - 21:59:59 575 5.1% 0.162.2 MB 6.4% 0.63
Jul 31 22:00:00 - 22:59:59 400 3.6% 0.111.3 MB 3.7% 0.36
Jul 31 23:00:00 - 23:59:59 388 3.4% 0.111.6 MB 4.8% 0.47
Aug 1 00:00:00 - 00:59:59 282 2.5% 0.08937.0 KB 2.7% 0.26
Aug 1 01:00:00 - 01:59:59 279 2.5% 0.08972.4 KB 2.8% 0.27
Aug 1 02:00:00 - 02:59:59 211 1.9% 0.06736.6 KB 2.1% 0.20
Aug 1 03:00:00 - 03:59:59 164 1.5% 0.05476.7 KB 1.4% 0.13
Aug 1 04:00:00 - 04:59:59 255 2.3% 0.07824.5 KB 2.3% 0.23
Aug 1 05:00:00 - 05:59:59 242 2.2% 0.07744.8 KB 2.1% 0.21
Aug 1 06:00:00 - 06:59:59 459 4.1% 0.131.9 MB 5.5% 0.54
Aug 1 07:00:00 - 07:59:59 500 4.4% 0.141.5 MB 4.3% 0.42
Aug 1 08:00:00 - 08:59:59 537 4.8% 0.151.4 MB 4.1% 0.40
Aug 1 09:00:00 - 09:59:59 526 4.7% 0.151.4 MB 3.9% 0.39
Aug 1 10:00:00 - 10:59:59 575 5.1% 0.161.6 MB 4.6% 0.45
Aug 1 11:00:00 - 11:59:59 536 4.8% 0.151.5 MB 4.4% 0.43
Aug 1 12:00:00 - 12:59:59 596 5.3% 0.171.9 MB 5.5% 0.54
Aug 1 13:00:00 - 13:59:59 630 5.6% 0.172.2 MB 6.4% 0.63
Aug 1 14:00:00 - 14:59:59 666 5.9% 0.181.9 MB 5.5% 0.54
Aug 1 15:00:00 - 15:00:02 2 0.0% 1.006.3 KB 0.0% 3.13
TOTAL: 24:00:01 11248 100.0% 0.1334.4 MB 100.0% 0.41
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB57.7 MB 5.6% 8 0.17 71.11
ONEDEFAULT1024.0 MB234.9 MB 22.9% 10 0.17 69.70
THREEDEFAULT1024.0 MB68.8 MB 6.7% 8 0.17 71.66
TWODEFAULT1024.0 MB65.1 MB 6.4% 8 0.17 71.06
TOTAL: 4-4.0 GB426.6 MB 10.4% 34 0.17-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 814 5 0 0 1 0 0 0 808
2hasname-out.news.weretis.net 457 2 0 0 0 0 0 0 455
3news-out.aioe.org 23 1 0 0 0 0 0 0 22
TOTAL: 3 1294 8 0 0 1 0 0 0 1285

Unwanted newsgroups [Top 20]:

NewsgroupCount
panix.chat.politics 3
alt.alt.alt 1
biz.misc 1
sybase.public.powerbuilder.general 1
alt.math 1
alt.exploding.barney 1
TOTAL: 6 8

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 503
EMP (phn path) 185
EMP (phn nph) 145
EMP (phl) 65
HTML Multipart 10
Scoring filter 5
Too many newsgroups 2
Binary: misplaced binary 2
TOTAL: 8 917

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 347
news-out.aioe.org 21
TOTAL: 2 368
TOTAL: 1 368

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 330 330 0 0 0 0100%18:07:10
2aioe 10330 78 7792 5 0 0 0%23:59:25
3nntp4 13800 6 11016 0 0 7 0%23:59:56
4weretis 3521 0 3327 5 0 0 0%23:54:45
TOTAL: 4 27981 414 22135 10 0 7 1%90:01:16
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.5 MB0.0 KB1.5 MB0.0 KB/s4.6 KB18:07:10
2aioe207.8 KB17.8 KB225.7 KB0.0 KB/s2.7 KB23:59:25
3nntp417.4 KB0.0 KB17.4 KB0.0 KB/s2.9 KB23:59:56
4weretis0.0 KB13.0 KB13.0 KB0.0 KB/s2.6 KB23:54:45
TOTAL: 41.7 MB30.8 KB1.7 MB0.0 KB/s4.2 KB90:01:16
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
46.101.202.170 0.000 0.003 0.00000:00:00
192.241.208.213 0.002 0.001 0.00000:00:00
92.255.85.212 0.001 0.001 0.00000:00:00
TOTAL: 3 0.003 0.005 0.00000:00:00

NNRP no permission clients:

SystemConn
46.101.202.170 1
192.241.208.213 1
92.255.85.212 1
TOTAL: 3 3