Daily Usenet report

Aug 29 03:00:01 -- Aug 30 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%)
Aug 29 04:52:30 andromeda expireover[12151]: buffindexed: ovgroupmmap could not mmap data block: Cannot allocate memory
Aug 29 14:09:30 andromeda innd: buffindexed: overview data is too large 10291
Aug 29 14:09:31 andromeda innd: buffindexed: overview data is too large 10259
Aug 29 14:10:45 andromeda innd: buffindexed: overview data is too large 8405
Aug 29 14:10:48 andromeda innd: buffindexed: overview data is too large 10429
Aug 29 14:10:51 andromeda innd: buffindexed: overview data is too large 10291
Aug 29 14:13:33 andromeda innd: buffindexed: overview data is too large 10291
Aug 29 14:13:37 andromeda innd: buffindexed: overview data is too large 10259
Aug 29 14:14:05 andromeda innd: buffindexed: overview data is too large 10261
Aug 29 14:14:08 andromeda innd: buffindexed: overview data is too large 10261
Aug 29 14:14:35 andromeda innd: buffindexed: overview data is too large 10259
Aug 29 16:32:11 andromeda innd: buffindexed: overview data is too large 10427
Aug 29 17:04:05 andromeda innd: buffindexed: overview data is too large 9072
Aug 29 17:18:20 andromeda innd: buffindexed: overview data is too large 10213
Aug 29 17:19:15 andromeda innd: buffindexed: overview data is too large 10213
Aug 29 17:22:31 andromeda innd: buffindexed: overview data is too large 10213
Aug 29 19:25:27 andromeda innd: buffindexed: overview data is too large 9366
Aug 29 20:28:30 andromeda innd: buffindexed: overview data is too large 8530
Aug 29 21:04:08 andromeda innd: buffindexed: overview data is too large 10211
Aug 30 01:03:49 andromeda innd: buffindexed: overview data is too large 10213
Aug 30 01:04:04 andromeda innd: buffindexed: overview data is too large 10291
Aug 30 01:04:06 andromeda innd: buffindexed: overview data is too large 10259
Aug 30 01:04:12 andromeda innd: buffindexed: overview data is too large 8903
Aug 30 01:04:37 andromeda innd: buffindexed: overview data is too large 10259
Aug 30 01:04:51 andromeda controlchan[4169]: Unknown "tags" control by robomod@news.nic.it
Aug 30 01:05:11 andromeda innd: buffindexed: overview data is too large 10259

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	397616	94.0%	36.0 MB	92.9%
nnrpd	17864	4.2%	1.7 MB	4.3%
innd	6876	1.6%	1.0 MB	2.6%
cnfsstat	288	0.1%	40.1 KB	0.1%
rnews	209	0.0%	19.2 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
expireover	1	0.0%	0.1 KB	0.0%

TOTAL: 7	422855	100.0%	38.8 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	397331	84.5%
Negative hits	73053	15.5%
Positive hits	34	0.0%
Cache misses	28	0.0%

TOTAL: 4	470446	100.0%

INND timer:

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

article cancel	00:00:00.346	0.0%	107	0.000	3.234	18.909
article cleanup	00:00:05.733	0.0%	397274	0.000	0.014	0.054
article logging	00:00:06.399	0.0%	397500	0.000	0.016	0.352
article parse	00:01:27.724	0.1%	2652152	0.010	0.033	0.060
article write	00:22:19.283	1.6%	344557	1.465	3.887	22.514
artlog/artcncl	00:00:00.001	0.0%	107	0.000	0.009	0.053
artlog/artparse	00:00:00.000	0.0%	9	0.000	0.000	0.000
data move	00:00:16.463	0.0%	4070479	0.000	0.004	0.013
hisgrep/artcncl	00:00:00.171	0.0%	61	0.000	2.803	16.222
hishave/artcncl	00:00:00.084	0.0%	107	0.000	0.785	5.636
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:02:16.967	0.2%	470339	0.000	0.291	2.565
history sync	00:00:00.023	0.0%	1357	0.000	0.017	4.000
history write	00:04:16.098	0.3%	397273	0.028	0.645	7.041
hiswrite/artcncl	00:00:00.051	0.0%	46	0.000	1.109	7.000
idle	23:03:28.030	96.1%	1983568	0.010	41.848	60061.000
nntp read	00:01:30.595	0.1%	2600850	0.000	0.035	0.286
overview write	00:22:37.882	1.6%	344557	1.087	3.941	37.739
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%	1	0.000	0.000	0.000

TOTAL: 23:59:38.765	23:58:25.850	99.9%	-	-	-	-

