Daily Usenet report: Oct 28 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	13938	49.1%	4.1 MB	65.8%
innd	10525	37.1%	1.4 MB	23.1%
innfeed	3907	13.8%	713.9 KB	11.1%
controlchan	12	0.0%	2.7 KB	0.0%
nocem	1	0.0%	0.1 KB	0.0%
pgpverify	1	0.0%	0.1 KB	0.0%
TOTAL: 6	28384	100.0%	6.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	138820	59.3%
Negative hits	81342	34.7%
Do not exist	13731	5.9%
Cache misses	257	0.1%
TOTAL: 4	234150	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.023	0.0%	34	0.000	0.676	1.200
article cleanup	00:00:00.080	0.0%	13769	0.000	0.006	0.033
article logging	00:00:00.493	0.0%	13908	0.000	0.035	0.115
article parse	00:00:00.257	0.0%	23560	0.000	0.011	0.069
article write	00:00:10.236	0.0%	12692	0.000	0.806	21.864
artlog/artcncl	00:00:00.000	0.0%	34	0.000	0.000	0.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:00.088	0.0%	238435	0.000	0.000	0.004
hisgrep/artcncl	00:00:00.000	0.0%	33	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	34	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.800	0.0%	234736	0.000	0.003	0.009
history sync	00:00:00.020	0.0%	390	0.000	0.051	1.000
history write	00:00:01.516	0.0%	13766	0.000	0.110	3.484
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
idle	23:59:30.005	99.9%	239943	194.503	359.961	2036.556
nntp read	00:00:02.178	0.0%	239878	0.002	0.009	0.018
overview write	00:00:01.404	0.0%	12692	0.000	0.111	1.709
perl filter	00:00:26.699	0.0%	13766	1.141	1.939	7.724
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:01.201	0.0%	25446	0.000	0.047	0.106
TOTAL: 24:01:00.950	24:00:15.000	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.020	0.0%	13007	0.000	0.002	0.024
article prepare	00:00:00.013	0.0%	187080	0.000	0.000	0.001
article read	00:00:00.765	0.0%	12561	0.000	0.061	0.926
backlog stats	00:00:00.606	0.0%	407711	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.596	0.0%	267515	0.003	0.010	0.021
data write	00:00:02.343	0.0%	256689	0.004	0.009	0.023
idle	23:55:21.622	100.0%	407711	109.836	211.232	886.640
status file	00:00:00.969	0.0%	379	0.000	2.557	88.333
TOTAL: 23:55:44.614	23:55:28.934	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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
control@usenet-fr.news.eu.org	0	0	1	1	0	1
TOTAL	0	0	1	1	0	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	news-out.aioe.org	3	9697	5013	4607	77	51%	24:08:04
2	usenet.blueworldhosting.com	5	12969	3345	9295	329	25%	23:44:07
3	i2pn-out.news.weretis.net	4	23184	1542	21592	50	6%	49:37:20
4	feeder.eternal-september.org	92	5547	901	4390	256	16%	41:11:43
5	news.nntp4.net	1	11903	524	11367	12	4%	23:59:58
6	paganini.bofh.team	1	10192	493	9590	109	4%	18:01:06
7	usenet.goja.nl.eu.org	11	12398	264	12008	126	2%	23:22:27
8	news-out.neodome.net	2	11305	142	11132	31	1%	23:59:23
9	news.swapon.de	13	1008	108	900	0	10%	23:11:26
10	nntp.alphanet.ch	32	6503	65	6435	3	0%	23:10:36
11	i2pn-out.feed.uzoreto.com	1515	13756	65	13631	60	0%	71:20:01
12	i2pn2.org	40	423	64	359	0	15%	20:16:55
13	news.samoylyk.net	2	10831	33	10797	1	0%	23:59:41
14	dodin.fr.nf	14	614	23	591	0	3%	20:22:12
15	news.niel.me	3	2760	18	2739	3	0%	25:41:49
16	novabbs.org	5	3922	3	3919	0	0%	24:20:14
17	news.bbs.nz	3	10206	2	10203	1	0%	24:33:39
18	news.furie.org.uk	2	5379	1	5378	0	0%	23:58:48
19	kf5zxw.com	1	0	0	0	0	0%	00:10:01
20	retrobbs.ddns.net	1	0	0	0	0	0%	00:10:00
21	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 21		1775	152597	12606	138933	1058	8%	509:19:30

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn-out.news.weretis.net	15.1 MB	0.0 KB	189.3 KB	15.3 MB	98%	9.8 KB
2	news-out.aioe.org	11.7 MB	0.0 KB	318.0 KB	12.0 MB	97%	2.4 KB
3	usenet.blueworldhosting.com	10.7 MB	0.0 KB	911.2 KB	11.6 MB	92%	3.2 KB
4	feeder.eternal-september.org	2.9 MB	0.0 KB	1.8 MB	4.7 MB	62%	4.1 KB
5	news.nntp4.net	2.1 MB	0.0 KB	134.5 KB	2.3 MB	94%	4.3 KB
6	paganini.bofh.team	1.1 MB	0.0 KB	464.5 KB	1.6 MB	71%	2.7 KB
7	usenet.goja.nl.eu.org	787.9 KB	0.0 KB	444.8 KB	1.2 MB	63%	3.2 KB
8	nntp.alphanet.ch	372.8 KB	0.0 KB	5.3 KB	378.1 KB	98%	5.6 KB
9	news-out.neodome.net	370.3 KB	7.1 KB	114.0 KB	491.3 KB	75%	2.8 KB
10	news.swapon.de	277.7 KB	0.0 KB	0.0 KB	277.7 KB	100%	2.6 KB
11	i2pn2.org	275.7 KB	0.0 KB	0.0 KB	275.7 KB	100%	4.3 KB
12	news.samoylyk.net	159.0 KB	7.1 KB	7.1 KB	173.2 KB	91%	5.1 KB
13	i2pn-out.feed.uzoreto.com	100.4 KB	0.0 KB	219.7 KB	320.2 KB	31%	2.6 KB
14	news.niel.me	58.9 KB	0.0 KB	7.9 KB	66.8 KB	88%	3.2 KB
15	dodin.fr.nf	42.4 KB	0.0 KB	0.0 KB	42.4 KB	100%	1.8 KB
16	novabbs.org	16.7 KB	0.0 KB	0.0 KB	16.7 KB	100%	5.6 KB
17	news.bbs.nz	2.1 KB	1.6 KB	1.6 KB	5.4 KB	39%	1.8 KB
18	news.furie.org.uk	1.3 KB	0.0 KB	0.0 KB	1.3 KB	100%	1.3 KB
19	kf5zxw.com	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	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 21		46.1 MB	15.8 KB	4.5 MB	50.7 MB	91%	3.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 28 04:15:01 - 04:59:59	239	1.9%	0.09	711.5 KB	1.5%	0.26
Oct 28 05:00:00 - 05:59:59	320	2.5%	0.09	918.2 KB	1.9%	0.26
Oct 28 06:00:00 - 06:59:59	417	3.3%	0.12	2.8 MB	5.9%	0.80
Oct 28 07:00:00 - 07:59:59	574	4.5%	0.16	1.6 MB	3.4%	0.46
Oct 28 08:00:00 - 08:59:59	725	5.7%	0.20	1.8 MB	3.8%	0.51
Oct 28 09:00:00 - 09:59:59	756	6.0%	0.21	2.6 MB	5.4%	0.73
Oct 28 10:00:00 - 10:59:59	693	5.5%	0.19	2.1 MB	4.5%	0.60
Oct 28 11:00:00 - 11:59:59	602	4.7%	0.17	1.6 MB	3.4%	0.45
Oct 28 12:00:00 - 12:59:59	589	4.6%	0.16	1.6 MB	3.4%	0.46
Oct 28 13:00:00 - 13:59:59	745	5.9%	0.21	1.9 MB	4.0%	0.54
Oct 28 14:00:00 - 14:59:59	852	6.7%	0.24	3.8 MB	8.1%	1.08
Oct 28 15:00:00 - 15:59:59	851	6.7%	0.24	2.5 MB	5.3%	0.71
Oct 28 16:00:00 - 16:59:59	723	5.7%	0.20	2.5 MB	5.3%	0.72
Oct 28 17:00:00 - 17:59:59	618	4.9%	0.17	2.7 MB	5.8%	0.78
Oct 28 18:00:00 - 18:59:59	661	5.2%	0.18	1.8 MB	3.8%	0.51
Oct 28 19:00:00 - 19:59:59	636	5.0%	0.18	4.6 MB	9.8%	1.31
Oct 28 20:00:00 - 20:59:59	515	4.1%	0.14	1.9 MB	4.1%	0.54
Oct 28 21:00:00 - 21:59:59	432	3.4%	0.12	1.4 MB	3.1%	0.41
Oct 28 22:00:00 - 22:59:59	438	3.5%	0.12	1.9 MB	4.0%	0.53
Oct 28 23:00:00 - 23:59:59	389	3.1%	0.11	2.7 MB	5.8%	0.78
Oct 29 00:00:00 - 00:59:59	270	2.1%	0.07	893.5 KB	1.9%	0.25
Oct 29 01:00:00 - 01:59:59	243	1.9%	0.07	799.8 KB	1.7%	0.22
Oct 29 02:00:00 - 02:59:59	171	1.3%	0.05	865.2 KB	1.8%	0.24
Oct 29 03:00:00 - 03:59:59	170	1.3%	0.05	772.0 KB	1.6%	0.21
Oct 29 04:00:00 - 04:15:01	58	0.5%	0.06	382.3 KB	0.8%	0.42
TOTAL: 24:00:00	12687	100.0%	0.15	47.1 MB	100.0%	0.56

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	usenet.blueworldhosting.com	338	45	0	293
2	feeder.eternal-september.org	259	2	0	257
3	usenet.goja.nl.eu.org	126	0	0	126
4	paganini.bofh.team	123	0	0	123
5	news-out.aioe.org	114	6	0	108
6	i2pn-out.news.weretis.net	76	12	0	64
7	news.swapon.de	66	0	0	66
8	i2pn-out.feed.uzoreto.com	60	0	0	60
9	news-out.neodome.net	36	0	1	35
10	news.nntp4.net	12	0	0	12
11	news.niel.me	3	0	0	3
12	nntp.alphanet.ch	3	0	0	3
13	news.samoylyk.net	1	0	1	0
14	news.bbs.nz	1	0	1	0
TOTAL: 14		1218	65	3	1150

