ROL USENET News Service
NewsServer Node 1 (andromeda)

Daily Usenet report

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

Unknown entries from news log file:

First 20 / 20 lines (100.0%)
Sep 5 04:07:26 andromeda innd: buffindexed: overview data is too large 10290
Sep 5 04:08:09 andromeda innd: buffindexed: overview data is too large 10259
Sep 5 04:23:00 andromeda innd: buffindexed: overview data is too large 10259
Sep 5 04:43:11 andromeda innd: buffindexed: overview data is too large 10259
Sep 5 04:56:19 andromeda expireover[11851]: buffindexed: ovgroupmmap could not mmap data block: Cannot allocate memory
Sep 5 06:41:11 andromeda innd: buffindexed: overview data is too large 10258
Sep 5 10:44:14 andromeda innd: buffindexed: overview data is too large 10291
Sep 5 12:45:18 andromeda innd: buffindexed: overview data is too large 8796
Sep 5 12:45:47 andromeda innd: buffindexed: overview data is too large 10426
Sep 5 16:52:10 andromeda innd: buffindexed: overview data is too large 10211
Sep 5 17:13:57 andromeda innd: buffindexed: overview data is too large 10212
Sep 5 17:15:42 andromeda innd: buffindexed: overview data is too large 10212
Sep 5 17:45:21 andromeda innd: buffindexed: overview data is too large 8852
Sep 5 18:24:38 andromeda innd: buffindexed: overview data is too large 9182
Sep 5 18:53:00 andromeda innd: buffindexed: overview data is too large 10212
Sep 5 19:10:23 andromeda innd: buffindexed: overview data is too large 8808
Sep 5 20:30:00 andromeda innd: buffindexed: overview data is too large 10213
Sep 5 22:08:37 andromeda innd: buffindexed: overview data is too large 10290
Sep 6 01:08:40 andromeda innd: buffindexed: overview data is too large 10428
Sep 6 01:08:40 andromeda innd: buffindexed: overview data is too large 8908

Log entries by program:

Program nameLines%LinesSize%Size
inn 331419 92.8%33.7 MB 92.4%
nnrpd 17868 5.0%1.7 MB 4.6%
innd 7574 2.1%1.0 MB 2.9%
cnfsstat 288 0.1%40.4 KB 0.1%
rnews 67 0.0%6.1 KB 0.0%
expireover 1 0.0%0.1 KB 0.0%
TOTAL: 6 357217 100.0%36.5 MB100.0%

History cache:

ReasonCount%Count
Do not exist 330672 70.5%
Negative hits 138175 29.5%
Positive hits 83 0.0%
Cache misses 37 0.0%
TOTAL: 4 468967 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.484 0.0%124 0.000 3.903 70.000
article cleanup00:00:05.359 0.0%330892 0.000 0.016 0.075
article logging00:00:05.843 0.0%331295 0.000 0.018 1.644
article parse00:00:55.858 0.1%1785873 0.004 0.031 0.062
article write00:20:12.701 1.4%210422 1.500 5.763 56.567
artlog/artcncl00:00:00.001 0.0%124 0.000 0.008 0.111
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:11.445 0.0%2720773 0.000 0.004 0.015
hisgrep/artcncl00:00:00.289 0.0%101 0.000 2.861 64.000
hishave/artcncl00:00:00.049 0.0%124 0.000 0.395 16.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:03:32.010 0.2%469329 0.000 0.452 7.518
history sync00:00:00.033 0.0%903 0.000 0.037 1.000
history write00:05:45.436 0.4%330878 0.000 1.044 11.367
hiswrite/artcncl00:00:00.039 0.0%23 0.000 1.696 7.750
idle22:15:56.491 92.8%1520684 0.000 52.711 60061.000
nntp read00:01:00.840 0.1%1839645 0.000 0.033 0.081
overview write01:10:52.615 4.9%210422 0.992 20.210 36060.250
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: 23:59:42.95923:58:39.493 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:13:11.796 97.5%5760 8.000 137.465 180.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.223 0.0%17427 0.000 0.013 0.000
TOTAL: 00:13:32.40800:13:12.019 97.5%----

Control commands to INND:

CommandNumber
flush 144
flushlogs 1
paused 2
TOTAL: 3 147

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1192.168.33.37 729 330897 210422 5 120470 63%155:49:06
TOTAL: 1 729 330897 210422 5 120470 63%155:49:06

Incoming Volume (INN):

