Daily Usenet report: Apr 6 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	26246	58.4%	5.1 MB	67.4%
innd	15550	34.6%	1.9 MB	25.5%
innfeed	3138	7.0%	551.8 KB	7.1%
nocem	9	0.0%	0.8 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	44944	100.0%	7.6 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	150849	51.7%
Negative hits	114775	39.4%
Do not exist	25827	8.9%
Cache misses	55	0.0%
TOTAL: 4	291506	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.053	0.0%	61	0.000	0.869	3.300
article cleanup	00:00:00.121	0.0%	25932	0.000	0.005	0.031
article logging	00:00:00.797	0.0%	26196	0.000	0.030	0.086
article parse	00:00:00.367	0.0%	47389	0.000	0.008	0.025
article write	00:00:06.622	0.0%	15485	0.044	0.428	10.010
artlog/artcncl	00:00:00.000	0.0%	60	0.000	0.000	0.000
artlog/artparse	00:00:00.000	0.0%	3	0.000	0.000	0.000
data move	00:00:00.093	0.0%	290419	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.000	0.0%	61	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	61	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:01.054	0.0%	292105	0.001	0.004	0.011
history sync	00:00:01.134	0.0%	307	0.000	3.694	563.500
history write	00:00:02.416	0.0%	25932	0.000	0.093	5.082
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:58:49.964	99.9%	300616	103.604	287.177	1153.762
nntp read	00:00:02.404	0.0%	299687	0.003	0.008	0.014
overview write	00:00:04.712	0.0%	15485	0.011	0.304	8.392
perl filter	00:00:27.163	0.0%	25929	0.796	1.048	1.904
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:01.136	0.0%	30999	0.000	0.037	0.164
TOTAL: 24:00:22.012	23:59:38.036	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.026	0.0%	15744	0.000	0.002	0.029
article prepare	00:00:00.009	0.0%	117006	0.000	0.000	0.002
article read	00:00:00.726	0.0%	15129	0.000	0.048	0.527
backlog stats	00:00:00.456	0.0%	354545	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.995	0.0%	242603	0.001	0.008	0.015
data write	00:00:01.851	0.0%	229153	0.001	0.008	0.016
idle	23:54:59.263	100.0%	354545	99.425	242.844	683.041
status file	00:00:01.930	0.0%	298	0.000	6.477	96.500
TOTAL: 23:55:14.937	23:55:06.256	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	12579	4903	7553	123	38%	24:08:58
2	i2pn-out.news.weretis.net	5	29106	4679	24278	149	16%	49:38:40
3	feeder.eternal-september.org	18	5635	2455	2721	459	43%	28:00:06
4	usenet.goja.nl.eu.org	14	17685	2207	13980	1498	12%	24:42:57
5	paganini.bofh.team	2	20209	684	19175	350	3%	27:49:48
6	news.swapon.de	4	1251	293	958	0	23%	24:00:13
7	news-out.neodome.net	2	14821	215	14580	26	1%	23:59:49
8	i2pn-out.feed.uzoreto.com	2186	25533	98	17594	7841	0%	71:19:11
9	i2pn2.org	34	204	51	153	0	25%	11:31:44
10	news.niel.me	2	3925	26	3897	2	0%	23:59:52
11	news.nntp4.net	2	17704	23	17562	119	0%	23:59:29
12	dodin.fr.nf	15	720	17	703	0	2%	20:18:06
13	news.bbs.nz	5	17681	10	17671	0	0%	36:38:16
14	novabbs.org	6	5211	4	5207	0	0%	17:00:05
15	news.samoylyk.net	1	12397	3	12392	2	0%	23:59:45
16	kf5zxw.com	1	0	0	0	0	0%	00:10:00
17	localhost	29	0	0	0	0	0%	00:00:00
TOTAL: 17		2328	184661	15668	158424	10569	8%	431:16:59

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn-out.news.weretis.net	25.9 MB	0.0 KB	1005.2 KB	26.9 MB	96%	5.7 KB
2	news-out.aioe.org	11.5 MB	0.0 KB	347.2 KB	11.8 MB	97%	2.4 KB
3	feeder.eternal-september.org	7.7 MB	0.0 KB	2.7 MB	10.4 MB	74%	3.6 KB
4	usenet.goja.nl.eu.org	4.9 MB	3.4 KB	4.1 MB	9.1 MB	54%	2.5 KB
5	paganini.bofh.team	2.2 MB	0.0 KB	1.2 MB	3.4 MB	64%	3.3 KB
6	news-out.neodome.net	906.0 KB	0.0 KB	354.9 KB	1.2 MB	71%	5.2 KB
7	news.swapon.de	671.6 KB	0.0 KB	0.0 KB	671.6 KB	100%	2.3 KB
8	i2pn-out.feed.uzoreto.com	246.3 KB	0.0 KB	12.4 MB	12.7 MB	1%	1.6 KB
9	news.nntp4.net	134.8 KB	0.0 KB	2.5 MB	2.6 MB	5%	18.6 KB
10	i2pn2.org	107.2 KB	0.0 KB	0.0 KB	107.2 KB	100%	2.1 KB
11	news.niel.me	74.3 KB	0.0 KB	4.1 KB	78.4 KB	94%	2.8 KB
12	novabbs.org	43.6 KB	0.0 KB	0.0 KB	43.6 KB	100%	10.9 KB
13	dodin.fr.nf	28.2 KB	0.0 KB	0.0 KB	28.2 KB	100%	1.7 KB
14	news.bbs.nz	18.6 KB	0.0 KB	0.0 KB	18.6 KB	100%	1.9 KB
15	news.samoylyk.net	5.7 KB	5.2 KB	5.2 KB	16.2 KB	35%	3.2 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		54.3 MB	8.6 KB	24.6 MB	78.9 MB	68%	3.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 6 04:15:01 - 04:59:59	228	1.5%	0.08	753.3 KB	1.4%	0.28
Apr 6 05:00:00 - 05:59:59	311	2.0%	0.09	1.1 MB	2.0%	0.30
Apr 6 06:00:00 - 06:59:59	476	3.1%	0.13	2.2 MB	4.2%	0.64
Apr 6 07:00:00 - 07:59:59	624	4.0%	0.17	1.7 MB	3.2%	0.48
Apr 6 08:00:00 - 08:59:59	771	5.0%	0.21	1.9 MB	3.5%	0.53
Apr 6 09:00:00 - 09:59:59	664	4.3%	0.18	1.9 MB	3.5%	0.53
Apr 6 10:00:00 - 10:59:59	857	5.5%	0.24	3.5 MB	6.5%	0.98
Apr 6 11:00:00 - 11:59:59	739	4.8%	0.21	2.2 MB	4.1%	0.63
Apr 6 12:00:00 - 12:59:59	1014	6.6%	0.28	3.9 MB	7.3%	1.11
Apr 6 13:00:00 - 13:59:59	960	6.2%	0.27	3.7 MB	7.0%	1.06
Apr 6 14:00:00 - 14:59:59	950	6.1%	0.26	3.3 MB	6.2%	0.94
Apr 6 15:00:00 - 15:59:59	1016	6.6%	0.28	3.8 MB	7.2%	1.09
Apr 6 16:00:00 - 16:59:59	838	5.4%	0.23	3.9 MB	7.4%	1.12
Apr 6 17:00:00 - 17:59:59	694	4.5%	0.19	2.4 MB	4.6%	0.69
Apr 6 18:00:00 - 18:59:59	897	5.8%	0.25	2.5 MB	4.7%	0.72
Apr 6 19:00:00 - 19:59:59	800	5.2%	0.22	2.3 MB	4.3%	0.65
Apr 6 20:00:00 - 20:59:59	625	4.0%	0.17	1.8 MB	3.4%	0.51
Apr 6 21:00:00 - 21:59:59	727	4.7%	0.20	2.7 MB	5.1%	0.78
Apr 6 22:00:00 - 22:59:59	526	3.4%	0.15	1.9 MB	3.5%	0.53
Apr 6 23:00:00 - 23:59:59	417	2.7%	0.12	1.2 MB	2.3%	0.35
Apr 7 00:00:00 - 00:59:59	338	2.2%	0.09	1.1 MB	2.0%	0.30
Apr 7 01:00:00 - 01:59:59	416	2.7%	0.12	1.2 MB	2.2%	0.34
Apr 7 02:00:00 - 02:59:59	282	1.8%	0.08	839.4 KB	1.5%	0.23
Apr 7 03:00:00 - 03:59:59	244	1.6%	0.07	1.6 MB	2.9%	0.44
Apr 7 04:00:00 - 04:15:01	65	0.4%	0.07	175.9 KB	0.3%	0.20
TOTAL: 24:00:00	15479	100.0%	0.18	53.5 MB	100.0%	0.63

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	i2pn-out.feed.uzoreto.com	7841	5969	0	1872
2	usenet.goja.nl.eu.org	1506	1	1	1504
3	feeder.eternal-september.org	457	5	0	452
4	paganini.bofh.team	271	115	0	156
5	i2pn-out.news.weretis.net	209	2	0	207
6	news-out.aioe.org	146	13	0	133
7	news.swapon.de	133	0	0	133
8	news.nntp4.net	120	39	0	81
9	news-out.neodome.net	20	0	0	20
10	news.samoylyk.net	2	0	2	0
11	news.niel.me	2	0	0	2
TOTAL: 11		10707	6144	3	4560

