Daily Usenet report: May 7 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	17723	56.8%	3.6 MB	65.2%
innd	10308	33.0%	1.4 MB	25.2%
innfeed	3184	10.2%	546.0 KB	9.6%
nocem	2	0.0%	0.1 KB	0.0%
controlchan	1	0.0%	0.0 KB	0.0%
TOTAL: 5	31218	100.0%	5.5 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	106807	48.0%
Negative hits	98366	44.2%
Do not exist	17280	7.8%
Cache misses	65	0.0%
TOTAL: 4	222518	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.065	0.0%	118	0.000	0.551	31.000
article cleanup	00:00:00.084	0.0%	17311	0.000	0.005	0.022
article logging	00:00:00.576	0.0%	17611	0.000	0.033	0.091
article parse	00:00:00.257	0.0%	35178	0.000	0.007	0.050
article write	00:00:02.992	0.0%	11459	0.015	0.261	10.231
artlog/artcncl	00:00:00.002	0.0%	118	0.000	0.017	1.000
artlog/artparse	00:00:00.001	0.0%	6	0.000	0.167	1.000
data move	00:00:00.076	0.0%	227157	0.000	0.000	0.003
hisgrep/artcncl	00:00:00.002	0.0%	118	0.000	0.017	1.000
hishave/artcncl	00:00:00.000	0.0%	118	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.784	0.0%	223007	0.000	0.004	0.009
history sync	00:00:00.013	0.0%	298	0.000	0.044	0.667
history write	00:00:01.111	0.0%	17312	0.000	0.064	0.987
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:59:18.817	99.9%	234264	219.014	368.639	1162.874
nntp read	00:00:01.906	0.0%	233517	0.002	0.008	0.018
overview write	00:00:05.005	0.0%	11459	0.021	0.437	23.156
perl filter	00:00:19.255	0.0%	17305	0.862	1.113	3.610
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.848	0.0%	23053	0.000	0.037	0.141
TOTAL: 24:00:20.970	23:59:51.794	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.017	0.0%	11525	0.000	0.001	0.026
article prepare	00:00:00.005	0.0%	94864	0.000	0.000	0.002
article read	00:00:00.550	0.0%	11224	0.000	0.049	0.531
backlog stats	00:00:00.330	0.0%	236825	0.000	0.001	0.005
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.282	0.0%	169470	0.002	0.008	0.016
data write	00:00:01.325	0.0%	158974	0.000	0.008	0.024
idle	23:55:19.992	100.0%	236825	180.783	363.644	912.439
status file	00:00:00.183	0.0%	334	0.000	0.548	1.000
TOTAL: 23:55:33.699	23:55:23.684	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	10580	4514	5997	69	42%	24:08:52
2	i2pn-out.news.weretis.net	4	20477	2930	17448	99	14%	47:53:35
3	feeder.eternal-september.org	23	3072	2008	713	351	65%	28:35:33
4	usenet.goja.nl.eu.org	12	12049	702	11113	234	5%	24:29:26
5	paganini.bofh.team	1	13120	515	12572	33	3%	24:55:13
6	news.swapon.de	7	1006	239	766	1	23%	23:47:09
7	news-out.neodome.net	1	10875	223	10598	54	2%	23:59:57
8	i2pn-out.feed.uzoreto.com	1701	16911	75	11859	4977	0%	71:01:22
9	i2pn2.org	15	76	69	7	0	90%	04:34:17
10	news.nntp4.net	2	12126	41	12027	58	0%	23:59:45
11	news.samoylyk.net	2	9869	40	9827	2	0%	23:59:45
12	dodin.fr.nf	24	772	19	752	1	2%	19:34:15
13	news.niel.me	1	3486	14	3472	0	0%	23:59:55
14	novabbs.org	14	72	7	65	0	9%	04:20:16
15	news.bbs.nz	4	5003	4	4998	1	0%	16:22:06
16	kf5zxw.com	1	0	0	0	0	0%	00:10:00
17	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 17		1839	119494	11400	102214	5880	9%	385:51:26

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn-out.news.weretis.net	17.1 MB	0.0 KB	555.7 KB	17.7 MB	96%	6.0 KB
2	news-out.aioe.org	11.3 MB	0.0 KB	270.8 KB	11.5 MB	97%	2.6 KB
3	feeder.eternal-september.org	8.5 MB	0.0 KB	4.4 MB	12.8 MB	65%	5.6 KB
4	usenet.goja.nl.eu.org	2.2 MB	2.5 KB	2.3 MB	4.5 MB	49%	4.9 KB
5	paganini.bofh.team	1.1 MB	0.0 KB	169.5 KB	1.3 MB	87%	2.4 KB
6	news-out.neodome.net	939.1 KB	2.0 KB	195.7 KB	1.1 MB	82%	4.1 KB
7	news.swapon.de	766.9 KB	0.0 KB	0.9 KB	767.8 KB	99%	3.2 KB
8	i2pn-out.feed.uzoreto.com	248.8 KB	0.0 KB	8.1 MB	8.4 MB	2%	1.7 KB
9	i2pn2.org	166.6 KB	0.0 KB	0.0 KB	166.6 KB	100%	2.4 KB
10	news.samoylyk.net	152.7 KB	4.7 KB	4.7 KB	162.1 KB	94%	3.9 KB
11	news.nntp4.net	92.8 KB	0.0 KB	552.5 KB	645.3 KB	14%	6.5 KB
12	novabbs.org	59.9 KB	0.0 KB	0.0 KB	59.9 KB	100%	8.6 KB
13	news.niel.me	42.4 KB	0.0 KB	0.0 KB	42.4 KB	100%	3.0 KB
14	dodin.fr.nf	34.8 KB	0.0 KB	0.9 KB	35.7 KB	97%	1.8 KB
15	news.bbs.nz	5.0 KB	1.8 KB	1.8 KB	8.7 KB	57%	1.7 KB
16	kf5zxw.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
17	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 17		42.6 MB	11.0 KB	16.5 MB	59.2 MB	72%	3.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 7 04:15:01 - 04:59:59	219	1.9%	0.08	862.1 KB	1.9%	0.32
May 7 05:00:00 - 05:59:59	375	3.3%	0.10	1.8 MB	4.0%	0.50
May 7 06:00:00 - 06:59:59	327	2.9%	0.09	941.6 KB	2.1%	0.26
May 7 07:00:00 - 07:59:59	502	4.4%	0.14	1.5 MB	3.4%	0.42
May 7 08:00:00 - 08:59:59	534	4.7%	0.15	1.6 MB	3.6%	0.45
May 7 09:00:00 - 09:59:59	575	5.0%	0.16	1.8 MB	4.0%	0.50
May 7 10:00:00 - 10:59:59	568	5.0%	0.16	2.0 MB	4.5%	0.57
May 7 11:00:00 - 11:59:59	512	4.5%	0.14	1.8 MB	4.0%	0.51
May 7 12:00:00 - 12:59:59	544	4.8%	0.15	2.0 MB	4.6%	0.58
May 7 13:00:00 - 13:59:59	638	5.6%	0.18	1.8 MB	4.0%	0.50
May 7 14:00:00 - 14:59:59	483	4.2%	0.13	1.5 MB	3.4%	0.43
May 7 15:00:00 - 15:59:59	585	5.1%	0.16	1.8 MB	4.1%	0.51
May 7 16:00:00 - 16:59:59	720	6.3%	0.20	3.6 MB	8.1%	1.02
May 7 17:00:00 - 17:59:59	594	5.2%	0.17	1.8 MB	4.1%	0.52
May 7 18:00:00 - 18:59:59	541	4.7%	0.15	1.4 MB	3.2%	0.40
May 7 19:00:00 - 19:59:59	585	5.1%	0.16	1.5 MB	3.5%	0.44
May 7 20:00:00 - 20:59:59	626	5.5%	0.17	3.3 MB	7.5%	0.95
May 7 21:00:00 - 21:59:59	484	4.2%	0.13	2.0 MB	4.6%	0.58
May 7 22:00:00 - 22:59:59	486	4.2%	0.14	2.2 MB	5.0%	0.63
May 7 23:00:00 - 23:59:59	372	3.2%	0.10	1.9 MB	4.3%	0.55
May 8 00:00:00 - 00:59:59	290	2.5%	0.08	2.7 MB	6.0%	0.75
May 8 01:00:00 - 01:59:59	251	2.2%	0.07	844.3 KB	1.9%	0.23
May 8 02:00:00 - 02:59:59	251	2.2%	0.07	949.4 KB	2.1%	0.26
May 8 03:00:00 - 03:59:59	281	2.5%	0.08	2.4 MB	5.4%	0.69
May 8 04:00:00 - 04:15:01	108	0.9%	0.12	369.2 KB	0.8%	0.41
TOTAL: 24:00:00	11451	100.0%	0.13	44.3 MB	100.0%	0.52

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	i2pn-out.feed.uzoreto.com	4977	4623	0	354
2	feeder.eternal-september.org	357	15	0	342
3	usenet.goja.nl.eu.org	241	1	1	239
4	i2pn-out.news.weretis.net	207	1	0	206
5	news.swapon.de	120	0	0	120
6	news-out.aioe.org	117	14	0	103
7	news-out.neodome.net	57	0	1	56
8	news.nntp4.net	55	8	0	47
9	paganini.bofh.team	20	1	0	19
10	news.samoylyk.net	2	0	2	0
11	news.bbs.nz	1	0	1	0
12	dodin.fr.nf	1	0	0	1
TOTAL: 12		6155	4663	5	1487

