Daily Usenet report: Oct 2 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	12585	48.0%	3.8 MB	65.2%
innd	9713	37.1%	1.3 MB	23.3%
innfeed	3896	14.9%	677.8 KB	11.5%
nocem	1	0.0%	0.2 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	26196	100.0%	5.8 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	122478	59.8%
Negative hits	69780	34.1%
Do not exist	12316	6.0%
Cache misses	216	0.1%
TOTAL: 4	204790	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.195	0.0%	305	0.000	0.639	2.750
article cleanup	00:00:00.071	0.0%	12636	0.000	0.006	0.065
article logging	00:00:00.414	0.0%	12834	0.000	0.032	0.109
article parse	00:00:00.222	0.0%	22573	0.000	0.010	0.045
article write	00:00:05.377	0.0%	11648	0.083	0.462	22.057
artlog/artcncl	00:00:00.005	0.0%	305	0.000	0.016	0.250
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:00:00.089	0.0%	213532	0.000	0.000	0.003
hisgrep/artcncl	00:00:00.002	0.0%	305	0.000	0.007	0.007
hishave/artcncl	00:00:00.000	0.0%	305	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.735	0.0%	211123	0.000	0.003	0.008
history sync	00:00:00.015	0.0%	316	0.000	0.047	0.500
history write	00:00:00.821	0.0%	12634	0.000	0.065	2.802
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:59:09.270	99.9%	215181	114.741	401.287	1621.773
nntp read	00:00:01.924	0.0%	214651	0.003	0.009	0.018
overview write	00:00:01.066	0.0%	11648	0.000	0.092	1.774
perl filter	00:00:26.730	0.0%	12633	1.142	2.116	9.703
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:01.323	0.0%	23352	0.000	0.057	0.183
TOTAL: 24:00:23.417	23:59:48.259	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.025	0.0%	11672	0.000	0.002	0.059
article prepare	00:00:00.007	0.0%	126352	0.000	0.000	0.002
article read	00:00:00.580	0.0%	11257	0.000	0.052	0.973
backlog stats	00:00:00.610	0.0%	350896	0.000	0.002	0.007
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.139	0.0%	225929	0.004	0.009	0.017
data write	00:00:01.864	0.0%	216146	0.001	0.009	0.015
idle	23:55:34.061	100.0%	350896	122.715	245.469	927.761
status file	00:00:01.195	0.0%	428	0.000	2.792	159.250
TOTAL: 23:55:53.423	23:55:40.481	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	8506	4125	4341	40	48%	24:09:29
2	usenet.blueworldhosting.com	5	12154	3106	8646	402	25%	25:05:36
3	i2pn-out.news.weretis.net	3	23354	2009	21298	47	8%	54:41:15
4	feeder.eternal-september.org	15	6034	1244	4603	187	20%	27:05:52
5	paganini.bofh.team	2	11147	300	10841	6	2%	22:00:20
6	news-out.neodome.net	1	10917	230	10619	68	2%	23:59:56
7	news.swapon.de	13	872	200	672	0	22%	22:11:04
8	usenet.goja.nl.eu.org	11	11108	169	10799	140	1%	23:56:44
9	news.niel.me	3	3044	136	2906	2	4%	25:46:42
10	nntp.alphanet.ch	24	6862	85	6776	1	1%	23:01:52
11	i2pn2.org	30	69	69	0	0	100%	07:10:38
12	i2pn-out.feed.uzoreto.com	1459	11998	55	11878	65	0%	71:23:11
13	news.nntp4.net	0	9089	51	9016	22	0%	17:38:18
14	news.samoylyk.net	1	10070	23	10046	1	0%	23:59:53
15	dodin.fr.nf	24	904	18	886	0	1%	18:56:44
16	news.bbs.nz	3	9777	5	9772	0	0%	25:22:52
17	news.furie.org.uk	1	5436	1	5435	0	0%	23:59:53
18	kf5zxw.com	1	0	0	0	0	0%	00:10:00
19	localhost	25	0	0	0	0	0%	00:00:00
20	retrobbs.ddns.net	2	1	0	1	0	0%	00:20:00
21	novabbs.org	29	67	0	67	0	0%	06:51:48
TOTAL: 21		1656	141409	11826	128602	981	8%	467:52:07

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn-out.news.weretis.net	18.5 MB	0.0 KB	254.9 KB	18.8 MB	98%	9.3 KB
2	usenet.blueworldhosting.com	11.2 MB	1.8 KB	1.3 MB	12.4 MB	89%	3.6 KB
3	news-out.aioe.org	9.4 MB	0.0 KB	105.5 KB	9.5 MB	98%	2.3 KB
4	feeder.eternal-september.org	5.4 MB	2.9 KB	1.6 MB	7.0 MB	77%	5.0 KB
5	paganini.bofh.team	981.5 KB	0.0 KB	15.6 KB	997.2 KB	98%	3.3 KB
6	usenet.goja.nl.eu.org	845.3 KB	0.0 KB	441.5 KB	1.3 MB	65%	4.2 KB
7	news-out.neodome.net	798.2 KB	0.0 KB	209.6 KB	1007.8 KB	79%	3.4 KB
8	news.swapon.de	642.9 KB	0.0 KB	0.0 KB	642.9 KB	100%	3.2 KB
9	news.niel.me	552.3 KB	0.0 KB	3.3 KB	555.6 KB	99%	4.0 KB
10	i2pn2.org	335.5 KB	0.0 KB	0.0 KB	335.5 KB	100%	4.9 KB
11	news.nntp4.net	229.9 KB	0.0 KB	142.4 KB	372.4 KB	61%	5.1 KB
12	nntp.alphanet.ch	228.6 KB	0.0 KB	0.9 KB	229.5 KB	99%	2.7 KB
13	i2pn-out.feed.uzoreto.com	91.4 KB	0.0 KB	211.7 KB	303.1 KB	30%	2.5 KB
14	news.samoylyk.net	83.6 KB	3.0 KB	3.0 KB	89.5 KB	93%	3.7 KB
15	news.bbs.nz	40.1 KB	0.0 KB	0.0 KB	40.1 KB	100%	8.0 KB
16	dodin.fr.nf	33.3 KB	0.0 KB	0.0 KB	33.3 KB	100%	1.9 KB
17	news.furie.org.uk	4.5 KB	0.0 KB	0.0 KB	4.5 KB	100%	4.5 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		49.2 MB	7.7 KB	4.2 MB	53.4 MB	92%	4.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 2 04:15:01 - 04:59:59	132	1.2%	0.05	721.9 KB	1.5%	0.27
Oct 2 05:00:00 - 05:59:59	240	2.1%	0.07	2.3 MB	5.0%	0.65
Oct 2 06:00:00 - 06:59:59	319	2.8%	0.09	958.2 KB	2.0%	0.27
Oct 2 07:00:00 - 07:59:59	425	3.7%	0.12	1.1 MB	2.4%	0.32
Oct 2 08:00:00 - 08:59:59	512	4.5%	0.14	2.7 MB	5.9%	0.77
Oct 2 09:00:00 - 09:59:59	568	5.0%	0.16	1.5 MB	3.4%	0.44
Oct 2 10:00:00 - 10:59:59	558	4.9%	0.15	1.5 MB	3.2%	0.42
Oct 2 11:00:00 - 11:59:59	646	5.7%	0.18	2.0 MB	4.3%	0.57
Oct 2 12:00:00 - 12:59:59	478	4.2%	0.13	2.4 MB	5.1%	0.67
Oct 2 13:00:00 - 13:59:59	525	4.6%	0.15	2.4 MB	5.1%	0.67
Oct 2 14:00:00 - 14:59:59	603	5.3%	0.17	2.3 MB	5.1%	0.67
Oct 2 15:00:00 - 15:59:59	647	5.7%	0.18	2.5 MB	5.4%	0.71
Oct 2 16:00:00 - 16:59:59	654	5.7%	0.18	2.2 MB	4.8%	0.62
Oct 2 17:00:00 - 17:59:59	721	6.3%	0.20	2.2 MB	4.8%	0.63
Oct 2 18:00:00 - 18:59:59	787	6.9%	0.22	3.5 MB	7.7%	1.00
Oct 2 19:00:00 - 19:59:59	599	5.3%	0.17	2.6 MB	5.6%	0.73
Oct 2 20:00:00 - 20:59:59	520	4.6%	0.14	2.5 MB	5.4%	0.71
Oct 2 21:00:00 - 21:59:59	518	4.6%	0.14	1.7 MB	3.7%	0.48
Oct 2 22:00:00 - 22:59:59	454	4.0%	0.13	2.3 MB	5.0%	0.65
Oct 2 23:00:00 - 23:59:59	359	3.2%	0.10	1.2 MB	2.5%	0.33
Oct 3 00:00:00 - 00:59:59	318	2.8%	0.09	933.6 KB	2.0%	0.26
Oct 3 01:00:00 - 01:59:59	258	2.3%	0.07	848.5 KB	1.8%	0.24
Oct 3 02:00:00 - 02:59:59	261	2.3%	0.07	1.0 MB	2.3%	0.30
Oct 3 03:00:00 - 03:59:59	176	1.5%	0.05	1.5 MB	3.3%	0.44
Oct 3 04:00:00 - 04:15:02	104	0.9%	0.12	1.3 MB	2.9%	1.50
TOTAL: 24:00:01	11382	100.0%	0.13	46.1 MB	100.0%	0.55

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	usenet.blueworldhosting.com	405	36	1	368
2	feeder.eternal-september.org	205	9	1	195
3	usenet.goja.nl.eu.org	142	0	0	142
4	i2pn-out.news.weretis.net	98	0	0	98
5	news-out.neodome.net	89	0	0	89
6	news.swapon.de	78	0	0	78
7	i2pn-out.feed.uzoreto.com	65	2	0	63
8	news-out.aioe.org	61	2	0	59
9	news.nntp4.net	22	0	0	22
10	paganini.bofh.team	10	3	0	7
11	news.niel.me	2	0	0	2
12	nntp.alphanet.ch	1	0	0	1
13	news.samoylyk.net	1	0	1	0
TOTAL: 13		1179	52	3	1124