Unwanted newsgroups [Top 20]:

Newsgroup	Count
talk.english.tw	4339
talk.russian.tg	956
talk.ukrainian.tg	578
0.test	175
talk.english.tg	49
comp.hackers	11
att.jobs	9
talk.generic.ua.ws	5
aus.jobs	4
winnipeg.general	4
1.test	2
news.oriens-occasus	2
wolfsburg.test	1
alt.sex.erotica.stories	1
alt.fan.rush-limbaugh.	1
reisdiegodos572gmail.com	1
oesterreich.wien.lokale	1
fr.petites-annonces.immobilier	1
alt.test.foo	1
at.blackbox.behinderte	1
TOTAL: 22	6144

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2604
Too many newsgroups	1323
Poison newsgroup	257
Binary: misplaced par2	60
User-issued cancel	17
HTML Multipart	15
User-issued spam cancel	11
Too many newsgroups (meow)	2
HTML post	1
Scoring filter (12)	1
Malformed article	1
HTML Image Tags	1
TOTAL: 12	4293

NoCeM on Spool:

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

INND no permission servers:

System	Conn
27.124.5.13	6
192.241.225.86	1
162.142.125.10	1
TOTAL: 3	8

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	i2pn-out.feed.uzoreto.com	5
	TOTAL: 1	5
