Daily Usenet report

Sep 5 15:00:03 -- Sep 6 15:00:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Sep 5 15:01:30 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 15014 78.7%1.8 MB 76.1%
innd 2277 11.9%323.1 KB 13.2%
innfeed 1219 6.4%174.5 KB 7.1%
cnfsstat 576 3.0%88.2 KB 3.6%
overchan 2 0.0%0.2 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 19089 100.0%2.4 MB100.0%

History cache:

ReasonCount%Count
Negative hits 40274 43.2%
Positive hits 38400 41.2%
Do not exist 14577 15.6%
Cache misses 27 0.0%
TOTAL: 4 93278 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.937 0.0%67 0.000 43.836 685.000
article cleanup00:00:00.112 0.0%14717 0.000 0.008 0.065
article logging00:00:00.505 0.0%14973 0.000 0.034 0.082
article parse00:00:00.283 0.0%25606 0.000 0.011 0.034
article write00:00:46.157 0.1%14021 0.000 3.292 481.571
artlog/artcncl00:00:00.000 0.0%67 0.000 0.000 0.000
data move00:00:00.075 0.0%102430 0.000 0.001 0.006
hisgrep/artcncl00:00:00.003 0.0%67 0.000 0.045 1.000
hishave/artcncl00:00:00.211 0.0%67 0.000 3.149 52.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:03:34.923 0.2%94079 0.001 2.284 61.556
history sync00:00:00.021 0.0%401 0.000 0.052 0.667
history write00:00:05.039 0.0%14713 0.000 0.342 7.955
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:54:14.112 99.5%100791 370.936 853.788 2266.838
nntp read00:00:00.845 0.0%101450 0.000 0.008 0.022
overview write00:00:00.053 0.0%14021 0.000 0.004 0.031
perl filter00:00:20.814 0.0%14713 1.023 1.415 14.342
python filter00:00:00.477 0.0%14713 0.000 0.032 0.091
site send00:00:02.720 0.0%42061 0.022 0.065 0.106
TOTAL: 24:01:03.93223:59:09.287 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.025 0.0%14005 0.000 0.002 0.025
article prepare00:00:00.002 0.0%722 0.000 0.003 0.125
article read00:00:00.068 0.0%527 0.000 0.129 16.000
backlog stats00:00:00.054 0.0%79913 0.000 0.001 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.436 0.0%48435 0.000 0.009 0.029
data write00:00:01.026 0.0%34592 0.000 0.030 0.122
idle23:59:31.373100.0%79913 618.494 1080.818 3001.595
status file00:00:01.825 0.0%227 0.000 8.040 430.000
TOTAL: 23:59:36.75923:59:34.809100.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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 7 25460 8849 16501 110 34%48:00:39
2news-out.aioe.org 3 12995 4239 8756 0 32%24:22:34
3news.nntp4.net 2 14339 920 12913 506 6%24:27:45
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 13 52794 14008 38170 616 26%96:50:58
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net29.9 MB0.0 KB180.6 KB30.1 MB 99%3.4 KB
2news-out.aioe.org11.4 MB0.0 KB0.0 KB11.4 MB100%2.8 KB
3news.nntp4.net2.6 MB9.3 KB2.2 MB4.8 MB 53%3.5 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 443.9 MB9.3 KB2.4 MB46.3 MB 94%3.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 5 15:00:03 - 15:59:59 732 5.2% 0.202.3 MB 5.2% 0.65
Sep 5 16:00:00 - 16:59:59 802 5.7% 0.222.4 MB 5.3% 0.67
Sep 5 17:00:00 - 17:59:59 876 6.3% 0.243.1 MB 7.1% 0.89
Sep 5 18:00:00 - 18:59:59 603 4.3% 0.171.7 MB 3.9% 0.49
Sep 5 19:00:00 - 19:59:59 692 4.9% 0.192.0 MB 4.5% 0.56
Sep 5 20:00:00 - 20:59:59 779 5.6% 0.222.3 MB 5.2% 0.65
Sep 5 21:00:00 - 21:59:59 562 4.0% 0.161.7 MB 3.8% 0.47
Sep 5 22:00:00 - 22:59:59 461 3.3% 0.131.8 MB 4.1% 0.52
Sep 5 23:00:00 - 23:59:59 396 2.8% 0.111.4 MB 3.1% 0.39
Sep 6 00:00:00 - 00:59:59 362 2.6% 0.101.4 MB 3.2% 0.40
Sep 6 01:00:00 - 01:59:59 286 2.0% 0.081.0 MB 2.3% 0.29
Sep 6 02:00:00 - 02:59:59 256 1.8% 0.07813.4 KB 1.8% 0.23
Sep 6 03:00:00 - 03:59:59 299 2.1% 0.081.1 MB 2.4% 0.30
Sep 6 04:00:00 - 04:59:59 278 2.0% 0.081.1 MB 2.6% 0.33
Sep 6 05:00:00 - 05:59:59 389 2.8% 0.111.7 MB 3.9% 0.49
Sep 6 06:00:00 - 06:59:59 485 3.5% 0.131.3 MB 3.0% 0.38
Sep 6 07:00:00 - 07:59:59 579 4.1% 0.161.7 MB 3.9% 0.49
Sep 6 08:00:00 - 08:59:59 629 4.5% 0.171.7 MB 3.8% 0.48
Sep 6 09:00:00 - 09:59:59 797 5.7% 0.222.1 MB 4.7% 0.59
Sep 6 10:00:00 - 10:59:59 718 5.1% 0.202.4 MB 5.3% 0.67
Sep 6 11:00:00 - 11:59:59 659 4.7% 0.182.2 MB 5.1% 0.64
Sep 6 12:00:00 - 12:59:59 671 4.8% 0.191.9 MB 4.2% 0.53
Sep 6 13:00:00 - 13:59:59 812 5.8% 0.232.3 MB 5.2% 0.65
Sep 6 14:00:00 - 14:59:59 875 6.3% 0.242.8 MB 6.4% 0.81
Sep 6 15:00:00 - 15:00:02 1 0.0% 0.501.1 KB 0.0% 0.57
TOTAL: 23:59:59 13999 100.0% 0.1644.2 MB 100.0% 0.52
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB843.0 MB 82.3% 2 0.21 56.91
ONEDEFAULT1024.0 MB1004.0 MB 98.0% 4 0.22 55.60
THREEDEFAULT1024.0 MB846.1 MB 82.6% 2 0.22 56.43
TWODEFAULT1024.0 MB841.6 MB 82.2% 2 0.21 57.26
TOTAL: 4-4.0 GB3.5 GB 86.3% 10 0.21-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 591 3 0 4 1 0 0 0 583
2hasname-out.news.weretis.net 289 4 0 0 0 0 0 0 285
3news-out.aioe.org 68 0 0 0 0 0 0 0 68
TOTAL: 3 948 7 0 4 1 0 0 0 936

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.math 3
tnn.foods.recipes 1
alt.security.terrorism.counter 1
mailing.freebsd.ports-bugs 1
panix.chat.politics 1
TOTAL: 5 7

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 300
EMP (phn path) 198
EMP (phn nph) 130
EMP (phl) 35
User-issued spam cancel 11
HTML Multipart 3
HTML post 2
Binary: misplaced binary 1
TOTAL: 8 680

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 187
news-out.aioe.org 68
news.nntp4.net 1
TOTAL: 3 256
TOTAL: 1 256

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 464 464 0 0 0 0100%20:53:51
2aioe 12502 39 9675 1 0 1 0%24:09:53
3nntp4 16036 0 13190 0 0 11 0%24:09:53
4weretis 5387 0 5158 25 0 0 0%24:09:48
TOTAL: 4 34389 503 28023 26 0 12 1%93:23:25
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom2.1 MB0.0 KB2.1 MB0.0 KB/s4.5 KB20:53:51
2aioe227.8 KB3.0 KB230.7 KB0.0 KB/s5.8 KB24:09:53
3nntp40.0 KB0.0 KB0.0 KB0.0 KB/s024:09:53
4weretis0.0 KB97.1 KB97.1 KB0.0 KB/s3.9 KB24:09:48
TOTAL: 42.3 MB100.1 KB2.4 MB0.0 KB/s4.6 KB93:23:25
Outgoing feeds (innfeed) by Volume