Daily Usenet report

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

Log entries by program
History cache
INND timer
nnrpd timer
Control commands to INND
Incoming Feeds (INN)
Incoming Volume (INN)
Incoming articles
CNFS buffer status
Sites sending bad articles
Unwanted newsgroups
Miscellaneous innd statistics
Rnews connections rejected
NNRP readership statistics
NNRP readership statistics (by domain)
NNRP total resource statistics
NNRP no permission clients

First 26 / 26 lines (100.0%)
Sep 4 04:49:38 andromeda expireover[11817]: buffindexed: ovgroupmmap could not mmap data block: Cannot allocate memory
Sep 4 14:05:58 andromeda innd: buffindexed: overview data is too large 13053
Sep 4 14:05:58 andromeda innd: buffindexed: overview data is too large 13053
Sep 4 14:05:58 andromeda innd: buffindexed: overview data is too large 13053
Sep 4 14:05:58 andromeda innd: buffindexed: overview data is too large 13053
Sep 4 14:06:49 andromeda innd: buffindexed: overview data is too large 10291
Sep 4 14:06:52 andromeda innd: buffindexed: overview data is too large 10258
Sep 4 14:11:53 andromeda innd: buffindexed: overview data is too large 10259
Sep 4 14:14:28 andromeda innd: buffindexed: overview data is too large 10291
Sep 4 14:14:53 andromeda innd: buffindexed: overview data is too large 8686
Sep 4 14:14:53 andromeda innd: buffindexed: overview data is too large 10426
Sep 4 16:07:05 andromeda innd: buffindexed: overview data is too large 10210
Sep 4 16:11:38 andromeda innd: buffindexed: overview data is too large 10210
Sep 4 16:21:10 andromeda innd: buffindexed: overview data is too large 10213
Sep 4 16:24:59 andromeda innd: buffindexed: overview data is too large 10213
Sep 4 17:20:49 andromeda innd: buffindexed: overview data is too large 10426
Sep 4 17:34:38 andromeda innd: buffindexed: overview data is too large 8740
Sep 4 17:35:05 andromeda innd: buffindexed: overview data is too large 10426
Sep 4 18:32:29 andromeda innd: buffindexed: overview data is too large 10212
Sep 4 20:16:16 andromeda innd: buffindexed: overview data is too large 10210
Sep 4 20:44:01 andromeda innd: buffindexed: overview data is too large 10210
Sep 4 20:45:03 andromeda innd: buffindexed: overview data is too large 10210
Sep 4 21:39:02 andromeda innd: buffindexed: overview data is too large 10290
Sep 4 21:39:59 andromeda innd: buffindexed: overview data is too large 10258
Sep 4 22:25:25 andromeda innd: buffindexed: overview data is too large 8752
Sep 4 23:35:43 andromeda innd: buffindexed: overview data is too large 10259

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	253507	91.2%	24.9 MB	90.4%
nnrpd	17873	6.4%	1.7 MB	6.1%
innd	6284	2.3%	950.0 KB	3.4%
cnfsstat	288	0.1%	39.2 KB	0.1%
rnews	157	0.1%	14.3 KB	0.1%
expireover	1	0.0%	0.1 KB	0.0%

TOTAL: 6	278110	100.0%	27.6 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	253166	77.7%
Negative hits	72494	22.3%
Positive hits	62	0.0%
Cache misses	18	0.0%

TOTAL: 4	325740	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)

article cancel	00:00:00.266	0.0%	107	0.000	2.486	17.833
article cleanup	00:00:03.961	0.0%	253135	0.000	0.016	0.049
article logging	00:00:04.126	0.0%	253400	0.000	0.016	0.143
article parse	00:00:37.320	0.0%	1270837	0.010	0.029	0.099
article write	00:15:07.812	1.1%	183933	1.341	4.936	34.393
artlog/artcncl	00:00:00.000	0.0%	107	0.000	0.000	0.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:07.964	0.0%	1856968	0.001	0.004	0.009
hisgrep/artcncl	00:00:00.164	0.0%	80	0.000	2.050	15.000
hishave/artcncl	00:00:00.036	0.0%	107	0.000	0.336	2.833
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:02:01.305	0.1%	325633	0.000	0.373	2.442
history sync	00:00:00.020	0.0%	1171	0.000	0.017	1.000
history write	00:04:47.094	0.3%	253135	0.076	1.134	6.366
hiswrite/artcncl	00:00:00.024	0.0%	27	0.000	0.889	1.500
idle	23:11:02.790	96.6%	1068514	0.005	78.111	60061.000
nntp read	00:00:41.135	0.0%	1259222	0.000	0.033	0.067
overview write	00:25:25.980	1.8%	183933	1.128	8.296	40.486
perl filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.000	0.0%	0	0.000	0.000	0.000

TOTAL: 24:00:45.026	23:59:59.997	99.9%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)

