Daily Usenet report

Aug 13 15:00:01 -- Aug 14 15:00:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Aug 13 15:01:04 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 11759 75.1%1.4 MB 72.2%
innd 2036 13.0%296.3 KB 14.5%
innfeed 1231 7.9%176.6 KB 8.7%
cnfsstat 576 3.7%88.1 KB 4.3%
nnrpd 47 0.3%5.3 KB 0.3%
controlchan 1 0.0%0.1 KB 0.0%
overchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 15651 100.0%2.0 MB100.0%

History cache:

ReasonCount%Count
Positive hits 30036 44.3%
Negative hits 26387 39.0%
Do not exist 11300 16.7%
Cache misses 17 0.0%
TOTAL: 4 67740 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.865 0.0%72 0.000 12.014 219.667
article cleanup00:00:00.090 0.0%11365 0.000 0.008 0.043
article logging00:00:00.378 0.0%11696 0.000 0.032 0.094
article parse00:00:00.215 0.0%19331 0.000 0.011 0.061
article write00:00:00.528 0.0%10745 0.000 0.049 0.143
artlog/artcncl00:00:00.001 0.0%72 0.000 0.014 0.500
data move00:00:00.033 0.0%74468 0.000 0.000 0.006
hisgrep/artcncl00:00:00.001 0.0%71 0.000 0.014 0.500
hishave/artcncl00:00:00.000 0.0%72 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.382 0.0%68073 0.000 0.006 0.031
history sync00:00:00.010 0.0%355 0.000 0.028 0.500
history write00:00:00.446 0.0%11365 0.000 0.039 1.012
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle24:00:21.174100.0%74475 562.837 1160.405 4057.959
nntp read00:00:00.494 0.0%74291 0.000 0.007 0.020
overview write00:00:00.050 0.0%10745 0.000 0.005 0.075
perl filter00:00:13.377 0.0%11365 0.719 1.177 16.304
python filter00:00:00.353 0.0%11365 0.000 0.031 0.118
site send00:00:01.743 0.0%32231 0.014 0.054 0.122
TOTAL: 24:00:47.64324:00:40.140100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.029 0.0%10728 0.000 0.003 0.033
article prepare00:00:00.000 0.0%915 0.000 0.000 0.000
article read00:00:00.028 0.0%492 0.000 0.057 1.000
backlog stats00:00:00.038 0.0%68927 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.320 0.0%39228 0.000 0.008 0.028
data write00:00:00.812 0.0%28633 0.000 0.028 0.072
idle23:58:42.857100.0%68927 656.796 1252.381 3022.118
status file00:00:00.822 0.0%243 0.000 3.383 250.333
TOTAL: 23:58:46.66223:58:44.906100.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%11 0.000 0.000 0.000
TOTAL: 00:00:00.42800: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 19757 7392 12262 103 37%48:05:10
2news-out.aioe.org 4 10636 3069 7567 0 28%24:31:12
3news.nntp4.net 3 10878 224 10146 508 2%23:26:48
4localhost 1 0 0 0 0 0%00:00:00
TOTAL: 4 13 41271 10685 29975 611 25%96:03:10
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1hasname-out.news.weretis.net24.4 MB0.0 KB354.6 KB24.7 MB 98%3.4 KB
2news-out.aioe.org7.5 MB0.0 KB0.0 KB7.5 MB100%2.5 KB
3news.nntp4.net797.4 KB0.0 KB1.1 MB1.8 MB 42%2.6 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 432.6 MB0.0 KB1.4 MB34.0 MB 95%3.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 13 15:00:01 - 15:59:59 618 5.8% 0.171.8 MB 5.5% 0.51
Aug 13 16:00:00 - 16:59:59 589 5.5% 0.161.8 MB 5.5% 0.51
Aug 13 17:00:00 - 17:59:59 553 5.1% 0.151.5 MB 4.6% 0.43
Aug 13 18:00:00 - 18:59:59 567 5.3% 0.161.8 MB 5.5% 0.51
Aug 13 19:00:00 - 19:59:59 488 4.5% 0.141.5 MB 4.5% 0.41
Aug 13 20:00:00 - 20:59:59 530 4.9% 0.151.6 MB 4.8% 0.45
Aug 13 21:00:00 - 21:59:59 489 4.6% 0.141.4 MB 4.3% 0.40
Aug 13 22:00:00 - 22:59:59 435 4.0% 0.121.3 MB 3.9% 0.36
Aug 13 23:00:00 - 23:59:59 302 2.8% 0.08898.0 KB 2.7% 0.25
Aug 14 00:00:00 - 00:59:59 277 2.6% 0.08830.7 KB 2.5% 0.23
Aug 14 01:00:00 - 01:59:59 283 2.6% 0.08816.7 KB 2.4% 0.23
Aug 14 02:00:00 - 02:59:59 254 2.4% 0.07775.8 KB 2.3% 0.22
Aug 14 03:00:00 - 03:59:59 201 1.9% 0.06635.0 KB 1.9% 0.18
Aug 14 04:00:00 - 04:59:59 247 2.3% 0.07787.6 KB 2.4% 0.22
Aug 14 05:00:00 - 05:59:59 236 2.2% 0.07958.3 KB 2.9% 0.27
Aug 14 06:00:00 - 06:59:59 252 2.3% 0.07768.1 KB 2.3% 0.21
Aug 14 07:00:00 - 07:59:59 521 4.9% 0.142.0 MB 6.2% 0.58
Aug 14 08:00:00 - 08:59:59 528 4.9% 0.152.1 MB 6.3% 0.59
Aug 14 09:00:00 - 09:59:59 467 4.3% 0.131.2 MB 3.6% 0.33
Aug 14 10:00:00 - 10:59:59 500 4.7% 0.141.3 MB 3.9% 0.36
Aug 14 11:00:00 - 11:59:59 559 5.2% 0.161.3 MB 4.1% 0.38
Aug 14 12:00:00 - 12:59:59 552 5.1% 0.151.6 MB 4.8% 0.44
Aug 14 13:00:00 - 13:59:59 650 6.1% 0.182.3 MB 7.1% 0.65
Aug 14 14:00:00 - 15:00:02 643 6.0% 0.181.9 MB 6.0% 0.55
TOTAL: 24:00:01 10741 100.0% 0.1232.6 MB 100.0% 0.39
Incoming articles
Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
FOURDEFAULT1024.0 MB246.6 MB 24.1% 8 0.16 75.77
ONEDEFAULT1024.0 MB423.9 MB 41.4% 10 0.16 74.94
THREEDEFAULT1024.0 MB257.7 MB 25.2% 8 0.16 75.16
TWODEFAULT1024.0 MB253.6 MB 24.8% 8 0.16 76.17
TOTAL: 4-4.0 GB1.2 GB 28.9% 34 0.16-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 515 0 0 0 1 0 0 0 514
2hasname-out.news.weretis.net 391 8 0 0 0 0 0 0 383
3news-out.aioe.org 40 0 0 0 0 0 0 0 40
TOTAL: 3 946 8 0 0 1 0 0 0 937

