Daily Usenet report

Sep 5 15:00:02 -- Sep 6 15:00:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Sep 5 15:00:53 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 13588 75.3%1.6 MB 72.7%
innd 2572 14.3%366.0 KB 15.8%
innfeed 1282 7.1%177.4 KB 7.7%
cnfsstat 576 3.2%87.0 KB 3.8%
nnrpd 13 0.1%1.3 KB 0.1%
overchan 2 0.0%0.3 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 18034 100.0%2.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 34819 42.6%
Negative hits 33859 41.4%
Do not exist 13029 15.9%
Cache misses 102 0.1%
TOTAL: 4 81809 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.253 0.0%62 0.000 20.210 425.000
article cleanup00:00:00.085 0.0%13129 0.000 0.006 0.050
article logging00:00:01.139 0.0%13562 0.000 0.084 7.121
article parse00:00:00.215 0.0%23560 0.000 0.009 0.033
article write00:00:01.848 0.0%11988 0.000 0.154 9.396
artlog/artcncl00:00:00.000 0.0%60 0.000 0.000 0.000
data move00:00:00.054 0.0%90203 0.000 0.001 0.004
hisgrep/artcncl00:00:00.001 0.0%56 0.000 0.018 1.000
hishave/artcncl00:00:00.550 0.0%62 0.000 8.871 346.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:01:47.566 0.1%82340 0.001 1.306 24.369
history sync00:00:00.189 0.0%364 0.000 0.519 56.667
history write00:00:00.590 0.0%13129 0.000 0.045 1.120
hiswrite/artcncl00:00:00.000 0.0%6 0.000 0.000 0.000
idle23:58:26.810 99.8%90474 439.990 953.940 3925.124
nntp read00:00:00.627 0.0%90662 0.000 0.007 0.015
overview write00:00:00.032 0.0%11988 0.000 0.003 0.037
perl filter00:00:16.499 0.0%13129 0.800 1.257 14.918
python filter00:00:00.388 0.0%13129 0.000 0.030 0.100
site send00:00:01.969 0.0%35963 0.000 0.055 0.096
TOTAL: 24:00:51.72524:00:39.815100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.034 0.0%11832 0.000 0.003 0.034
article prepare00:00:00.000 0.0%741 0.000 0.000 0.000
article read00:00:00.020 0.0%414 0.000 0.048 7.000
backlog stats00:00:00.042 0.0%70860 0.000 0.001 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.336 0.0%41992 0.000 0.008 0.035
data write00:00:00.718 0.0%30285 0.000 0.024 0.070
idle23:49:58.313100.0%70860 638.537 1210.814 3243.557
status file00:00:00.078 0.0%275 0.000 0.284 1.000
TOTAL: 23:50:01.32323:49:59.541100.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:00.78500: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 5 23194 8707 14203 284 37%48:12:44
2news-out.aioe.org 4 11953 3128 8821 4 26%24:08:31
3news.nntp4.net 2 14027 193 12917 917 1%25:06:58
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 12 49174 12028 35941 1205 24%97:28:13
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net27.1 MB0.0 KB517.3 KB27.6 MB 98%3.1 KB
2news-out.aioe.org8.4 MB0.0 KB6.9 KB8.4 MB 99%2.7 KB
3news.nntp4.net610.3 KB0.0 KB2.7 MB3.3 MB 18%3.0 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 436.0 MB0.0 KB3.2 MB39.2 MB 91%3.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 5 15:00:02 - 15:59:59 815 6.8% 0.232.5 MB 7.0% 0.72
Sep 5 16:00:00 - 16:59:59 714 6.0% 0.202.3 MB 6.4% 0.65
Sep 5 17:00:00 - 17:59:59 698 5.8% 0.191.8 MB 5.0% 0.51
Sep 5 18:00:00 - 18:59:59 630 5.3% 0.171.8 MB 5.1% 0.52
Sep 5 19:00:00 - 19:59:59 574 4.8% 0.161.6 MB 4.6% 0.47
Sep 5 20:00:00 - 20:59:59 577 4.8% 0.161.8 MB 4.9% 0.50
Sep 5 21:00:00 - 21:59:59 494 4.1% 0.141.7 MB 4.7% 0.48
Sep 5 22:00:00 - 22:59:59 431 3.6% 0.121.4 MB 4.0% 0.41
Sep 5 23:00:00 - 23:59:59 262 2.2% 0.07749.1 KB 2.0% 0.21
Sep 6 00:00:00 - 00:59:59 248 2.1% 0.07838.3 KB 2.3% 0.23
Sep 6 01:00:00 - 01:59:59 205 1.7% 0.06795.2 KB 2.2% 0.22
Sep 6 02:00:00 - 02:59:59 224 1.9% 0.06751.7 KB 2.1% 0.21
Sep 6 03:00:00 - 03:59:59 189 1.6% 0.05622.3 KB 1.7% 0.17
Sep 6 04:00:00 - 04:59:59 259 2.2% 0.07699.3 KB 1.9% 0.19
Sep 6 05:00:00 - 05:59:59 276 2.3% 0.08865.9 KB 2.4% 0.24
Sep 6 06:00:00 - 06:59:59 422 3.5% 0.121.1 MB 3.1% 0.31
Sep 6 07:00:00 - 07:59:59 565 4.7% 0.161.6 MB 4.4% 0.45
Sep 6 08:00:00 - 08:59:59 564 4.7% 0.161.7 MB 4.8% 0.48
Sep 6 09:00:00 - 09:59:59 681 5.7% 0.192.0 MB 5.6% 0.57
Sep 6 10:00:00 - 10:59:59 603 5.0% 0.171.9 MB 5.2% 0.53
Sep 6 11:00:00 - 11:59:59 582 4.9% 0.162.0 MB 5.5% 0.56
Sep 6 12:00:00 - 12:59:59 593 5.0% 0.161.6 MB 4.5% 0.46
Sep 6 13:00:00 - 13:59:59 609 5.1% 0.171.6 MB 4.3% 0.44
Sep 6 14:00:00 - 15:00:01 752 6.3% 0.212.2 MB 6.2% 0.63
TOTAL: 23:59:59 11967 100.0% 0.1435.8 MB 100.0% 0.42
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB586.0 MB 57.2% 8 0.18 68.48
ONEDEFAULT1024.0 MB764.3 MB 74.6% 10 0.17 69.37
THREEDEFAULT1024.0 MB599.9 MB 58.6% 8 0.18 67.08
TWODEFAULT1024.0 MB594.1 MB 58.0% 8 0.18 67.57
TOTAL: 4-4.0 GB2.5 GB 62.1% 34 0.18-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 850 10 0 0 1 0 0 0 839
2hasname-out.news.weretis.net 670 3 0 0 0 0 0 0 667
3news-out.aioe.org 41 0 0 0 0 0 0 0 41
TOTAL: 3 1561 13 0 0 1 0 0 0 1547

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.culture 2
sybase.public.powerdesigner.general 1
tw.k-12.health 1
alt.alt.alt 1
alt.math 1
alt.investors 1
tw.environment 1
alt.fetish.feet 1
wolfsburg.test 1
tw.k-12.education 1
alt.news 1
tw.talk 1
TOTAL: 12 13

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) 430
EMP (md5) 398
EMP (phl) 220
EMP (phn nph) 60
HTML post 4
Scoring filter 1
Too many newsgroups 1
HTML Multipart 1
TOTAL: 8 1115