Unwanted newsgroups [Top 20]:

Newsgroup	Count
talk.english.tw	3193
talk.russian.tg	745
talk.ukrainian.tg	549
talk.english.tg	97
talk.generic.ua.ws	26
att.jobs	10
winnipeg.general	8
alt.politics.liberal	7
sympatico.highspeed	6
comp.hackers	4
aus.jobs	4
news.oriens-occasus.ru	3
talk.from.diary	2
alt.games.programming	1
alt.music.pink-floyd.publius	1
alt.alt.alt.alt	1
fr.petites-annonces.divers	1
alt.consumers	1
rec.electronics	1
sportteamtgbornheim.de	1
TOTAL: 22	4663

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	622
Too many newsgroups	246
EMP (fsl)	143
Poison newsgroup	138
MID-Bot	21
User-issued cancel	4
Too many newsgroups (meow)	3
Scoring filter (8)	2
U2 violation - invalid distribution	1
TOTAL: 9	1180

INND no permission servers:

System	Conn
159.223.46.224	40
71.6.199.23	2
80.82.77.139	2
192.241.222.201	1
162.142.125.9	1
62.233.50.179	1
TOTAL: 6	47

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	i2pn-out.feed.uzoreto.com	11
	TOTAL: 1	11
Including strange strings
	news.swapon.de	119
	i2pn-out.news.weretis.net	114
	news-out.aioe.org	50
	usenet.goja.nl.eu.org	9
	feeder.eternal-september.org	4
	news-out.neodome.net	3
	paganini.bofh.team	1
	TOTAL: 7	300