idle	00:13:46.014	98.0%	5759	29.000	143.430	205.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.286	0.0%	17426	0.000	0.016	0.000

TOTAL: 00:14:02.747	00:13:46.300	98.0%	-	-	-	-

Control commands to INND:

Command	Number

flush	144
flushlogs	1
paused	2

TOTAL: 3	147

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	192.168.33.37	503	253135	183933	0	69202	72%	102:11:34

TOTAL: 1		503	253135	183933	0	69202	72%	102:11:34

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	6.3 GB	0.0 KB	6.3 GB	100%	26.2 KB	102:11:34

TOTAL: 1		6.3 GB	0.0 KB	6.3 GB	100%	26.2 KB	102:11:34

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec

Sep 4 14:00:02 - 14:59:59	61676	33.5%	17.14	1.3 GB	21.1%	388.48
Sep 4 15:00:00 - 15:59:59	9506	5.2%	2.64	346.6 MB	5.3%	98.58
Sep 4 16:00:00 - 16:59:59	7919	4.3%	2.20	251.1 MB	3.9%	71.42
Sep 4 17:00:00 - 17:59:59	10042	5.5%	2.79	238.7 MB	3.7%	67.90
Sep 4 18:00:00 - 18:59:59	9620	5.2%	2.67	342.3 MB	5.3%	97.35
Sep 4 19:00:00 - 19:59:59	6128	3.3%	1.70	173.4 MB	2.7%	49.33
Sep 4 20:00:00 - 20:59:59	10444	5.7%	2.90	244.7 MB	3.8%	69.59
Sep 4 21:00:00 - 21:59:59	6133	3.3%	1.70	187.3 MB	2.9%	53.28
Sep 4 22:00:00 - 22:59:59	16388	8.9%	4.55	846.3 MB	13.1%	240.73
Sep 4 23:00:00 - 23:59:59	11239	6.1%	3.12	536.6 MB	8.3%	152.62
Sep 5 00:00:00 - 00:59:59	20034	10.9%	5.57	1.1 GB	17.4%	321.55
Sep 5 01:00:00 - 03:00:01	14804	8.0%	4.11	821.5 MB	12.7%	233.62

TOTAL: 11:59:59	183933	100.0%	4.26	6.3 GB	100.0%	153.69

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	SMALL	130.4 GB	16.4 GB	12.5%	8	26.65	59.39
02	BIN	763.2 GB	305.7 GB	40.0%	157	136.30	67.96

TOTAL: 2	-	893.6 GB	322.0 GB	36.0%	165	81.47	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	69467	69202	0	0	0	0	0	0	265

TOTAL: 1		69467	69202	0	0	0	0	0	0	265

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.jerry	3390
alt.binaries.inner-sanctum	3137
alt.binaries.newznzb.alpha	3120
alt.binaries.newznzb.juliet	3115
alt.binaries.newznzb.delta	3112
alt.binaries.newznzb.bravo	3106
alt.binaries.newznzb.india	3102
alt.binaries.newznzb.beta	3100
alt.binaries.newznzb.echo	3099
alt.binaries.newznzb.lima	3099
alt.binaries.newznzb.charlie	3098
alt.binaries.newznzb.hotel	3074
alt.binaries.newznzb.foxtrot	3056
alt.binaries.newznzb.novemeber	3055
alt.binaries.newznzb.golf	3042
alt.binaries.newznzb.mike	3022
alt.binaries.newznzb.kilo	3009
alt.binaries.flowed	1428
alt.binaries.encrypted	1071
alt.binaries.newznzb.xray	1037

TOTAL: 197	69202

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	265
	TOTAL: 1	265

TOTAL: 1		265

Rnews connections rejected:

Reason	Conn

400 No space left on device writing logging article file -- throttling	134
400 No space (spool) [innwatch:36] 7120 lt 8000	19
400 No space (spool) [innwatch:36] 1960 lt 8000	4

TOTAL: 3	157

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	balancer-b.rol.ru	2879	0	0.0 KB	0	0	0	00:06:46
2	balancer-a.rol.ru	2880	0	0.0 KB	0	0	0	00:07:13

TOTAL: 2		5759	0	0.0 KB	0	0	0	00:14:03

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.rol.ru	5759	0	0.0 KB	0	0	0	00:14:00

TOTAL: 1		5759	0	0.0 KB	0	0	0	00:14:00

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed

balancer-a.rol.ru	3.867	4.181	0.000	00:07:13
balancer-b.rol.ru	3.897	4.212	0.000	00:06:46
net1-x-ring.tony.pp.ru	0.163	0.267	0.000	00:00:03
75-151-74-61-independence.hfc.comcastbusiness.net	0.002	0.001	0.000	00:00:00

TOTAL: 4	7.929	8.661	0.000	00:14:03

NNRP no permission clients:

System	Conn

net1-x-ring.tony.pp.ru	148
75-151-74-61-independence.hfc.comcastbusiness.net	1

TOTAL: 2	149