Unwanted newsgroups [Top 20]:

Newsgroup	Count
talk.generic.ua.ws	13
alt.politics.liberal	9
sybase.public.powerdesigner.general	6
alt.entrepreneurs	2
fr.petites-annonces.informatique.materiel	2
alt.metaphysics	2
soc.culture.ukraine	2
alt.bbs.misc	2
it-alt.discussioni.italianiallestero	1
talk.from.diary	1
clari.web.local.virginia+dc	1
clari.web.local.alabama	1
clari.web.local.georgia	1
winnipeg.general	1
talk.from.war.diary	1
rec.sport.sport-wrestling	1
clari.web.local.kentucky	1
a.b.boneless	1
jana.zolitudegmail.com	1
altprivacy.anon-server	1
TOTAL: 22	52

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	397
Too many newsgroups	347
Poison newsgroup	160
User-issued cancel	6
Scoring filter (11)	5
Too many newsgroups (meow)	4
HTML Multipart	3
Scoring filter (12)	1
Scoring filter (8)	1
Scoring filter (9)	1
TOTAL: 10	925

INND no permission servers:

System	Conn
159.203.122.199	8
71.6.146.186	2
192.241.218.17	1
167.94.138.119	1
TOTAL: 4	12

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news.swapon.de	78
	i2pn-out.news.weretis.net	63
	news-out.neodome.net	25
	news-out.aioe.org	22
	usenet.blueworldhosting.com	5
	feeder.eternal-september.org	4
	usenet.goja.nl.eu.org	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	11356	10288	174	750	0	90%	23:59:52
