Daily Usenet report: Oct 3 04:15:02

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	13433	48.9%	4.0 MB	66.6%
innd	10164	37.0%	1.4 MB	23.0%
innfeed	3881	14.1%	640.8 KB	10.4%
controlchan	1	0.0%	0.0 KB	0.0%
nocem	1	0.0%	0.2 KB	0.0%
TOTAL: 5	27480	100.0%	6.0 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	119771	59.1%
Negative hits	69470	34.3%
Do not exist	13175	6.5%
Cache misses	257	0.1%
TOTAL: 4	202673	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.024	0.0%	30	0.000	0.800	1.300
article cleanup	00:00:00.058	0.0%	13223	0.000	0.004	0.029
article logging	00:00:00.418	0.0%	13421	0.000	0.031	0.122
article parse	00:00:00.223	0.0%	22248	0.000	0.010	0.034
article write	00:00:04.387	0.0%	12209	0.071	0.359	5.151
artlog/artcncl	00:00:00.000	0.0%	30	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.071	0.0%	208140	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.001	0.0%	30	0.000	0.033	1.000
hishave/artcncl	00:00:00.000	0.0%	30	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.743	0.0%	203217	0.000	0.004	0.009
history sync	00:00:00.013	0.0%	305	0.000	0.043	1.000
history write	00:00:00.991	0.0%	13217	0.000	0.075	1.527
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:59:12.886	99.9%	210151	224.817	410.909	1600.136
nntp read	00:00:01.968	0.0%	209381	0.002	0.009	0.026
overview write	00:00:01.325	0.0%	12209	0.000	0.109	4.714
perl filter	00:00:25.644	0.0%	13216	1.279	1.940	7.280
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:01.660	0.0%	24476	0.000	0.068	0.176
TOTAL: 24:00:24.484	23:59:50.412	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.024	0.0%	12327	0.000	0.002	0.025
article prepare	00:00:00.013	0.0%	131484	0.000	0.000	0.002
article read	00:00:00.658	0.0%	12037	0.000	0.055	0.925
backlog stats	00:00:00.540	0.0%	341744	0.000	0.002	0.006
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.339	0.0%	221042	0.003	0.011	0.019
data write	00:00:01.957	0.0%	209728	0.003	0.009	0.020
idle	23:55:44.763	100.0%	341744	124.828	252.074	754.055
status file	00:00:00.813	0.0%	419	0.000	1.940	51.833
TOTAL: 23:56:09.246	23:55:51.107	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	4	9871	4142	5668	61	41%	24:11:35
2	usenet.blueworldhosting.com	5	12393	3371	8683	339	27%	23:04:52
3	feeder.eternal-september.org	16	6504	1693	4503	308	26%	27:07:00
4	i2pn-out.news.weretis.net	3	12992	1419	11529	44	10%	30:27:55
5	news-out.neodome.net	1	11118	317	10789	12	2%	23:59:57
6	paganini.bofh.team	1	6618	198	6414	6	2%	13:40:51
7	news.swapon.de	14	847	197	650	0	23%	21:51:47
8	usenet.goja.nl.eu.org	11	11094	151	10804	139	1%	21:26:18
9	nntp.alphanet.ch	24	7640	100	7539	1	1%	24:45:21
10	i2pn2.org	35	85	85	0	0	100%	07:25:10
11	i2pn-out.feed.uzoreto.com	1614	12977	54	12858	65	0%	70:49:49
12	dodin.fr.nf	15	812	30	782	0	3%	19:28:38
13	news.samoylyk.net	2	10482	23	10456	3	0%	23:59:28
14	news.bbs.nz	11	10641	5	10634	2	0%	32:59:36
15	news.niel.me	0	298	3	295	0	1%	05:09:17
16	2a01:4f8:c17:a9e2::8e	0	530	3	505	22	0%	02:35:38
17	news.furie.org.uk	2	5393	2	5389	2	0%	24:46:18
18	kf5zxw.com	1	0	0	0	0	0%	00:10:01
19	localhost	25	0	0	0	0	0%	00:00:00
20	retrobbs.ddns.net	1	0	0	0	0	0%	00:00:00
21	novabbs.org	31	81	0	81	0	0%	06:49:58
TOTAL: 21		1816	120376	11793	107579	1004	9%	404:49:29

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn-out.news.weretis.net	12.6 MB	0.0 KB	131.8 KB	12.7 MB	98%	8.9 KB
2	usenet.blueworldhosting.com	11.3 MB	0.0 KB	890.8 KB	12.2 MB	92%	3.4 KB
3	news-out.aioe.org	9.5 MB	1.9 KB	163.0 KB	9.7 MB	98%	2.4 KB
4	feeder.eternal-september.org	6.4 MB	0.0 KB	2.3 MB	8.6 MB	73%	4.4 KB
5	news-out.neodome.net	1.2 MB	0.0 KB	103.7 KB	1.3 MB	91%	3.9 KB
6	paganini.bofh.team	764.0 KB	0.0 KB	377.3 KB	1.1 MB	66%	5.6 KB
7	news.swapon.de	554.7 KB	0.0 KB	0.0 KB	554.7 KB	100%	2.8 KB
8	usenet.goja.nl.eu.org	495.4 KB	0.0 KB	510.6 KB	1006.0 KB	49%	3.5 KB
9	i2pn2.org	295.6 KB	0.0 KB	0.0 KB	295.6 KB	100%	3.5 KB
10	nntp.alphanet.ch	201.4 KB	0.0 KB	0.8 KB	202.2 KB	99%	2.0 KB
11	i2pn-out.feed.uzoreto.com	97.7 KB	0.0 KB	254.6 KB	352.4 KB	27%	3.0 KB
12	news.samoylyk.net	95.1 KB	27.4 KB	27.4 KB	150.0 KB	63%	5.8 KB
13	dodin.fr.nf	56.5 KB	0.0 KB	0.0 KB	56.5 KB	100%	1.9 KB
14	news.bbs.nz	10.8 KB	3.6 KB	3.6 KB	17.9 KB	60%	2.6 KB
15	news.niel.me	9.8 KB	0.0 KB	0.0 KB	9.8 KB	100%	3.3 KB
16	2a01:4f8:c17:a9e2::8e	9.3 KB	0.0 KB	85.2 KB	94.4 KB	9%	3.8 KB
17	news.furie.org.uk	6.6 KB	2.9 KB	9.0 KB	18.5 KB	35%	4.6 KB
18	kf5zxw.com	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	retrobbs.ddns.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
21	novabbs.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 21		43.5 MB	35.8 KB	4.8 MB	48.3 MB	90%	3.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 3 04:15:02 - 04:59:59	205	1.7%	0.08	639.5 KB	1.4%	0.24
Oct 3 05:00:00 - 05:59:59	295	2.4%	0.08	1.3 MB	2.7%	0.36
Oct 3 06:00:00 - 06:59:59	387	3.2%	0.11	1.0 MB	2.2%	0.29
Oct 3 07:00:00 - 07:59:59	502	4.1%	0.14	2.3 MB	5.0%	0.65
Oct 3 08:00:00 - 08:59:59	619	5.1%	0.17	1.8 MB	4.0%	0.52
Oct 3 09:00:00 - 09:59:59	731	6.0%	0.20	2.1 MB	4.6%	0.60
Oct 3 10:00:00 - 10:59:59	556	4.6%	0.15	1.7 MB	3.7%	0.49
Oct 3 11:00:00 - 11:59:59	683	5.6%	0.19	3.2 MB	6.9%	0.90
Oct 3 12:00:00 - 12:59:59	573	4.7%	0.16	1.8 MB	4.0%	0.52
Oct 3 13:00:00 - 13:59:59	702	5.8%	0.20	2.6 MB	5.6%	0.74
Oct 3 14:00:00 - 14:59:59	725	5.9%	0.20	2.5 MB	5.4%	0.70
Oct 3 15:00:00 - 15:59:59	705	5.8%	0.20	4.0 MB	8.6%	1.12
Oct 3 16:00:00 - 16:59:59	617	5.1%	0.17	2.0 MB	4.3%	0.56
Oct 3 17:00:00 - 17:59:59	761	6.2%	0.21	2.2 MB	4.7%	0.61
Oct 3 18:00:00 - 18:59:59	727	6.0%	0.20	2.5 MB	5.4%	0.70
Oct 3 19:00:00 - 19:59:59	708	5.8%	0.20	2.3 MB	5.0%	0.65
Oct 3 20:00:00 - 20:59:59	491	4.0%	0.14	2.7 MB	5.8%	0.76
Oct 3 21:00:00 - 21:59:59	504	4.1%	0.14	1.8 MB	4.0%	0.52
Oct 3 22:00:00 - 22:59:59	412	3.4%	0.11	1.4 MB	3.1%	0.40
Oct 3 23:00:00 - 23:59:59	310	2.5%	0.09	1.2 MB	2.7%	0.35
Oct 4 00:00:00 - 00:59:59	286	2.3%	0.08	859.3 KB	1.8%	0.24
Oct 4 01:00:00 - 01:59:59	241	2.0%	0.07	1.2 MB	2.5%	0.33
Oct 4 02:00:00 - 02:59:59	183	1.5%	0.05	1.6 MB	3.5%	0.46
Oct 4 03:00:00 - 03:59:59	215	1.8%	0.06	1.2 MB	2.6%	0.34
Oct 4 04:00:00 - 04:15:02	56	0.5%	0.06	197.8 KB	0.4%	0.22
TOTAL: 24:00:00	12194	100.0%	0.14	45.9 MB	100.0%	0.54

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	usenet.blueworldhosting.com	353	37	0	316
2	feeder.eternal-september.org	300	0	0	300
3	usenet.goja.nl.eu.org	163	0	0	163
4	i2pn-out.news.weretis.net	93	1	0	92
5	news.swapon.de	84	0	0	84
6	news-out.aioe.org	83	11	1	71
7	i2pn-out.feed.uzoreto.com	65	0	0	65
8	news-out.neodome.net	46	0	0	46
9	paganini.bofh.team	14	0	0	14
10	news.samoylyk.net	4	0	3	1
11	news.bbs.nz	2	0	2	0
12	news.furie.org.uk	2	1	1	0
13	nntp.alphanet.ch	1	0	0	1
TOTAL: 13		1210	50	7	1153

