Daily Usenet report

Sep 2 15:00:01 -- Sep 3 15:00:04

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Sep 2 15:01:31 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 15398 77.9%1.9 MB 75.2%
innd 2662 13.5%385.0 KB 15.2%
innfeed 1130 5.7%157.8 KB 6.2%
cnfsstat 576 2.9%87.3 KB 3.4%
nnrpd 8 0.0%0.7 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 19775 100.0%2.5 MB100.0%

History cache:

ReasonCount%Count
Negative hits 42532 43.7%
Positive hits 39673 40.8%
Do not exist 15017 15.4%
Cache misses 49 0.1%
TOTAL: 4 97271 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:07.986 0.0%65 0.000 122.862 3064.000
article cleanup00:00:00.089 0.0%15088 0.000 0.006 0.038
article logging00:00:00.520 0.0%15341 0.000 0.034 0.125
article parse00:00:00.252 0.0%26290 0.000 0.010 0.036
article write00:00:06.738 0.0%13797 0.000 0.488 24.784
artlog/artcncl00:00:00.001 0.0%65 0.000 0.015 0.500
data move00:00:00.044 0.0%106692 0.000 0.000 0.003
hisgrep/artcncl00:00:00.001 0.0%65 0.000 0.015 0.500
hishave/artcncl00:00:02.368 0.0%65 0.000 36.431 2292.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:01:37.938 0.1%97668 0.000 1.003 21.026
history sync00:00:00.417 0.0%351 0.000 1.188 199.500
history write00:00:04.029 0.0%15087 0.000 0.267 7.440
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:58:08.056 99.8%105787 475.557 815.677 2167.379
nntp read00:00:00.805 0.0%106237 0.000 0.008 0.022
overview write00:00:00.051 0.0%13797 0.000 0.004 0.045
perl filter00:00:15.840 0.0%15087 0.831 1.050 1.457
python filter00:00:00.396 0.0%15087 0.000 0.026 0.108
site send00:00:02.613 0.0%41390 0.028 0.063 0.118
TOTAL: 24:00:43.51524:00:28.144100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.022 0.0%13768 0.000 0.002 0.026
article prepare00:00:00.000 0.0%831 0.000 0.000 0.000
article read00:00:00.113 0.0%635 0.000 0.178 21.000
backlog stats00:00:00.056 0.0%78544 0.000 0.001 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.396 0.0%47789 0.000 0.008 0.021
data write00:00:01.075 0.0%34142 0.006 0.031 0.078
idle23:58:39.159100.0%78544 641.136 1098.991 2685.169
status file00:00:00.359 0.0%204 0.000 1.760 61.600
TOTAL: 23:58:43.33823:58:41.180100.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%2 0.000 0.000 0.000
TOTAL: 00:00:02.01300:00:00.000 0.0%----

Control commands to INND:

CommandNumber
flush 1
go 2
logmode 1
lowmark 1
mode 146
name 1
pause 1
paused 1
reserve 2
TOTAL: 9 156

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 5 25890 9071 16413 406 35%47:45:29
2news-out.aioe.org 3 13512 4001 9503 8 29%23:56:43
3news.nntp4.net 2 16564 597 15038 929 3%25:57:38
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 11 55966 13669 40954 1343 24%97:39:50
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net28.3 MB0.0 KB730.9 KB29.0 MB 97%3.1 KB
2news-out.aioe.org10.4 MB1.2 KB10.1 KB10.4 MB 99%2.7 KB
3news.nntp4.net1.7 MB0.0 KB2.6 MB4.3 MB 38%2.9 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 440.3 MB1.2 KB3.4 MB43.7 MB 92%3.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 2 15:00:01 - 15:59:59 797 5.8% 0.222.1 MB 5.0% 0.58
Sep 2 16:00:00 - 16:59:59 696 5.0% 0.192.0 MB 4.9% 0.57
Sep 2 17:00:00 - 17:59:59 735 5.3% 0.202.3 MB 5.5% 0.64
Sep 2 18:00:00 - 18:59:59 642 4.7% 0.181.9 MB 4.5% 0.53
Sep 2 19:00:00 - 19:59:59 706 5.1% 0.202.1 MB 5.1% 0.60
Sep 2 20:00:00 - 20:59:59 668 4.8% 0.191.8 MB 4.3% 0.50
Sep 2 21:00:00 - 21:59:59 597 4.3% 0.171.7 MB 4.2% 0.49
Sep 2 22:00:00 - 22:59:59 615 4.5% 0.172.1 MB 5.0% 0.58
Sep 2 23:00:00 - 23:59:59 444 3.2% 0.121.4 MB 3.4% 0.39
Sep 3 00:00:00 - 00:59:59 323 2.3% 0.091.1 MB 2.8% 0.33
Sep 3 01:00:00 - 01:59:59 317 2.3% 0.09956.3 KB 2.3% 0.27
Sep 3 02:00:00 - 02:59:59 288 2.1% 0.081.1 MB 2.6% 0.31
Sep 3 03:00:00 - 03:59:59 282 2.0% 0.08974.3 KB 2.3% 0.27
Sep 3 04:00:00 - 04:59:59 281 2.0% 0.08849.3 KB 2.0% 0.24
Sep 3 05:00:00 - 05:59:59 366 2.7% 0.101006.2 KB 2.4% 0.28
Sep 3 06:00:00 - 06:59:59 456 3.3% 0.131.2 MB 3.0% 0.34
Sep 3 07:00:00 - 07:59:59 537 3.9% 0.151.3 MB 3.2% 0.38
Sep 3 08:00:00 - 08:59:59 705 5.1% 0.201.9 MB 4.5% 0.53
Sep 3 09:00:00 - 09:59:59 612 4.4% 0.171.8 MB 4.3% 0.50
Sep 3 10:00:00 - 10:59:59 745 5.4% 0.212.3 MB 5.5% 0.64
Sep 3 11:00:00 - 11:59:59 619 4.5% 0.171.9 MB 4.7% 0.55
Sep 3 12:00:00 - 12:59:59 742 5.4% 0.212.3 MB 5.5% 0.64
Sep 3 13:00:00 - 13:59:59 774 5.6% 0.212.6 MB 6.3% 0.74
Sep 3 14:00:00 - 14:59:59 828 6.0% 0.232.6 MB 6.3% 0.73
Sep 3 15:00:00 - 15:00:04 11 0.1% 2.7533.5 KB 0.1% 8.39
TOTAL: 24:00:03 13786 100.0% 0.1640.9 MB 100.0% 0.48
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB791.8 MB 77.3% 2 0.20 59.50
ONEDEFAULT1024.0 MB952.8 MB 93.1% 4 0.20 59.99
THREEDEFAULT1024.0 MB795.5 MB 77.7% 2 0.20 59.61
TWODEFAULT1024.0 MB790.6 MB 77.2% 2 0.21 59.19
TOTAL: 4-4.0 GB3.3 GB 81.3% 10 0.20-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 877 8 0 0 1 0 0 0 868
2hasname-out.news.weretis.net 608 14 0 0 0 0 0 0 594
3news-out.aioe.org 62 0 0 1 0 0 0 0 61
TOTAL: 3 1547 22 0 1 1 0 0 0 1523

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.math 13
alt.business.import.export 5
alt.bestjobsusa.florida.jobs 1
teranews.test 1
wolfsburg.test 1
alt.mechanical.engineering 1
TOTAL: 6 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) 775
EMP (md5) 258
EMP (phn nph) 198
EMP (phl) 13
HTML Multipart 13
User-issued spam cancel 9
Binary: misplaced binary 2
Scoring filter 2
Too many newsgroups 1
TOTAL: 9 1271

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 197
news-out.aioe.org 54
news.nntp4.net 1
TOTAL: 3 252
TOTAL: 1 252

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 562 562 0 0 0 0100%21:38:18
2aioe 12178 32 9510 1 0 0 0%23:51:01
3nntp4 15834 4 13188 0 0 0 0%23:55:58
4weretis 4726 0 4498 28 0 0 0%23:50:01
TOTAL: 4 33300 598 27196 29 0 0 1%93:15:18
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom2.0 MB0.0 KB2.0 MB0.0 KB/s3.7 KB21:38:18
2aioe96.5 KB3.8 KB100.3 KB0.0 KB/s3.0 KB23:51:01
3nntp414.6 KB0.0 KB14.6 KB0.0 KB/s3.7 KB23:55:58
4weretis0.0 KB110.2 KB110.2 KB0.0 KB/s3.9 KB23:50:01
TOTAL: 42.1 MB114.0 KB2.2 MB0.0 KB/s3.7 KB93:15:18
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
news.nntp4.net 0.003 0.004 0.00000:00:02
TOTAL: 1 0.003 0.004 0.00000:00:02

NNRP no permission clients:

SystemConn
news.nntp4.net 2
TOTAL: 1 2