Daily Usenet report

Sep 1 15:00:03 -- Sep 2 15:00:02

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Sep 1 15:01:13 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
Sep 1 21:00:02 colo-sc-1 pgpverify[8388]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 16613 79.7%2.1 MB 77.6%
innd 2407 11.5%348.4 KB 12.7%
innfeed 1221 5.9%179.2 KB 6.6%
cnfsstat 576 2.8%81.5 KB 3.0%
controlchan 12 0.1%2.5 KB 0.1%
nnrpd 10 0.0%1.0 KB 0.0%
overchan 2 0.0%0.4 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 8 20842 100.0%2.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 39645 42.8%
Negative hits 36814 39.7%
Do not exist 15751 17.0%
Cache misses 416 0.4%
TOTAL: 4 92626 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.200 0.0%1481 0.000 0.810 51.667
article cleanup00:00:00.102 0.0%14826 0.000 0.007 0.043
article logging00:00:00.478 0.0%15138 0.000 0.032 0.093
article parse00:00:00.241 0.0%25089 0.000 0.010 0.053
article write00:00:04.707 0.0%13812 0.000 0.341 21.677
artlog/artcncl00:00:00.010 0.0%1477 0.000 0.007 0.167
data move00:00:00.043 0.0%98237 0.000 0.000 0.009
hisgrep/artcncl00:00:00.006 0.0%436 0.000 0.014 0.125
hishave/artcncl00:00:00.419 0.0%1481 0.000 0.283 51.667
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:02.950 0.0%91868 0.000 0.032 1.657
history sync00:00:00.018 0.0%348 0.000 0.052 1.000
history write00:00:03.152 0.0%14826 0.000 0.213 6.707
hiswrite/artcncl00:00:00.010 0.0%1045 0.010 0.010 0.010
idle24:00:04.179 99.9%98706 106.543 875.369 4514.805
nntp read00:00:00.705 0.0%98566 0.000 0.007 0.027
overview write00:00:00.049 0.0%13812 0.000 0.004 0.032
perl filter00:00:15.285 0.0%14826 0.373 1.031 1.674
python filter00:00:00.433 0.0%14826 0.000 0.029 0.094
site send00:00:02.100 0.0%41437 0.008 0.051 0.094
TOTAL: 24:00:49.93324:00:36.087100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.027 0.0%14173 0.000 0.002 0.031
article prepare00:00:00.000 0.0%935 0.000 0.000 0.000
article read00:00:00.023 0.0%526 0.000 0.044 1.000
backlog stats00:00:00.059 0.0%80807 0.000 0.001 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.340 0.0%48158 0.000 0.007 0.026
data write00:00:00.869 0.0%34725 0.000 0.025 0.096
idle23:58:19.027100.0%80807 128.574 1067.965 4323.194
status file00:00:00.123 0.0%234 0.000 0.526 16.500
TOTAL: 23:58:22.78523:58:20.468100.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%2 0.000 0.000 0.000
TOTAL: 00:00:00.09800:00:00.000 0.0%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
moderator@dana.de001101
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 6 26521 10294 15947 280 38%48:43:37
2news-out.aioe.org 3 13771 3461 10308 2 25%24:09:50
3news.nntp4.net 2 16275 224 15283 768 1%26:50:41
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 12 56567 13979 41538 1050 24%99:44:08
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net30.3 MB0.0 KB530.5 KB30.8 MB 98%3.0 KB
2news-out.aioe.org8.5 MB0.0 KB3.6 KB8.5 MB 99%2.5 KB
3news.nntp4.net876.5 KB0.0 KB2.1 MB2.9 MB 29%3.0 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 439.6 MB0.0 KB2.6 MB42.2 MB 93%2.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 1 15:00:03 - 15:59:59 712 5.2% 0.202.0 MB 5.1% 0.57
Sep 1 16:00:00 - 16:59:59 785 5.7% 0.222.6 MB 6.6% 0.73
Sep 1 17:00:00 - 17:59:59 662 4.8% 0.181.7 MB 4.4% 0.48
Sep 1 18:00:00 - 18:59:59 600 4.3% 0.171.6 MB 4.0% 0.44
Sep 1 19:00:00 - 19:59:59 596 4.3% 0.171.6 MB 4.0% 0.44
Sep 1 20:00:00 - 20:59:59 580 4.2% 0.161.7 MB 4.3% 0.48
Sep 1 21:00:00 - 21:59:59 476 3.4% 0.131.4 MB 3.6% 0.40
Sep 1 22:00:00 - 22:59:59 457 3.3% 0.131.7 MB 4.3% 0.48
Sep 1 23:00:00 - 23:59:59 366 2.7% 0.101.5 MB 3.9% 0.43
Sep 2 00:00:00 - 00:59:59 231 1.7% 0.06963.0 KB 2.4% 0.27
Sep 2 01:00:00 - 01:59:59 260 1.9% 0.07900.7 KB 2.3% 0.25
Sep 2 02:00:00 - 02:59:59 174 1.3% 0.05620.9 KB 1.6% 0.17
Sep 2 03:00:00 - 03:59:59 203 1.5% 0.06639.5 KB 1.6% 0.18
Sep 2 04:00:00 - 04:59:59 545 3.9% 0.152.4 MB 6.1% 0.68
Sep 2 05:00:00 - 05:59:59 290 2.1% 0.08850.7 KB 2.1% 0.24
Sep 2 06:00:00 - 06:59:59 1520 11.0% 0.422.5 MB 6.5% 0.72
Sep 2 07:00:00 - 07:59:59 555 4.0% 0.151.6 MB 4.2% 0.47
Sep 2 08:00:00 - 08:59:59 621 4.5% 0.171.6 MB 4.1% 0.45
Sep 2 09:00:00 - 09:59:59 626 4.5% 0.171.6 MB 4.1% 0.46
Sep 2 10:00:00 - 10:59:59 689 5.0% 0.191.7 MB 4.4% 0.49
Sep 2 11:00:00 - 11:59:59 691 5.0% 0.191.8 MB 4.6% 0.51
Sep 2 12:00:00 - 12:59:59 618 4.5% 0.171.7 MB 4.4% 0.49
Sep 2 13:00:00 - 13:59:59 665 4.8% 0.182.0 MB 5.0% 0.56
Sep 2 14:00:00 - 14:59:59 887 6.4% 0.252.5 MB 6.5% 0.72
Sep 2 15:00:00 - 15:00:02 2 0.0% 1.009.1 KB 0.0% 4.54
TOTAL: 23:59:59 13811 100.0% 0.1639.0 MB 100.0% 0.46
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB528.9 MB 51.7% 8 0.20 59.26
ONEDEFAULT1024.0 MB707.5 MB 69.1% 10 0.20 59.85
THREEDEFAULT1024.0 MB541.8 MB 52.9% 8 0.20 60.46
TWODEFAULT1024.0 MB536.9 MB 52.4% 8 0.20 60.75
TOTAL: 4-4.0 GB2.3 GB 56.5% 34 0.20-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 735 5 0 0 0 0 0 0 730
2hasname-out.news.weretis.net 561 0 0 0 0 0 0 0 561
3news-out.aioe.org 29 0 0 0 0 0 0 0 29
TOTAL: 3 1325 5 0 0 0 0 0 0 1320

