Daily Usenet report: May 30 15:00:07

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

May 30 15:03:31 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	15109	78.6%	1.8 MB	75.8%
innd	2297	12.0%	327.0 KB	13.4%
innfeed	1238	6.4%	175.8 KB	7.2%
cnfsstat	576	3.0%	86.3 KB	3.5%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	19221	100.0%	2.4 MB	100.0%

History cache:

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:02.693	0.0%	33	0.000	81.606	750.000
article cleanup	00:00:00.117	0.0%	14722	0.000	0.008	0.056
article logging	00:00:00.466	0.0%	15074	0.000	0.031	0.118
article parse	00:00:00.261	0.0%	25313	0.000	0.010	0.040
article write	00:00:02.700	0.0%	13859	0.000	0.195	4.831
artlog/artcncl	00:00:00.000	0.0%	33	0.000	0.000	0.000
data move	00:00:00.208	0.0%	103309	0.000	0.002	0.013
hisgrep/artcncl	00:00:00.002	0.0%	32	0.000	0.062	1.000
hishave/artcncl	00:00:01.165	0.0%	33	0.000	35.303	494.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:12:16.697	0.9%	98752	0.002	7.460	56.314
history sync	00:00:02.284	0.0%	356	0.000	6.416	754.333
history write	00:00:06.267	0.0%	14719	0.000	0.426	14.193
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
idle	23:47:17.485	99.1%	100035	443.501	856.075	2349.937
nntp read	00:00:00.712	0.0%	103219	0.000	0.007	0.017
overview write	00:00:00.063	0.0%	13859	0.000	0.005	0.025
perl filter	00:00:30.002	0.0%	14719	0.864	2.038	22.289
python filter	00:00:00.450	0.0%	14719	0.000	0.031	0.098
site send	00:00:02.535	0.0%	41576	0.024	0.061	0.098
TOTAL: 24:00:52.735	24:00:24.107	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.031	0.0%	13912	0.000	0.002	0.019
article prepare	00:00:00.000	0.0%	446	0.000	0.000	0.000
article read	00:00:00.364	0.0%	401	0.000	0.908	110.667
backlog stats	00:00:00.053	0.0%	63505	0.000	0.001	0.008
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.335	0.0%	42251	0.000	0.008	0.030
data write	00:00:00.795	0.0%	28777	0.000	0.028	0.058
idle	23:59:23.779	100.0%	63505	712.272	1359.952	3353.668
status file	00:00:05.575	0.0%	258	0.000	21.609	693.000
TOTAL: 23:59:34.522	23:59:30.932	100.0%	-	-	-	-

