Daily Usenet report: May 8 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	17919	57.7%	3.6 MB	65.9%
innd	9908	31.9%	1.4 MB	24.6%
innfeed	3200	10.3%	541.9 KB	9.6%
nocem	1	0.0%	0.2 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 5	31029	100.0%	5.5 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	108814	47.8%
Negative hits	101380	44.5%
Do not exist	17464	7.7%
Cache misses	62	0.0%
TOTAL: 4	227720	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.019	0.0%	77	0.000	0.247	1.000
article cleanup	00:00:00.108	0.0%	17480	0.000	0.006	0.028
article logging	00:00:00.683	0.0%	17821	0.000	0.038	0.855
article parse	00:00:00.262	0.0%	34986	0.000	0.007	0.031
article write	00:00:05.336	0.0%	11616	0.047	0.459	15.658
artlog/artcncl	00:00:00.001	0.0%	77	0.000	0.013	0.500
artlog/artparse	00:00:00.000	0.0%	8	0.000	0.000	0.000
data move	00:00:00.063	0.0%	230429	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.001	0.0%	74	0.000	0.014	1.000
hishave/artcncl	00:00:00.000	0.0%	77	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.862	0.0%	228014	0.001	0.004	0.010
history sync	00:00:00.004	0.0%	305	0.000	0.013	0.500
history write	00:00:04.528	0.0%	17480	0.000	0.259	14.441
hiswrite/artcncl	00:00:00.000	0.0%	3	0.000	0.000	0.000
idle	23:59:08.024	99.9%	237514	210.319	363.549	911.816
nntp read	00:00:01.846	0.0%	236913	0.003	0.008	0.014
overview write	00:00:02.327	0.0%	11616	0.000	0.200	11.491
perl filter	00:00:19.263	0.0%	17472	0.755	1.103	2.922
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.794	0.0%	23344	0.000	0.034	0.084
TOTAL: 24:00:20.768	23:59:44.121	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.024	0.0%	11720	0.000	0.002	0.029
article prepare	00:00:00.010	0.0%	96600	0.000	0.000	0.002
article read	00:00:01.064	0.0%	11432	0.000	0.093	6.739
backlog stats	00:00:00.298	0.0%	240152	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.439	0.0%	171658	0.002	0.008	0.016
data write	00:00:01.332	0.0%	161457	0.000	0.008	0.019
idle	23:55:22.808	100.0%	240152	194.242	358.618	989.307
status file	00:00:00.764	0.0%	353	0.000	2.164	61.200
TOTAL: 23:55:37.541	23:55:27.739	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	11028	3704	7293	31	33%	24:09:49
2	usenet.goja.nl.eu.org	13	11401	3100	8124	177	27%	22:41:17
3	feeder.eternal-september.org	31	3147	2133	809	205	67%	28:17:57
4	i2pn-out.news.weretis.net	4	19889	1663	18171	55	8%	43:28:04
5	paganini.bofh.team	2	15517	457	15047	13	2%	32:01:33
6	news.swapon.de	13	1056	268	787	1	25%	23:01:11
7	news-out.neodome.net	1	11078	186	10875	17	1%	23:59:57
8	2a01:4f8:c17:a9e2::8e	0	701	64	624	13	9%	02:28:20
9	i2pn-out.feed.uzoreto.com	1695	17378	64	12039	5275	0%	70:44:05
10	i2pn2.org	17	66	63	3	0	95%	04:24:35
11	news.nntp4.net	1	12052	43	11944	65	0%	23:59:54
12	dodin.fr.nf	19	631	36	595	0	5%	19:29:18
13	news.samoylyk.net	2	10459	18	10439	2	0%	23:59:48
14	news.bbs.nz	7	15844	6	15837	1	0%	38:34:34
15	news.niel.me	2	3598	5	3592	1	0%	23:59:09
16	novabbs.org	16	64	3	61	0	4%	04:15:22
17	localhost	25	0	0	0	0	0%	00:00:00
18	kf5zxw.com	1	0	0	0	0	0%	00:10:03
TOTAL: 18		1851	133909	11813	116240	5856	8%	409:44:56

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn-out.news.weretis.net	14.0 MB	3.2 KB	278.7 KB	14.3 MB	98%	8.5 KB
2	feeder.eternal-september.org	9.3 MB	0.0 KB	3.0 MB	12.3 MB	75%	5.4 KB
3	news-out.aioe.org	9.1 MB	3.1 KB	67.7 KB	9.1 MB	99%	2.5 KB
4	usenet.goja.nl.eu.org	7.9 MB	5.5 KB	1.3 MB	9.3 MB	85%	2.9 KB
5	paganini.bofh.team	1.2 MB	0.0 KB	61.5 KB	1.2 MB	95%	2.7 KB
6	news.swapon.de	750.0 KB	0.0 KB	0.7 KB	750.7 KB	99%	2.8 KB
7	news-out.neodome.net	624.0 KB	2.4 KB	207.5 KB	833.8 KB	74%	4.1 KB
8	news.nntp4.net	209.5 KB	0.0 KB	1.8 MB	2.0 MB	10%	19.3 KB
9	2a01:4f8:c17:a9e2::8e	149.9 KB	0.0 KB	496.2 KB	646.1 KB	23%	8.4 KB
10	i2pn2.org	133.4 KB	0.0 KB	0.0 KB	133.4 KB	100%	2.1 KB
11	i2pn-out.feed.uzoreto.com	125.8 KB	0.0 KB	9.3 MB	9.4 MB	1%	1.8 KB
12	news.samoylyk.net	67.2 KB	5.6 KB	5.6 KB	78.4 KB	85%	3.9 KB
13	dodin.fr.nf	57.7 KB	0.0 KB	0.0 KB	57.7 KB	100%	1.6 KB
14	novabbs.org	37.8 KB	0.0 KB	0.0 KB	37.8 KB	100%	12.6 KB
15	news.niel.me	10.0 KB	0.0 KB	1.4 KB	11.5 KB	87%	1.9 KB
16	news.bbs.nz	8.1 KB	1.4 KB	1.4 KB	10.9 KB	74%	1.6 KB
17	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
18	kf5zxw.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 18		43.6 MB	21.2 KB	16.5 MB	60.1 MB	72%	3.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 8 04:15:01 - 04:59:59	169	1.5%	0.06	647.2 KB	1.5%	0.24
May 8 05:00:00 - 05:59:59	240	2.1%	0.07	686.6 KB	1.6%	0.19
May 8 06:00:00 - 06:59:59	403	3.5%	0.11	1.2 MB	2.8%	0.33
May 8 07:00:00 - 07:59:59	425	3.7%	0.12	1018.0 KB	2.4%	0.28
May 8 08:00:00 - 08:59:59	523	4.5%	0.15	2.7 MB	6.5%	0.77
May 8 09:00:00 - 09:59:59	582	5.0%	0.16	1.7 MB	4.0%	0.48
May 8 10:00:00 - 10:59:59	449	3.9%	0.12	1.1 MB	2.6%	0.31
May 8 11:00:00 - 11:59:59	536	4.6%	0.15	2.0 MB	4.8%	0.57
May 8 12:00:00 - 12:59:59	615	5.3%	0.17	2.0 MB	4.7%	0.56
May 8 13:00:00 - 13:59:59	567	4.9%	0.16	2.6 MB	6.3%	0.75
May 8 14:00:00 - 14:59:59	596	5.1%	0.17	2.6 MB	6.3%	0.75
May 8 15:00:00 - 15:59:59	527	4.5%	0.15	1.4 MB	3.3%	0.39
May 8 16:00:00 - 16:59:59	691	5.9%	0.19	2.1 MB	5.1%	0.61
May 8 17:00:00 - 17:59:59	702	6.0%	0.20	3.4 MB	8.1%	0.96
May 8 18:00:00 - 18:59:59	783	6.7%	0.22	2.9 MB	7.0%	0.84
May 8 19:00:00 - 19:59:59	616	5.3%	0.17	1.7 MB	4.0%	0.48
May 8 20:00:00 - 20:59:59	593	5.1%	0.16	2.2 MB	5.2%	0.61
May 8 21:00:00 - 21:59:59	514	4.4%	0.14	1.8 MB	4.4%	0.53
May 8 22:00:00 - 22:59:59	441	3.8%	0.12	1.2 MB	2.9%	0.34
May 8 23:00:00 - 23:59:59	390	3.4%	0.11	1.7 MB	4.0%	0.47
May 9 00:00:00 - 00:59:59	316	2.7%	0.09	1.8 MB	4.2%	0.50
May 9 01:00:00 - 01:59:59	283	2.4%	0.08	1.1 MB	2.6%	0.31
May 9 02:00:00 - 02:59:59	269	2.3%	0.07	984.1 KB	2.3%	0.27
May 9 03:00:00 - 03:59:59	289	2.5%	0.08	955.9 KB	2.2%	0.27
May 9 04:00:00 - 04:15:02	100	0.9%	0.11	466.0 KB	1.1%	0.52
TOTAL: 24:00:01	11619	100.0%	0.13	41.8 MB	100.0%	0.50

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	i2pn-out.feed.uzoreto.com	5277	5092	0	185
2	usenet.goja.nl.eu.org	299	0	2	297
3	feeder.eternal-september.org	220	1	0	219
4	i2pn-out.news.weretis.net	121	0	1	120
5	news.swapon.de	120	0	0	120
6	news-out.aioe.org	70	3	1	66
7	news.nntp4.net	65	0	0	65
8	news-out.neodome.net	18	0	1	17
9	2a01:4f8:c17:a9e2::8e	14	0	0	14
10	paganini.bofh.team	14	2	0	12
11	news.samoylyk.net	2	0	2	0
12	news.niel.me	1	0	0	1
13	news.bbs.nz	1	0	1	0
TOTAL: 13		6222	5098	8	1116

