ROL USENET News Service
NewsServer Node 2 (perseus)

Daily Usenet report

Sep 26 02:00:01 -- Sep 27 02:00:01

Unknown entries from news log file:

First 5 / 12 lines (41.7%)
Sep 26 03:35:24 perseus expireover[32388]: buffindexed: ovgroupmmap could not mmap data block: Cannot allocate memory
Sep 26 14:08:23 perseus innd: buffindexed: overview data is too large 10270
Sep 26 14:08:25 perseus innd: buffindexed: overview data is too large 10259
Sep 26 14:10:01 perseus innd: buffindexed: overview data is too large 10259
Sep 26 14:10:02 perseus innd: buffindexed: overview data is too large 10270

Log entries by program:

Program nameLines%LinesSize%Size
inn 292972 92.3%28.9 MB 91.8%
nnrpd 17852 5.6%1.6 MB 5.2%
innd 6080 1.9%939.7 KB 2.9%
cnfsstat 288 0.1%39.0 KB 0.1%
rnews 204 0.1%17.2 KB 0.1%
expireover 1 0.0%0.1 KB 0.0%
TOTAL: 6 317397 100.0%31.5 MB100.0%

History cache:

ReasonCount%Count
Do not exist 292414 69.6%
Negative hits 127754 30.4%
Positive hits 61 0.0%
Cache misses 27 0.0%
TOTAL: 4 420256 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.402 0.0%128 0.000 3.141 30.000
article cleanup00:00:04.412 0.0%292372 0.000 0.015 0.064
article logging00:00:03.843 0.0%292846 0.000 0.013 0.065
article parse00:00:58.454 0.1%1835932 0.008 0.032 0.047
article write00:13:11.183 0.9%195253 1.530 4.052 29.370
artlog/artcncl00:00:00.002 0.0%126 0.000 0.016 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:12.006 0.0%2904477 0.000 0.004 0.009
hisgrep/artcncl00:00:00.228 0.0%85 0.000 2.682 60.000
hishave/artcncl00:00:00.034 0.0%128 0.000 0.266 3.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:02:28.594 0.2%420128 0.000 0.354 2.406
history sync00:00:00.026 0.0%1365 0.000 0.019 1.000
history write00:02:41.341 0.2%195253 0.000 0.826 4.312
hiswrite/artcncl00:00:00.010 0.0%43 0.000 0.233 0.692
idle23:25:46.872 97.6%1513669 0.006 55.723 60061.000
nntp read00:01:01.559 0.1%1885407 0.000 0.033 0.055
overview write00:13:17.276 0.9%195253 0.816 4.083 33.611
perl filter00:00:00.000 0.0%0 0.000 0.000 0.000
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:00.000 0.0%0 0.000 0.000 0.000
TOTAL: 24:00:40.40823:59:46.242 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:12:34.428 97.9%5760 95.000 130.977 181.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.113 0.0%17423 0.000 0.006 0.000
TOTAL: 00:12:50.62500:12:34.541 97.9%----

Control commands to INND:

CommandNumber
flush 144
flushlogs 1
paused 2
TOTAL: 3 147

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1192.168.33.37 406 292372 195253 0 97119 66%74:25:31
TOTAL: 1 406 292372 195253 0 97119 66%74:25:31

Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolTotalVol%AccVol/ArtElapsed
1192.168.33.378.3 GB94.5 KB8.3 GB 99%29.9 KB74:25:31
TOTAL: 18.3 GB94.5 KB8.3 GB 99%29.9 KB74:25:31

Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 26 14:00:01 - 14:59:59 61122 31.3% 16.981.7 GB 20.7% 503.66
Sep 26 15:00:00 - 15:59:59 30937 15.8% 8.591.7 GB 20.7% 503.80
Sep 26 16:00:00 - 16:59:59 7420 3.8% 2.06275.4 MB 3.2% 78.34
Sep 26 17:00:00 - 17:59:59 22239 11.4% 6.181.2 GB 14.3% 346.88
Sep 26 18:00:00 - 18:59:59 32631 16.7% 9.061.8 GB 21.8% 530.44
Sep 26 19:00:00 - 19:59:59 13399 6.9% 3.72670.1 MB 7.8% 190.62
Sep 26 20:00:00 - 20:59:59 11361 5.8% 3.16581.4 MB 6.8% 165.37
Sep 26 21:00:00 - 21:59:59 775 0.4% 0.2224.5 MB 0.3% 6.98
Sep 26 22:00:00 - 22:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 26 23:00:00 - 23:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 27 00:00:00 - 00:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 27 01:00:00 - 02:00:01 15369 7.9% 4.27362.7 MB 4.2% 103.14
TOTAL: 12:00:00 195253 100.0% 4.528.3 GB 100.0% 202.43

Incoming articles

Incoming articles (size)

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
01SMALL130.4 GB28.7 GB 22.0% 8 29.75 53.19
02BIN763.2 GB231.7 GB 30.4% 155 306.06 30.26
TOTAL: 2-893.6 GB260.3 GB 29.1% 163 167.90-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1192.168.33.37 97593 97116 0 3 0 0 0 0 474
TOTAL: 1 97593 97116 0 3 0 0 0 0 474

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.binaries.kleverig 13414
alt.binaries.insiderz 13045
alt.binaries.usc 12943
alt.binaries.newznzb.beta 2675
alt.binaries.newznzb.juliet 2674
alt.binaries.newznzb.hotel 2672
alt.binaries.newznzb.bravo 2664
alt.binaries.newznzb.novemeber 2664
alt.binaries.newznzb.charlie 2634
alt.binaries.newznzb.delta 2592
alt.binaries.newznzb.mike 2590
alt.binaries.newznzb.lima 2589
alt.binaries.newznzb.golf 2581
alt.binaries.newznzb.echo 2568
alt.binaries.newznzb.alpha 2564
alt.binaries.newznzb.kilo 2552
alt.binaries.newznzb.foxtrot 2545
alt.binaries.newznzb.india 2525
alt.binaries.newznzb.whiskey 1295
alt.binaries.newznzb.victor 1278
TOTAL: 153 97116

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
192.168.33.37 474
TOTAL: 1 474
TOTAL: 1 474

Rnews connections rejected:

ReasonConn
400 No space left on device writing logging article file -- throttling 156
400 No space (spool) [innwatch:36] 7544 lt 8000 48
TOTAL: 2 204

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1balancer-b.rol.ru2880 00.0 KB 0 0 000:05:55
2balancer-a.rol.ru2880 00.0 KB 0 0 000:06:53
TOTAL: 25760 00.0 KB 0 0 000:12:51

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.rol.ru5760 00.0 KB 0 0 000:12:48
TOTAL: 15760 00.0 KB 0 0 000:12:48

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
balancer-a.rol.ru 3.976 4.352 0.00000:06:53
balancer-b.rol.ru 4.112 4.242 0.00000:05:55
net1-x-ring.tony.pp.ru 0.165 0.275 0.00000:00:02
TOTAL: 3 8.253 8.869 0.00000:12:51

NNRP no permission clients:

SystemConn
net1-x-ring.tony.pp.ru 143
TOTAL: 1 143

innreport 3.0.2 (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>.

Copyright © 1995-2007 Golden Telecom