Daily Usenet report

May 19 15:00:10 -- May 20 15:00:05

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

May 19 15:03:12 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 16783 80.6%2.0 MB 77.9%
innd 2293 11.0%321.8 KB 12.2%
innfeed 1175 5.6%171.0 KB 6.5%
cnfsstat 576 2.8%87.8 KB 3.3%
controlchan 1 0.0%0.1 KB 0.0%
overchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 20829 100.0%2.6 MB100.0%

History cache:

ReasonCount%Count
Negative hits 51882 47.2%
Positive hits 41658 37.9%
Do not exist 16311 14.8%
Cache misses 35 0.0%
TOTAL: 4 109886 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:04.782 0.0%53 0.000 90.226 444.500
article cleanup00:00:00.117 0.0%16429 0.000 0.007 0.039
article logging00:00:00.542 0.0%16726 0.000 0.032 0.096
article parse00:00:00.272 0.0%30182 0.000 0.009 0.034
article write00:00:12.859 0.0%15738 0.011 0.817 26.961
artlog/artcncl00:00:00.001 0.0%53 0.000 0.019 0.333
data move00:00:00.101 0.0%119713 0.000 0.001 0.008
hisgrep/artcncl00:00:00.466 0.0%53 0.000 8.792 233.000
hishave/artcncl00:00:00.191 0.0%53 0.000 3.604 48.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:08:34.949 0.6%110712 0.001 4.651 23.037
history sync00:00:00.047 0.0%400 0.000 0.117 10.000
history write00:00:12.318 0.0%16429 0.000 0.750 11.036
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:50:37.929 99.3%116259 448.900 738.334 2887.240
nntp read00:00:00.804 0.0%118654 0.000 0.007 0.016
overview write00:00:00.062 0.0%15738 0.000 0.004 0.040
perl filter00:00:32.675 0.0%16429 0.851 1.989 17.376
python filter00:00:00.453 0.0%16429 0.000 0.028 0.106
site send00:00:02.698 0.0%47213 0.027 0.057 0.103
TOTAL: 24:01:08.58624:00:21.266 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.034 0.0%15700 0.000 0.002 0.026
article prepare00:00:00.001 0.0%743 0.000 0.001 0.333
article read00:00:00.033 0.0%637 0.000 0.052 0.667
backlog stats00:00:00.051 0.0%73121 0.000 0.001 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.388 0.0%48946 0.000 0.008 0.033
data write00:00:00.987 0.0%33508 0.000 0.029 0.089
idle23:57:50.083100.0%73121 679.400 1179.826 3179.611
status file00:00:02.975 0.0%211 0.000 14.100 582.750
TOTAL: 23:57:56.49423:57:54.552100.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 4 28999 8310 20515 174 28%48:35:27
2news-out.aioe.org 2 13142 5545 7587 10 42%23:49:59
3news.nntp4.net 3 16522 1850 14176 496 11%24:27:12
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 10 58663 15705 42278 680 26%96:52:38
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net25.8 MB0.0 KB457.5 KB26.3 MB 98%3.2 KB
2news-out.aioe.org14.8 MB0.0 KB15.8 KB14.9 MB 99%2.7 KB
3news.nntp4.net4.6 MB0.0 KB1.7 MB6.3 MB 72%2.8 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 445.2 MB0.0 KB2.2 MB47.4 MB 95%3.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 19 15:00:10 - 15:59:59 899 5.7% 0.252.2 MB 4.8% 0.62
May 19 16:00:00 - 16:59:59 910 5.8% 0.252.7 MB 6.0% 0.77
May 19 17:00:00 - 17:59:59 902 5.7% 0.252.6 MB 5.8% 0.75
May 19 18:00:00 - 18:59:59 815 5.2% 0.232.2 MB 4.9% 0.63
May 19 19:00:00 - 19:59:59 929 5.9% 0.262.6 MB 5.8% 0.75
May 19 20:00:00 - 20:59:59 705 4.5% 0.202.3 MB 5.1% 0.66
May 19 21:00:00 - 21:59:59 630 4.0% 0.171.6 MB 3.6% 0.47
May 19 22:00:00 - 22:59:59 536 3.4% 0.151.7 MB 3.8% 0.49
May 19 23:00:00 - 23:59:59 635 4.0% 0.182.3 MB 5.0% 0.65
May 20 00:00:00 - 00:59:59 329 2.1% 0.091.4 MB 3.0% 0.39
May 20 01:00:00 - 01:59:59 359 2.3% 0.101.4 MB 3.1% 0.41
May 20 02:00:00 - 02:59:59 258 1.6% 0.07894.0 KB 1.9% 0.25
May 20 03:00:00 - 03:59:59 318 2.0% 0.091.1 MB 2.4% 0.31
May 20 04:00:00 - 04:59:59 282 1.8% 0.08945.7 KB 2.0% 0.26
May 20 05:00:00 - 05:59:59 339 2.2% 0.091.0 MB 2.3% 0.29
May 20 06:00:00 - 06:59:59 474 3.0% 0.131.5 MB 3.2% 0.42
May 20 07:00:00 - 07:59:59 642 4.1% 0.181.9 MB 4.2% 0.54
May 20 08:00:00 - 08:59:59 850 5.4% 0.242.0 MB 4.4% 0.56
May 20 09:00:00 - 09:59:59 752 4.8% 0.211.9 MB 4.1% 0.53
May 20 10:00:00 - 10:59:59 766 4.9% 0.212.0 MB 4.4% 0.57
May 20 11:00:00 - 11:59:59 782 5.0% 0.221.9 MB 4.2% 0.54
May 20 12:00:00 - 12:59:59 818 5.2% 0.232.2 MB 4.8% 0.62
May 20 13:00:00 - 13:59:59 828 5.3% 0.232.3 MB 5.0% 0.65
May 20 14:00:00 - 14:59:59 973 6.2% 0.272.7 MB 6.0% 0.78
May 20 15:00:00 - 15:00:05 10 0.1% 2.0022.5 KB 0.0% 4.49
TOTAL: 23:59:55 15741 100.0% 0.1845.4 MB 100.0% 0.54
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB1014.4 MB 99.1% 0 0.23 52.39
ONEDEFAULT1024.0 MB149.9 MB 14.6% 3 0.23 52.04
THREEDEFAULT1024.0 MB1017.5 MB 99.4% 0 0.23 52.80
TWODEFAULT1024.0 MB1017.3 MB 99.3% 0 0.23 52.36
TOTAL: 4-4.0 GB3.1 GB 78.1% 3 0.23-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 516 9 0 0 2 0 0 0 505
2hasname-out.news.weretis.net 270 6 0 0 0 0 0 0 264
3news-out.aioe.org 202 0 0 0 0 0 0 0 202
TOTAL: 3 988 15 0 0 2 0 0 0 971

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.math 4
biz.marketplace 2
alt.buttered.scones 2
alt.blah 2
af.philo 2
panix.chat 1
alt.business.marketeplace 1
tnn.real-estate 1
TOTAL: 8 15

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