Including strange strings
	news.swapon.de	133
	i2pn-out.news.weretis.net	79
	news-out.aioe.org	32
	usenet.goja.nl.eu.org	15
	feeder.eternal-september.org	4
	news-out.neodome.net	1
	TOTAL: 6	264
No colon-space in header
	i2pn-out.feed.uzoreto.com	3
	TOTAL: 1	3
TOTAL: 3		272

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	i2pn2	15147	13641	142	1158	1	0	90%	23:59:55
2	novabbs	20560	8685	5526	899	0	51	42%	23:59:55
3	aioe	10237	1156	8842	7	0	0	11%	23:59:54
4	news.samoylyk.net	16874	867	14478	9	0	0	5%	23:59:41
5	news.niel.me	5056	571	4183	179	0	0	11%	23:59:54
6	news.bbs.nz	29837	296	15124	47	0	187	0%	23:59:54
7	news.nntp4.net	17104	123	15308	4	0	1	0%	23:59:53
8	paganini.bofh.team	16323	104	14746	1	0	1	0%	23:59:54
9	neodome	16586	93	14921	0	0	1	0%	23:59:54
10	swapon.de	1560	82	1382	0	0	0	5%	23:52:45
11	weretis.net	17131	80	9711	985	0	13	0%	23:59:55
12	news.uzoreto.com	14873	76	13145	0	0	1	0%	23:59:54
13	eternal-september	14537	70	12875	6	0	1	0%	23:59:38
14	dodin.fr.nf	1461	61	733	3	0	0	4%	21:15:17
15	usenet.goja.nl.eu.org	14916	49	13037	50	0	35	0%	23:59:54
16	kf5zxw.com	0	0	0	0	0	15479	0%	23:57:45
TOTAL: 16		212202	25954	144153	3348	1	15770	12%	381:04:02

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	i2pn2	36.5 MB	3.7 MB	40.2 MB	0.5 KB/s	2.8 KB	23:59:55
2	novabbs	33.6 MB	3.5 MB	37.1 MB	0.4 KB/s	4.0 KB	23:59:55
3	aioe	4.1 MB	43.3 KB	4.1 MB	0.0 KB/s	3.6 KB	23:59:54
4	news.samoylyk.net	2.7 MB	54.9 KB	2.7 MB	0.0 KB/s	3.2 KB	23:59:41
5	news.niel.me	1.9 MB	670.1 KB	2.6 MB	0.0 KB/s	3.5 KB	23:59:54
6	news.bbs.nz	1.1 MB	238.1 KB	1.3 MB	0.0 KB/s	3.9 KB	23:59:54
7	news.nntp4.net	358.4 KB	47.3 KB	405.7 KB	0.0 KB/s	3.2 KB	23:59:53
8	paganini.bofh.team	343.0 KB	10.4 KB	353.5 KB	0.0 KB/s	3.4 KB	23:59:54
9	swapon.de	294.6 KB	0.0 KB	294.6 KB	0.0 KB/s	3.6 KB	23:52:45
10	neodome	285.7 KB	0.0 KB	285.7 KB	0.0 KB/s	3.1 KB	23:59:54
11	dodin.fr.nf	251.9 KB	11.0 KB	262.8 KB	0.0 KB/s	4.1 KB	21:15:17
12	usenet.goja.nl.eu.org	192.8 KB	109.7 KB	302.5 KB	0.0 KB/s	3.1 KB	23:59:54
13	news.uzoreto.com	192.5 KB	0.0 KB	192.5 KB	0.0 KB/s	2.5 KB	23:59:54
14	weretis.net	185.3 KB	1.9 MB	2.1 MB	0.0 KB/s	2.0 KB	23:59:55
15	eternal-september	156.7 KB	40.6 KB	197.4 KB	0.0 KB/s	2.6 KB	23:59:38
16	kf5zxw.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:45
TOTAL: 16		82.1 MB	10.3 MB	92.4 MB	0.1 KB/s	3.2 KB	381:04:02

Daily Usenet report

Apr 6 04:15:01 -- Apr 7 04:15:01