Daily Usenet report: Oct 24 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	14192	49.4%	4.2 MB	66.2%
innd	10670	37.2%	1.5 MB	23.4%
innfeed	3848	13.4%	673.8 KB	10.3%
controlchan	1	0.0%	0.2 KB	0.0%
nocem	1	0.0%	0.2 KB	0.0%
TOTAL: 5	28712	100.0%	6.4 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	146646	58.8%
Negative hits	84580	33.9%
Do not exist	13926	5.6%
Cache misses	4354	1.7%
TOTAL: 4	249506	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.014	0.0%	32	0.000	0.438	1.222
article cleanup	00:00:00.085	0.0%	13944	0.000	0.006	0.031
article logging	00:00:00.454	0.0%	14169	0.000	0.032	0.121
article parse	00:00:00.235	0.0%	23485	0.000	0.010	0.042
article write	00:00:04.834	0.0%	12814	0.067	0.377	7.803
artlog/artcncl	00:00:00.000	0.0%	32	0.000	0.000	0.000
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:00:00.092	0.0%	254356	0.000	0.000	0.003
hisgrep/artcncl	00:00:00.001	0.0%	31	0.000	0.032	0.111
hishave/artcncl	00:00:00.000	0.0%	32	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.971	0.0%	249894	0.000	0.004	0.011
history sync	00:00:00.019	0.0%	392	0.000	0.048	1.000
history write	00:00:01.724	0.0%	13945	0.000	0.124	4.011
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
idle	23:59:35.450	99.9%	256161	200.184	337.192	1133.126
nntp read	00:00:02.440	0.0%	255910	0.002	0.010	0.017
overview write	00:00:01.997	0.0%	12814	0.000	0.156	2.779
perl filter	00:00:27.155	0.0%	13898	1.215	1.954	6.125
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:01.365	0.0%	25696	0.000	0.053	0.148
TOTAL: 24:01:06.071	24:00:16.836	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.040	0.0%	13095	0.000	0.003	0.034
article prepare	00:00:00.021	0.0%	180534	0.000	0.000	0.003
article read	00:00:00.706	0.0%	12749	0.000	0.055	1.425
backlog stats	00:00:00.709	0.0%	409043	0.000	0.002	0.004
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.683	0.0%	269765	0.004	0.010	0.017
data write	00:00:02.337	0.0%	258611	0.002	0.009	0.017
idle	23:55:35.765	100.0%	409043	117.830	210.579	735.882
status file	00:00:00.580	0.0%	360	0.000	1.611	10.750
TOTAL: 23:55:56.627	23:55:42.841	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	news-out.aioe.org	2	9588	4761	4778	49	49%	24:08:56
2	usenet.blueworldhosting.com	5	12743	2971	9481	291	23%	22:01:38
3	i2pn-out.news.weretis.net	7	25375	2101	23228	46	8%	55:11:30
4	feeder.eternal-september.org	15	5833	1246	4270	317	21%	26:34:43
5	news.nntp4.net	2	12181	550	11612	19	4%	23:59:53
6	paganini.bofh.team	1	15558	307	15239	12	1%	29:20:44
7	news.swapon.de	9	1116	250	865	1	22%	22:42:25
8	usenet.goja.nl.eu.org	12	12870	229	12452	189	1%	24:29:59
9	news-out.neodome.net	2	11284	157	11116	11	1%	23:59:52
10	i2pn2.org	26	4423	72	4351	0	1%	20:07:23
11	i2pn-out.feed.uzoreto.com	1647	14557	69	14391	97	0%	71:12:27
12	nntp.alphanet.ch	23	6828	58	6770	0	0%	24:43:32
13	news.niel.me	1	2725	43	2677	5	1%	23:59:57
14	news.samoylyk.net	2	11121	14	11104	3	0%	23:56:07
15	dodin.fr.nf	22	551	7	544	0	1%	19:50:33
16	novabbs.org	6	23700	4	23599	97	0%	28:47:22
17	news.furie.org.uk	2	5308	2	5306	0	0%	23:59:46
18	news.bbs.nz	3	7792	1	7791	0	0%	24:18:43
19	retrobbs.ddns.net	1	0	0	0	0	0%	00:10:00
20	kf5zxw.com	1	0	0	0	0	0%	00:10:00
21	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 21		1814	183553	12842	169574	1137	6%	513:45:30

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn-out.news.weretis.net	17.2 MB	258.0 KB	17.5 MB	98%	8.3 KB
2	news-out.aioe.org	11.1 MB	118.8 KB	11.2 MB	98%	2.4 KB
3	usenet.blueworldhosting.com	10.4 MB	777.1 KB	11.1 MB	93%	3.5 KB
4	feeder.eternal-september.org	4.3 MB	1.7 MB	6.1 MB	71%	4.0 KB
5	news.nntp4.net	1.8 MB	64.0 KB	1.8 MB	96%	3.3 KB
6	paganini.bofh.team	1.1 MB	42.1 KB	1.1 MB	96%	3.6 KB
7	news.swapon.de	720.1 KB	0.7 KB	720.8 KB	99%	2.9 KB
8	usenet.goja.nl.eu.org	631.4 KB	604.0 KB	1.2 MB	51%	3.0 KB
9	news-out.neodome.net	603.8 KB	39.5 KB	643.3 KB	93%	3.8 KB
10	news.niel.me	475.1 KB	15.8 KB	490.8 KB	96%	10.2 KB
11	i2pn2.org	360.6 KB	0.0 KB	360.6 KB	100%	5.0 KB
12	nntp.alphanet.ch	299.1 KB	0.0 KB	299.1 KB	100%	5.2 KB
13	i2pn-out.feed.uzoreto.com	110.6 KB	260.3 KB	370.8 KB	29%	2.2 KB
14	news.samoylyk.net	41.7 KB	12.0 KB	53.7 KB	77%	3.2 KB
15	dodin.fr.nf	9.7 KB	0.0 KB	9.7 KB	100%	1.4 KB
16	novabbs.org	8.7 KB	629.7 KB	638.4 KB	1%	6.3 KB
17	news.furie.org.uk	6.9 KB	0.0 KB	6.9 KB	100%	3.4 KB
18	news.bbs.nz	2.0 KB	0.0 KB	2.0 KB	100%	2.0 KB
19	retrobbs.ddns.net	0.0 KB	0.0 KB	0.0 KB	0%	0
20	kf5zxw.com	0.0 KB	0.0 KB	0.0 KB	0%	0
21	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 21		49.1 MB	4.5 MB	53.6 MB	91%	3.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 24 04:15:01 - 04:59:59	164	1.3%	0.06	445.9 KB	0.9%	0.17
Oct 24 05:00:00 - 05:59:59	286	2.2%	0.08	1.0 MB	2.1%	0.29
Oct 24 06:00:00 - 06:59:59	391	3.1%	0.11	1.0 MB	2.1%	0.30
Oct 24 07:00:00 - 07:59:59	600	4.7%	0.17	2.7 MB	5.4%	0.76
Oct 24 08:00:00 - 08:59:59	585	4.6%	0.16	1.9 MB	3.9%	0.55
Oct 24 09:00:00 - 09:59:59	763	6.0%	0.21	2.6 MB	5.3%	0.74
Oct 24 10:00:00 - 10:59:59	679	5.3%	0.19	2.2 MB	4.5%	0.63
Oct 24 11:00:00 - 11:59:59	690	5.4%	0.19	2.7 MB	5.5%	0.77
Oct 24 12:00:00 - 12:59:59	701	5.5%	0.19	3.3 MB	6.7%	0.94
Oct 24 13:00:00 - 13:59:59	669	5.2%	0.19	2.4 MB	4.8%	0.67
Oct 24 14:00:00 - 14:59:59	812	6.3%	0.23	2.3 MB	4.6%	0.64
Oct 24 15:00:00 - 15:59:59	793	6.2%	0.22	2.7 MB	5.6%	0.78
Oct 24 16:00:00 - 16:59:59	755	5.9%	0.21	2.4 MB	4.9%	0.69
Oct 24 17:00:00 - 17:59:59	645	5.0%	0.18	3.1 MB	6.2%	0.87
Oct 24 18:00:00 - 18:59:59	684	5.3%	0.19	2.2 MB	4.5%	0.64
Oct 24 19:00:00 - 19:59:59	614	4.8%	0.17	3.4 MB	7.0%	0.98
Oct 24 20:00:00 - 20:59:59	687	5.4%	0.19	2.3 MB	4.7%	0.66
Oct 24 21:00:00 - 21:59:59	523	4.1%	0.15	2.5 MB	5.0%	0.70
Oct 24 22:00:00 - 22:59:59	414	3.2%	0.12	2.2 MB	4.4%	0.61
Oct 24 23:00:00 - 23:59:59	317	2.5%	0.09	1.3 MB	2.7%	0.37
Oct 25 00:00:00 - 00:59:59	264	2.1%	0.07	1.0 MB	2.1%	0.30
Oct 25 01:00:00 - 01:59:59	263	2.1%	0.07	849.7 KB	1.7%	0.24
Oct 25 02:00:00 - 02:59:59	246	1.9%	0.07	1.6 MB	3.2%	0.45
Oct 25 03:00:00 - 03:59:59	199	1.6%	0.06	909.4 KB	1.8%	0.25
Oct 25 04:00:00 - 04:15:01	66	0.5%	0.07	261.3 KB	0.5%	0.29
TOTAL: 24:00:00	12810	100.0%	0.15	49.3 MB	100.0%	0.58