INND no permission servers:

SystemConn
125.56.40.12 2
TOTAL: 1 2

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 390
news-out.aioe.org 38
news.nntp4.net 4
TOTAL: 3 432
TOTAL: 1 432

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 316 316 0 0 0 0100%18:45:37
2aioe 11486 95 8552 1 0 0 0%23:59:55
3nntp4 14919 9 11767 1 0 1 0%23:59:56
4weretis 3382 0 3229 4 0 0 0%23:58:33
TOTAL: 4 30103 420 23548 6 0 1 1%90:44:01
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.4 MB0.0 KB1.4 MB0.0 KB/s4.6 KB18:45:37
2aioe318.6 KB2.0 KB320.6 KB0.0 KB/s3.3 KB23:59:55
3nntp426.8 KB3.0 KB29.7 KB0.0 KB/s3.0 KB23:59:56
4weretis0.0 KB13.2 KB13.2 KB0.0 KB/s3.3 KB23:58:33
TOTAL: 41.7 MB18.2 KB1.8 MB0.0 KB/s4.2 KB90:44:01
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
125-56-40-12.ppp.bbiq.jp 0.003 0.003 0.00000:00:00
192.241.213.57 0.000 0.004 0.00000:00:00
TOTAL: 2 0.003 0.007 0.00000:00:00

NNRP no permission clients:

SystemConn
125-56-40-12.ppp.bbiq.jp 2
192.241.213.57 1
TOTAL: 2 3