ServerAcceptVolDupVolTotalVol%AccVol/ArtElapsed
1192.168.33.379.0 GB303.7 KB9.0 GB 99%28.5 KB155:49:06
TOTAL: 19.0 GB303.7 KB9.0 GB 99%28.5 KB155:49:06

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 5 03:00:02 - 03:59:59 10871 5.2% 3.02308.9 MB 3.4% 87.90
Sep 5 04:00:00 - 04:59:59 5135 2.4% 1.43173.2 MB 1.9% 49.28
Sep 5 05:00:00 - 05:59:59 4266 2.0% 1.19152.0 MB 1.7% 43.24
Sep 5 06:00:00 - 06:59:59 7857 3.7% 2.18111.1 MB 1.2% 31.61
Sep 5 07:00:00 - 07:59:59 4041 1.9% 1.12144.1 MB 1.6% 40.98
Sep 5 08:00:00 - 08:59:59 4457 2.1% 1.24157.6 MB 1.7% 44.82
Sep 5 09:00:00 - 09:59:59 4729 2.2% 1.31165.7 MB 1.8% 47.14
Sep 5 10:00:00 - 10:59:59 11548 5.5% 3.21611.6 MB 6.6% 173.97
Sep 5 11:00:00 - 11:59:59 5140 2.4% 1.43145.6 MB 1.6% 41.41
Sep 5 12:00:00 - 12:59:59 5788 2.8% 1.61222.8 MB 2.4% 63.38
Sep 5 13:00:00 - 13:59:59 14344 6.8% 3.98752.8 MB 8.2% 214.14
Sep 5 14:00:00 - 14:59:59 11722 5.6% 3.26539.7 MB 5.9% 153.53
Sep 5 15:00:00 - 15:59:59 6626 3.1% 1.84201.0 MB 2.2% 57.18
Sep 5 16:00:00 - 16:59:59 13991 6.6% 3.89729.8 MB 7.9% 207.58
Sep 5 17:00:00 - 17:59:59 4905 2.3% 1.36171.6 MB 1.9% 48.81
Sep 5 18:00:00 - 18:59:59 8243 3.9% 2.29349.8 MB 3.8% 99.49
Sep 5 19:00:00 - 19:59:59 15636 7.4% 4.34853.5 MB 9.3% 242.78
Sep 5 20:00:00 - 20:59:59 35153 16.7% 9.762.0 GB 22.7% 596.10
Sep 5 21:00:00 - 21:59:59 16495 7.8% 4.581007.9 MB 10.9% 286.70
Sep 5 22:00:00 - 22:59:59 3679 1.7% 1.0270.8 MB 0.8% 20.14
Sep 5 23:00:00 - 23:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 6 00:00:00 - 00:59:59 0 0.0% 0.000.0 KB 0.0% 0.00
Sep 6 01:00:00 - 03:00:01 15796 7.5% 4.39247.2 MB 2.7% 70.30
TOTAL: 22:59:59 210422 100.0% 2.549.0 GB 100.0% 113.93

CNFS buffer status:

BufferClassSizeUsed%UsedCyclesKB/secDays
01SMALL130.4 GB17.0 GB 13.1% 8 10.54 150.15
02BIN763.2 GB314.1 GB 41.2% 157 130.69 70.88
TOTAL: 2-893.6 GB331.1 GB 37.1% 165 70.61-

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1192.168.33.37120873120456 0 14 0 0 0 0 403
TOTAL: 1120873120456 0 14 0 0 0 0 403

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.binaries.newznzb.juliet 6115
alt.binaries.newznzb.foxtrot 6086
alt.binaries.newznzb.bravo 6071
alt.binaries.newznzb.delta 6057
alt.binaries.newznzb.hotel 6051
alt.binaries.newznzb.beta 6035
alt.binaries.newznzb.echo 6034
alt.binaries.newznzb.golf 6029
alt.binaries.newznzb.charlie 5987
alt.binaries.newznzb.india 5969
alt.binaries.newznzb.lima 5961
alt.binaries.newznzb.mike 5933
alt.binaries.newznzb.kilo 5914
alt.binaries.newznzb.novemeber 5912
alt.binaries.newznzb.alpha 5876
alt.binaries.newznzb.oscar 1817
alt.binaries.newznzb.romeo 1809
alt.binaries.newznzb.tango 1798
alt.binaries.newznzb.victor 1795
alt.binaries.newznzb.quebec 1742
TOTAL: 202 120456

INND misc events:

EventsCount
CCreader 5
TOTAL: 1 5

Miscellaneous innd statistics [Top 10]:

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

Rnews connections rejected:

ReasonConn
400 No space (spool) [innwatch:36] 5388 lt 8000 34
400 No space left on device writing logging article file -- throttling 22
400 No space (spool) [innwatch:36] 6940 lt 8000 10
400 No space (spool) [innwatch:36] 7120 lt 8000 1
TOTAL: 4 67

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1balancer-b.rol.ru2880 00.0 KB 0 0 000:06:27
2balancer-a.rol.ru2880 00.0 KB 0 0 000:07:02
TOTAL: 25760 00.0 KB 0 0 000:13:33

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.rol.ru5760 00.0 KB 0 0 000:13:30
TOTAL: 15760 00.0 KB 0 0 000:13:30

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
balancer-a.rol.ru 3.951 4.234 0.00000:07:02
balancer-b.rol.ru 3.941 4.267 0.00000:06:27
net1-x-ring.tony.pp.ru 0.182 0.250 0.00000:00:02
TOTAL: 3 8.074 8.751 0.00000:13:33

NNRP no permission clients:

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

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

Copyright © 1995-2007 Golden Telecom