Daily Usenet report

Sep 11 15:00:02 -- Sep 12 15:00:06

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

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

Log entries by program:

Program nameLines%LinesSize%Size
inn 14254 76.7%1.7 MB 73.8%
innd 2598 14.0%378.1 KB 15.8%
innfeed 1158 6.2%163.6 KB 6.8%
cnfsstat 576 3.1%84.4 KB 3.5%
nnrpd 4 0.0%0.5 KB 0.0%
controlchan 3 0.0%0.3 KB 0.0%
TOTAL: 6 18593 100.0%2.3 MB100.0%

History cache:

ReasonCount%Count
Negative hits 38975 44.1%
Positive hits 35483 40.1%
Do not exist 13900 15.7%
Cache misses 20 0.0%
TOTAL: 4 88378 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.989 0.0%50 0.000 19.780 127.571
article cleanup00:00:00.092 0.0%14046 0.000 0.007 0.031
article logging00:00:00.462 0.0%14238 0.000 0.032 0.143
article parse00:00:00.255 0.0%27089 0.000 0.009 0.057
article write00:00:01.832 0.0%12758 0.000 0.144 4.865
artlog/artcncl00:00:00.000 0.0%50 0.000 0.000 0.000
data move00:00:00.058 0.0%100014 0.000 0.001 0.004
hisgrep/artcncl00:00:00.001 0.0%49 0.000 0.020 0.333
hishave/artcncl00:00:00.079 0.0%50 0.000 1.580 11.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:30.349 0.0%89273 0.000 0.340 16.985
history sync00:00:00.017 0.0%326 0.000 0.052 0.500
history write00:00:00.537 0.0%14046 0.000 0.038 0.380
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:59:33.221 99.9%99563 411.256 867.523 2174.203
nntp read00:00:00.793 0.0%99551 0.000 0.008 0.020
overview write00:00:00.042 0.0%12758 0.000 0.003 0.024
perl filter00:00:16.610 0.0%14046 0.779 1.183 9.789
python filter00:00:00.406 0.0%14046 0.000 0.029 0.099
site send00:00:02.421 0.0%38276 0.016 0.063 0.098
TOTAL: 24:00:43.84924:00:28.164100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.026 0.0%12704 0.000 0.002 0.030
article prepare00:00:00.000 0.0%686 0.000 0.000 0.000
article read00:00:00.030 0.0%545 0.000 0.055 1.000
backlog stats00:00:00.028 0.0%69798 0.000 0.000 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.357 0.0%43003 0.000 0.008 0.027
data write00:00:00.904 0.0%30416 0.000 0.030 0.067
idle23:57:14.472100.0%69798 668.203 1235.486 3443.257
status file00:00:00.061 0.0%212 0.000 0.288 1.000
TOTAL: 23:57:17.67223:57:15.878100.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.001 3.7%1 1.000 1.000 1.000
TOTAL: 00:00:00.02700:00:00.001 3.7%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
anton@solovyev.com200022
TOTAL200022

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1hasname-out.news.weretis.net 4 23547 8209 14968 370 34%47:44:11
2news-out.aioe.org 3 12154 3846 8308 0 31%24:20:43
3news.nntp4.net 1 14160 651 12561 948 4%24:18:49
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 9 49861 12706 35837 1318 25%96:23:43
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net24.7 MB0.0 KB521.8 KB25.2 MB 97%3.0 KB
2news-out.aioe.org9.8 MB0.0 KB0.0 KB9.8 MB100%2.6 KB
3news.nntp4.net1.8 MB0.0 KB9.2 MB11.0 MB 16%7.1 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 436.4 MB0.0 KB9.7 MB46.1 MB 78%3.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 11 15:00:02 - 15:59:59 665 5.2% 0.181.9 MB 5.1% 0.53
Sep 11 16:00:00 - 16:59:59 725 5.7% 0.202.1 MB 5.7% 0.59
Sep 11 17:00:00 - 17:59:59 681 5.4% 0.191.8 MB 4.8% 0.50
Sep 11 18:00:00 - 18:59:59 696 5.5% 0.191.7 MB 4.7% 0.50
Sep 11 19:00:00 - 19:59:59 758 6.0% 0.212.3 MB 6.3% 0.66
Sep 11 20:00:00 - 20:59:59 732 5.8% 0.202.3 MB 6.3% 0.66
Sep 11 21:00:00 - 21:59:59 562 4.4% 0.161.5 MB 4.0% 0.42
Sep 11 22:00:00 - 22:59:59 556 4.4% 0.151.9 MB 5.1% 0.53
Sep 11 23:00:00 - 23:59:59 471 3.7% 0.131.5 MB 4.2% 0.44
Sep 12 00:00:00 - 00:59:59 382 3.0% 0.111.2 MB 3.3% 0.34
Sep 12 01:00:00 - 01:59:59 340 2.7% 0.091.0 MB 2.8% 0.30
Sep 12 02:00:00 - 02:59:59 320 2.5% 0.091.1 MB 3.1% 0.33
Sep 12 03:00:00 - 03:59:59 293 2.3% 0.08998.4 KB 2.7% 0.28
Sep 12 04:00:00 - 04:59:59 232 1.8% 0.06843.8 KB 2.2% 0.23
Sep 12 05:00:00 - 05:59:59 329 2.6% 0.09970.8 KB 2.6% 0.27
Sep 12 06:00:00 - 06:59:59 378 3.0% 0.101.1 MB 2.9% 0.30
Sep 12 07:00:00 - 07:59:59 442 3.5% 0.121.1 MB 3.0% 0.31
Sep 12 08:00:00 - 08:59:59 551 4.3% 0.151.7 MB 4.8% 0.50
Sep 12 09:00:00 - 09:59:59 633 5.0% 0.181.6 MB 4.4% 0.46
Sep 12 10:00:00 - 10:59:59 539 4.2% 0.151.3 MB 3.4% 0.36
Sep 12 11:00:00 - 11:59:59 587 4.6% 0.161.6 MB 4.3% 0.45
Sep 12 12:00:00 - 12:59:59 577 4.5% 0.161.5 MB 4.0% 0.42
Sep 12 13:00:00 - 13:59:59 565 4.4% 0.161.4 MB 3.7% 0.39
Sep 12 14:00:00 - 14:59:59 712 5.6% 0.202.4 MB 6.5% 0.68
Sep 12 15:00:00 - 15:00:06 2 0.0% 0.336.7 KB 0.0% 1.11
TOTAL: 24:00:04 12728 100.0% 0.1536.7 MB 100.0% 0.44
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB946.0 MB 92.4% 2 0.19 64.69
ONEDEFAULT1024.0 MB84.2 MB 8.2% 5 0.19 65.06
THREEDEFAULT1024.0 MB950.5 MB 92.8% 2 0.19 65.48
TWODEFAULT1024.0 MB945.6 MB 92.3% 2 0.19 64.98
TOTAL: 4-4.0 GB2.9 GB 71.4% 11 0.19-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 917 2 0 0 1 0 0 0 914
2hasname-out.news.weretis.net 507 0 0 0 0 0 0 0 507
3news-out.aioe.org 52 0 0 0 0 0 0 0 52
TOTAL: 3 1476 2 0 0 1 0 0 0 1473

