Daily Usenet report: Oct 14 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	13979	48.6%	4.1 MB	65.2%
innd	10952	38.1%	1.5 MB	24.1%
innfeed	3821	13.3%	678.2 KB	10.7%
controlchan	1	0.0%	0.2 KB	0.0%
nocem	1	0.0%	0.2 KB	0.0%
TOTAL: 5	28754	100.0%	6.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	132650	58.4%
Negative hits	80419	35.4%
Do not exist	13666	6.0%
Cache misses	287	0.1%
TOTAL: 4	227022	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.011	0.0%	18	0.000	0.611	1.000
article cleanup	00:00:00.079	0.0%	13684	0.000	0.006	0.047
article logging	00:00:00.426	0.0%	13968	0.000	0.030	0.091
article parse	00:00:00.262	0.0%	24768	0.000	0.011	0.071
article write	00:00:04.373	0.0%	12184	0.059	0.359	6.565
artlog/artcncl	00:00:00.000	0.0%	18	0.000	0.000	0.000
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:00:00.078	0.0%	231920	0.000	0.000	0.004
hisgrep/artcncl	00:00:00.001	0.0%	17	0.000	0.059	1.000
hishave/artcncl	00:00:00.000	0.0%	18	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.740	0.0%	227253	0.000	0.003	0.009
history sync	00:00:00.018	0.0%	303	0.000	0.059	0.500
history write	00:00:01.128	0.0%	13682	0.000	0.082	7.862
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
idle	23:59:07.965	99.9%	232990	208.669	370.608	1257.933
nntp read	00:00:02.097	0.0%	232861	0.002	0.009	0.018
overview write	00:00:01.305	0.0%	12184	0.000	0.107	4.879
perl filter	00:00:27.818	0.0%	13681	1.214	2.033	8.271
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:01.452	0.0%	24427	0.000	0.059	0.170
TOTAL: 24:00:23.899	23:59:47.753	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.037	0.0%	12451	0.000	0.003	0.031
article prepare	00:00:00.019	0.0%	188720	0.000	0.000	0.002
article read	00:00:00.643	0.0%	12051	0.000	0.053	0.822
backlog stats	00:00:00.642	0.0%	374165	0.000	0.002	0.006
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.377	0.0%	250811	0.001	0.009	0.018
data write	00:00:02.186	0.0%	240347	0.002	0.009	0.015
idle	23:55:35.721	100.0%	374165	117.871	230.208	716.491
status file	00:00:00.404	0.0%	347	0.000	1.164	8.667
TOTAL: 23:55:58.260	23:55:42.029	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	9267	4335	4877	55	46%	24:09:53
2	usenet.blueworldhosting.com	4	25959	3430	22065	464	13%	24:27:25
3	i2pn-out.news.weretis.net	4	21960	1688	20201	71	7%	48:05:33
4	feeder.eternal-september.org	15	6385	1172	4631	582	18%	28:30:53
5	paganini.bofh.team	1	7741	412	7307	22	5%	16:34:32
6	news.nntp4.net	2	12092	366	11688	38	3%	23:59:55
7	news-out.neodome.net	2	10811	286	10507	18	2%	23:59:48
8	news.swapon.de	8	955	182	772	1	19%	23:23:01
9	usenet.goja.nl.eu.org	12	12367	149	12004	214	1%	23:50:24
10	i2pn-out.feed.uzoreto.com	1613	13619	62	13431	126	0%	70:55:19
11	i2pn2.org	35	54	53	1	0	98%	06:37:28
12	nntp.alphanet.ch	25	7606	38	7568	0	0%	24:46:00
13	dodin.fr.nf	15	600	37	563	0	6%	19:44:47
14	news.niel.me	2	2627	32	2592	3	1%	23:58:12
15	news.samoylyk.net	2	10410	30	10379	1	0%	23:59:36
16	news.bbs.nz	9	9448	2	9445	1	0%	29:04:47
17	novabbs.org	32	51	1	50	0	1%	06:08:19
18	news.furie.org.uk	2	5355	1	5354	0	0%	23:59:41
19	localhost	25	0	0	0	0	0%	00:00:00
20	kf5zxw.com	1	0	0	0	0	0%	00:10:00
21	retrobbs.ddns.net	1	0	0	0	0	0%	00:10:01
TOTAL: 21		1812	157307	12276	143435	1596	7%	466:35:34

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn-out.news.weretis.net	15.0 MB	0.0 KB	427.4 KB	15.4 MB	97%	9.0 KB
2	usenet.blueworldhosting.com	12.2 MB	0.0 KB	1.6 MB	13.8 MB	88%	3.6 KB
3	news-out.aioe.org	9.8 MB	0.0 KB	141.9 KB	9.9 MB	98%	2.3 KB
4	feeder.eternal-september.org	4.6 MB	0.0 KB	7.8 MB	12.4 MB	36%	7.2 KB
5	news.nntp4.net	1.4 MB	0.0 KB	761.3 KB	2.1 MB	64%	5.3 KB
6	paganini.bofh.team	1.0 MB	0.0 KB	205.3 KB	1.2 MB	83%	2.9 KB
7	news-out.neodome.net	859.3 KB	0.0 KB	58.7 KB	918.1 KB	93%	3.0 KB
8	usenet.goja.nl.eu.org	468.5 KB	0.0 KB	865.5 KB	1.3 MB	35%	3.7 KB
9	news.swapon.de	463.7 KB	0.0 KB	3.0 KB	466.7 KB	99%	2.6 KB
10	i2pn2.org	265.2 KB	0.0 KB	0.0 KB	265.2 KB	100%	5.0 KB
11	nntp.alphanet.ch	235.5 KB	0.0 KB	0.0 KB	235.5 KB	100%	6.2 KB
12	news.niel.me	147.6 KB	8.0 KB	62.5 KB	218.1 KB	67%	6.2 KB
13	news.samoylyk.net	119.8 KB	4.2 KB	4.2 KB	128.1 KB	93%	4.1 KB
14	i2pn-out.feed.uzoreto.com	98.2 KB	0.0 KB	522.5 KB	620.7 KB	15%	3.3 KB
15	dodin.fr.nf	64.5 KB	0.0 KB	0.0 KB	64.5 KB	100%	1.7 KB
16	news.bbs.nz	2.8 KB	1.4 KB	1.4 KB	5.6 KB	50%	1.9 KB
17	novabbs.org	1.9 KB	0.0 KB	0.0 KB	1.9 KB	100%	1.9 KB
18	news.furie.org.uk	1.6 KB	0.0 KB	0.0 KB	1.6 KB	100%	1.6 KB
19	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
20	kf5zxw.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
21	retrobbs.ddns.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 21		46.6 MB	13.5 KB	12.5 MB	59.1 MB	78%	4.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 14 04:15:01 - 04:59:59	243	2.0%	0.09	2.0 MB	4.4%	0.77
Oct 14 05:00:00 - 05:59:59	309	2.5%	0.09	1.6 MB	3.5%	0.46
Oct 14 06:00:00 - 06:59:59	347	2.8%	0.10	1.8 MB	4.0%	0.52
Oct 14 07:00:00 - 07:59:59	616	5.1%	0.17	2.1 MB	4.6%	0.60
Oct 14 08:00:00 - 08:59:59	620	5.1%	0.17	2.0 MB	4.3%	0.57
Oct 14 09:00:00 - 09:59:59	673	5.5%	0.19	3.0 MB	6.6%	0.86
Oct 14 10:00:00 - 10:59:59	592	4.9%	0.16	2.3 MB	5.0%	0.65
Oct 14 11:00:00 - 11:59:59	631	5.2%	0.18	2.0 MB	4.4%	0.58
Oct 14 12:00:00 - 12:59:59	761	6.2%	0.21	2.1 MB	4.5%	0.58
Oct 14 13:00:00 - 13:59:59	650	5.3%	0.18	2.9 MB	6.4%	0.83
Oct 14 14:00:00 - 14:59:59	738	6.1%	0.20	2.9 MB	6.2%	0.81
Oct 14 15:00:00 - 15:59:59	759	6.2%	0.21	2.5 MB	5.5%	0.72
Oct 14 16:00:00 - 16:59:59	652	5.4%	0.18	2.2 MB	4.8%	0.63
Oct 14 17:00:00 - 17:59:59	624	5.1%	0.17	2.2 MB	4.8%	0.62
Oct 14 18:00:00 - 18:59:59	572	4.7%	0.16	2.9 MB	6.4%	0.84
Oct 14 19:00:00 - 19:59:59	688	5.6%	0.19	2.0 MB	4.4%	0.58
Oct 14 20:00:00 - 20:59:59	578	4.7%	0.16	1.9 MB	4.1%	0.53
Oct 14 21:00:00 - 21:59:59	452	3.7%	0.13	1.2 MB	2.6%	0.34
Oct 14 22:00:00 - 22:59:59	342	2.8%	0.10	1.6 MB	3.4%	0.45
Oct 14 23:00:00 - 23:59:59	319	2.6%	0.09	1.5 MB	3.3%	0.43
Oct 15 00:00:00 - 00:59:59	277	2.3%	0.08	895.1 KB	1.9%	0.25
Oct 15 01:00:00 - 01:59:59	242	2.0%	0.07	661.8 KB	1.4%	0.18
Oct 15 02:00:00 - 02:59:59	220	1.8%	0.06	656.4 KB	1.4%	0.18
Oct 15 03:00:00 - 03:59:59	195	1.6%	0.05	613.3 KB	1.3%	0.17
Oct 15 04:00:00 - 04:15:01	80	0.7%	0.09	229.7 KB	0.5%	0.25
TOTAL: 24:00:00	12180	100.0%	0.14	45.8 MB	100.0%	0.54

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	feeder.eternal-september.org	504	5	0	499
2	usenet.blueworldhosting.com	440	26	0	414
3	usenet.goja.nl.eu.org	213	0	0	213
4	i2pn-out.feed.uzoreto.com	126	0	0	126
5	i2pn-out.news.weretis.net	125	4	0	121
6	news.swapon.de	109	0	0	109
7	news-out.aioe.org	98	1	0	97
8	news-out.neodome.net	76	0	0	76
9	paganini.bofh.team	43	0	0	43
10	news.nntp4.net	41	0	0	41
11	news.niel.me	4	0	1	3
12	news.bbs.nz	1	0	1	0
13	2a01:4f8:c17:a9e2::8e	1	0	0	1
14	news.samoylyk.net	1	0	1	0
TOTAL: 14		1782	36	3	1743