Unwanted newsgroups [Top 20]:

Newsgroup	Count
talk.english.tw	3620
talk.russian.tg	809
talk.ukrainian.tg	517
talk.english.tg	110
talk.generic.ua.ws	25
comp.hackers	4
news.oriens-occasus.ru	3
talk.from.diary	2
alt.jobs.search.tw	2
news.test	1
alt.politics.liberal	1
alt.religion.islam.arabic	1
microsoft.public.fr.windowsnt	1
alt.islam	1
biz.marketplace	1
TOTAL: 15	5098

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	504
Too many newsgroups	156
Poison newsgroup	68
User-issued cancel	15
HTML Multipart	11
EMP (fsl)	9
Scoring filter (9)	2
Binary: misplaced obj	1
Binary: misplaced rar	1
TOTAL: 9	767

INND no permission servers:

System	Conn
2a01:4f8:c17:a9e2::8e	12
194.165.16.11	3
62.233.50.179	1
TOTAL: 3	16

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	i2pn-out.feed.uzoreto.com	1
	TOTAL: 1	1
Including strange strings
	news.swapon.de	119
	usenet.goja.nl.eu.org	117
	i2pn-out.news.weretis.net	62
	news-out.aioe.org	34
	feeder.eternal-september.org	4
	i2pn-out.feed.uzoreto.com	2
	news-out.neodome.net	1
	2a01:4f8:c17:a9e2::8e	1
	paganini.bofh.team	1
	TOTAL: 9	341
