Daily Usenet report

May 25 15:00:08 -- May 26 15:00:10

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

May 25 15:06:18 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 17749 80.2%2.1 MB 77.6%
innd 2629 11.9%375.5 KB 13.4%
innfeed 1159 5.2%167.2 KB 6.0%
cnfsstat 576 2.6%81.4 KB 2.9%
nnrpd 12 0.1%1.3 KB 0.0%
overchan 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 22127 100.0%2.7 MB100.0%

History cache:

ReasonCount%Count
Negative hits 55416 48.0%
Positive hits 42732 37.0%
Do not exist 17146 14.9%
Cache misses 46 0.0%
TOTAL: 4 115340 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:14.812 0.0%68 0.000 217.824 2909.000
article cleanup00:00:00.125 0.0%17382 0.000 0.007 0.041
article logging00:00:00.560 0.0%17697 0.000 0.032 0.076
article parse00:00:00.308 0.0%30860 0.000 0.010 0.030
article write00:00:07.323 0.0%16195 0.000 0.452 10.162
artlog/artcncl00:00:00.001 0.0%67 0.000 0.015 0.333
data move00:00:00.072 0.0%123854 0.000 0.001 0.004
hisgrep/artcncl00:00:01.797 0.0%68 0.000 26.426 359.400
hishave/artcncl00:00:06.721 0.0%68 0.000 98.838 2649.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:20:43.630 1.4%116417 0.002 10.683 71.755
history sync00:00:00.012 0.0%367 0.000 0.033 0.500
history write00:00:18.473 0.0%17342 0.000 1.065 26.406
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:38:11.708 98.4%117597 371.758 723.587 1944.101
nntp read00:00:00.848 0.0%123002 0.000 0.007 0.017
overview write00:00:00.069 0.0%16195 0.000 0.004 0.043
perl filter00:00:36.546 0.0%17342 0.831 2.107 18.493
python filter00:00:00.467 0.0%17342 0.000 0.027 0.085
site send00:00:02.749 0.0%48585 0.019 0.057 0.101
TOTAL: 24:00:57.91524:00:26.221100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.043 0.0%16144 0.000 0.003 0.029
article prepare00:00:00.000 0.0%625 0.000 0.000 0.000
article read00:00:00.033 0.0%592 0.000 0.056 1.000
backlog stats00:00:00.055 0.0%73326 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.426 0.0%49670 0.000 0.009 0.027
data write00:00:00.953 0.0%33867 0.000 0.028 0.077
idle23:57:07.373100.0%73326 561.887 1175.945 3532.541
status file00:00:03.290 0.0%209 0.000 15.742 420.250
TOTAL: 23:57:14.88823:57:12.173100.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%3 0.000 0.000 0.000
TOTAL: 00:00:01.87900:00:00.000 0.0%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 7 30016 9668 20047 301 32%48:39:49
2news-out.aioe.org 3 12929 4333 8545 51 33%23:31:43
3news.nntp4.net 3 17546 2214 14500 832 12%24:39:12
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 14 60491 16215 43092 1184 26%96:50:44
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net29.0 MB37.5 KB675.1 KB29.7 MB 97%3.1 KB
2news-out.aioe.org11.3 MB37.0 KB87.6 KB11.4 MB 98%2.7 KB
3news.nntp4.net5.4 MB38.0 KB4.8 MB10.2 MB 52%3.4 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 445.7 MB112.6 KB5.6 MB51.4 MB 88%3.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 25 15:00:08 - 15:59:59 943 5.8% 0.262.6 MB 5.6% 0.73
May 25 16:00:00 - 16:59:59 922 5.7% 0.262.5 MB 5.5% 0.71
May 25 17:00:00 - 17:59:59 888 5.5% 0.252.4 MB 5.3% 0.69
May 25 18:00:00 - 18:59:59 865 5.3% 0.242.5 MB 5.4% 0.70
May 25 19:00:00 - 19:59:59 814 5.0% 0.232.2 MB 4.8% 0.63
May 25 20:00:00 - 20:59:59 722 4.5% 0.202.0 MB 4.4% 0.57
May 25 21:00:00 - 21:59:59 833 5.1% 0.232.5 MB 5.4% 0.70
May 25 22:00:00 - 22:59:59 529 3.3% 0.151.6 MB 3.6% 0.46
May 25 23:00:00 - 23:59:59 505 3.1% 0.141.5 MB 3.4% 0.44
May 26 00:00:00 - 00:59:59 388 2.4% 0.111.4 MB 3.0% 0.39
May 26 01:00:00 - 01:59:59 285 1.8% 0.081.5 MB 3.2% 0.42
May 26 02:00:00 - 02:59:59 299 1.8% 0.081017.5 KB 2.2% 0.28
May 26 03:00:00 - 03:59:59 272 1.7% 0.08854.0 KB 1.8% 0.24
May 26 04:00:00 - 04:59:59 324 2.0% 0.091.0 MB 2.2% 0.29
May 26 05:00:00 - 05:59:59 408 2.5% 0.111.2 MB 2.6% 0.34
May 26 06:00:00 - 06:59:59 528 3.3% 0.151.4 MB 3.2% 0.41
May 26 07:00:00 - 07:59:59 665 4.1% 0.181.8 MB 3.9% 0.50
May 26 08:00:00 - 08:59:59 766 4.7% 0.211.8 MB 4.0% 0.52
May 26 09:00:00 - 09:59:59 738 4.6% 0.202.0 MB 4.4% 0.57
May 26 10:00:00 - 10:59:59 708 4.4% 0.201.8 MB 3.9% 0.50
May 26 11:00:00 - 11:59:59 878 5.4% 0.242.3 MB 5.1% 0.66
May 26 12:00:00 - 12:59:59 967 6.0% 0.272.6 MB 5.6% 0.73
May 26 13:00:00 - 13:59:59 959 5.9% 0.272.5 MB 5.5% 0.71
May 26 14:00:00 - 14:59:59 969 6.0% 0.272.6 MB 5.8% 0.75
May 26 15:00:00 - 15:00:10 10 0.1% 1.0038.7 KB 0.1% 3.87
TOTAL: 24:00:02 16185 100.0% 0.1945.6 MB 100.0% 0.54
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB102.8 MB 10.0% 1 0.24 51.13
ONEDEFAULT1024.0 MB262.4 MB 25.6% 3 0.23 52.39
THREEDEFAULT1024.0 MB106.5 MB 10.4% 1 0.24 50.90
TWODEFAULT1024.0 MB104.8 MB 10.2% 1 0.23 51.99
TOTAL: 4-4.0 GB576.5 MB 14.1% 6 0.24-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 848 9 0 12 1 0 0 0 826
2hasname-out.news.weretis.net 462 1 0 15 0 0 0 0 446
3news-out.aioe.org 187 0 0 13 0 0 0 0 174
TOTAL: 3 1497 10 0 40 1 0 0 0 1446

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.blah 2
alt.sys.icl 2
alt.fetish.feet 1
biz.misc 1
alt.business.ads 1
alt.penthouse.sex.femdom 1
alt.uk 1
alt.biz.misc 1
TOTAL: 8 10

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 519
EMP (phn path) 457
EMP (phl) 91
EMP (phn nph) 25
User-issued spam cancel 22
Too many newsgroups 13
Scoring filter 2
HTML Multipart 1
Too many newsgroups (meow) 1
TOTAL: 9 1131

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 161
news-out.aioe.org 132
news.nntp4.net 22
TOTAL: 3 315
TOTAL: 1 315

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 588 588 0 0 0 0100%21:23:40
2aioe 11867 6 11527 2 0 0 0%24:02:24
3nntp4 14233 0 14040 0 0 0 0%23:59:55
4weretis 6628 0 6448 3 0 0 0%23:55:01
TOTAL: 4 33316 594 32015 5 0 0 1%93:21:00
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom2.2 MB0.0 KB2.2 MB0.0 KB/s3.9 KB21:23:40
2aioe10.8 KB6.5 KB17.4 KB0.0 KB/s2.2 KB24:02:24
3nntp40.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
4weretis0.0 KB14.9 KB14.9 KB0.0 KB/s5.0 KB23:55:01
TOTAL: 42.2 MB21.4 KB2.2 MB0.0 KB/s3.8 KB93:21:00
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
news.nntp4.net 0.004 0.004 0.00000:00:01
scanner-04.ch1.censys-scanner.com 0.000 0.003 0.00000:00:00
TOTAL: 2 0.004 0.007 0.00000:00:01

NNRP no permission clients:

SystemConn
news.nntp4.net 2
scanner-04.ch1.censys-scanner.com 1
TOTAL: 2 3