Daily Usenet report: Dec 12 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	12981	48.4%	3.9 MB	65.8%
innd	9989	37.2%	1.4 MB	23.0%
innfeed	3852	14.4%	683.7 KB	11.2%
controlchan	1	0.0%	0.2 KB	0.0%
nocem	1	0.0%	0.2 KB	0.0%
TOTAL: 5	26824	100.0%	6.0 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	133153	60.1%
Negative hits	75263	34.0%
Do not exist	12676	5.7%
Cache misses	357	0.2%
TOTAL: 4	221449	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.003	0.0%	32	0.000	0.094	1.000
article cleanup	00:00:00.082	0.0%	12706	0.000	0.006	0.061
article logging	00:00:00.417	0.0%	12963	0.000	0.032	0.103
article parse	00:00:00.223	0.0%	21550	0.000	0.010	0.031
article write	00:00:01.294	0.0%	11976	0.000	0.108	5.250
artlog/artcncl	00:00:00.000	0.0%	16	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.114	0.0%	224806	0.000	0.001	0.004
hisgrep/artcncl	00:00:00.001	0.0%	31	0.000	0.032	0.100
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.789	0.0%	221822	0.000	0.004	0.009
history sync	00:00:00.019	0.0%	397	0.000	0.048	1.000
history write	00:00:01.011	0.0%	12703	0.000	0.080	2.340
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
idle	23:59:51.150	99.9%	226768	191.522	380.967	1337.285
nntp read	00:00:02.011	0.0%	226060	0.002	0.009	0.019
overview write	00:00:01.295	0.0%	11976	0.000	0.108	0.843
perl filter	00:00:25.381	0.0%	12702	1.316	1.998	8.100
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:01.441	0.0%	24003	0.000	0.060	0.151
TOTAL: 24:01:06.174	24:00:25.231	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.019	0.0%	12122	0.000	0.002	0.024
article prepare	00:00:00.018	0.0%	172196	0.000	0.000	0.002
article read	00:00:00.748	0.0%	11899	0.000	0.063	1.326
backlog stats	00:00:00.582	0.0%	394115	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.411	0.0%	257083	0.004	0.009	0.015
data write	00:00:02.351	0.0%	247029	0.003	0.010	0.017
idle	23:54:15.955	100.0%	394115	109.736	218.352	659.381
status file	00:00:00.333	0.0%	362	0.000	0.920	2.333
TOTAL: 23:54:36.319	23:54:22.417	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	i2pn-out.news.weretis.net	4	29187	3235	25905	47	11%	66:48:56
2	usenet.blueworldhosting.com	5	12386	3193	8957	236	25%	25:41:41
3	news-out.aioe.org	2	8995	2468	6517	10	27%	24:08:58
4	feeder.eternal-september.org	19	6681	2199	4196	286	32%	28:33:37
5	paganini.bofh.team	2	20634	300	20327	7	1%	45:45:27
6	news.nntp4.net	1	11334	233	11095	6	2%	23:59:58
7	news.swapon.de	11	1061	151	910	0	14%	23:14:37
8	usenet.goja.nl.eu.org	11	11400	150	11175	75	1%	23:28:09
9	nntp.alphanet.ch	25	7808	115	7689	4	1%	25:41:51
10	news-out.neodome.net	1	10253	106	10114	33	1%	23:59:55
11	dodin.fr.nf	17	698	76	619	3	10%	19:30:54
12	i2pn2.org	38	264	62	202	0	23%	15:57:10
13	i2pn-out.feed.uzoreto.com	1444	12744	56	12643	45	0%	71:33:23
14	news.samoylyk.net	2	9968	26	9941	1	0%	23:59:43
15	news.niel.me	2	2501	17	2482	2	0%	23:59:40
16	news.bbs.nz	5	10137	3	10133	1	0%	27:38:40
17	novabbs.org	6	2362	1	2361	0	0%	20:55:33
18	news.furie.org.uk	2	9308	0	9308	0	0%	47:48:08
19	localhost	25	0	0	0	0	0%	00:00:00
20	kf5zxw.com	1	0	0	0	0	0%	00:10:00
21	retrobbs.ddns.net	1	0	0	0	0	0%	00:10:00
TOTAL: 21		1624	167721	12391	154574	756	7%	563:06:20

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn-out.news.weretis.net	20.4 MB	0.0 KB	239.7 KB	20.7 MB	98%	6.4 KB
2	usenet.blueworldhosting.com	11.7 MB	0.0 KB	624.7 KB	12.4 MB	95%	3.7 KB
3	feeder.eternal-september.org	6.6 MB	0.0 KB	1.2 MB	7.8 MB	85%	3.2 KB
4	news-out.aioe.org	6.1 MB	0.0 KB	37.4 KB	6.2 MB	99%	2.5 KB
5	paganini.bofh.team	1.1 MB	0.0 KB	14.9 KB	1.2 MB	98%	3.9 KB
6	news.nntp4.net	1.1 MB	0.0 KB	30.6 KB	1.2 MB	97%	5.0 KB
7	usenet.goja.nl.eu.org	560.1 KB	3.7 KB	302.9 KB	866.7 KB	64%	3.9 KB
8	news-out.neodome.net	378.9 KB	1.8 KB	849.7 KB	1.2 MB	30%	8.9 KB
9	news.swapon.de	353.3 KB	0.0 KB	0.0 KB	353.3 KB	100%	2.3 KB
10	nntp.alphanet.ch	300.8 KB	0.0 KB	11.5 KB	312.3 KB	96%	2.6 KB
11	i2pn2.org	260.6 KB	0.0 KB	0.0 KB	260.6 KB	100%	4.2 KB
12	dodin.fr.nf	134.4 KB	0.0 KB	4.5 KB	138.9 KB	96%	1.8 KB
13	i2pn-out.feed.uzoreto.com	126.5 KB	0.0 KB	149.4 KB	275.9 KB	45%	2.7 KB
14	news.samoylyk.net	97.6 KB	1.8 KB	1.8 KB	101.2 KB	96%	3.7 KB
15	news.niel.me	59.4 KB	0.0 KB	4.5 KB	63.9 KB	92%	3.4 KB
16	news.bbs.nz	5.2 KB	1.5 KB	1.5 KB	8.3 KB	62%	2.1 KB
17	novabbs.org	1.4 KB	0.0 KB	0.0 KB	1.4 KB	100%	1.4 KB
18	news.furie.org.uk	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
19	localhost	0.0 KB	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 KB	0%	0
21	retrobbs.ddns.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 21		49.4 MB	8.9 KB	3.4 MB	52.8 MB	93%	4.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 12 04:15:01 - 04:59:59	169	1.4%	0.06	1.1 MB	2.3%	0.40
Dec 12 05:00:00 - 05:59:59	249	2.1%	0.07	1.5 MB	3.3%	0.43
Dec 12 06:00:00 - 06:59:59	204	1.7%	0.06	691.2 KB	1.5%	0.19
Dec 12 07:00:00 - 07:59:59	356	3.0%	0.10	1.2 MB	2.6%	0.34
Dec 12 08:00:00 - 08:59:59	480	4.0%	0.13	1.6 MB	3.6%	0.47
Dec 12 09:00:00 - 09:59:59	537	4.5%	0.15	1.8 MB	3.9%	0.50
Dec 12 10:00:00 - 10:59:59	709	5.9%	0.20	2.3 MB	4.9%	0.64
Dec 12 11:00:00 - 11:59:59	602	5.0%	0.17	2.2 MB	4.7%	0.62
Dec 12 12:00:00 - 12:59:59	614	5.1%	0.17	2.1 MB	4.7%	0.61
Dec 12 13:00:00 - 13:59:59	617	5.2%	0.17	1.7 MB	3.7%	0.48
Dec 12 14:00:00 - 14:59:59	772	6.4%	0.21	2.7 MB	5.9%	0.77
Dec 12 15:00:00 - 15:59:59	698	5.8%	0.19	3.8 MB	8.3%	1.09
Dec 12 16:00:00 - 16:59:59	780	6.5%	0.22	2.3 MB	5.0%	0.65
Dec 12 17:00:00 - 17:59:59	710	5.9%	0.20	2.7 MB	5.8%	0.75
Dec 12 18:00:00 - 18:59:59	733	6.1%	0.20	3.4 MB	7.4%	0.96
Dec 12 19:00:00 - 19:59:59	594	5.0%	0.17	2.0 MB	4.4%	0.58
Dec 12 20:00:00 - 20:59:59	601	5.0%	0.17	1.8 MB	3.9%	0.52
Dec 12 21:00:00 - 21:59:59	557	4.7%	0.15	3.6 MB	7.8%	1.02
Dec 12 22:00:00 - 22:59:59	450	3.8%	0.12	1.5 MB	3.3%	0.44
Dec 12 23:00:00 - 23:59:59	463	3.9%	0.13	1.3 MB	2.8%	0.37
Dec 13 00:00:00 - 00:59:59	341	2.8%	0.09	1.3 MB	2.7%	0.36
Dec 13 01:00:00 - 01:59:59	255	2.1%	0.07	902.1 KB	1.9%	0.25
Dec 13 02:00:00 - 02:59:59	214	1.8%	0.06	1.9 MB	4.1%	0.53
Dec 13 03:00:00 - 03:59:59	227	1.9%	0.06	573.1 KB	1.2%	0.16
Dec 13 04:00:00 - 04:15:01	45	0.4%	0.05	145.4 KB	0.3%	0.16
TOTAL: 24:00:00	11977	100.0%	0.14	46.0 MB	100.0%	0.54

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	feeder.eternal-september.org	302	2	0	300
2	usenet.blueworldhosting.com	246	17	0	229
3	i2pn-out.news.weretis.net	183	1	0	182
4	news.swapon.de	79	0	0	79
5	usenet.goja.nl.eu.org	75	0	1	74
6	i2pn-out.feed.uzoreto.com	45	0	0	45
7	news-out.aioe.org	21	7	0	14
8	news-out.neodome.net	16	0	1	15
9	news.nntp4.net	7	0	0	7
10	paganini.bofh.team	4	0	0	4
11	nntp.alphanet.ch	4	2	0	2
12	dodin.fr.nf	3	3	0	0
13	news.niel.me	1	0	0	1
14	news.bbs.nz	1	0	1	0
15	news.samoylyk.net	1	0	1	0
TOTAL: 15		988	32	4	952

