Daily Usenet report: Jan 25 04:15:02

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	21086	85.5%	2.7 MB	83.6%
innd	2261	9.2%	338.8 KB	10.3%
innfeed	1315	5.3%	197.1 KB	6.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 4	24663	100.0%	3.2 MB	100.0%

History cache:

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.031	0.0%	114	0.000	0.272	1.000
article cleanup	00:00:00.102	0.0%	20489	0.000	0.005	0.025
article logging	00:00:00.470	0.0%	20985	0.000	0.022	0.059
article parse	00:00:00.323	0.0%	36287	0.000	0.009	0.028
article write	00:00:10.425	0.0%	19673	0.040	0.530	7.098
artlog/artcncl	00:00:00.003	0.0%	109	0.000	0.028	0.200
data move	00:00:00.066	0.0%	111665	0.000	0.001	0.006
hisgrep/artcncl	00:00:00.000	0.0%	114	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	114	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:00.389	0.0%	95950	0.000	0.004	0.015
history sync	00:00:00.012	0.0%	314	0.000	0.038	1.000
history write	00:00:04.443	0.0%	20485	0.000	0.217	4.854
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:59:30.758	99.9%	108904	442.159	793.091	2308.119
nntp read	00:00:01.251	0.0%	108732	0.002	0.012	0.026
overview write	00:00:02.729	0.0%	19673	0.014	0.139	5.068
perl filter	00:00:13.178	0.0%	20485	0.493	0.643	1.018
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:01.280	0.0%	39346	0.000	0.033	0.103
TOTAL: 24:00:22.460	24:00:05.460	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.037	0.0%	19825	0.000	0.002	0.020
article prepare	00:00:00.009	0.0%	76096	0.000	0.000	0.005
article read	00:00:00.772	0.0%	18972	0.000	0.041	0.342
backlog stats	00:00:00.108	0.0%	154079	0.000	0.001	0.004
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.934	0.0%	95842	0.001	0.010	0.026
data write	00:00:01.579	0.0%	76521	0.005	0.021	0.053
idle	23:54:22.877	100.0%	154079	307.393	558.563	1542.915
status file	00:00:07.213	0.0%	217	0.000	33.240	254.115
TOTAL: 23:54:36.531	23:54:33.529	100.0%	-	-	-	-