Unwanted newsgroups [Top 20]:

NewsgroupCount
list.postfix.users 1
alt.math 1
alt.personals.where-are-you-now 1
alt.culture 1
alt.windows 1
TOTAL: 5 5

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 423
EMP (phn path) 337
EMP (phl) 149
EMP (phn nph) 87
Scoring filter 12
HTML Multipart 1
TOTAL: 6 1009

INND no permission servers:

SystemConn
152.89.196.25 1
TOTAL: 1 1

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 282
news-out.aioe.org 27
news.nntp4.net 2
TOTAL: 3 311
TOTAL: 1 311

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 404 404 0 0 0 0100%20:26:40
2aioe 13370 75 10142 4 0 27 0%23:59:52
3nntp4 17083 37 13637 8 0 357 0%24:04:13
4weretis 3768 0 3581 11 0 0 0%24:09:49
TOTAL: 4 34625 516 27360 23 0 384 1%92:40:34
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.4 MB0.0 KB1.4 MB0.0 KB/s3.6 KB20:26:40
2aioe220.0 KB10.9 KB231.0 KB0.0 KB/s2.9 KB23:59:52
3nntp4135.2 KB63.4 KB198.6 KB0.0 KB/s4.4 KB24:04:13
4weretis0.0 KB46.3 KB46.3 KB0.0 KB/s4.2 KB24:09:49
TOTAL: 41.8 MB120.6 KB1.9 MB0.0 KB/s3.6 KB92:40:34
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
192.241.209.58 0.001 0.001 0.00000:00:00
192.241.195.58 0.001 0.002 0.00000:00:00
TOTAL: 2 0.002 0.003 0.00000:00:00

NNRP no permission clients:

SystemConn
192.241.195.58 1
192.241.209.58 1
TOTAL: 2 2