Daily Usenet report: May 3 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	24015	60.8%	4.6 MB	68.7%
innd	12347	31.3%	1.6 MB	23.4%
innfeed	3121	7.9%	542.5 KB	7.8%
nocem	2	0.0%	0.1 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 5	39486	100.0%	6.8 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	123602	51.1%
Negative hits	94734	39.2%
Do not exist	23445	9.7%
Cache misses	63	0.0%
TOTAL: 4	241844	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.033	0.0%	64	0.000	0.516	1.875
article cleanup	00:00:00.150	0.0%	23522	0.000	0.006	0.028
article logging	00:00:00.751	0.0%	23911	0.000	0.031	0.091
article parse	00:00:00.322	0.0%	51822	0.000	0.006	0.028
article write	00:00:08.637	0.0%	13486	0.054	0.640	41.410
artlog/artcncl	00:00:00.001	0.0%	61	0.000	0.016	1.000
artlog/artparse	00:00:00.000	0.0%	3	0.000	0.000	0.000
data move	00:00:00.067	0.0%	247448	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.000	0.0%	64	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	64	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.941	0.0%	242723	0.000	0.004	0.008
history sync	00:00:00.019	0.0%	305	0.000	0.062	0.500
history write	00:00:02.707	0.0%	23516	0.000	0.115	6.924
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:58:52.210	99.9%	259299	200.267	332.945	1259.884
nntp read	00:00:01.927	0.0%	258558	0.002	0.007	0.015
overview write	00:00:03.624	0.0%	13486	0.000	0.269	5.506
perl filter	00:00:24.378	0.0%	23512	0.731	1.037	3.824
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.901	0.0%	27130	0.000	0.033	0.084
TOTAL: 24:00:19.590	23:59:36.668	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.022	0.0%	13595	0.000	0.002	0.023
article prepare	00:00:00.009	0.0%	128064	0.000	0.000	0.002
article read	00:00:00.837	0.0%	13271	0.000	0.063	0.769
backlog stats	00:00:00.374	0.0%	354293	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.753	0.0%	229252	0.002	0.008	0.016
data write	00:00:01.869	0.0%	216654	0.003	0.009	0.019
idle	23:56:33.466	100.0%	354293	127.715	243.283	706.694
status file	00:00:00.183	0.0%	299	0.000	0.612	1.500
TOTAL: 23:56:47.880	23:56:38.513	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	5	24780	5229	19434	117	21%	47:29:07
2	news-out.aioe.org	3	10494	3721	6713	60	35%	24:08:59
3	feeder.eternal-september.org	27	6147	2533	3406	208	41%	27:51:17
4	usenet.goja.nl.eu.org	12	13726	578	12991	157	4%	24:08:22
5	news.swapon.de	6	1302	397	904	1	30%	23:37:24
6	paganini.bofh.team	1	10044	396	9634	14	3%	15:09:11
7	news-out.neodome.net	1	12983	243	12706	34	1%	23:59:56
8	i2pn2.org	18	92	88	4	0	95%	05:34:17
9	news.nntp4.net	2	14012	73	13776	163	0%	23:59:54
10	i2pn-out.feed.uzoreto.com	1626	23058	61	13696	9301	0%	71:18:19
11	news.samoylyk.net	2	11857	47	11808	2	0%	23:59:49
12	dodin.fr.nf	15	833	21	812	0	2%	20:11:33
13	news.niel.me	2	3209	15	3193	1	0%	23:59:03
14	novabbs.org	17	92	4	88	0	4%	05:25:11
15	news.bbs.nz	2	4704	1	4703	0	0%	11:45:36
16	kf5zxw.com	1	0	0	0	0	0%	00:10:02
17	localhost	26	0	0	0	0	0%	00:00:00
TOTAL: 17		1766	137333	13407	113868	10058	9%	372:48:00

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn-out.news.weretis.net	21.9 MB	23.9 KB	942.3 KB	22.8 MB	95%	4.4 KB
2	feeder.eternal-september.org	9.5 MB	0.0 KB	2.9 MB	12.4 MB	76%	4.6 KB
3	news-out.aioe.org	8.8 MB	0.0 KB	204.5 KB	9.0 MB	97%	2.4 KB
4	usenet.goja.nl.eu.org	1.4 MB	11.2 KB	522.6 KB	1.9 MB	73%	2.7 KB
5	paganini.bofh.team	1.1 MB	0.0 KB	409.9 KB	1.5 MB	72%	3.7 KB
6	news.swapon.de	853.3 KB	1.6 KB	1.6 KB	856.4 KB	99%	2.2 KB
7	news-out.neodome.net	697.7 KB	0.0 KB	110.9 KB	808.6 KB	86%	2.9 KB
8	news.nntp4.net	251.2 KB	0.0 KB	11.3 MB	11.6 MB	2%	50.2 KB
9	i2pn2.org	198.0 KB	0.0 KB	0.0 KB	198.0 KB	100%	2.2 KB
10	i2pn-out.feed.uzoreto.com	183.3 KB	0.0 KB	10.9 MB	11.1 MB	1%	1.2 KB
11	news.samoylyk.net	175.3 KB	12.7 KB	12.7 KB	200.6 KB	87%	4.1 KB
12	dodin.fr.nf	44.7 KB	0.0 KB	0.0 KB	44.7 KB	100%	2.1 KB
13	news.niel.me	42.9 KB	11.0 KB	11.0 KB	64.9 KB	66%	4.1 KB
14	novabbs.org	42.6 KB	0.0 KB	0.0 KB	42.6 KB	100%	10.6 KB
15	news.bbs.nz	0.7 KB	0.0 KB	0.0 KB	0.7 KB	100%	0.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		45.0 MB	60.4 KB	27.4 MB	72.5 MB	62%	3.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 3 04:15:01 - 04:59:59	334	2.5%	0.12	939.0 KB	2.0%	0.35
May 3 05:00:00 - 05:59:59	336	2.5%	0.09	2.0 MB	4.5%	0.58
May 3 06:00:00 - 06:59:59	467	3.5%	0.13	1.2 MB	2.5%	0.33
May 3 07:00:00 - 07:59:59	507	3.8%	0.14	1.7 MB	3.8%	0.49
May 3 08:00:00 - 08:59:59	645	4.8%	0.18	2.0 MB	4.4%	0.57
May 3 09:00:00 - 09:59:59	780	5.8%	0.22	3.0 MB	6.7%	0.86
May 3 10:00:00 - 10:59:59	733	5.4%	0.20	2.7 MB	6.0%	0.78
May 3 11:00:00 - 11:59:59	652	4.8%	0.18	2.1 MB	4.6%	0.60
May 3 12:00:00 - 12:59:59	608	4.5%	0.17	2.0 MB	4.4%	0.57
May 3 13:00:00 - 13:59:59	675	5.0%	0.19	1.7 MB	3.8%	0.48
May 3 14:00:00 - 14:59:59	866	6.4%	0.24	3.1 MB	6.9%	0.89
May 3 15:00:00 - 15:59:59	795	5.9%	0.22	3.1 MB	6.8%	0.88
May 3 16:00:00 - 16:59:59	809	6.0%	0.22	2.7 MB	5.9%	0.76
May 3 17:00:00 - 17:59:59	734	5.4%	0.20	2.5 MB	5.6%	0.72
May 3 18:00:00 - 18:59:59	699	5.2%	0.19	1.7 MB	3.8%	0.48
May 3 19:00:00 - 19:59:59	726	5.4%	0.20	2.5 MB	5.5%	0.71
May 3 20:00:00 - 20:59:59	625	4.6%	0.17	1.7 MB	3.8%	0.49
May 3 21:00:00 - 21:59:59	590	4.4%	0.16	1.7 MB	3.9%	0.50
May 3 22:00:00 - 22:59:59	387	2.9%	0.11	1.2 MB	2.6%	0.33
May 3 23:00:00 - 23:59:59	311	2.3%	0.09	851.4 KB	1.8%	0.24
May 4 00:00:00 - 00:59:59	243	1.8%	0.07	1.0 MB	2.3%	0.29
May 4 01:00:00 - 01:59:59	338	2.5%	0.09	1.9 MB	4.1%	0.53
May 4 02:00:00 - 02:59:59	278	2.1%	0.08	1.1 MB	2.3%	0.30
May 4 03:00:00 - 03:59:59	253	1.9%	0.07	709.8 KB	1.5%	0.20
May 4 04:00:00 - 04:15:01	84	0.6%	0.09	235.7 KB	0.5%	0.26
TOTAL: 24:00:00	13475	100.0%	0.16	45.3 MB	100.0%	0.54

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	i2pn-out.feed.uzoreto.com	9338	6579	0	2759
2	i2pn-out.news.weretis.net	257	0	3	254
3	feeder.eternal-september.org	214	0	0	214
4	news.swapon.de	211	0	1	210
5	news.nntp4.net	158	0	1	157
6	usenet.goja.nl.eu.org	151	0	1	150
7	news-out.aioe.org	88	20	0	68
8	news-out.neodome.net	29	0	0	29
9	paganini.bofh.team	29	2	0	27
10	news.samoylyk.net	3	0	2	1
11	news.niel.me	1	0	1	0
TOTAL: 11		10479	6601	9	3869