Control commands to INND:

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	news-out.aioe.org	5	17677	10582	7032	63	59%	24:26:49
2	feeder.eternal-september.org	3	20348	8819	10778	751	43%	24:41:26
3	news.swapon.de	10	1499	294	1204	1	19%	23:14:08
4	news.bbs.nz	1	18095	25	18060	10	0%	23:59:45
5	localhost	25	0	0	0	0	0%	00:00:00
6	i2pn2	2	0	0	0	0	0%	00:19:06
TOTAL: 6		46	57619	19720	37074	825	34%	96:41:14

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	37.2 MB	0.0 KB	3.7 MB	40.8 MB	90%	4.4 KB
2	news-out.aioe.org	29.4 MB	29.3 KB	352.3 KB	29.8 MB	98%	2.9 KB
3	news.swapon.de	738.7 KB	0.0 KB	4.5 KB	743.2 KB	99%	2.5 KB
4	news.bbs.nz	347.3 KB	0.0 KB	163.8 KB	511.1 KB	67%	14.6 KB
5	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
6	i2pn2	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 6		67.6 MB	29.3 KB	4.2 MB	71.8 MB	94%	3.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 25 04:15:02 - 04:59:59	253	1.3%	0.09	1.5 MB	2.3%	0.57
Jan 25 05:00:00 - 05:59:59	330	1.7%	0.09	1.3 MB	1.9%	0.36
Jan 25 06:00:00 - 06:59:59	462	2.3%	0.13	1.8 MB	2.7%	0.51
Jan 25 07:00:00 - 07:59:59	586	3.0%	0.16	1.8 MB	2.6%	0.50
Jan 25 08:00:00 - 08:59:59	827	4.2%	0.23	2.3 MB	3.4%	0.65
Jan 25 09:00:00 - 09:59:59	834	4.2%	0.23	2.4 MB	3.6%	0.68
Jan 25 10:00:00 - 10:59:59	1021	5.2%	0.28	3.3 MB	4.9%	0.93
Jan 25 11:00:00 - 11:59:59	1014	5.2%	0.28	2.7 MB	4.0%	0.76
Jan 25 12:00:00 - 12:59:59	854	4.3%	0.24	2.2 MB	3.4%	0.64
Jan 25 13:00:00 - 13:59:59	918	4.7%	0.26	2.4 MB	3.6%	0.68
Jan 25 14:00:00 - 14:59:59	1027	5.2%	0.29	4.2 MB	6.2%	1.19
Jan 25 15:00:00 - 15:59:59	1145	5.8%	0.32	3.2 MB	4.7%	0.90
Jan 25 16:00:00 - 16:59:59	1216	6.2%	0.34	4.2 MB	6.3%	1.20
Jan 25 17:00:00 - 17:59:59	1157	5.9%	0.32	4.9 MB	7.3%	1.40
Jan 25 18:00:00 - 18:59:59	1129	5.7%	0.31	3.3 MB	5.0%	0.95
Jan 25 19:00:00 - 19:59:59	1070	5.4%	0.30	3.7 MB	5.6%	1.06
Jan 25 20:00:00 - 20:59:59	1073	5.5%	0.30	3.7 MB	5.6%	1.06
Jan 25 21:00:00 - 21:59:59	1018	5.2%	0.28	4.1 MB	6.1%	1.17
Jan 25 22:00:00 - 22:59:59	903	4.6%	0.25	4.0 MB	5.9%	1.13
Jan 25 23:00:00 - 23:59:59	804	4.1%	0.22	2.4 MB	3.5%	0.67
Jan 26 00:00:00 - 00:59:59	591	3.0%	0.16	2.0 MB	3.0%	0.57
Jan 26 01:00:00 - 01:59:59	492	2.5%	0.14	2.0 MB	3.0%	0.57
Jan 26 02:00:00 - 02:59:59	435	2.2%	0.12	1.7 MB	2.5%	0.47
Jan 26 03:00:00 - 03:59:59	422	2.1%	0.12	1.7 MB	2.6%	0.50
Jan 26 04:00:00 - 04:15:01	82	0.4%	0.09	280.6 KB	0.4%	0.31
TOTAL: 23:59:59	19663	100.0%	0.23	66.9 MB	100.0%	0.79

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	feeder.eternal-september.org	754	8	0	746
2	news-out.aioe.org	436	1	4	431
3	news.swapon.de	121	0	0	121
4	news.bbs.nz	3	1	0	2
TOTAL: 4		1314	10	4	1300

Unwanted newsgroups [Top 20]:

Newsgroup	Count
spline.fli4l.opt	7
alt.business.international	1
macromedia.general.latinamerica	1
aioe.helpdesk	1
TOTAL: 4	10

INND Perl filter [Top 20]:

INND no permission servers:

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news-out.aioe.org	374
	news.swapon.de	120
	feeder.eternal-september.org	3
	TOTAL: 3	497
TOTAL: 1		497

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn2	19006	18778	0	226	0	98%	23:59:51
2	aioe	8529	19	8342	4	0	0%	23:59:43
3	news.bbs.nz	37270	17	19615	6	194	0%	23:59:51
4	eternal-september	10878	6	10813	0	0	0%	23:59:55
5	swapon.de	1318	0	1314	0	0	0%	23:01:26
TOTAL: 5		77001	18820	40084	236	194	24%	119:00:46

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	i2pn2	50.8 MB	884.2 KB	51.6 MB	0.6 KB/s	2.8 KB	23:59:51
2	news.bbs.nz	48.5 KB	57.5 KB	106.0 KB	0.0 KB/s	4.6 KB	23:59:51
3	aioe	47.5 KB	14.6 KB	62.1 KB	0.0 KB/s	2.7 KB	23:59:43
4	eternal-september	31.6 KB	0.0 KB	31.6 KB	0.0 KB/s	5.3 KB	23:59:55
5	swapon.de	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:01:26
TOTAL: 5		50.9 MB	956.3 KB	51.8 MB	0.1 KB/s	2.8 KB	119:00:46

Daily Usenet report