Daily Usenet report

Sep 20 15:00:01 -- Sep 21 15:00:04

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Sep 20 15:02:17 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 15593 76.3%1.9 MB 73.8%
innd 3058 15.0%416.5 KB 16.0%
innfeed 1199 5.9%179.5 KB 6.9%
cnfsstat 576 2.8%83.9 KB 3.2%
controlchan 3 0.0%0.4 KB 0.0%
overchan 2 0.0%0.2 KB 0.0%
TOTAL: 6 20431 100.0%2.5 MB100.0%

History cache:

ReasonCount%Count
Negative hits 42611 44.0%
Positive hits 39100 40.4%
Do not exist 15061 15.6%
Cache misses 22 0.0%
TOTAL: 4 96794 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.059 0.0%56 0.000 1.054 9.667
article cleanup00:00:00.107 0.0%15237 0.000 0.007 0.053
article logging00:00:00.508 0.0%15528 0.000 0.033 0.100
article parse00:00:00.285 0.0%29927 0.000 0.010 0.047
article write00:00:01.133 0.0%13623 0.000 0.083 1.796
artlog/artcncl00:00:00.001 0.0%56 0.000 0.018 0.333
data move00:00:00.056 0.0%109564 0.000 0.001 0.003
hisgrep/artcncl00:00:00.001 0.0%56 0.000 0.018 0.333
hishave/artcncl00:00:00.011 0.0%56 0.000 0.196 2.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:03:14.440 0.2%97917 0.003 1.986 32.874
history sync00:00:00.016 0.0%360 0.000 0.044 0.500
history write00:00:01.541 0.0%15237 0.000 0.101 6.095
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:56:55.065 99.7%109191 414.473 789.580 2728.577
nntp read00:00:00.861 0.0%109761 0.000 0.008 0.017
overview write00:00:00.058 0.0%13623 0.000 0.004 0.038
perl filter00:00:19.845 0.0%15237 0.810 1.302 13.347
python filter00:00:00.455 0.0%15237 0.000 0.030 0.087
site send00:00:02.529 0.0%40870 0.028 0.062 0.106
TOTAL: 24:00:53.73624:00:36.971100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.019 0.0%13602 0.000 0.001 0.018
article prepare00:00:00.000 0.0%912 0.000 0.000 0.000
article read00:00:00.024 0.0%589 0.000 0.041 0.500
backlog stats00:00:00.049 0.0%75980 0.000 0.001 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.362 0.0%46504 0.000 0.008 0.028
data write00:00:00.949 0.0%33116 0.004 0.029 0.117
idle23:57:55.150100.0%75980 623.142 1135.498 2917.977
status file00:00:01.088 0.0%214 0.000 5.084 390.000
TOTAL: 23:58:00.31523:57:57.641100.0%----

Control commands to INND:

CommandNumber
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 146
name 2
newgroup 1
pause 2
paused 2
reserve 2
TOTAL: 11 167

Newsgroups created:

GroupMode
alt.comp.os.windows-11y
TOTAL1

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
usenet@andyburns.uk100011
TOTAL100011

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 8 27493 9580 17390 523 34%49:53:25
2news-out.aioe.org 2 13336 3961 9371 4 29%23:59:34
3news.nntp4.net 2 14975 430 13470 1075 2%23:58:25
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 13 55804 13971 40231 1602 25%97:51:24
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net31.0 MB0.0 KB1.3 MB32.3 MB 96%3.3 KB
2news-out.aioe.org10.4 MB0.0 KB7.3 KB10.4 MB 99%2.7 KB
3news.nntp4.net1.6 MB0.0 KB9.2 MB10.9 MB 15%7.4 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 443.0 MB0.0 KB10.5 MB53.5 MB 80%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 20 15:00:01 - 15:59:59 847 6.2% 0.242.5 MB 5.9% 0.70
Sep 20 16:00:00 - 16:59:59 746 5.5% 0.212.6 MB 6.2% 0.74
Sep 20 17:00:00 - 17:59:59 662 4.9% 0.181.8 MB 4.2% 0.50
Sep 20 18:00:00 - 18:59:59 731 5.4% 0.202.3 MB 5.6% 0.67
Sep 20 19:00:00 - 19:59:59 739 5.4% 0.212.1 MB 5.0% 0.59
Sep 20 20:00:00 - 20:59:59 619 4.5% 0.171.9 MB 4.5% 0.54
Sep 20 21:00:00 - 21:59:59 571 4.2% 0.162.0 MB 4.8% 0.57
Sep 20 22:00:00 - 22:59:59 491 3.6% 0.141.9 MB 4.6% 0.55
Sep 20 23:00:00 - 23:59:59 453 3.3% 0.131.9 MB 4.5% 0.54
Sep 21 00:00:00 - 00:59:59 349 2.6% 0.101.1 MB 2.6% 0.32
Sep 21 01:00:00 - 01:59:59 289 2.1% 0.081.3 MB 3.1% 0.37
Sep 21 02:00:00 - 02:59:59 332 2.4% 0.091.1 MB 2.7% 0.32
Sep 21 03:00:00 - 03:59:59 288 2.1% 0.08904.4 KB 2.1% 0.25
Sep 21 04:00:00 - 04:59:59 276 2.0% 0.08912.7 KB 2.1% 0.25
Sep 21 05:00:00 - 05:59:59 384 2.8% 0.111.2 MB 2.9% 0.35
Sep 21 06:00:00 - 06:59:59 437 3.2% 0.121.2 MB 3.0% 0.35
Sep 21 07:00:00 - 07:59:59 617 4.5% 0.171.8 MB 4.3% 0.52
Sep 21 08:00:00 - 08:59:59 716 5.3% 0.201.9 MB 4.6% 0.55
Sep 21 09:00:00 - 09:59:59 646 4.7% 0.181.7 MB 4.0% 0.48
Sep 21 10:00:00 - 10:59:59 686 5.0% 0.192.0 MB 4.8% 0.57
Sep 21 11:00:00 - 11:59:59 592 4.3% 0.161.7 MB 4.0% 0.47
Sep 21 12:00:00 - 12:59:59 687 5.0% 0.192.0 MB 4.8% 0.57
Sep 21 13:00:00 - 13:59:59 625 4.6% 0.171.9 MB 4.4% 0.53
Sep 21 14:00:00 - 14:59:59 843 6.2% 0.232.2 MB 5.2% 0.62
Sep 21 15:00:00 - 15:00:04 8 0.1% 2.0033.2 KB 0.1% 8.31
TOTAL: 24:00:03 13634 100.0% 0.1642.0 MB 100.0% 0.50
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB77.6 MB 7.6% 3 0.21 58.68
ONEDEFAULT1024.0 MB239.4 MB 23.4% 5 0.20 59.40
THREEDEFAULT1024.0 MB80.5 MB 7.9% 3 0.21 58.44
TWODEFAULT1024.0 MB76.0 MB 7.4% 3 0.20 59.50
TOTAL: 4-4.0 GB473.4 MB 11.6% 14 0.21-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 1109 17 0 0 1 0 0 0 1091
2hasname-out.news.weretis.net 699 10 0 0 0 0 0 0 689
3news-out.aioe.org 95 0 0 0 0 0 0 0 95
TOTAL: 3 1903 27 0 0 1 0 0 0 1875

Unwanted newsgroups [Top 20]:

NewsgroupCount
panix.chat.politics 10
wolfsburg.test 3
alt.bestjobsusa.jobs.offered 3
alt.bestjobsusa.philly.jobs 3
alt.microcontrollers.8bit 1
alt.math 1
alt.fun 1
alt.personals.sex 1
alt.biz.misc 1
clari.web.local.missouri 1
bit.listserv.vmesa-l 1
alt.bestjobsusa.florida.jobs 1
TOTAL: 12 27

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) 803
EMP (md5) 529
EMP (phn nph) 174
EMP (phl) 42
Binary Image: misplaced jpg 20
User-issued spam cancel 12
HTML Multipart 1
Scoring filter 1
Binary: misplaced binary 1
TOTAL: 9 1583

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 198
news-out.aioe.org 91
news.nntp4.net 3
TOTAL: 3 292
TOTAL: 1 292

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 484 484 0 0 0 0100%21:53:28
2aioe 11993 75 9545 1 0 1 0%23:59:56
3weretis 4456 0 4257 31 0 1 0%23:59:54
4nntp4 15633 0 13225 0 0 1 0%23:59:56
TOTAL: 4 32566 559 27027 32 0 3 1%93:53:14
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom2.2 MB0.0 KB2.2 MB0.0 KB/s4.8 KB21:53:28
2aioe304.1 KB2.5 KB306.6 KB0.0 KB/s4.0 KB23:59:56
3weretis0.0 KB138.7 KB138.7 KB0.0 KB/s4.5 KB23:59:54
4nntp40.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
TOTAL: 42.5 MB141.2 KB2.7 MB0.0 KB/s4.6 KB93:53:14
Outgoing feeds (innfeed) by Volume