nnrpd timer:

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

idle	00:13:19.263	97.7%	5760	20.000	138.761	192.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:13:37.727	00:13:19.549	97.8%	-	-	-	-

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	539	397283	344557	0	52726	86%	97:35:07

TOTAL: 1		539	397283	344557	0	52726	86%	97:35:07

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	17.8 GB	31.5 KB	17.8 GB	99%	46.9 KB	97:35:07

TOTAL: 1		17.8 GB	31.5 KB	17.8 GB	99%	46.9 KB	97:35:07

Incoming articles:

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

Aug 29 14:00:01 - 14:59:59	76548	22.2%	21.27	2.7 GB	15.4%	795.77
Aug 29 15:00:00 - 15:59:59	34110	9.9%	9.47	2.0 GB	11.1%	575.30
Aug 29 16:00:00 - 16:59:59	44091	12.8%	12.25	2.6 GB	14.6%	755.05
Aug 29 17:00:00 - 17:59:59	52737	15.3%	14.65	3.2 GB	17.8%	920.65
Aug 29 18:00:00 - 18:59:59	30560	8.9%	8.49	1.7 GB	9.7%	501.32
Aug 29 19:00:00 - 19:59:59	56362	16.4%	15.66	3.3 GB	18.7%	969.52
Aug 29 20:00:00 - 20:59:59	23292	6.8%	6.47	1.3 GB	7.5%	387.69
Aug 29 21:00:00 - 21:59:59	9225	2.7%	2.56	388.3 MB	2.1%	110.46
Aug 29 22:00:00 - 22:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Aug 29 23:00:00 - 23:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Aug 30 00:00:00 - 00:59:59	0	0.0%	0.00	0.0 KB	0.0%	0.00
Aug 30 01:00:00 - 03:00:01	17632	5.1%	4.90	546.2 MB	3.0%	155.33

TOTAL: 12:00:00	344557	100.0%	7.98	17.8 GB	100.0%	430.91

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	SMALL	130.4 GB	11.0 GB	8.4%	8	41.91	37.76
02	BIN	763.2 GB	251.2 GB	32.9%	157	673.42	13.75

TOTAL: 2	-	893.6 GB	262.2 GB	29.3%	165	357.67	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	52952	52716	0	1	0	0	0	0	235

TOTAL: 1		52952	52716	0	1	0	0	0	0	235

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.newznzb.foxtrot	2356
alt.binaries.newznzb.lima	2353
alt.binaries.jerry	2344
alt.binaries.newznzb.golf	2318
alt.binaries.newznzb.kilo	2313
alt.binaries.newznzb.charlie	2308
alt.binaries.newznzb.echo	2282
alt.binaries.inner-sanctum	2271
alt.binaries.newznzb.beta	2265
alt.binaries.newznzb.novemeber	2246
alt.binaries.newznzb.delta	2243
alt.binaries.newznzb.bravo	2242
alt.binaries.newznzb.alpha	2238
alt.binaries.newznzb.india	2233
alt.binaries.newznzb.juliet	2191
alt.binaries.newznzb.mike	2189
alt.binaries.newznzb.hotel	2168
alt.binaries.newznzb.uniform	1130
alt.binaries.newznzb.xray	1079
alt.binaries.newznzb.sierra	1078

TOTAL: 192	52716

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	226
	TOTAL: 1	226

TOTAL: 1		226

Rnews connections rejected:

Reason	Conn

400 No space left on device writing logging article file -- throttling	157
400 No space (spool) [innwatch:36] 2760 lt 8000	46
400 No space (spool) [innwatch:36] 5924 lt 8000	6

TOTAL: 3	209

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	balancer-b.rol.ru	2880	0	0.0 KB	0	0	0	00:06:40
2	balancer-a.rol.ru	2880	0	0.0 KB	0	0	0	00:06:53

TOTAL: 2		5760	0	0.0 KB	0	0	0	00:13:38

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.rol.ru	5760	0	0.0 KB	0	0	0	00:13:33

TOTAL: 1		5760	0	0.0 KB	0	0	0	00:13:33

NNRP total resource statistics [Top 20]:

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

balancer-a.rol.ru	3.771	4.142	0.000	00:06:53
balancer-b.rol.ru	3.892	4.185	0.000	00:06:40
net1-x-ring.tony.pp.ru	0.161	0.264	0.000	00:00:04

TOTAL: 3	7.824	8.591	0.000	00:13:38

NNRP no permission clients:

System	Conn

net1-x-ring.tony.pp.ru	146

TOTAL: 1	146