Daily Usenet report: Oct 12 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	13802	48.7%	4.1 MB	65.5%
innd	10710	37.8%	1.5 MB	23.5%
innfeed	3814	13.5%	697.8 KB	11.0%
nocem	3	0.0%	0.2 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	28330	100.0%	6.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	136512	41.3%
Cache misses	98560	29.8%
Negative hits	81764	24.8%
Do not exist	13466	4.1%
TOTAL: 4	330302	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.025	0.0%	40	0.000	0.625	2.000
article cleanup	00:00:00.097	0.0%	13493	0.000	0.007	0.067
article logging	00:00:00.475	0.0%	13767	0.000	0.035	0.111
article parse	00:00:00.216	0.0%	23588	0.000	0.009	0.033
article write	00:00:05.967	0.0%	12262	0.031	0.487	17.103
artlog/artcncl	00:00:00.001	0.0%	40	0.000	0.025	0.125
artlog/artparse	00:00:00.000	0.0%	2	0.000	0.000	0.000
data move	00:00:00.099	0.0%	253406	0.000	0.000	0.003
hisgrep/artcncl	00:00:00.001	0.0%	40	0.000	0.025	1.000
hishave/artcncl	00:00:00.000	0.0%	40	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:01.026	0.0%	330581	0.000	0.003	0.008
history sync	00:00:00.009	0.0%	306	0.000	0.029	0.500
history write	00:00:00.812	0.0%	13490	0.000	0.060	2.905
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:58:49.448	99.9%	255084	65.581	338.435	1089.069
nntp read	00:00:02.402	0.0%	254628	0.002	0.009	0.017
overview write	00:00:01.287	0.0%	12262	0.000	0.105	2.793
perl filter	00:00:26.946	0.0%	13488	1.256	1.998	5.389
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:01.358	0.0%	24583	0.000	0.055	0.173
TOTAL: 24:00:23.910	23:59:30.169	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.026	0.0%	21259	0.000	0.001	0.024
article prepare	00:00:00.009	0.0%	193848	0.000	0.000	0.001
article read	00:00:00.581	0.0%	12128	0.000	0.048	0.482
backlog stats	00:00:00.550	0.0%	379604	0.000	0.001	0.004
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.499	0.0%	255623	0.003	0.010	0.017
data write	00:00:02.243	0.0%	244257	0.004	0.009	0.017
idle	23:56:11.890	100.0%	379604	89.687	227.005	867.892
status file	00:00:00.991	0.0%	318	0.000	3.116	48.875
TOTAL: 23:56:31.510	23:56:18.789	100.0%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	5
flushlogs	2
go	2
logmode	2
mode	149
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	171

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	usenet.blueworldhosting.com	4	12299	3260	8539	500	26%	21:43:20
2	news-out.aioe.org	3	9820	3251	6504	65	33%	24:08:27
3	feeder.eternal-september.org	16	7102	2189	4642	271	30%	28:04:40
4	i2pn-out.news.weretis.net	3	25575	1980	23480	115	7%	56:18:51
5	news.nntp4.net	6	108625	359	108243	23	0%	19:21:07
6	paganini.bofh.team	2	14204	356	13836	12	2%	30:56:15
7	news.swapon.de	7	1100	257	840	3	23%	23:09:18
8	usenet.goja.nl.eu.org	11	11642	191	11283	168	1%	23:39:32
9	207.223.241.25	0	311	156	152	3	50%	02:14:01
10	news-out.neodome.net	2	10974	153	10816	5	1%	23:59:20
11	nntp.alphanet.ch	25	8018	81	7935	2	1%	23:54:27
12	news.niel.me	1	2686	64	2615	7	2%	23:59:56
13	i2pn-out.feed.uzoreto.com	1649	13879	61	13749	69	0%	71:14:12
14	i2pn2.org	25	51	51	0	0	100%	05:33:46
15	dodin.fr.nf	22	588	19	569	0	3%	19:34:00
16	news.samoylyk.net	2	11015	12	11003	0	0%	23:59:50
17	news.bbs.nz	3	9572	3	9569	0	0%	25:38:59
18	retrobbs.ddns.net	2	2	2	0	0	100%	00:25:01
19	news.furie.org.uk	2	5796	1	5795	0	0%	23:59:51
20	kf5zxw.com	1	0	0	0	0	0%	00:10:01
21	localhost	25	0	0	0	0	0%	00:00:00
22	novabbs.org	24	50	0	50	0	0%	05:24:43
TOTAL: 22		1835	253309	12446	239620	1243	4%	477:29:37

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn-out.news.weretis.net	18.4 MB	0.0 KB	466.5 KB	18.9 MB	97%	9.2 KB
2	usenet.blueworldhosting.com	12.2 MB	3.2 KB	1.5 MB	13.7 MB	89%	3.7 KB
3	feeder.eternal-september.org	7.9 MB	0.0 KB	1.6 MB	9.5 MB	82%	4.0 KB
4	news-out.aioe.org	7.4 MB	13.3 KB	189.8 KB	7.6 MB	97%	2.3 KB
5	news.nntp4.net	1.2 MB	0.0 KB	373.0 KB	1.5 MB	75%	4.1 KB
6	paganini.bofh.team	1.0 MB	0.0 KB	39.5 KB	1.1 MB	96%	3.0 KB
7	news.swapon.de	770.5 KB	0.0 KB	2.0 KB	772.5 KB	99%	3.0 KB
8	news-out.neodome.net	679.4 KB	0.0 KB	19.3 KB	698.7 KB	97%	4.4 KB
9	usenet.goja.nl.eu.org	556.7 KB	0.0 KB	576.0 KB	1.1 MB	49%	3.2 KB
10	207.223.241.25	472.6 KB	0.0 KB	7.2 KB	479.8 KB	98%	3.0 KB
11	i2pn2.org	281.2 KB	0.0 KB	0.0 KB	281.2 KB	100%	5.5 KB
12	nntp.alphanet.ch	248.7 KB	0.0 KB	78.3 KB	327.1 KB	76%	3.9 KB
13	news.niel.me	231.2 KB	0.0 KB	22.1 KB	253.3 KB	91%	3.6 KB
14	i2pn-out.feed.uzoreto.com	125.0 KB	0.0 KB	296.3 KB	421.3 KB	29%	3.2 KB
15	dodin.fr.nf	32.8 KB	0.0 KB	0.0 KB	32.8 KB	100%	1.7 KB
16	news.samoylyk.net	23.9 KB	0.0 KB	0.0 KB	23.9 KB	100%	2.0 KB
17	news.bbs.nz	5.4 KB	0.0 KB	0.0 KB	5.4 KB	100%	1.8 KB
18	news.furie.org.uk	3.8 KB	0.0 KB	0.0 KB	3.8 KB	100%	3.8 KB
19	retrobbs.ddns.net	1.7 KB	0.0 KB	0.0 KB	1.7 KB	100%	0.9 KB
20	kf5zxw.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
21	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
22	novabbs.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 22		51.4 MB	16.5 KB	5.1 MB	56.5 MB	90%	4.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 12 04:15:01 - 04:59:59	199	1.6%	0.07	883.7 KB	1.8%	0.33
Oct 12 05:00:00 - 05:59:59	316	2.6%	0.09	1.2 MB	2.4%	0.34
Oct 12 06:00:00 - 06:59:59	318	2.6%	0.09	903.6 KB	1.8%	0.25
Oct 12 07:00:00 - 07:59:59	543	4.4%	0.15	2.4 MB	4.9%	0.68
Oct 12 08:00:00 - 08:59:59	560	4.6%	0.16	2.2 MB	4.5%	0.62
Oct 12 09:00:00 - 09:59:59	579	4.7%	0.16	1.6 MB	3.2%	0.45
Oct 12 10:00:00 - 10:59:59	599	4.9%	0.17	1.5 MB	3.0%	0.41
Oct 12 11:00:00 - 11:59:59	527	4.3%	0.15	1.6 MB	3.2%	0.44
Oct 12 12:00:00 - 12:59:59	628	5.1%	0.17	2.8 MB	5.7%	0.79
Oct 12 13:00:00 - 13:59:59	625	5.1%	0.17	2.1 MB	4.4%	0.61
Oct 12 14:00:00 - 14:59:59	724	5.9%	0.20	1.9 MB	4.0%	0.55
Oct 12 15:00:00 - 15:59:59	756	6.2%	0.21	4.0 MB	8.2%	1.14
Oct 12 16:00:00 - 16:59:59	749	6.1%	0.21	3.3 MB	6.8%	0.95
Oct 12 17:00:00 - 17:59:59	666	5.4%	0.18	2.3 MB	4.7%	0.65
Oct 12 18:00:00 - 18:59:59	580	4.7%	0.16	2.4 MB	5.0%	0.69
Oct 12 19:00:00 - 19:59:59	626	5.1%	0.17	1.7 MB	3.5%	0.49
Oct 12 20:00:00 - 20:59:59	591	4.8%	0.16	2.7 MB	5.5%	0.77
Oct 12 21:00:00 - 21:59:59	654	5.3%	0.18	3.2 MB	6.5%	0.90
Oct 12 22:00:00 - 22:59:59	525	4.3%	0.15	3.1 MB	6.3%	0.88
Oct 12 23:00:00 - 23:59:59	328	2.7%	0.09	1.4 MB	2.9%	0.41
Oct 13 00:00:00 - 00:59:59	280	2.3%	0.08	1.3 MB	2.7%	0.38
Oct 13 01:00:00 - 01:59:59	347	2.8%	0.10	1.7 MB	3.5%	0.49
Oct 13 02:00:00 - 02:59:59	247	2.0%	0.07	924.6 KB	1.8%	0.26
Oct 13 03:00:00 - 03:59:59	203	1.7%	0.06	814.8 KB	1.6%	0.23
Oct 13 04:00:00 - 04:15:01	87	0.7%	0.10	1.0 MB	2.1%	1.17
TOTAL: 24:00:00	12257	100.0%	0.14	48.8 MB	100.0%	0.58

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	usenet.blueworldhosting.com	507	19	1	487
2	feeder.eternal-september.org	290	7	0	283
3	usenet.goja.nl.eu.org	187	0	0	187
4	i2pn-out.news.weretis.net	154	11	0	143
5	news.swapon.de	131	0	0	131
6	news-out.aioe.org	92	8	4	80
7	i2pn-out.feed.uzoreto.com	69	2	0	67
8	news.nntp4.net	27	3	0	24
9	news-out.neodome.net	23	0	0	23
10	paganini.bofh.team	15	1	0	14
11	news.niel.me	8	0	0	8
12	nntp.alphanet.ch	2	0	0	2
13	news.samoylyk.net	1	0	0	1
TOTAL: 13		1506	51	5	1450

