Daily Usenet report

Oct 24 15:00:02 -- Oct 25 15:00:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Oct 24 15:01:18 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 14960 73.2%1.8 MB 71.1%
innd 3652 17.9%482.3 KB 18.8%
innfeed 1204 5.9%165.9 KB 6.4%
cnfsstat 576 2.8%91.3 KB 3.6%
nnrpd 32 0.2%3.5 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 20425 100.0%2.5 MB100.0%

History cache:

ReasonCount%Count
Negative hits 40561 44.2%
Positive hits 36686 39.9%
Do not exist 14588 15.9%
Cache misses 25 0.0%
TOTAL: 4 91860 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.645 0.0%55 0.000 11.727 154.000
article cleanup00:00:00.080 0.0%14705 0.000 0.005 0.033
article logging00:00:00.422 0.0%14925 0.000 0.028 0.103
article parse00:00:00.242 0.0%28010 0.000 0.009 0.040
article write00:00:05.262 0.0%12672 0.000 0.415 40.207
artlog/artcncl00:00:00.000 0.0%53 0.000 0.000 0.000
data move00:00:00.041 0.0%102746 0.000 0.000 0.004
hisgrep/artcncl00:00:00.001 0.0%54 0.000 0.019 0.100
hishave/artcncl00:00:00.351 0.0%55 0.000 6.382 154.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:02:03.691 0.1%92544 0.000 1.337 39.308
history sync00:00:00.293 0.0%405 0.000 0.723 93.667
history write00:00:03.656 0.0%14705 0.000 0.249 24.010
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:58:10.739 99.8%102413 373.014 842.576 2390.813
nntp read00:00:00.744 0.0%102632 0.000 0.007 0.016
overview write00:00:00.032 0.0%12672 0.000 0.003 0.022
perl filter00:00:18.040 0.0%14705 0.812 1.227 15.380
python filter00:00:00.373 0.0%14705 0.000 0.025 0.109
site send00:00:02.297 0.0%38015 0.022 0.060 0.116
TOTAL: 24:01:05.56024:00:46.909100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.024 0.0%12626 0.000 0.002 0.023
article prepare00:00:00.002 0.0%3657 0.000 0.001 0.030
article read00:00:00.056 0.0%1210 0.000 0.046 0.500
backlog stats00:00:00.034 0.0%71221 0.000 0.000 0.016
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.309 0.0%43513 0.000 0.007 0.024
data write00:00:00.887 0.0%31075 0.000 0.029 0.074
idle23:58:16.943100.0%71221 604.311 1211.678 3226.210
status file00:00:00.182 0.0%234 0.000 0.778 30.500
TOTAL: 23:58:20.29623:58:18.437100.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%8 0.000 0.000 0.000
TOTAL: 00:00:00.22600: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 6 25477 9016 15622 839 35%48:39:33
2news-out.aioe.org 3 12856 3475 9370 11 27%24:49:40
3news.nntp4.net 2 12563 291 11239 1033 2%22:30:37
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 12 50896 12782 36231 1883 25%95:59:50
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net28.8 MB0.0 KB1.7 MB30.5 MB 94%3.2 KB
2news-out.aioe.org9.3 MB0.0 KB14.0 KB9.3 MB 99%2.7 KB
3news.nntp4.net1.2 MB0.0 KB5.8 MB6.9 MB 16%5.3 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 439.2 MB0.0 KB7.4 MB46.7 MB 84%3.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 24 15:00:02 - 15:59:59 612 4.8% 0.172.1 MB 5.4% 0.59
Oct 24 16:00:00 - 16:59:59 640 5.1% 0.182.1 MB 5.3% 0.59
Oct 24 17:00:00 - 17:59:59 611 4.8% 0.171.8 MB 4.7% 0.52
Oct 24 18:00:00 - 18:59:59 663 5.2% 0.182.1 MB 5.4% 0.60
Oct 24 19:00:00 - 19:59:59 538 4.3% 0.151.7 MB 4.3% 0.47
Oct 24 20:00:00 - 20:59:59 599 4.7% 0.171.5 MB 4.0% 0.44
Oct 24 21:00:00 - 21:59:59 644 5.1% 0.182.0 MB 5.3% 0.58
Oct 24 22:00:00 - 22:59:59 529 4.2% 0.151.9 MB 5.0% 0.55
Oct 24 23:00:00 - 23:59:59 338 2.7% 0.091.1 MB 2.9% 0.32
Oct 25 00:00:00 - 00:59:59 275 2.2% 0.08894.8 KB 2.3% 0.25
Oct 25 01:00:00 - 01:59:59 275 2.2% 0.08857.4 KB 2.2% 0.24
Oct 25 02:00:00 - 02:59:59 256 2.0% 0.07830.0 KB 2.1% 0.23
Oct 25 03:00:00 - 03:59:59 275 2.2% 0.08934.1 KB 2.4% 0.26
Oct 25 04:00:00 - 04:59:59 259 2.0% 0.07874.0 KB 2.2% 0.24
Oct 25 05:00:00 - 05:59:59 340 2.7% 0.091.1 MB 2.8% 0.31
Oct 25 06:00:00 - 06:59:59 373 2.9% 0.101.2 MB 3.2% 0.35
Oct 25 07:00:00 - 07:59:59 607 4.8% 0.171.8 MB 4.7% 0.52
Oct 25 08:00:00 - 08:59:59 735 5.8% 0.202.3 MB 5.8% 0.64
Oct 25 09:00:00 - 09:59:59 638 5.0% 0.181.7 MB 4.4% 0.49
Oct 25 10:00:00 - 10:59:59 701 5.5% 0.192.3 MB 5.9% 0.65
Oct 25 11:00:00 - 11:59:59 600 4.7% 0.171.7 MB 4.5% 0.49
Oct 25 12:00:00 - 12:59:59 623 4.9% 0.171.8 MB 4.6% 0.51
Oct 25 13:00:00 - 13:59:59 770 6.1% 0.212.2 MB 5.6% 0.62
Oct 25 14:00:00 - 14:59:59 747 5.9% 0.212.0 MB 5.1% 0.57
Oct 25 15:00:00 - 15:00:02 2 0.0% 1.001.7 KB 0.0% 0.85
TOTAL: 24:00:00 12650 100.0% 0.1538.8 MB 100.0% 0.46
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB660.2 MB 64.5% 3 0.19 62.27
ONEDEFAULT1024.0 MB821.6 MB 80.2% 5 0.19 64.28
THREEDEFAULT1024.0 MB663.5 MB 64.8% 3 0.19 64.61
TWODEFAULT1024.0 MB655.6 MB 64.0% 3 0.19 63.16
TOTAL: 4-4.0 GB2.7 GB 68.4% 14 0.19-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 1195 8 0 0 1 0 0 0 1186
2hasname-out.news.weretis.net 1012 1 0 0 0 0 0 0 1011
3news-out.aioe.org 50 0 0 0 0 0 0 0 50
TOTAL: 3 2257 9 0 0 1 0 0 0 2247

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.health.policy.drug-approval 2
ga.jobs 1
alt.politics.congress 1
alt.bestjobsusa.jobs.offered 1
list.postfix.users 1
alt.math 1
alt.sys.alpha-micro 1
autodesk.autocad.r14general 1
TOTAL: 8 9

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 1317
EMP (md5) 425
EMP (phn nph) 221
EMP (phl) 47
User-issued spam cancel 11
HTML Multipart 6
Binary: misplaced binary 2
Scoring filter 1
TOTAL: 8 2030