Control commands to INND:

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	hasname-out.news.weretis.net	6	26370	8113	18002	255	30%	49:14:03
2	news-out.aioe.org	5	11076	3710	7332	34	33%	23:32:05
3	news.nntp4.net	3	13683	1680	11500	503	12%	23:14:36
4	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 4		15	51129	13503	36834	792	26%	96:00:44

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	hasname-out.news.weretis.net	25.0 MB	0.0 KB	602.8 KB	25.6 MB	97%	3.1 KB
2	news-out.aioe.org	10.0 MB	2.9 KB	39.4 KB	10.1 MB	99%	2.8 KB
3	news.nntp4.net	4.4 MB	1.5 KB	1.2 MB	5.6 MB	78%	2.6 KB
4	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 4		39.4 MB	4.3 KB	1.8 MB	41.2 MB	95%	3.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 30 15:00:07 - 15:59:59	618	4.5%	0.17	1.4 MB	3.5%	0.40
May 30 16:00:00 - 16:59:59	738	5.3%	0.20	2.0 MB	4.9%	0.56
May 30 17:00:00 - 17:59:59	836	6.0%	0.23	2.4 MB	6.0%	0.68
May 30 18:00:00 - 18:59:59	780	5.6%	0.22	2.3 MB	5.6%	0.65
May 30 19:00:00 - 19:59:59	765	5.5%	0.21	2.2 MB	5.4%	0.62
May 30 20:00:00 - 20:59:59	792	5.7%	0.22	2.2 MB	5.3%	0.61
May 30 21:00:00 - 21:59:59	616	4.4%	0.17	1.7 MB	4.1%	0.47
May 30 22:00:00 - 22:59:59	586	4.2%	0.16	2.2 MB	5.5%	0.63
May 30 23:00:00 - 23:59:59	460	3.3%	0.13	1.5 MB	3.8%	0.43
May 31 00:00:00 - 00:59:59	347	2.5%	0.10	1.6 MB	4.0%	0.46
May 31 01:00:00 - 01:59:59	273	2.0%	0.08	1.3 MB	3.3%	0.37
May 31 02:00:00 - 02:59:59	328	2.4%	0.09	1.1 MB	2.6%	0.30
May 31 03:00:00 - 03:59:59	287	2.1%	0.08	1.3 MB	3.3%	0.37
May 31 04:00:00 - 04:59:59	352	2.5%	0.10	1.2 MB	2.9%	0.34
May 31 05:00:00 - 05:59:59	431	3.1%	0.12	1.2 MB	3.0%	0.35
May 31 06:00:00 - 06:59:59	357	2.6%	0.10	1.1 MB	2.6%	0.30
May 31 07:00:00 - 07:59:59	544	3.9%	0.15	1.6 MB	3.9%	0.45
May 31 08:00:00 - 08:59:59	533	3.8%	0.15	1.4 MB	3.4%	0.40
May 31 09:00:00 - 09:59:59	716	5.2%	0.20	1.9 MB	4.7%	0.54
May 31 10:00:00 - 10:59:59	674	4.9%	0.19	1.5 MB	3.7%	0.43
May 31 11:00:00 - 11:59:59	666	4.8%	0.18	1.9 MB	4.6%	0.53
May 31 12:00:00 - 12:59:59	681	4.9%	0.19	1.7 MB	4.3%	0.50
May 31 13:00:00 - 13:59:59	671	4.8%	0.19	1.6 MB	3.9%	0.45
May 31 14:00:00 - 14:59:59	795	5.7%	0.22	2.2 MB	5.5%	0.63
May 31 15:00:00 - 15:00:09	9	0.1%	1.00	33.0 KB	0.1%	3.67
TOTAL: 24:00:02	13855	100.0%	0.16	40.4 MB	100.0%	0.48

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days
FOUR	DEFAULT	1024.0 MB	191.3 MB	18.7%	1	0.20	59.40
ONE	DEFAULT	1024.0 MB	351.1 MB	34.3%	3	0.20	59.72
THREE	DEFAULT	1024.0 MB	195.9 MB	19.1%	1	0.21	58.07
TWO	DEFAULT	1024.0 MB	193.3 MB	18.9%	1	0.20	59.40
TOTAL: 4	-	4.0 GB	931.6 MB	22.7%	6	0.21	-

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nntp4.net	583	17	1	1	564
2	hasname-out.news.weretis.net	501	0	0	0	501
3	news-out.aioe.org	137	0	2	0	135
TOTAL: 3		1221	17	3	1	1200

Unwanted newsgroups [Top 20]:

Supposedly-moderated groups with unmoderated postings [Top 20]:

Groups	Count
bit.listserv.catholic	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Miscellaneous innd statistics [Top 10]:

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	bbsgslincom	386	386	0	0	0	100%	18:34:44
2	aioe	9875	6	9592	1	38	0%	23:52:47
3	weretis	5748	0	5511	8	0	0%	23:55:25
4	nntp4	12210	0	11987	0	35	0%	23:54:10
TOTAL: 4		28219	392	27090	9	73	1%	90:17:06

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	bbsgslincom	1.8 MB	0.0 KB	1.8 MB	4.7 KB	18:34:44
2	aioe	17.7 KB	1.3 KB	19.0 KB	2.7 KB	23:52:47
3	weretis	0.0 KB	34.6 KB	34.6 KB	4.3 KB	23:55:25
4	nntp4	0.0 KB	0.0 KB	0.0 KB	0	23:54:10
TOTAL: 4		1.8 MB	35.9 KB	1.8 MB	4.6 KB	90:17:06

Daily Usenet report