Sites sending bad articles:

Server		Total	Group	TooOld	Other
1	feeder.eternal-september.org	334	0	0	334
2	usenet.blueworldhosting.com	309	35	0	274
3	usenet.goja.nl.eu.org	209	0	0	209
4	news.swapon.de	158	0	0	158
5	i2pn-out.feed.uzoreto.com	97	2	0	95
6	news-out.aioe.org	85	8	0	77
7	i2pn-out.news.weretis.net	54	4	0	50
8	novabbs.org	46	0	46	0
9	news.nntp4.net	27	0	0	27
10	news-out.neodome.net	14	0	0	14
11	paganini.bofh.team	9	0	0	9
12	news.niel.me	5	0	0	5
13	news.samoylyk.net	3	0	0	3
TOTAL: 13		1350	49	46	1255

Unwanted newsgroups [Top 20]:

Newsgroup	Count
sybase.public.powerdesigner.general	12
att.jobs	9
aus.jobs	6
alt.info-science	5
comp.windows.garnet	3
1.test	3
alt.culture	2
alt.ads	1
a.b.mp3.audiobooks	1
fr.petites-annonces.informatique.materiel	1
clari.web.local.nevada	1
alt.sex.breasts	1
clari.web.local.arkansas	1
alt.sounds.audiobooks	1
alt.business.home	1
alt.penthouse.sex.first-time	1
TOTAL: 16	49

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	602
Too many newsgroups	358
Poison newsgroup	48
Scoring filter (9)	6
User-issued cancel	5
HTML Multipart	3
Scoring filter (8)	3
Scoring filter (10)	2
Scoring filter (11)	1
MID-Bot	1
TOTAL: 10	1029