INND no permission servers:

SystemConn
89.248.165.23 1
TOTAL: 1 1

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 178
news-out.aioe.org 39
TOTAL: 2 217
TOTAL: 1 217

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp4 13931 719 11617 8 0 0 5%23:59:57
2bbsgslincom 462 462 0 0 0 0100%20:50:14
3aioe 11507 44 9140 2 0 0 0%23:59:55
4weretis 3902 2 3614 26 0 0 0%23:59:48
TOTAL: 4 29802 1227 24371 36 0 0 4%92:49:54
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp43.0 MB19.1 KB3.0 MB0.0 KB/s4.2 KB23:59:57
2bbsgslincom1.7 MB0.0 KB1.7 MB0.0 KB/s3.9 KB20:50:14
3aioe162.4 KB6.9 KB169.3 KB0.0 KB/s3.7 KB23:59:55
4weretis7.8 KB104.1 KB112.0 KB0.0 KB/s4.0 KB23:59:48
TOTAL: 44.9 MB130.2 KB5.0 MB0.0 KB/s4.0 KB92:49:54
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
zl-lax-us-gp1-wk133.internet-census.org 0.004 0.018 0.00000:00:00
TOTAL: 1 0.004 0.018 0.00000:00:00

NNRP no permission clients:

SystemConn
zl-lax-us-gp1-wk133.internet-census.org 8
TOTAL: 1 8
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>