Unwanted newsgroups [Top 20]:

NewsgroupCount
aaa.test 1
alt.math 1
TOTAL: 2 2

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) 762
EMP (md5) 322
EMP (phn nph) 184
User-issued spam cancel 8
EMP (phl) 4
Binary: misplaced binary 1
TOTAL: 6 1281

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 136
news-out.aioe.org 52
news.nntp4.net 4
TOTAL: 3 192
TOTAL: 1 192

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 498 498 0 0 0 0100%20:31:20
2aioe 10719 27 8816 2 0 0 0%23:59:40
3weretis 4561 0 4348 18 0 0 0%23:50:00
4nntp4 14084 0 12100 0 0 0 0%24:00:00
TOTAL: 4 29862 525 25264 20 0 0 1%92:21:00
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom2.1 MB0.0 KB2.1 MB0.0 KB/s4.3 KB20:31:20
2aioe134.2 KB5.2 KB139.4 KB0.0 KB/s4.8 KB23:59:40
3weretis0.0 KB61.8 KB61.8 KB0.0 KB/s3.4 KB23:50:00
4nntp40.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
TOTAL: 42.2 MB67.0 KB2.3 MB0.0 KB/s4.3 KB92:21:00
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
scanner-06.ch1.censys-scanner.com 0.002 0.001 0.00000:00:00
TOTAL: 1 0.002 0.001 0.00000:00:00

NNRP no permission clients:

SystemConn
scanner-06.ch1.censys-scanner.com 1
TOTAL: 1 1