Unwanted newsgroups [Top 20]:

Newsgroup	Count
talk.english.tw	4564
talk.russian.tg	862
talk.ukrainian.tg	689
alt.jobs.search.tw	314
talk.english.tg	74
talk.generic.ua.ws	27
news.oriens-occasus.ru	25
att.jobs	13
comp.hackers	11
0.0ssptest	7
aus.jobs	4
talk.from.diary	3
alt.music.pink-floyd.publius	2
aioe.helpdesk	2
tottenham.hotspurs	1
biz.marketplace	1
rec.travel.resorts.all	1
alt.info-science	1
TOTAL: 18	6601

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2742
EMP (fsl)	416
Too many newsgroups	158
Poison newsgroup	140
User-issued cancel	7
HTML Multipart	6
Scoring filter (15)	5
hierarchy violation - crosspost outside netscape	1
Malformed article	1
TOTAL: 9	3476

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	1	0	1	1
TOTAL: 1	1	0	1	1

INND no permission servers:

System	Conn
172.105.87.91	36
167.94.138.46	2
44.234.87.170	1
TOTAL: 3	39

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	i2pn-out.feed.uzoreto.com	3
	TOTAL: 1	3
Including strange strings
	news.swapon.de	210
	i2pn-out.news.weretis.net	133
	news-out.aioe.org	27
	usenet.goja.nl.eu.org	8
	feeder.eternal-september.org	8
	paganini.bofh.team	1
	news.samoylyk.net	1
	news-out.neodome.net	1
	TOTAL: 8	389