Unwanted newsgroups [Top 20]:

Newsgroup	Count
sybase.public.powerdesigner.general	12
talk.generic.ua.ws	11
aus.jobs	11
att.jobs	7
1.test	3
3com.totalservice.test	1
talk.from.war.diary	1
talk.from.diary	1
alt.ads	1
alt.culture	1
fr.petites-annonces.informatique.materiel	1
TOTAL: 11	50

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	487
Too many newsgroups	309
Poison newsgroup	132
User-issued cancel	14
Too many newsgroups (meow)	5
Scoring filter (9)	2
HTML Image Tags	2
HTML Multipart	2
Scoring filter (8)	1
TOTAL: 9	954

INND no permission servers:

System	Conn
192.241.220.50	1
2a01:4f8:c17:a9e2::8e	1
104.152.52.132	1
104.152.52.199	1
TOTAL: 4	4

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news.swapon.de	84
	i2pn-out.news.weretis.net	40
	news-out.neodome.net	34
	news-out.aioe.org	20
	usenet.blueworldhosting.com	12
	feeder.eternal-september.org	7
	news.samoylyk.net	1
	TOTAL: 7	198
No colon-space in header
	i2pn-out.feed.uzoreto.com	1
	TOTAL: 1	1
TOTAL: 2		199

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	novabbs	12076	11185	140	644	0	92%	23:59:46
2	i2pn2	12006	11160	126	572	0	92%	23:51:21
3	aioe	8260	1884	5654	40	11	22%	23:59:45
4	paganini.bofh.team	13929	1114	10714	0	0	7%	23:59:45
5	usenet.goja.nl.eu.org	13646	1047	10760	13	12	7%	23:55:16
6	neodome	13990	920	10842	0	0	6%	23:59:46
7	news.bbs.nz	23017	842	10918	414	38	3%	23:59:46
8	nntp.alphanet.ch	13229	708	10932	317	0	5%	23:59:31
9	news.furie.org.uk	8392	360	5506	63	55	4%	23:59:46
10	news.uzoreto.com	13605	339	10485	1	0	2%	23:59:24
11	usenet.blueworldhosting.com	14640	120	8490	1	10	0%	23:59:46
12	eternal-september	13492	120	9969	11	9	0%	23:59:14
13	dodin.fr.nf	1298	109	790	0	0	8%	18:57:00
14	weretis.net	15642	105	9741	535	4	0%	23:59:46
15	news.samoylyk.net	15283	88	11913	36	0	0%	23:59:46
16	news.niel.me	433	82	250	50	3501	18%	23:59:46
17	kf5zxw.com	0	0	0	0	12166	0%	23:50:00
18	swapon.de	831	0	679	0	0	0%	22:05:41
19	retrobbs.ddns.net	0	0	0	0	11969	0%	23:57:46
20	news.nntp4.net	0	0	0	0	12188	0%	23:59:46
TOTAL: 20		193769	30183	117909	2697	39963	15%	472:32:37

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	novabbs	41.5 MB	1.7 MB	43.2 MB	0.5 KB/s	3.7 KB	23:59:46
2	i2pn2	41.2 MB	1.6 MB	42.8 MB	0.5 KB/s	3.7 KB	23:51:21
3	aioe	6.2 MB	94.4 KB	6.3 MB	0.1 KB/s	3.4 KB	23:59:45
4	paganini.bofh.team	3.0 MB	0.0 KB	3.0 MB	0.0 KB/s	2.7 KB	23:59:45
5	news.bbs.nz	2.9 MB	1.1 MB	4.1 MB	0.0 KB/s	3.3 KB	23:59:46
6	usenet.goja.nl.eu.org	2.6 MB	163.3 KB	2.8 MB	0.0 KB/s	2.7 KB	23:55:16
7	neodome	2.6 MB	0.0 KB	2.6 MB	0.0 KB/s	2.9 KB	23:59:46
8	nntp.alphanet.ch	2.4 MB	1.1 MB	3.6 MB	0.0 KB/s	3.6 KB	23:59:31
9	news.furie.org.uk	1.2 MB	255.2 KB	1.5 MB	0.0 KB/s	3.6 KB	23:59:46
10	news.uzoreto.com	1004.2 KB	4.1 KB	1008.2 KB	0.0 KB/s	3.0 KB	23:59:24
11	usenet.blueworldhosting.com	374.6 KB	2.4 KB	376.9 KB	0.0 KB/s	3.1 KB	23:59:46
12	dodin.fr.nf	306.4 KB	0.0 KB	306.4 KB	0.0 KB/s	2.8 KB	18:57:00
13	eternal-september	282.8 KB	152.0 KB	434.8 KB	0.0 KB/s	3.3 KB	23:59:14
14	news.niel.me	272.5 KB	86.9 KB	359.4 KB	0.0 KB/s	2.7 KB	23:59:46
15	weretis.net	223.5 KB	872.8 KB	1.1 MB	0.0 KB/s	1.7 KB	23:59:46
16	news.samoylyk.net	180.4 KB	197.3 KB	377.7 KB	0.0 KB/s	3.0 KB	23:59:46
17	kf5zxw.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:00
18	swapon.de	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:05:41
19	retrobbs.ddns.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:46
20	news.nntp4.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:46
TOTAL: 20		106.2 MB	7.4 MB	113.6 MB	0.1 KB/s	3.5 KB	472:32:37

Daily Usenet report

Oct 3 04:15:02 -- Oct 4 04:15:02