INND no permission servers:

System	Conn
143.198.39.186	40
192.241.202.246	1
TOTAL: 2	41

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news.swapon.de	157
	news-out.aioe.org	33
	i2pn-out.news.weretis.net	18
	feeder.eternal-september.org	5
	news.nntp4.net	4
	usenet.blueworldhosting.com	4
	news-out.neodome.net	3
	usenet.goja.nl.eu.org	1
	TOTAL: 8	225
No colon-space in header
	i2pn-out.feed.uzoreto.com	1
	TOTAL: 1	1
TOTAL: 2		226

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	retrobbs.ddns.net	12550	12300	0	248	0	0	98%	23:59:44
2	i2pn2	12608	11785	101	589	1	89	93%	23:59:43
3	novabbs	16490	8018	3935	591	0	11	48%	23:59:51
4	nntp.alphanet.ch	13792	1705	10300	607	0	3	12%	23:59:50
5	aioe	8053	1666	5635	101	0	0	20%	23:59:07
6	news.nntp4.net	14223	1105	11091	36	0	0	7%	23:59:51
7	paganini.bofh.team	14721	1088	11520	0	0	0	7%	23:59:51
8	neodome	14592	940	11581	0	0	0	6%	23:59:51
9	news.bbs.nz	24377	800	11698	297	0	34	3%	23:59:51
10	usenet.goja.nl.eu.org	14040	688	11432	27	0	4	4%	23:59:51
11	news.niel.me	4152	675	2811	250	0	0	16%	23:59:51
12	news.furie.org.uk	8435	442	5492	151	0	0	5%	23:59:51
13	dodin.fr.nf	1062	117	602	2	0	0	11%	21:15:54
14	news.uzoreto.com	14337	114	11085	1	0	0	0%	23:59:41
15	weretis.net	16219	94	10024	454	0	9	0%	23:59:51
16	eternal-september	13914	92	10405	18	0	1	0%	23:59:51
17	usenet.blueworldhosting.com	16142	91	9454	2	0	12	0%	23:59:51
18	news.samoylyk.net	15886	88	12542	17	0	138	0%	23:59:51
19	swapon.de	1042	1	887	0	0	0	0%	22:55:28
20	kf5zxw.com	0	0	0	0	0	12799	0%	23:57:42
TOTAL: 20		236635	41809	140595	3391	1	13100	17%	476:05:21

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	retrobbs.ddns.net	47.6 MB	796.8 KB	48.4 MB	0.6 KB/s	4.0 KB	23:59:44
2	i2pn2	43.8 MB	3.9 MB	47.7 MB	0.6 KB/s	4.0 KB	23:59:43
3	novabbs	35.4 MB	2.3 MB	37.7 MB	0.4 KB/s	4.5 KB	23:59:51
4	nntp.alphanet.ch	5.5 MB	2.1 MB	7.6 MB	0.1 KB/s	3.4 KB	23:59:50
5	aioe	5.4 MB	295.7 KB	5.7 MB	0.1 KB/s	3.3 KB	23:59:07
6	paganini.bofh.team	3.6 MB	0.0 KB	3.6 MB	0.0 KB/s	3.4 KB	23:59:51
7	news.nntp4.net	3.3 MB	189.5 KB	3.5 MB	0.0 KB/s	3.2 KB	23:59:51
8	news.bbs.nz	3.2 MB	2.4 MB	5.7 MB	0.1 KB/s	5.3 KB	23:59:51
9	neodome	2.8 MB	0.0 KB	2.8 MB	0.0 KB/s	3.1 KB	23:59:51
10	usenet.goja.nl.eu.org	2.3 MB	248.7 KB	2.5 MB	0.0 KB/s	3.6 KB	23:59:51
11	news.niel.me	2.1 MB	641.6 KB	2.7 MB	0.0 KB/s	3.0 KB	23:59:51
12	news.furie.org.uk	1.7 MB	576.9 KB	2.3 MB	0.0 KB/s	4.0 KB	23:59:51
13	dodin.fr.nf	578.3 KB	4.4 KB	582.7 KB	0.0 KB/s	4.9 KB	21:15:54
14	news.uzoreto.com	470.1 KB	1.4 KB	471.6 KB	0.0 KB/s	4.1 KB	23:59:41
15	usenet.blueworldhosting.com	387.2 KB	63.9 KB	451.2 KB	0.0 KB/s	4.9 KB	23:59:51
16	weretis.net	327.2 KB	787.5 KB	1.1 MB	0.0 KB/s	2.0 KB	23:59:51
17	eternal-september	311.4 KB	171.7 KB	483.1 KB	0.0 KB/s	4.4 KB	23:59:51
18	news.samoylyk.net	274.3 KB	155.4 KB	429.8 KB	0.0 KB/s	4.1 KB	23:59:51
19	swapon.de	1.1 KB	0.0 KB	1.1 KB	0.0 KB/s	1.1 KB	22:55:28
20	kf5zxw.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:42
TOTAL: 20		159.1 MB	14.7 MB	173.9 MB	0.1 KB/s	3.9 KB	476:05:21

Daily Usenet report

Oct 24 04:15:01 -- Oct 25 04:15:01