No colon-space in header
	i2pn-out.feed.uzoreto.com	2
	TOTAL: 1	2
TOTAL: 3		394

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn2	13601	11647	350	1078	26	85%	23:59:50
2	novabbs	13693	11490	508	1256	0	83%	23:59:36
3	aioe	9641	2427	6849	42	0	25%	23:59:44
4	news.niel.me	4697	1182	3200	268	0	25%	23:59:53
5	news.bbs.nz	26077	657	12717	95	84	2%	23:59:13
6	news.uzoreto.com	14292	250	11070	2	0	1%	23:59:53
7	usenet.goja.nl.eu.org	15647	154	12600	37	19	0%	23:59:53
8	paganini.bofh.team	15789	145	12846	0	0	0%	23:59:37
9	neodome	15924	137	12974	0	0	0%	23:59:53
10	weretis.net	13989	122	7419	633	11	0%	23:59:53
11	eternal-september	13737	114	10775	9	0	0%	23:59:33
12	news.samoylyk.net	16216	108	13189	38	0	0%	23:59:47
13	news.nntp4.net	16300	90	13311	3	2	0%	23:59:30
14	dodin.fr.nf	1471	44	809	0	0	2%	20:02:47
15	swapon.de	1525	38	1248	0	0	2%	23:53:53
16	kf5zxw.com	0	0	0	0	13475	0%	23:57:44
TOTAL: 16		192599	28605	119865	3461	13617	14%	379:50:39

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	novabbs	38.7 MB	4.2 MB	42.9 MB	0.5 KB/s	3.4 KB	23:59:36
2	i2pn2	30.9 MB	3.4 MB	34.2 MB	0.4 KB/s	2.8 KB	23:59:50
3	aioe	8.0 MB	151.0 KB	8.2 MB	0.1 KB/s	3.4 KB	23:59:44
4	news.niel.me	4.2 MB	734.2 KB	4.9 MB	0.1 KB/s	3.5 KB	23:59:53
5	news.bbs.nz	2.8 MB	396.7 KB	3.2 MB	0.0 KB/s	4.3 KB	23:59:13
6	news.uzoreto.com	673.8 KB	3.3 KB	677.1 KB	0.0 KB/s	2.7 KB	23:59:53
7	usenet.goja.nl.eu.org	529.2 KB	95.3 KB	624.5 KB	0.0 KB/s	3.3 KB	23:59:53
8	news.nntp4.net	521.4 KB	39.6 KB	560.9 KB	0.0 KB/s	6.0 KB	23:59:30
9	paganini.bofh.team	389.7 KB	0.0 KB	389.7 KB	0.0 KB/s	2.7 KB	23:59:37
10	neodome	363.7 KB	0.0 KB	363.7 KB	0.0 KB/s	2.7 KB	23:59:53
11	eternal-september	301.6 KB	48.0 KB	349.6 KB	0.0 KB/s	2.8 KB	23:59:33
12	weretis.net	281.6 KB	1.0 MB	1.3 MB	0.0 KB/s	1.8 KB	23:59:53
13	news.samoylyk.net	270.0 KB	127.2 KB	397.1 KB	0.0 KB/s	2.7 KB	23:59:47
14	dodin.fr.nf	137.7 KB	0.0 KB	137.7 KB	0.0 KB/s	3.1 KB	20:02:47
15	swapon.de	89.0 KB	0.0 KB	89.0 KB	0.0 KB/s	2.3 KB	23:53:53
16	kf5zxw.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:44
TOTAL: 16		88.1 MB	10.2 MB	98.3 MB	0.1 KB/s	3.1 KB	379:50:39

Daily Usenet report

May 3 04:15:01 -- May 4 04:15:01