No colon-space in header
	i2pn-out.feed.uzoreto.com	8
	TOTAL: 1	8
TOTAL: 3		350

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn2	11617	10160	297	808	6	87%	23:59:53
2	novabbs	11819	10015	446	969	1	84%	23:59:53
3	aioe	7565	355	7068	10	0	4%	23:59:53
4	news.bbs.nz	22914	189	11369	47	108	0%	23:59:48
5	news.niel.me	4156	142	3873	117	0	3%	23:59:53
6	paganini.bofh.team	11628	110	11137	0	0	0%	23:59:45
7	neodome	11678	105	11199	0	0	0%	23:59:10
8	news.nntp4.net	12040	102	11461	5	12	0%	23:59:46
9	news.uzoreto.com	9764	101	9250	0	0	1%	23:59:53
10	news.samoylyk.net	11867	100	11389	3	0	0%	23:59:53
11	eternal-september	9772	97	9300	6	0	0%	23:59:51
12	weretis.net	9410	93	7559	541	0	0%	23:59:53
13	usenet.goja.nl.eu.org	8882	59	8241	53	8	0%	23:59:53
14	dodin.fr.nf	1075	17	595	0	0	1%	19:53:20
15	kf5zxw.com	0	0	0	0	11619	0%	23:57:42
16	swapon.de	1047	0	1009	0	0	0%	23:44:41
TOTAL: 16		145234	21645	104193	2559	11754	14%	379:33:07

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	novabbs	36.1 MB	3.4 MB	39.5 MB	0.5 KB/s	3.7 KB	23:59:53
2	i2pn2	27.6 MB	2.7 MB	30.2 MB	0.4 KB/s	2.8 KB	23:59:53
3	aioe	1.2 MB	55.2 KB	1.3 MB	0.0 KB/s	3.5 KB	23:59:53
4	news.bbs.nz	580.5 KB	136.8 KB	717.3 KB	0.0 KB/s	3.0 KB	23:59:48
5	dodin.fr.nf	473.7 KB	0.0 KB	473.7 KB	0.0 KB/s	27.9 KB	19:53:20
6	news.niel.me	451.2 KB	402.1 KB	853.2 KB	0.0 KB/s	3.3 KB	23:59:53
7	paganini.bofh.team	243.4 KB	0.0 KB	243.4 KB	0.0 KB/s	2.2 KB	23:59:45
8	neodome	237.0 KB	0.0 KB	237.0 KB	0.0 KB/s	2.3 KB	23:59:10
9	news.uzoreto.com	227.5 KB	0.0 KB	227.5 KB	0.0 KB/s	2.3 KB	23:59:53
10	news.nntp4.net	204.0 KB	41.5 KB	245.5 KB	0.0 KB/s	2.3 KB	23:59:46
11	news.samoylyk.net	196.8 KB	37.8 KB	234.6 KB	0.0 KB/s	2.3 KB	23:59:53
12	eternal-september	188.6 KB	43.1 KB	231.7 KB	0.0 KB/s	2.2 KB	23:59:51
13	weretis.net	180.3 KB	959.7 KB	1.1 MB	0.0 KB/s	1.8 KB	23:59:53
14	usenet.goja.nl.eu.org	142.5 KB	117.8 KB	260.3 KB	0.0 KB/s	2.3 KB	23:59:53
15	kf5zxw.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:42
16	swapon.de	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:44:41
TOTAL: 16		67.9 MB	7.8 MB	75.8 MB	0.1 KB/s	3.2 KB	379:33:07

Daily Usenet report

May 8 04:15:01 -- May 9 04:15:02