Unwanted newsgroups [Top 20]:

Newsgroup	Count
sybase.public.powerdesigner.general	10
wolfsburg.test	9
att.jobs	7
aus.jobs	4
gun.general	2
test.post	2
it-alt.media.internet.podcast	1
a.b.e-book.flood	1
TOTAL: 8	36

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	745
Too many newsgroups	477
Poison newsgroup	147
EMP (fsl)	52
HTML Multipart	14
User-issued cancel	13
Scoring filter (8)	6
HTML post	1
Scoring filter (10)	1
HTML Image Tags	1
Scoring filter (9)	1
TOTAL: 11	1458

INND no permission servers:

System	Conn
2400:6180:100:d0::bb3:a001	40
192.241.205.171	1
TOTAL: 2	41

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news.swapon.de	108
	news-out.neodome.net	58
	news-out.aioe.org	49
	i2pn-out.news.weretis.net	47
	paganini.bofh.team	8
	usenet.blueworldhosting.com	4
	feeder.eternal-september.org	4
	news.nntp4.net	3
	usenet.goja.nl.eu.org	2
	news.niel.me	1
	TOTAL: 10	284
No colon-space in header
	i2pn-out.feed.uzoreto.com	1
	TOTAL: 1	1
TOTAL: 2		285

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	retrobbs.ddns.net	11934	11645	0	282	0	97%	23:59:48
2	novabbs	11991	11282	76	570	0	94%	23:59:46
3	i2pn2	12156	11074	264	538	32	91%	23:59:48
4	aioe	7911	1950	5179	102	0	24%	23:59:48
5	paganini.bofh.team	12971	1747	9908	0	0	13%	23:59:48
6	news.bbs.nz	22652	1166	10559	446	114	5%	23:59:14
7	neodome	13746	1156	10594	0	0	8%	23:59:48
8	news.niel.me	4282	868	2787	200	0	20%	23:59:39
9	news.nntp4.net	13883	836	10927	29	0	6%	23:59:48
10	nntp.alphanet.ch	13605	727	10953	321	0	5%	23:59:41
11	usenet.goja.nl.eu.org	13716	701	11103	23	7	5%	23:59:47
12	news.furie.org.uk	8371	356	5514	58	36	4%	23:59:48
13	news.uzoreto.com	13765	219	10555	0	0	1%	23:59:48
14	usenet.blueworldhosting.com	13821	99	8537	0	41	0%	23:59:16
15	news.samoylyk.net	15299	97	11890	21	0	0%	23:59:48
16	weretis.net	15070	95	9694	461	5	0%	23:59:48
17	eternal-september	13511	82	9957	16	30	0%	23:59:48
18	dodin.fr.nf	1052	82	590	0	0	7%	20:21:12
19	swapon.de	1155	3	886	0	0	0%	23:40:05
20	kf5zxw.com	0	0	0	0	12179	0%	23:57:38
TOTAL: 20		220891	44185	129973	3067	12444	20%	475:54:06

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	retrobbs.ddns.net	43.0 MB	1.6 MB	44.6 MB	0.5 KB/s	3.8 KB	23:59:48
2	i2pn2	38.9 MB	4.6 MB	43.4 MB	0.5 KB/s	3.8 KB	23:59:48
3	novabbs	38.8 MB	5.4 MB	44.2 MB	0.5 KB/s	3.8 KB	23:59:46
4	aioe	6.6 MB	287.4 KB	6.9 MB	0.1 KB/s	3.4 KB	23:59:48
5	paganini.bofh.team	5.1 MB	0.0 KB	5.1 MB	0.1 KB/s	3.0 KB	23:59:48
6	news.bbs.nz	4.4 MB	1.5 MB	5.9 MB	0.1 KB/s	3.7 KB	23:59:14
7	neodome	3.8 MB	0.0 KB	3.8 MB	0.0 KB/s	3.3 KB	23:59:48
8	news.niel.me	2.7 MB	395.6 KB	3.1 MB	0.0 KB/s	3.0 KB	23:59:39
9	nntp.alphanet.ch	2.6 MB	1.4 MB	4.0 MB	0.0 KB/s	3.9 KB	23:59:41
10	news.nntp4.net	2.5 MB	169.0 KB	2.7 MB	0.0 KB/s	3.1 KB	23:59:48
11	usenet.goja.nl.eu.org	2.3 MB	214.3 KB	2.5 MB	0.0 KB/s	3.6 KB	23:59:47
12	news.furie.org.uk	1.2 MB	223.5 KB	1.5 MB	0.0 KB/s	3.6 KB	23:59:48
13	news.uzoreto.com	695.5 KB	0.0 KB	695.5 KB	0.0 KB/s	3.2 KB	23:59:48
14	usenet.blueworldhosting.com	349.3 KB	0.0 KB	349.3 KB	0.0 KB/s	3.5 KB	23:59:16
15	news.samoylyk.net	268.9 KB	164.0 KB	433.0 KB	0.0 KB/s	3.7 KB	23:59:48
16	dodin.fr.nf	264.9 KB	0.0 KB	264.9 KB	0.0 KB/s	3.2 KB	20:21:12
17	weretis.net	255.6 KB	820.6 KB	1.1 MB	0.0 KB/s	1.9 KB	23:59:48
18	eternal-september	218.9 KB	185.3 KB	404.2 KB	0.0 KB/s	4.1 KB	23:59:48
19	swapon.de	8.2 KB	0.0 KB	8.2 KB	0.0 KB/s	2.7 KB	23:40:05
20	kf5zxw.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:38
TOTAL: 20		153.9 MB	16.9 MB	170.8 MB	0.1 KB/s	3.7 KB	475:54:06

Daily Usenet report

Oct 14 04:15:01 -- Oct 15 04:15:01