Daily Usenet report

Aug 4 15:00:03 -- Aug 5 15:00:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Aug 4 15:01:05 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 13402 73.9%1.6 MB 71.8%
innd 2881 15.9%390.1 KB 16.9%
innfeed 1245 6.9%171.7 KB 7.4%
cnfsstat 576 3.2%85.8 KB 3.7%
nnrpd 37 0.2%3.9 KB 0.2%
overchan 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 18143 100.0%2.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 33369 42.7%
Negative hits 31790 40.7%
Do not exist 13000 16.6%
Cache misses 38 0.0%
TOTAL: 4 78197 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.761 0.0%89 0.000 8.551 99.000
article cleanup00:00:00.091 0.0%13139 0.000 0.007 0.040
article logging00:00:00.713 0.0%13352 0.000 0.053 4.747
article parse00:00:00.205 0.0%23847 0.000 0.009 0.040
article write00:00:01.436 0.0%11867 0.000 0.121 14.283
artlog/artcncl00:00:00.002 0.0%89 0.000 0.022 0.182
data move00:00:00.040 0.0%87914 0.000 0.000 0.006
hisgrep/artcncl00:00:00.001 0.0%86 0.000 0.012 0.500
hishave/artcncl00:00:00.156 0.0%89 0.000 1.753 12.250
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:01:24.265 0.1%79017 0.001 1.066 17.164
history sync00:00:00.015 0.0%410 0.000 0.037 0.500
history write00:00:01.265 0.0%13139 0.000 0.096 6.726
hiswrite/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
idle23:59:15.396 99.9%88373 295.536 977.169 4805.856
nntp read00:00:00.640 0.0%88435 0.000 0.007 0.024
overview write00:00:00.035 0.0%11867 0.000 0.003 0.040
perl filter00:00:14.970 0.0%13139 0.842 1.139 1.468
python filter00:00:00.380 0.0%13139 0.000 0.029 0.083
site send00:00:01.912 0.0%35600 0.009 0.054 0.107
TOTAL: 24:01:12.89924:01:02.283100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.022 0.0%11806 0.000 0.002 0.031
article prepare00:00:00.000 0.0%799 0.000 0.000 0.000
article read00:00:00.038 0.0%486 0.000 0.078 7.333
backlog stats00:00:00.051 0.0%66640 0.000 0.001 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.286 0.0%40354 0.000 0.007 0.029
data write00:00:00.747 0.0%28628 0.000 0.026 0.093
idle23:58:07.543100.0%66640 652.919 1294.831 3778.717
status file00:00:00.737 0.0%253 0.000 2.913 128.200
TOTAL: 23:58:13.14623:58:09.424100.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%9 0.000 0.000 0.000
TOTAL: 00:00:00.54000: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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 5 22221 8148 13945 128 36%48:32:23
2news-out.aioe.org 3 11792 3685 8105 2 31%24:27:17
3news.nntp4.net 2 13403 169 12101 1133 1%24:35:02
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 11 47416 12002 34151 1263 25%97:34:42
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net26.4 MB0.0 KB222.9 KB26.6 MB 99%3.3 KB
2news-out.aioe.org8.7 MB0.0 KB2.1 KB8.7 MB 99%2.4 KB
3news.nntp4.net689.5 KB0.0 KB3.8 MB4.5 MB 14%3.6 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 435.7 MB0.0 KB4.1 MB39.8 MB 89%3.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 4 15:00:03 - 15:59:59 786 6.6% 0.222.3 MB 6.6% 0.66
Aug 4 16:00:00 - 16:59:59 687 5.8% 0.192.0 MB 5.8% 0.57
Aug 4 17:00:00 - 17:59:59 605 5.1% 0.171.7 MB 5.0% 0.49
Aug 4 18:00:00 - 18:59:59 558 4.7% 0.151.7 MB 5.0% 0.50
Aug 4 19:00:00 - 19:59:59 563 4.8% 0.161.6 MB 4.6% 0.46
Aug 4 20:00:00 - 20:59:59 474 4.0% 0.131.5 MB 4.3% 0.42
Aug 4 21:00:00 - 21:59:59 424 3.6% 0.121.6 MB 4.6% 0.46
Aug 4 22:00:00 - 22:59:59 395 3.3% 0.111.4 MB 3.9% 0.39
Aug 4 23:00:00 - 23:59:59 375 3.2% 0.101.1 MB 3.1% 0.31
Aug 5 00:00:00 - 00:59:59 269 2.3% 0.071.0 MB 2.9% 0.29
Aug 5 01:00:00 - 01:59:59 476 4.0% 0.131.5 MB 4.3% 0.42
Aug 5 02:00:00 - 02:59:59 182 1.5% 0.05541.8 KB 1.5% 0.15
Aug 5 03:00:00 - 03:59:59 200 1.7% 0.06627.3 KB 1.8% 0.17
Aug 5 04:00:00 - 04:59:59 245 2.1% 0.07804.2 KB 2.2% 0.22
Aug 5 05:00:00 - 05:59:59 299 2.5% 0.08986.2 KB 2.8% 0.27
Aug 5 06:00:00 - 06:59:59 367 3.1% 0.101.1 MB 3.2% 0.32
Aug 5 07:00:00 - 07:59:59 468 4.0% 0.131.3 MB 3.7% 0.36
Aug 5 08:00:00 - 08:59:59 645 5.5% 0.181.8 MB 5.2% 0.52
Aug 5 09:00:00 - 09:59:59 612 5.2% 0.171.5 MB 4.4% 0.44
Aug 5 10:00:00 - 10:59:59 616 5.2% 0.171.5 MB 4.3% 0.42
Aug 5 11:00:00 - 11:59:59 626 5.3% 0.171.7 MB 4.9% 0.49
Aug 5 12:00:00 - 12:59:59 555 4.7% 0.151.8 MB 5.2% 0.51
Aug 5 13:00:00 - 13:59:59 739 6.3% 0.211.9 MB 5.6% 0.55
Aug 5 14:00:00 - 15:00:01 657 5.6% 0.181.9 MB 5.4% 0.53
TOTAL: 23:59:58 11823 100.0% 0.1434.9 MB 100.0% 0.41
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB116.3 MB 11.4% 8 0.17 69.51
ONEDEFAULT1024.0 MB293.6 MB 28.7% 10 0.17 69.84
THREEDEFAULT1024.0 MB127.4 MB 12.4% 8 0.17 69.99
TWODEFAULT1024.0 MB124.2 MB 12.1% 8 0.17 69.37
TOTAL: 4-4.0 GB661.4 MB 16.1% 34 0.17-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 1144 13 0 0 1 0 0 0 1130
2hasname-out.news.weretis.net 310 0 0 0 0 0 0 0 310
3news-out.aioe.org 34 0 0 0 0 0 0 0 34
TOTAL: 3 1488 13 0 0 1 0 0 0 1474

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.sports.hockey.nhl 10
alt.math 1
panix.chat.politics 1
alt.culture 1
TOTAL: 4 13

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 793
EMP (phn path) 237
EMP (phl) 120
EMP (phn nph) 89
Scoring filter 8
HTML Multipart 6
User-issued spam cancel 6
Too many newsgroups (low_xpost) 2
Too many newsgroups 1
TOTAL: 9 1262

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 180
news-out.aioe.org 32
TOTAL: 2 212
TOTAL: 1 212

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 389 389 0 0 0 0100%19:04:23
2aioe 9617 68 7957 4 0 0 0%23:59:53
3nntp4 14119 7 11680 0 0 7 0%23:59:53
4weretis 3990 0 3745 24 0 0 0%23:54:42
TOTAL: 4 28115 464 23382 28 0 7 1%90:58:51
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.5 MB0.0 KB1.5 MB0.0 KB/s3.9 KB19:04:23
2aioe238.6 KB7.3 KB245.9 KB0.0 KB/s3.4 KB23:59:53
3nntp419.0 KB0.0 KB19.0 KB0.0 KB/s2.7 KB23:59:53
4weretis0.0 KB56.2 KB56.2 KB0.0 KB/s2.3 KB23:54:42
TOTAL: 41.7 MB63.5 KB1.8 MB0.0 KB/s3.7 KB90:58:51
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
zl-dal-us-gp1-wk122.internet-census.org 0.009 0.007 0.00000:00:00
192.241.221.155 0.002 0.001 0.00000:00:00
zl-dal-us-gp1-wk122b.internet-census.org 0.001 0.001 0.00000:00:00
TOTAL: 3 0.012 0.009 0.00000:00:00

NNRP no permission clients:

SystemConn
zl-dal-us-gp1-wk122.internet-census.org 7
192.241.221.155 1
zl-dal-us-gp1-wk122b.internet-census.org 1
TOTAL: 3 9