Daily Usenet report

May 2 15:00:01 -- May 3 15:00:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

May 2 15:00:57 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 14111 76.8%1.7 MB 74.1%
innd 2435 13.3%348.5 KB 14.8%
innfeed 1212 6.6%168.2 KB 7.1%
cnfsstat 576 3.1%90.3 KB 3.8%
nnrpd 40 0.2%4.4 KB 0.2%
controlchan 1 0.0%0.1 KB 0.0%
overchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 18376 100.0%2.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 36931 42.2%
Negative hits 36825 42.1%
Do not exist 13658 15.6%
Cache misses 24 0.0%
TOTAL: 4 87438 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.445 0.0%59 0.000 41.441 2371.000
article cleanup00:00:00.110 0.0%13705 0.000 0.008 0.046
article logging00:00:00.420 0.0%14057 0.000 0.030 0.095
article parse00:00:00.213 0.0%25223 0.000 0.008 0.034
article write00:00:00.627 0.0%12682 0.000 0.049 0.163
artlog/artcncl00:00:00.001 0.0%59 0.000 0.017 0.100
data move00:00:00.045 0.0%96596 0.000 0.000 0.004
hisgrep/artcncl00:00:00.007 0.0%57 0.000 0.123 0.750
hishave/artcncl00:00:00.903 0.0%59 0.000 15.305 886.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:01:58.227 0.1%87680 0.000 1.348 45.166
history sync00:00:00.013 0.0%355 0.000 0.037 0.500
history write00:00:04.073 0.0%13705 0.000 0.297 18.192
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle23:58:06.874 99.8%96898 460.959 890.492 2439.715
nntp read00:00:00.691 0.0%97193 0.000 0.007 0.018
overview write00:00:00.039 0.0%12682 0.000 0.003 0.024
perl filter00:00:21.718 0.0%13705 0.883 1.585 39.983
python filter00:00:00.403 0.0%13705 0.000 0.029 0.088
site send00:00:02.126 0.0%38046 0.009 0.056 0.100
TOTAL: 24:00:50.87024:00:38.935100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.026 0.0%12667 0.000 0.002 0.024
article prepare00:00:00.000 0.0%821 0.000 0.000 0.000
article read00:00:00.023 0.0%568 0.000 0.040 0.500
backlog stats00:00:00.043 0.0%72656 0.000 0.001 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.317 0.0%43840 0.000 0.007 0.021
data write00:00:00.818 0.0%31319 0.000 0.026 0.081
idle23:58:18.625100.0%72656 648.702 1187.770 3064.819
status file00:00:00.068 0.0%237 0.000 0.287 1.000
TOTAL: 23:58:25.97423:58:19.920100.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%10 0.000 0.000 0.000
TOTAL: 00:00:02.05600: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 7 24784 8220 16094 470 33%48:38:47
2news-out.aioe.org 3 12746 4441 8292 13 34%24:22:39
3news.nntp4.net 1 12455 151 11796 508 1%22:42:25
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 12 49985 12812 36182 991 25%95:43:51
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net25.8 MB0.0 KB990.6 KB26.8 MB 96%3.2 KB
2news-out.aioe.org11.3 MB0.0 KB16.4 KB11.3 MB 99%2.6 KB
3news.nntp4.net518.3 KB0.0 KB1.2 MB1.7 MB 29%2.7 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 437.6 MB0.0 KB2.2 MB39.8 MB 94%3.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 2 15:00:01 - 15:59:59 676 5.3% 0.191.8 MB 4.8% 0.51
May 2 16:00:00 - 16:59:59 670 5.3% 0.191.9 MB 5.0% 0.53
May 2 17:00:00 - 17:59:59 665 5.2% 0.182.1 MB 5.7% 0.60
May 2 18:00:00 - 18:59:59 624 4.9% 0.171.8 MB 5.0% 0.52
May 2 19:00:00 - 19:59:59 632 5.0% 0.181.7 MB 4.7% 0.49
May 2 20:00:00 - 20:59:59 526 4.1% 0.151.4 MB 3.9% 0.41
May 2 21:00:00 - 21:59:59 490 3.9% 0.141.4 MB 3.8% 0.40
May 2 22:00:00 - 22:59:59 418 3.3% 0.121.4 MB 3.6% 0.38
May 2 23:00:00 - 23:59:59 374 3.0% 0.101.2 MB 3.2% 0.34
May 3 00:00:00 - 00:59:59 296 2.3% 0.081.1 MB 3.0% 0.31
May 3 01:00:00 - 01:59:59 295 2.3% 0.081.2 MB 3.1% 0.33
May 3 02:00:00 - 02:59:59 252 2.0% 0.07805.7 KB 2.1% 0.22
May 3 03:00:00 - 03:59:59 335 2.6% 0.091.1 MB 2.9% 0.31
May 3 04:00:00 - 04:59:59 400 3.2% 0.111.3 MB 3.4% 0.36
May 3 05:00:00 - 05:59:59 331 2.6% 0.091.1 MB 3.0% 0.32
May 3 06:00:00 - 06:59:59 465 3.7% 0.131.2 MB 3.1% 0.33
May 3 07:00:00 - 07:59:59 500 3.9% 0.141.7 MB 4.6% 0.49
May 3 08:00:00 - 08:59:59 638 5.0% 0.181.7 MB 4.7% 0.49
May 3 09:00:00 - 09:59:59 762 6.0% 0.212.3 MB 6.3% 0.67
May 3 10:00:00 - 10:59:59 682 5.4% 0.191.7 MB 4.5% 0.48
May 3 11:00:00 - 11:59:59 635 5.0% 0.181.6 MB 4.4% 0.46
May 3 12:00:00 - 12:59:59 591 4.7% 0.161.7 MB 4.5% 0.48
May 3 13:00:00 - 13:59:59 655 5.2% 0.181.7 MB 4.6% 0.48
May 3 14:00:00 - 15:00:01 763 6.0% 0.212.2 MB 6.0% 0.64
TOTAL: 24:00:00 12675 100.0% 0.1537.1 MB 100.0% 0.44
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB784.6 MB 76.6% 6 0.19 64.97
ONEDEFAULT1024.0 MB958.6 MB 93.6% 8 0.19 65.40
THREEDEFAULT1024.0 MB794.9 MB 77.6% 6 0.19 65.07
TWODEFAULT1024.0 MB786.1 MB 76.8% 6 0.19 64.93
TOTAL: 4-4.0 GB3.2 GB 81.2% 26 0.19-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1hasname-out.news.weretis.net 735 0 0 0 0 0 0 0 735
2news.nntp4.net 564 22 0 0 1 0 0 0 541
3news-out.aioe.org 78 0 0 0 0 0 0 0 78
TOTAL: 3 1377 22 0 0 1 0 0 0 1354

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.sex.female 6
panix.chat.politics 5
alt.personals.sex 5
alt.health.policy.drug-approval 1
alt.penthouse.sex.first-time 1
panix.questions 1
alt.penthouse.sex.femdom 1
biz.marketplace 1
alt.sports.hockey.nhl 1
TOTAL: 9 22

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) 504
EMP (md5) 266
EMP (phl) 119
EMP (phn nph) 108
HTML Multipart 3
Scoring filter 1
TOTAL: 6 1001

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 285
news-out.aioe.org 65
news.nntp4.net 3
TOTAL: 3 353
TOTAL: 1 353

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 486 486 0 0 0 0100%21:49:44
2aioe 10439 59 8078 2 0 1 0%23:59:51
3nntp4 14887 2 12492 0 0 1 0%23:59:52
4weretis 4944 0 4525 21 0 7 0%23:59:53
TOTAL: 4 30756 547 25095 23 0 9 1%93:49:20
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.5 MB0.0 KB1.5 MB0.0 KB/s3.2 KB21:49:44
2aioe238.1 KB27.2 KB265.3 KB0.0 KB/s4.3 KB23:59:51
3nntp45.9 KB0.0 KB5.9 KB0.0 KB/s3.0 KB23:59:52
4weretis0.0 KB124.7 KB124.7 KB0.0 KB/s5.9 KB23:59:53
TOTAL: 41.7 MB151.9 KB1.9 MB0.0 KB/s3.4 KB93:49:20
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
s205-250-135-83.bc.hsia.telus.net 0.001 0.003 0.00000:00:01
c-71-201-168-107.hsd1.il.comcast.net 0.005 0.019 0.00000:00:00
TOTAL: 2 0.006 0.022 0.00000:00:02

NNRP no permission clients:

SystemConn
c-71-201-168-107.hsd1.il.comcast.net 9
s205-250-135-83.bc.hsia.telus.net 1
TOTAL: 2 10