Unwanted newsgroups [Top 20]:

Newsgroup	Count
att.jobs	7
fr.misc.domotique	6
aus.jobs	6
gun.general	2
mailing.openssl.users	2
alt.meditation.quanyin	1
alt.rock-n-roll.psychedelic	1
alt.biz	1
fr.petites-annonces.informatique.materiel	1
su.market	1
trollnet.cinema	1
wolfsburg.test	1
hk.seminars	1
1.test	1
TOTAL: 14	32

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	335
Too many newsgroups	196
Poison newsgroup	130
EMP (fsl)	17
User-issued cancel	9
HTML Multipart	4
Scoring filter (8)	3
TOTAL: 7	694

INND no permission servers:

System	Conn
172.104.4.17	24
87.236.176.13	1
TOTAL: 2	25

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	i2pn-out.news.weretis.net	135
	news.swapon.de	79
	usenet.blueworldhosting.com	15
	news-out.aioe.org	11
	news-out.neodome.net	8
	feeder.eternal-september.org	8
	news.nntp4.net	1
	TOTAL: 7	257
No colon-space in header
	i2pn-out.feed.uzoreto.com	1
	TOTAL: 1	1
TOTAL: 2		258

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	retrobbs.ddns.net	11855	11338	0	510	0	95%	23:59:47
2	i2pn2	11980	11047	182	557	16	92%	23:59:51
3	novabbs	14233	8858	2444	545	1	62%	23:59:51
4	aioe	9548	2034	6840	75	0	21%	23:59:51
5	neodome	13746	1115	10608	0	0	8%	23:59:51
6	news.niel.me	3866	961	2517	109	0	24%	23:59:43
7	news.nntp4.net	13935	898	10821	16	0	6%	23:59:51
8	news.furie.org.uk	8366	745	4990	59	0	8%	23:59:51
9	usenet.goja.nl.eu.org	13831	724	10932	26	9	5%	24:04:19
10	paganini.bofh.team	14504	460	11355	3	0	3%	23:59:25
11	news.bbs.nz	23037	443	11221	303	90	1%	23:59:51
12	nntp.alphanet.ch	13556	425	11006	289	10	3%	23:59:51
13	usenet.blueworldhosting.com	15785	152	8603	2	20	0%	23:59:31
14	weretis.net	13071	139	7926	808	7	1%	23:59:41
15	eternal-september	13151	138	9585	9	8	1%	23:59:49
16	news.samoylyk.net	15017	137	11660	9	0	0%	23:59:47
17	news.uzoreto.com	14039	130	10807	0	0	0%	23:59:51
18	dodin.fr.nf	1215	64	620	0	0	5%	19:29:24
19	swapon.de	1137	1	932	0	0	0%	23:03:53
20	kf5zxw.com	0	0	0	0	11974	0%	23:57:43
TOTAL: 20		225872	39809	133049	3320	12135	17%	474:31:41

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	retrobbs.ddns.net	43.6 MB	1.5 MB	45.1 MB	0.5 KB/s	3.9 KB	23:59:47
2	i2pn2	41.6 MB	2.6 MB	44.2 MB	0.5 KB/s	3.9 KB	23:59:51
3	novabbs	35.9 MB	2.2 MB	38.2 MB	0.5 KB/s	4.2 KB	23:59:51
4	aioe	6.7 MB	204.7 KB	6.9 MB	0.1 KB/s	3.3 KB	23:59:51
5	neodome	3.2 MB	0.0 KB	3.2 MB	0.0 KB/s	2.9 KB	23:59:51
6	news.niel.me	3.0 MB	204.4 KB	3.2 MB	0.0 KB/s	3.1 KB	23:59:43
7	news.nntp4.net	2.5 MB	318.4 KB	2.8 MB	0.0 KB/s	3.2 KB	23:59:51
8	news.furie.org.uk	1.9 MB	284.4 KB	2.2 MB	0.0 KB/s	2.8 KB	23:59:51
9	usenet.goja.nl.eu.org	1.8 MB	207.0 KB	2.0 MB	0.0 KB/s	2.8 KB	24:04:19
10	news.bbs.nz	1.7 MB	871.5 KB	2.6 MB	0.0 KB/s	3.5 KB	23:59:51
11	paganini.bofh.team	1.5 MB	181.7 KB	1.7 MB	0.0 KB/s	3.8 KB	23:59:25
12	nntp.alphanet.ch	1.5 MB	1.3 MB	2.7 MB	0.0 KB/s	3.9 KB	23:59:51
13	dodin.fr.nf	983.7 KB	0.0 KB	983.7 KB	0.0 KB/s	15.4 KB	19:29:24
14	usenet.blueworldhosting.com	439.4 KB	30.5 KB	469.9 KB	0.0 KB/s	3.1 KB	23:59:31
15	news.uzoreto.com	416.6 KB	0.0 KB	416.6 KB	0.0 KB/s	3.2 KB	23:59:51
16	eternal-september	307.0 KB	138.5 KB	445.5 KB	0.0 KB/s	3.0 KB	23:59:49
17	news.samoylyk.net	291.8 KB	138.0 KB	429.8 KB	0.0 KB/s	2.9 KB	23:59:47
18	weretis.net	289.3 KB	1.6 MB	1.9 MB	0.0 KB/s	2.0 KB	23:59:41
19	swapon.de	1.4 KB	0.0 KB	1.4 KB	0.0 KB/s	1.4 KB	23:03:53
20	kf5zxw.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:43
TOTAL: 20		147.7 MB	11.7 MB	159.4 MB	0.1 KB/s	3.8 KB	474:31:41

Daily Usenet report

Dec 12 04:15:01 -- Dec 13 04:15:01