Unwanted newsgroups [Top 20]:

Newsgroup	Count
wolfsburg.test	15
att.jobs	10
aus.jobs	8
sybase.public.powerdesigner.general	5
alt.info-science	2
gun.general	2
alt.va.personals	2
alt.test.abc	1
soc.culture.mexico	1
alt.biz.misc	1
mailing.freebsd.questions	1
a.b.e-book.flood	1
alt.math	1
a.business.internet	1
TOTAL: 14	51

INND Perl filter [Top 20]:

Reason	Count
Too many newsgroups	424
EMP (md5)	402
Poison newsgroup	281
User-issued cancel	28
Scoring filter (8)	10
Too many newsgroups (meow)	10
HTML Multipart	7
Scoring filter (11)	5
Scoring filter (9)	3
HTML post	2
HTML Image Tags	1
Scoring filter (12)	1
TOTAL: 12	1174

INND no permission servers:

System	Conn
192.46.210.172	27
157.230.85.0	8
207.223.241.25	3
167.248.133.45	1
192.241.204.36	1
TOTAL: 5	40

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news.swapon.de	128
	i2pn-out.news.weretis.net	72
	news-out.aioe.org	31
	news-out.neodome.net	17
	usenet.blueworldhosting.com	12
	paganini.bofh.team	5
	feeder.eternal-september.org	4
	usenet.goja.nl.eu.org	3
	news.samoylyk.net	1
	news.nntp4.net	1
	TOTAL: 10	274