GroupsCount
bit.listserv.catholic 2
TOTAL: 1 2

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 324
EMP (phn path) 164
EMP (phl) 99
User-issued spam cancel 34
HTML Multipart 16
Too many newsgroups 13
EMP (phn nph) 12
Binary: misplaced binary 9
HTML post 2
Scoring filter 1
TOTAL: 10 674

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 192
hasname-out.news.weretis.net 98
news.nntp4.net 7
TOTAL: 3 297
TOTAL: 1 297

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 603 603 0 0 0 0100%22:38:15
2aioe 10315 15 9818 1 0 3 0%23:59:50
3nntp4 14189 3 13928 0 0 0 0%23:59:50
4weretis 7831 0 7369 16 0 0 0%23:59:43
TOTAL: 4 32938 621 31115 17 0 3 1%94:37:38
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom2.2 MB0.0 KB2.2 MB0.0 KB/s3.7 KB22:38:15
2aioe39.4 KB3.6 KB43.0 KB0.0 KB/s2.7 KB23:59:50
3nntp428.3 KB0.0 KB28.3 KB0.0 KB/s9.4 KB23:59:50
4weretis0.0 KB241.5 KB241.5 KB0.0 KB/s15.1 KB23:59:43
TOTAL: 42.2 MB245.1 KB2.5 MB0.0 KB/s4.0 KB94:37:38
Outgoing feeds (innfeed) by Volume