Unwanted newsgroups [Top 20]:

Newsgroup	Count
sybase.public.powerdesigner.general	21
alt.info-science	11
att.jobs	7
aus.jobs	5
alt.culture	4
wolfsburg.test	3
alt.penthouse.sex.femdom	2
soc.culutre.china	1
alt.french	1
alt.music.home-recording	1
soc.culture.mexico	1
alt.religion.jewish	1
alt.soc.germans	1
alt.aviation	1
soc.culture.france	1
soc.culture.germany	1
alt.music.mandolin	1
a.b.sounds.karaoke	1
alt.business.home	1
TOTAL: 19	65

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	527
Too many newsgroups	344
Poison newsgroup	116
Scoring filter (9)	13
User-issued cancel	6
Scoring filter (12)	3
Scoring filter (8)	1
TOTAL: 7	1010

INND no permission servers:

System	Conn
192.241.208.189	1
92.255.85.183	1
192.210.207.202	1
94.102.61.41	1
192.241.216.218	1
TOTAL: 5	5

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news.swapon.de	66
	news-out.aioe.org	36
	i2pn-out.news.weretis.net	27
	news-out.neodome.net	5
	usenet.blueworldhosting.com	5
	feeder.eternal-september.org	1
	TOTAL: 6	140
TOTAL: 1		140

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	retrobbs.ddns.net	12424	12189	0	233	0	98%	23:59:48
2	i2pn2	12493	11712	89	591	8	93%	24:08:50
3	novabbs	16113	8140	3778	501	29	50%	23:59:37
4	paganini.bofh.team	13453	1948	10215	2	0	14%	24:09:20
5	nntp.alphanet.ch	13452	1941	9988	579	63	14%	24:08:00
6	aioe	7756	1831	5137	70	0	23%	24:09:40
7	news.nntp4.net	13827	1464	10632	34	0	10%	23:59:48
8	neodome	14722	1087	11353	0	0	7%	24:09:38
9	usenet.goja.nl.eu.org	13804	865	10993	27	8	6%	24:04:16
10	news.niel.me	4109	787	2729	155	0	19%	23:58:17
11	news.bbs.nz	24276	751	11660	298	130	3%	24:08:15
12	news.furie.org.uk	8287	313	5436	156	0	3%	24:09:40
13	news.samoylyk.net	15808	111	12377	9	0	0%	23:59:48
14	weretis.net	16566	109	10080	663	38	0%	23:59:21
15	usenet.blueworldhosting.com	15432	99	9092	0	55	0%	24:09:01
16	eternal-september	13747	90	10200	17	5	0%	24:09:40
17	dodin.fr.nf	1163	81	609	0	0	6%	21:08:35
18	news.uzoreto.com	14375	62	11083	0	0	0%	23:59:46
19	swapon.de	1153	3	950	0	0	0%	23:15:03
20	kf5zxw.com	0	0	0	0	12710	0%	24:05:20
TOTAL: 20		232960	43583	136401	3335	13046	18%	477:51:43

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	retrobbs.ddns.net	45.1 MB	703.8 KB	45.8 MB	0.5 KB/s	3.8 KB	23:59:48
2	i2pn2	43.0 MB	1.9 MB	44.9 MB	0.5 KB/s	3.7 KB	24:08:50
3	novabbs	34.7 MB	1.3 MB	36.0 MB	0.4 KB/s	4.3 KB	23:59:37
4	aioe	6.0 MB	202.7 KB	6.2 MB	0.1 KB/s	3.4 KB	24:09:40
5	nntp.alphanet.ch	5.9 MB	2.2 MB	8.1 MB	0.1 KB/s	3.3 KB	24:08:00
6	paganini.bofh.team	5.7 MB	13.4 KB	5.8 MB	0.1 KB/s	3.0 KB	24:09:20
7	news.nntp4.net	4.3 MB	183.4 KB	4.5 MB	0.1 KB/s	3.1 KB	23:59:48
8	neodome	3.3 MB	0.0 KB	3.3 MB	0.0 KB/s	3.1 KB	24:09:38
9	news.bbs.nz	2.7 MB	1.0 MB	3.7 MB	0.0 KB/s	3.6 KB	24:08:15
10	usenet.goja.nl.eu.org	2.6 MB	246.5 KB	2.9 MB	0.0 KB/s	3.3 KB	24:04:16
11	news.niel.me	2.4 MB	411.0 KB	2.8 MB	0.0 KB/s	3.0 KB	23:58:17
12	news.furie.org.uk	1.1 MB	608.6 KB	1.7 MB	0.0 KB/s	3.7 KB	24:09:40
13	dodin.fr.nf	526.6 KB	0.0 KB	526.6 KB	0.0 KB/s	6.5 KB	21:08:35
14	usenet.blueworldhosting.com	353.0 KB	0.0 KB	353.0 KB	0.0 KB/s	3.6 KB	24:09:01
15	news.samoylyk.net	339.0 KB	96.4 KB	435.3 KB	0.0 KB/s	3.6 KB	23:59:48
16	eternal-september	286.7 KB	160.2 KB	446.8 KB	0.0 KB/s	4.2 KB	24:09:40
17	news.uzoreto.com	281.2 KB	0.0 KB	281.2 KB	0.0 KB/s	4.5 KB	23:59:46
18	weretis.net	270.3 KB	1.0 MB	1.3 MB	0.0 KB/s	1.7 KB	23:59:21
19	swapon.de	8.8 KB	0.0 KB	8.8 KB	0.0 KB/s	2.9 KB	23:15:03
20	kf5zxw.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:05:20
TOTAL: 20		158.9 MB	10.1 MB	169.0 MB	0.1 KB/s	3.7 KB	477:51:43

Daily Usenet report

Oct 28 04:15:01 -- Oct 29 04:15:01