No colon-space in header
	i2pn-out.feed.uzoreto.com	2
	TOTAL: 1	2
TOTAL: 2		276

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	retrobbs.ddns.net	12030	11742	1	283	1	97%	24:01:28
2	novabbs	12183	11481	107	494	1	94%	24:09:39
3	i2pn2	12200	11445	164	419	1	93%	24:09:11
4	aioe	9173	1983	6369	118	0	21%	24:09:26
5	news.bbs.nz	22583	1578	10359	378	33	6%	24:09:07
6	paganini.bofh.team	13701	1330	10629	0	1	9%	24:01:50
7	usenet.goja.nl.eu.org	13324	1280	10613	29	21	9%	24:04:21
8	neodome	13745	1196	10825	0	1	8%	24:08:40
9	nntp.alphanet.ch	13269	1182	10594	274	1	8%	24:02:14
10	news.nntp4.net	22575	993	19605	22	58	4%	24:08:51
11	news.niel.me	4181	856	2700	162	0	20%	24:05:25
12	news.furie.org.uk	8796	474	5720	52	0	5%	24:09:38
13	news.uzoreto.com	14400	254	10919	0	1	1%	24:09:28
14	dodin.fr.nf	787	86	573	0	0	10%	20:38:24
15	usenet.blueworldhosting.com	13439	75	8654	0	197	0%	24:09:39
16	weretis.net	15199	62	9781	341	6	0%	24:00:45
17	eternal-september	13453	55	9982	13	1	0%	24:00:13
18	news.samoylyk.net	15417	48	12089	33	1	0%	24:09:33
19	swapon.de	1171	1	949	0	0	0%	23:48:16
20	kf5zxw.com	0	0	0	0	12305	0%	24:05:21
TOTAL: 20		231626	46121	140633	2618	12629	19%	478:21:29

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	retrobbs.ddns.net	47.2 MB	867.1 KB	48.1 MB	0.6 KB/s	4.1 KB	24:01:28
2	novabbs	44.7 MB	3.1 MB	47.9 MB	0.6 KB/s	4.1 KB	24:09:39
3	i2pn2	44.4 MB	2.9 MB	47.3 MB	0.6 KB/s	4.1 KB	24:09:11
4	aioe	6.9 MB	372.2 KB	7.3 MB	0.1 KB/s	3.5 KB	24:09:26
5	news.bbs.nz	5.8 MB	2.6 MB	8.4 MB	0.1 KB/s	4.4 KB	24:09:07
6	nntp.alphanet.ch	4.3 MB	1.2 MB	5.5 MB	0.1 KB/s	3.8 KB	24:02:14
7	paganini.bofh.team	4.2 MB	0.0 KB	4.2 MB	0.0 KB/s	3.2 KB	24:01:50
8	neodome	4.0 MB	0.0 KB	4.0 MB	0.0 KB/s	3.4 KB	24:08:40
9	usenet.goja.nl.eu.org	3.9 MB	271.6 KB	4.2 MB	0.0 KB/s	3.3 KB	24:04:21
10	news.nntp4.net	3.1 MB	205.0 KB	3.3 MB	0.0 KB/s	3.3 KB	24:08:51
11	news.niel.me	2.8 MB	398.7 KB	3.2 MB	0.0 KB/s	3.2 KB	24:05:25
12	news.furie.org.uk	2.0 MB	195.0 KB	2.1 MB	0.0 KB/s	4.2 KB	24:09:38
13	news.uzoreto.com	851.4 KB	0.0 KB	851.4 KB	0.0 KB/s	3.4 KB	24:09:28
14	dodin.fr.nf	412.6 KB	0.0 KB	412.6 KB	0.0 KB/s	4.8 KB	20:38:24
15	usenet.blueworldhosting.com	329.7 KB	0.0 KB	329.7 KB	0.0 KB/s	4.4 KB	24:09:39
16	weretis.net	178.6 KB	774.3 KB	952.9 KB	0.0 KB/s	2.4 KB	24:00:45
17	eternal-september	150.7 KB	655.4 KB	806.1 KB	0.0 KB/s	11.9 KB	24:00:13
18	news.samoylyk.net	115.5 KB	251.2 KB	366.8 KB	0.0 KB/s	4.5 KB	24:09:33
19	swapon.de	26.5 KB	0.0 KB	26.5 KB	0.0 KB/s	26.5 KB	23:48:16
20	kf5zxw.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:05:21
TOTAL: 20		175.2 MB	13.8 MB	189.0 MB	0.1 KB/s	4.0 KB	478:21:29

Daily Usenet report

Oct 12 04:15:01 -- Oct 13 04:15:01