No colon-space in header
	i2pn-out.feed.uzoreto.com	6
	TOTAL: 1	6
TOTAL: 3		317

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn2	11326	10076	200	731	7	88%	23:59:51
2	novabbs	11528	9797	360	1057	0	84%	23:59:51
3	aioe	6582	250	6169	43	4	3%	23:59:51
4	news.bbs.nz	22629	139	11238	62	57	0%	23:59:51
5	news.niel.me	3706	103	3490	89	0	2%	23:58:03
6	paganini.bofh.team	11310	103	10870	0	8	0%	23:59:45
7	neodome	11397	97	10981	0	0	0%	23:59:50
8	news.nntp4.net	11821	92	11310	6	8	0%	23:59:28
9	news.samoylyk.net	11589	89	11172	5	0	0%	23:59:51
10	news.uzoreto.com	8999	88	8558	0	0	0%	23:59:51
11	eternal-september	9677	86	9277	6	0	0%	23:59:51
12	weretis.net	10250	74	7742	649	1	0%	23:59:44
13	usenet.goja.nl.eu.org	10991	59	10448	41	10	0%	23:59:51
14	dodin.fr.nf	1393	11	754	2	0	0%	19:34:58
15	swapon.de	957	5	903	0	0	0%	23:36:34
16	kf5zxw.com	0	0	0	0	11451	0%	23:57:42
TOTAL: 16		144155	21069	103472	2691	11546	14%	379:04:52

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	novabbs	38.0 MB	4.1 MB	42.1 MB	0.5 KB/s	4.0 KB	23:59:51
2	i2pn2	27.4 MB	2.7 MB	30.1 MB	0.4 KB/s	2.9 KB	23:59:51
3	aioe	1016.7 KB	152.3 KB	1.1 MB	0.0 KB/s	4.0 KB	23:59:51
4	dodin.fr.nf	577.7 KB	3.8 KB	581.5 KB	0.0 KB/s	44.7 KB	19:34:58
5	news.bbs.nz	507.9 KB	337.2 KB	845.1 KB	0.0 KB/s	4.2 KB	23:59:51
6	news.niel.me	359.9 KB	337.8 KB	697.7 KB	0.0 KB/s	3.6 KB	23:58:03
7	paganini.bofh.team	281.9 KB	0.0 KB	281.9 KB	0.0 KB/s	2.7 KB	23:59:45
8	neodome	273.7 KB	0.0 KB	273.7 KB	0.0 KB/s	2.8 KB	23:59:50
9	news.uzoreto.com	241.0 KB	0.0 KB	241.0 KB	0.0 KB/s	2.7 KB	23:59:51
10	news.nntp4.net	214.1 KB	56.7 KB	270.8 KB	0.0 KB/s	2.8 KB	23:59:28
11	news.samoylyk.net	201.3 KB	55.7 KB	256.9 KB	0.0 KB/s	2.7 KB	23:59:51
12	eternal-september	195.8 KB	56.7 KB	252.5 KB	0.0 KB/s	2.7 KB	23:59:51
13	weretis.net	159.9 KB	1.3 MB	1.5 MB	0.0 KB/s	2.1 KB	23:59:44
14	usenet.goja.nl.eu.org	156.4 KB	113.1 KB	269.5 KB	0.0 KB/s	2.7 KB	23:59:51
15	swapon.de	12.8 KB	0.0 KB	12.8 KB	0.0 KB/s	2.6 KB	23:36:34
16	kf5zxw.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:42
TOTAL: 16		69.5 MB	9.2 MB	78.7 MB	0.1 KB/s	3.4 KB	379:04:52

Daily Usenet report

May 7 04:15:01 -- May 8 04:15:01