Daily Usenet report

May 8 15:00:14 -- May 9 15:00:10

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

May 8 15:02:52 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 14662 79.1%1.8 MB 76.5%
innd 2067 11.2%303.9 KB 12.8%
innfeed 1222 6.6%164.9 KB 6.9%
cnfsstat 576 3.1%89.2 KB 3.8%
nnrpd 4 0.0%0.3 KB 0.0%
overchan 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 18533 100.0%2.3 MB100.0%

History cache:

ReasonCount%Count
Negative hits 38541 43.7%
Positive hits 30117 34.1%
Do not exist 14332 16.2%
Cache misses 5283 6.0%
TOTAL: 4 88273 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:04.987 0.0%50 0.000 99.740 778.500
article cleanup00:00:00.105 0.0%14430 0.000 0.007 0.033
article logging00:00:00.456 0.0%14641 0.000 0.031 0.140
article parse00:00:00.262 0.0%31752 0.000 0.008 0.033
article write00:00:02.833 0.0%13716 0.000 0.207 6.127
artlog/artcncl00:00:00.001 0.0%50 0.000 0.020 1.000
data move00:00:00.137 0.0%96033 0.000 0.001 0.008
hisgrep/artcncl00:00:00.001 0.0%46 0.000 0.022 1.000
hishave/artcncl00:00:02.341 0.0%50 0.000 46.820 581.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:09:23.251 0.7%88764 0.000 6.345 48.944
history sync00:00:00.013 0.0%348 0.000 0.037 0.500
history write00:00:07.941 0.0%14413 0.000 0.551 19.836
hiswrite/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
idle23:50:11.106 99.3%92809 112.653 924.599 3634.685
nntp read00:00:00.699 0.0%94976 0.000 0.007 0.017
overview write00:00:00.046 0.0%13716 0.000 0.003 0.024
perl filter00:00:23.089 0.0%14413 0.821 1.602 16.774
python filter00:00:00.399 0.0%14413 0.000 0.028 0.065
site send00:00:02.360 0.0%41148 0.023 0.057 0.122
TOTAL: 24:00:49.49624:00:20.027100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.023 0.0%21879 0.000 0.001 0.023
article prepare00:00:00.000 0.0%1786 0.000 0.000 0.000
article read00:00:09.720 0.0%746 0.000 13.029 27.876
backlog stats00:00:00.051 0.0%61240 0.000 0.001 0.013
callbacks00:00:00.000 0.0%3 0.000 0.000 0.000
data read00:00:00.303 0.0%39864 0.000 0.008 0.026
data write00:00:04.748 0.0%26683 0.000 0.178 0.758
idle23:57:35.011100.0%61240 66.567 1408.475 3686.804
status file00:00:00.578 0.0%258 0.000 2.240 69.000
TOTAL: 23:57:53.91623:57:50.434100.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%1 0.000 0.000 0.000
TOTAL: 00:00:00.60000:00:00.000 0.0%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 6 22638 6369 16259 10 28%48:30:52
2news-out.aioe.org 2 10353 4537 5805 11 43%23:32:34
3news.nntp4.net 6 17311 2770 13861 680 16%18:09:49
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 15 50302 13676 35925 701 27%90:13:15
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net21.5 MB26.5 KB37.5 KB21.5 MB 99%3.5 KB
2news-out.aioe.org12.6 MB28.4 KB35.1 KB12.6 MB 99%2.8 KB
3news.nntp4.net6.7 MB29.4 KB10.3 MB17.0 MB 39%5.0 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 440.7 MB84.3 KB10.4 MB51.1 MB 79%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 8 15:00:14 - 15:59:59 708 5.2% 0.202.9 MB 6.9% 0.82
May 8 16:00:00 - 16:59:59 727 5.3% 0.202.2 MB 5.3% 0.62
May 8 17:00:00 - 17:59:59 689 5.0% 0.192.4 MB 5.8% 0.69
May 8 18:00:00 - 18:59:59 695 5.1% 0.191.9 MB 4.6% 0.55
May 8 19:00:00 - 19:59:59 646 4.7% 0.182.2 MB 5.4% 0.63
May 8 20:00:00 - 20:59:59 655 4.8% 0.181.8 MB 4.3% 0.51
May 8 21:00:00 - 21:59:59 1918 14.0% 0.534.3 MB 10.5% 1.24
May 8 22:00:00 - 22:59:59 558 4.1% 0.152.2 MB 5.4% 0.64
May 8 23:00:00 - 23:59:59 436 3.2% 0.121.3 MB 3.1% 0.37
May 9 00:00:00 - 00:59:59 345 2.5% 0.101.2 MB 2.9% 0.34
May 9 01:00:00 - 01:59:59 290 2.1% 0.08953.8 KB 2.3% 0.26
May 9 02:00:00 - 02:59:59 236 1.7% 0.071.2 MB 3.0% 0.35
May 9 03:00:00 - 03:59:59 223 1.6% 0.06694.3 KB 1.6% 0.19
May 9 04:00:00 - 04:59:59 295 2.2% 0.081.0 MB 2.5% 0.29
May 9 05:00:00 - 05:59:59 260 1.9% 0.07854.0 KB 2.0% 0.24
May 9 06:00:00 - 06:59:59 411 3.0% 0.111014.7 KB 2.4% 0.28
May 9 07:00:00 - 07:59:59 532 3.9% 0.151.3 MB 3.2% 0.38
May 9 08:00:00 - 08:59:59 629 4.6% 0.171.8 MB 4.4% 0.51
May 9 09:00:00 - 09:59:59 598 4.4% 0.171.5 MB 3.5% 0.42
May 9 10:00:00 - 10:59:59 551 4.0% 0.151.3 MB 3.2% 0.38
May 9 11:00:00 - 11:59:59 525 3.8% 0.151.1 MB 2.6% 0.30
May 9 12:00:00 - 12:59:59 583 4.3% 0.162.0 MB 4.9% 0.57
May 9 13:00:00 - 13:59:59 612 4.5% 0.171.9 MB 4.5% 0.53
May 9 14:00:00 - 14:59:59 557 4.1% 0.152.3 MB 5.5% 0.64
May 9 15:00:00 - 15:00:10 9 0.1% 0.9063.9 KB 0.2% 6.39
TOTAL: 23:59:56 13688 100.0% 0.1641.4 MB 100.0% 0.49
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB805.1 MB 78.6% 0 0.21 56.55
ONEDEFAULT1024.0 MB964.0 MB 94.1% 2 0.21 58.57
THREEDEFAULT1024.0 MB806.7 MB 78.8% 0 0.20 59.88
TWODEFAULT1024.0 MB808.3 MB 78.9% 0 0.21 57.41
TOTAL: 4-4.0 GB3.3 GB 82.6% 2 0.21-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 706 9 0 6 1 0 0 0 690
2hasname-out.news.weretis.net 118 0 0 5 0 0 0 0 113
3news-out.aioe.org 100 0 0 6 0 0 0 0 94
TOTAL: 3 924 9 0 17 1 0 0 0 897

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.blah 2
alt.computer.hardware 2
clari.web.local.california.sfbay.living 1
alt.sex.beastial 1
ga.jobs 1
alt.sex.beastiality 1
alt.math 1
TOTAL: 7 9

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 538
EMP (phl) 109
EMP (phn nph) 25
EMP (phn path) 7
U2 violation - invalid distribution 3
Scoring filter 2
Binary: misplaced binary 1
User-issued spam cancel 1
HTML Multipart 1
TOTAL: 9 687

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 108
news-out.aioe.org 89
news.nntp4.net 13
TOTAL: 3 210
TOTAL: 1 210

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 393 393 0 0 0 0100%18:24:21
2nntp4 14907 319 14455 13 8 4275 2%23:56:20
3aioe 8919 3 8702 1 0 0 0%23:50:01
4weretis 7446 0 7293 8 0 0 0%23:59:33
TOTAL: 4 31665 715 30450 22 8 4275 2%90:10:15
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom2.1 MB0.0 KB2.1 MB0.0 KB/s5.5 KB18:24:21
2nntp41.2 MB37.2 KB1.2 MB0.0 KB/s3.8 KB23:56:20
3aioe3.7 KB1.3 KB5.0 KB0.0 KB/s1.2 KB23:50:01
4weretis0.0 KB252.4 KB252.4 KB0.0 KB/s31.5 KB23:59:33
TOTAL: 43.3 MB290.8 KB3.6 MB0.0 KB/s5.0 KB90:10:15
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
news.nntp4.net 0.000 0.004 0.00000:00:00
TOTAL: 1 0.000 0.004 0.00000:00:00

NNRP no permission clients:

SystemConn
news.nntp4.net 1
TOTAL: 1 1