Unwanted newsgroups [Top 20]:

NewsgroupCount
wolfsburg.test 7
alt.music.home-recording 1
TOTAL: 2 8

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 293
EMP (phn path) 130
EMP (phl) 109
EMP (phn nph) 52
HTML Multipart 15
User-issued spam cancel 7
Too many newsgroups 1
TOTAL: 7 607

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
hasname-out.news.weretis.net 286
news-out.aioe.org 40
news.nntp4.net 4
TOTAL: 3 330
TOTAL: 1 330

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1bbsgslincom 359 359 0 0 0 0100%18:44:14
2aioe 10454 128 7295 1 0 0 1%23:59:58
3nntp4 13865 7 10475 0 0 0 0%23:59:58
4weretis 3397 1 3251 2 0 0 0%23:59:58
TOTAL: 4 28075 495 21021 3 0 0 1%90:44:08
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1bbsgslincom1.2 MB0.0 KB1.2 MB0.0 KB/s3.4 KB18:44:14
2aioe488.2 KB1.6 KB489.8 KB0.0 KB/s3.8 KB23:59:58
3nntp430.7 KB0.0 KB30.7 KB0.0 KB/s4.4 KB23:59:58
4weretis3.7 KB27.6 KB31.4 KB0.0 KB/s10.5 KB23:59:58
TOTAL: 41.7 MB29.2 KB1.7 MB0.0 KB/s3.6 KB90:44:08
Outgoing feeds (innfeed) by Volume

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
zl-dal-us-gp1-wk119.internet-census.org 0.005 0.009 0.00000:00:00
192.241.237.88 0.003 0.000 0.00000:00:00
128.199.140.255 0.002 0.000 0.00000:00:00
zl-dal-us-gp1-wk119b.internet-census.org 0.001 0.001 0.00000:00:00
80.66.76.175 0.000 0.002 0.00000:00:00
TOTAL: 5 0.011 0.012 0.00000:00:00

NNRP no permission clients:

SystemConn
zl-dal-us-gp1-wk119.internet-census.org 7
zl-dal-us-gp1-wk119b.internet-census.org 1
192.241.237.88 1
128.199.140.255 1
80.66.76.175 1
TOTAL: 5 11