2	i2pn2	11460	10189	284	670	24	88%	23:59:52
3	aioe	7097	2264	4314	136	0	31%	23:59:52
4	news.niel.me	4079	876	2599	250	1	21%	23:59:27
5	neodome	13156	861	10140	0	3	6%	23:59:33
6	usenet.goja.nl.eu.org	12884	796	10287	14	10	6%	23:59:51
7	nntp.alphanet.ch	12460	779	10071	293	0	6%	23:59:52
8	paganini.bofh.team	13509	681	10399	0	2	5%	23:59:52
9	news.bbs.nz	21795	574	10452	348	124	2%	23:59:51
10	news.furie.org.uk	8114	356	5351	54	10	4%	23:59:52
11	news.nntp4.net	10121	221	8056	10	3050	2%	23:59:52
12	news.uzoreto.com	13046	152	9991	0	14	1%	23:59:52
13	usenet.blueworldhosting.com	14209	140	8040	0	40	0%	23:59:52
14	eternal-september	12665	107	9245	11	58	0%	23:59:09
15	dodin.fr.nf	1296	80	675	0	3	6%	19:29:46
16	weretis.net	14546	49	8836	616	6	0%	23:59:52
17	news.samoylyk.net	14325	43	11113	57	14	0%	23:59:21
18	retrobbs.ddns.net	0	0	0	0	11212	0%	23:57:47
19	swapon.de	1083	0	837	0	0	0%	22:11:23
20	kf5zxw.com	0	0	0	0	11381	0%	23:57:43
TOTAL: 20		197201	28456	120864	3209	25952	14%	473:32:31

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	novabbs	38.4 MB	5.5 MB	43.9 MB	0.5 KB/s	4.1 KB	23:59:52
2	i2pn2	37.6 MB	5.4 MB	43.0 MB	0.5 KB/s	4.1 KB	23:59:52
3	aioe	7.5 MB	345.1 KB	7.9 MB	0.1 KB/s	3.4 KB	23:59:52
4	news.niel.me	3.1 MB	572.9 KB	3.6 MB	0.0 KB/s	3.3 KB	23:59:27
5	nntp.alphanet.ch	2.8 MB	1.2 MB	4.0 MB	0.0 KB/s	3.8 KB	23:59:52
6	neodome	2.7 MB	0.0 KB	2.7 MB	0.0 KB/s	3.2 KB	23:59:33
7	news.bbs.nz	2.4 MB	1.9 MB	4.2 MB	0.1 KB/s	4.7 KB	23:59:51
8	usenet.goja.nl.eu.org	2.2 MB	180.5 KB	2.4 MB	0.0 KB/s	3.0 KB	23:59:51
9	paganini.bofh.team	2.2 MB	0.0 KB	2.2 MB	0.0 KB/s	3.3 KB	23:59:52
10	news.furie.org.uk	1.3 MB	180.5 KB	1.5 MB	0.0 KB/s	3.8 KB	23:59:52
11	news.nntp4.net	876.8 KB	103.2 KB	980.0 KB	0.0 KB/s	4.2 KB	23:59:52
12	news.uzoreto.com	581.1 KB	0.0 KB	581.1 KB	0.0 KB/s	3.8 KB	23:59:52
13	usenet.blueworldhosting.com	461.4 KB	0.0 KB	461.4 KB	0.0 KB/s	3.3 KB	23:59:52
14	dodin.fr.nf	386.7 KB	0.0 KB	386.7 KB	0.0 KB/s	4.8 KB	19:29:46
15	eternal-september	289.6 KB	172.2 KB	461.8 KB	0.0 KB/s	3.9 KB	23:59:09
16	weretis.net	194.5 KB	1.2 MB	1.3 MB	0.0 KB/s	2.1 KB	23:59:52
17	news.samoylyk.net	117.2 KB	287.3 KB	404.6 KB	0.0 KB/s	4.0 KB	23:59:21
18	retrobbs.ddns.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:47
19	swapon.de	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:11:23
20	kf5zxw.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:43
TOTAL: 20		103.1 MB	16.9 MB	119.9 MB	0.1 KB/s	3.9 KB	473:32:31

Daily Usenet report

Oct 2 04:15:01 -- Oct 3 04:15:02