Daily Usenet report

Oct 15 02:00:01 -- Oct 16 02:00:02

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
INND misc events
Miscellaneous innd statistics
Rnews connections rejected
NNRP readership statistics
NNRP readership statistics (by domain)
NNRP total resource statistics
NNRP no permission clients

First 5 / 7 lines (71.4%)
Oct 15 03:25:41 perseus innd: buffindexed: overview data is too large 10270
Oct 15 03:25:49 perseus innd: buffindexed: overview data is too large 10259
Oct 15 03:34:03 perseus innd: buffindexed: overview data is too large 10210
Oct 15 03:34:07 perseus innd: buffindexed: overview data is too large 10210
Oct 15 03:56:36 perseus expireover[31486]: buffindexed: ovgroupmmap could not mmap data block: Cannot allocate memory

Log entries by program:

Program name	Lines	%Lines	Size	%Size

inn	196912	89.3%	17.7 MB	87.8%
nnrpd	17869	8.1%	1.6 MB	7.9%
innd	5154	2.3%	830.9 KB	4.0%
cnfsstat	288	0.1%	38.9 KB	0.2%
rnews	258	0.1%	22.2 KB	0.1%
expireover	1	0.0%	0.1 KB	0.0%

TOTAL: 6	220482	100.0%	20.2 MB	100.0%

History cache:

Reason	Count	%Count

Do not exist	196082	82.4%
Negative hits	41602	17.5%
Positive hits	129	0.1%
Cache misses	14	0.0%

TOTAL: 4	237827	100.0%

INND timer:

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

article cancel	00:00:00.055	0.0%	48	0.000	1.146	21.000
article cleanup	00:00:02.810	0.0%	196648	0.000	0.014	0.082
article logging	00:00:02.763	0.0%	196865	0.000	0.014	0.063
article parse	00:00:43.663	0.1%	1062009	0.015	0.041	0.090
article write	00:12:37.253	0.9%	172554	1.214	4.388	16.294
artlog/artcncl	00:00:00.002	0.0%	47	0.000	0.043	0.250
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:06.939	0.0%	1550610	0.000	0.004	0.014
hisgrep/artcncl	00:00:00.037	0.0%	12	0.000	3.083	21.000
hishave/artcncl	00:00:00.014	0.0%	48	0.000	0.292	1.273
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:02:08.063	0.1%	238458	0.006	0.537	1.782
history sync	00:00:00.009	0.0%	1536	0.000	0.006	1.000
history write	00:03:34.463	0.2%	172554	0.046	1.243	6.069
hiswrite/artcncl	00:00:00.000	0.0%	36	0.000	0.000	0.000
idle	23:01:54.258	96.0%	643942	0.000	128.760	60061.000
nntp read	00:00:37.834	0.0%	989889	0.000	0.038	0.088
overview write	00:37:03.280	2.6%	172554	0.580	12.885	804.480
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: 23:59:22.170	23:58:51.443	100.0%	-	-	-	-

nnrpd timer:

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

idle	00:12:05.480	97.8%	5760	103.000	125.951	222.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.166	0.0%	17427	0.000	0.010	0.000

TOTAL: 00:12:21.903	00:12:05.646	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	280	196672	172554	24	24094	87%	42:51:02

TOTAL: 1		280	196672	172554	24	24094	87%	42:51:02

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	192.168.33.37	8.8 GB	3.3 MB	8.8 GB	99%	46.7 KB	42:51:02

TOTAL: 1		8.8 GB	3.3 MB	8.8 GB	99%	46.7 KB	42:51:02

Incoming articles:

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

Oct 15 03:00:01 - 03:59:59	76220	44.2%	21.18	3.1 GB	35.2%	897.75
Oct 15 04:00:00 - 04:59:59	58493	33.9%	16.25	3.5 GB	39.4%	1005.27
Oct 15 05:00:00 - 05:59:59	28088	16.3%	7.80	1.7 GB	19.1%	486.84
Oct 15 06:00:00 - 02:00:02	9753	5.7%	2.71	566.3 MB	6.3%	160.98

TOTAL: 04:00:01	172554	100.0%	11.98	8.8 GB	100.0%	637.63

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

01	SMALL	130.4 GB	43.4 GB	33.3%	8	49.04	32.27
02	BIN	763.2 GB	358.0 GB	46.9%	155	863.87	10.72

TOTAL: 2	-	893.6 GB	401.4 GB	44.9%	163	456.46	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	192.168.33.37	24311	23987	0	107	0	0	0	0	217

TOTAL: 1		24311	23987	0	107	0	0	0	0	217

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.newznzb.hotel	1396
alt.binaries.newznzb.beta	1366
alt.binaries.newznzb.mike	1361
alt.binaries.newznzb.bravo	1341
alt.binaries.newznzb.juliet	1333
alt.binaries.newznzb.echo	1312
alt.binaries.newznzb.kilo	1306
alt.binaries.newznzb.lima	1303
alt.binaries.newznzb.novemeber	1302
alt.binaries.newznzb.foxtrot	1295
alt.binaries.newznzb.india	1289
alt.binaries.newznzb.delta	1288
alt.binaries.newznzb.alpha	1284
alt.binaries.newznzb.charlie	1279
alt.binaries.newznzb.golf	1261
alt.binaries.jerry	641
alt.binaries.inner-sanctum	535
alt.binaries.flowed	268
alt.binaries.moovee	206
alt.binaries.e-book.magazines	200

TOTAL: 101	23987

INND misc events:

Events	Count

CCreader	2

TOTAL: 1	2

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	192.168.33.37	217
	TOTAL: 1	217

TOTAL: 1		217

Rnews connections rejected:

Reason	Conn

400 No space (spool) [innwatch:36] 2824 lt 8000	238
400 No space (spool) [innwatch:36] 5844 lt 8000	14
400 No space (spool) [innwatch:36] 5276 lt 8000	6

TOTAL: 3	258

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:24
2	balancer-a.rol.ru	2880	0	0.0 KB	0	0	0	00:05:54

TOTAL: 2		5760	0	0.0 KB	0	0	0	00:12:21

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:12:18

TOTAL: 1		5760	0	0.0 KB	0	0	0	00:12:18

NNRP total resource statistics [Top 20]:

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

balancer-b.rol.ru	3.969	4.228	0.000	00:06:24
balancer-a.rol.ru	4.064	4.311	0.000	00:05:54
net1-x-ring.tony.pp.ru	0.177	0.275	0.000	00:00:02
107.170.196.137	0.003	0.000	0.000	00:00:00

TOTAL: 4	8.213	8.814	0.000	00:12:21

NNRP no permission clients:

System	Conn

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

TOTAL: 2	147