Daily Usenet report: Dec 28 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	12642	45.1%	3.8 MB	62.8%
innd	11571	41.3%	1.6 MB	25.9%
innfeed	3820	13.6%	699.4 KB	11.3%
controlchan	1	0.0%	0.2 KB	0.0%
nocem	1	0.0%	0.2 KB	0.0%
TOTAL: 5	28035	100.0%	6.0 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	136926	61.7%
Negative hits	71671	32.3%
Do not exist	12446	5.6%
Cache misses	731	0.3%
TOTAL: 4	221774	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.002	0.0%	43	0.000	0.047	1.000
article cleanup	00:00:00.062	0.0%	12451	0.000	0.005	0.073
article logging	00:00:00.395	0.0%	12602	0.000	0.031	0.083
article parse	00:00:00.223	0.0%	22075	0.000	0.010	0.042
article write	00:00:01.161	0.0%	11500	0.000	0.101	5.536
artlog/artcncl	00:00:00.000	0.0%	43	0.000	0.000	0.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:00.063	0.0%	227874	0.000	0.000	0.003
hisgrep/artcncl	00:00:00.000	0.0%	43	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	43	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.804	0.0%	221803	0.000	0.004	0.010
history sync	00:00:00.016	0.0%	407	0.000	0.039	0.667
history write	00:00:01.088	0.0%	12450	0.000	0.087	2.718
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:59:58.653	99.9%	229818	213.305	375.944	1792.591
nntp read	00:00:02.036	0.0%	229301	0.003	0.009	0.018
overview write	00:00:02.090	0.0%	11500	0.000	0.182	5.897
perl filter	00:00:26.482	0.0%	12450	1.357	2.127	6.391
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:01.196	0.0%	23056	0.000	0.052	0.163
TOTAL: 24:01:10.304	24:00:34.271	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.028	0.0%	12826	0.000	0.002	0.050
article prepare	00:00:00.013	0.0%	182112	0.000	0.000	0.001
article read	00:00:00.668	0.0%	11481	0.000	0.058	2.211
backlog stats	00:00:00.740	0.0%	417733	0.000	0.002	0.004
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.581	0.0%	270123	0.000	0.010	0.016
data write	00:00:02.612	0.0%	259528	0.003	0.010	0.020
idle	23:56:15.298	100.0%	417733	107.516	206.293	739.463
status file	00:00:02.158	0.0%	351	0.000	6.148	410.667
TOTAL: 23:56:35.917	23:56:24.098	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	usenet.blueworldhosting.com	5	12017	3490	8219	308	29%	25:15:28
2	i2pn-out.news.weretis.net	4	17607	2691	14849	67	15%	42:08:24
3	news-out.aioe.org	3	9488	2439	6992	57	25%	24:01:19
4	feeder.eternal-september.org	342	6353	1895	4130	328	29%	97:31:20
5	usenet.goja.nl.eu.org	11	11328	467	10737	124	4%	24:11:54
6	news.nntp4.net	1	11373	193	11174	6	1%	23:59:57
7	news.swapon.de	14	835	90	745	0	10%	22:44:59
8	news-out.neodome.net	2	10377	72	10297	8	0%	23:59:50
9	i2pn2.org	39	401	43	358	0	10%	19:55:16
10	i2pn-out.feed.uzoreto.com	1367	12753	38	12656	59	0%	71:26:43
11	nntp.alphanet.ch	23	6904	36	6868	0	0%	23:56:11
12	dodin.fr.nf	17	517	18	499	0	3%	19:10:19
13	news.niel.me	2	2255	18	2236	1	0%	23:56:50
14	news.samoylyk.net	1	9798	13	9784	1	0%	23:59:50
15	news.bbs.nz	6	8610	1	8609	0	0%	25:28:43
16	localhost	25	0	0	0	0	0%	00:00:00
17	novabbs.org	9	1876	0	1876	0	0%	20:42:00
18	kf5zxw.com	1	2676	0	2676	0	0%	11:52:30
19	paganini.bofh.team	1	153	0	153	0	0%	01:03:25
20	retrobbs.ddns.net	1	0	0	0	0	0%	00:10:00
21	news.furie.org.uk	1	263	0	263	0	0%	01:29:21
TOTAL: 21		1875	125584	11504	113121	959	9%	527:04:19

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn-out.news.weretis.net	20.1 MB	2.1 KB	311.6 KB	20.4 MB	98%	7.6 KB
2	usenet.blueworldhosting.com	13.0 MB	0.0 KB	1.4 MB	14.4 MB	90%	3.9 KB
3	feeder.eternal-september.org	5.8 MB	0.0 KB	1.1 MB	6.9 MB	83%	3.2 KB
4	news-out.aioe.org	5.7 MB	0.0 KB	149.1 KB	5.9 MB	97%	2.4 KB
5	usenet.goja.nl.eu.org	1.3 MB	0.0 KB	490.3 KB	1.8 MB	73%	3.1 KB
6	news.nntp4.net	692.0 KB	0.0 KB	27.7 KB	719.7 KB	96%	3.6 KB
7	news-out.neodome.net	377.5 KB	0.0 KB	31.4 KB	408.8 KB	92%	5.1 KB
8	i2pn2.org	264.4 KB	0.0 KB	0.0 KB	264.4 KB	100%	6.1 KB
9	news.swapon.de	222.0 KB	0.0 KB	0.0 KB	222.0 KB	100%	2.5 KB
10	i2pn-out.feed.uzoreto.com	67.7 KB	0.0 KB	156.2 KB	223.8 KB	30%	2.3 KB
11	nntp.alphanet.ch	57.7 KB	0.0 KB	0.0 KB	57.7 KB	100%	1.6 KB
12	news.niel.me	53.3 KB	0.0 KB	3.0 KB	56.4 KB	94%	3.0 KB
13	news.samoylyk.net	48.1 KB	2.0 KB	2.0 KB	52.0 KB	92%	3.7 KB
14	dodin.fr.nf	34.1 KB	0.0 KB	0.0 KB	34.1 KB	100%	1.9 KB
15	news.bbs.nz	1.2 KB	0.0 KB	0.0 KB	1.2 KB	100%	1.2 KB
16	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
17	novabbs.org	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
19	paganini.bofh.team	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
20	retrobbs.ddns.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
21	news.furie.org.uk	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 21		47.7 MB	4.0 KB	3.6 MB	51.3 MB	92%	4.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 28 04:15:01 - 04:59:59	156	1.4%	0.06	502.5 KB	1.0%	0.19
Dec 28 05:00:00 - 05:59:59	237	2.1%	0.07	1.2 MB	2.4%	0.33
Dec 28 06:00:00 - 06:59:59	228	2.0%	0.06	2.2 MB	4.5%	0.62
Dec 28 07:00:00 - 07:59:59	381	3.3%	0.11	1.5 MB	3.1%	0.43
Dec 28 08:00:00 - 08:59:59	558	4.9%	0.15	2.3 MB	4.7%	0.64
Dec 28 09:00:00 - 09:59:59	587	5.1%	0.16	1.7 MB	3.5%	0.48
Dec 28 10:00:00 - 10:59:59	604	5.3%	0.17	1.9 MB	4.0%	0.55
Dec 28 11:00:00 - 11:59:59	545	4.7%	0.15	2.9 MB	6.0%	0.83
Dec 28 12:00:00 - 12:59:59	631	5.5%	0.18	3.1 MB	6.3%	0.87
Dec 28 13:00:00 - 13:59:59	585	5.1%	0.16	2.4 MB	5.0%	0.69
Dec 28 14:00:00 - 14:59:59	704	6.1%	0.20	2.0 MB	4.1%	0.57
Dec 28 15:00:00 - 15:59:59	652	5.7%	0.18	2.4 MB	5.0%	0.68
Dec 28 16:00:00 - 16:59:59	627	5.5%	0.17	3.0 MB	6.3%	0.86
Dec 28 17:00:00 - 17:59:59	637	5.5%	0.18	2.2 MB	4.5%	0.61
Dec 28 18:00:00 - 18:59:59	625	5.4%	0.17	2.4 MB	4.9%	0.68
Dec 28 19:00:00 - 19:59:59	620	5.4%	0.17	1.8 MB	3.8%	0.52
Dec 28 20:00:00 - 20:59:59	548	4.8%	0.15	3.1 MB	6.4%	0.88
Dec 28 21:00:00 - 21:59:59	509	4.4%	0.14	2.3 MB	4.7%	0.65
Dec 28 22:00:00 - 22:59:59	475	4.1%	0.13	1.8 MB	3.8%	0.52
Dec 28 23:00:00 - 23:59:59	419	3.6%	0.12	2.0 MB	4.1%	0.57
Dec 29 00:00:00 - 00:59:59	366	3.2%	0.10	1.3 MB	2.6%	0.36
Dec 29 01:00:00 - 01:59:59	255	2.2%	0.07	884.3 KB	1.8%	0.25
Dec 29 02:00:00 - 02:59:59	298	2.6%	0.08	2.4 MB	5.0%	0.68
Dec 29 03:00:00 - 03:59:59	210	1.8%	0.06	1.1 MB	2.2%	0.30
Dec 29 04:00:00 - 04:15:01	41	0.4%	0.05	89.6 KB	0.2%	0.10
TOTAL: 24:00:00	11498	100.0%	0.13	48.4 MB	100.0%	0.57

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	feeder.eternal-september.org	336	0	0	336
2	usenet.blueworldhosting.com	306	14	0	292
3	i2pn-out.news.weretis.net	137	0	0	137
4	usenet.goja.nl.eu.org	125	0	0	125
5	news-out.aioe.org	60	5	0	55
6	i2pn-out.feed.uzoreto.com	59	0	0	59
7	news.swapon.de	57	0	0	57
8	news-out.neodome.net	11	0	0	11
9	news.nntp4.net	6	0	0	6
10	paganini.bofh.team	2	0	0	2
11	news.samoylyk.net	1	0	1	0
12	news.niel.me	1	0	0	1
TOTAL: 12		1101	19	1	1081

Unwanted newsgroups [Top 20]:

Newsgroup	Count
att.jobs	6
aus.jobs	3
alt.wheel.of.time	3
1.test	1
aioe.helpdesk	1
trollnet.cinema	1
alt.music.pink-floyd.publius	1
lokkygotgel.org	1
list.postfix.users	1
de.soc.dateschutz	1
TOTAL: 10	19

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	435
Too many newsgroups	347
Poison newsgroup	101
User-issued cancel	22
Binary: misplaced rar	14
Scoring filter (9)	3
Scoring filter (8)	2
HTML Multipart	2
Too many newsgroups (meow)	2
Scoring filter (12)	1
Scoring filter (14)	1
TOTAL: 11	930

INND no permission servers:

System	Conn
150.129.136.34	6
192.241.223.31	1
167.94.138.46	1
TOTAL: 3	8

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	i2pn-out.news.weretis.net	73
	news.swapon.de	57
	feeder.eternal-september.org	8
	usenet.blueworldhosting.com	6
	news-out.aioe.org	4
	news-out.neodome.net	3
	TOTAL: 6	151
TOTAL: 1		151

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	retrobbs.ddns.net	11271	10901	0	366	0	96%	23:59:53
2	i2pn2	11421	10599	188	437	7	92%	23:59:26
3	novabbs	13091	8973	1854	440	1	68%	23:59:53
4	kf5zxw.com	18771	3951	7539	0	85	21%	23:59:53
5	aioe	9053	1938	6475	32	8	21%	23:59:15
6	paganini.bofh.team	13256	1140	10189	1	0	8%	23:59:53
7	news.niel.me	3378	845	2209	142	0	25%	23:59:53
8	neodome	13500	782	10480	0	0	5%	23:59:53
9	nntp.alphanet.ch	16221	674	10214	413	1145	4%	23:59:53
10	usenet.goja.nl.eu.org	12740	650	10184	23	25	5%	23:59:53
11	news.furie.org.uk	8561	536	5389	40	0	6%	23:59:52
12	news.nntp4.net	13808	488	10792	16	0	3%	23:59:53
13	news.bbs.nz	22161	472	10723	289	41	2%	23:59:12
14	news.uzoreto.com	13231	301	10135	0	0	2%	23:59:50
15	usenet.blueworldhosting.com	14473	72	7932	0	8	0%	23:59:53
16	weretis.net	12302	71	7881	793	3	0%	23:59:53
17	news.samoylyk.net	14445	55	11248	14	0	0%	23:59:53
18	eternal-september	12913	54	9525	14	15	0%	23:59:01
19	dodin.fr.nf	883	41	499	0	0	4%	19:49:09
20	swapon.de	958	1	808	1	0	0%	22:49:47
TOTAL: 20		236437	42544	134264	3021	1338	17%	474:34:08

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	retrobbs.ddns.net	44.5 MB	1.5 MB	46.0 MB	0.5 KB/s	4.2 KB	23:59:53
2	i2pn2	42.6 MB	2.4 MB	45.0 MB	0.5 KB/s	4.2 KB	23:59:26
3	novabbs	37.9 MB	2.2 MB	40.2 MB	0.5 KB/s	4.4 KB	23:59:53
4	kf5zxw.com	14.5 MB	0.0 KB	14.5 MB	0.2 KB/s	3.8 KB	23:59:53
5	aioe	6.7 MB	97.8 KB	6.8 MB	0.1 KB/s	3.5 KB	23:59:15
6	paganini.bofh.team	3.6 MB	2.1 KB	3.6 MB	0.0 KB/s	3.2 KB	23:59:53
7	news.niel.me	2.8 MB	308.8 KB	3.1 MB	0.0 KB/s	3.2 KB	23:59:53
8	nntp.alphanet.ch	2.7 MB	1.8 MB	4.5 MB	0.1 KB/s	4.3 KB	23:59:53
9	neodome	2.4 MB	0.0 KB	2.4 MB	0.0 KB/s	3.2 KB	23:59:53
10	usenet.goja.nl.eu.org	1.8 MB	224.9 KB	2.0 MB	0.0 KB/s	3.1 KB	23:59:53
11	news.furie.org.uk	1.7 MB	207.0 KB	1.9 MB	0.0 KB/s	3.3 KB	23:59:52
12	news.bbs.nz	1.6 MB	1.1 MB	2.7 MB	0.0 KB/s	3.6 KB	23:59:12
13	news.nntp4.net	1.5 MB	194.6 KB	1.7 MB	0.0 KB/s	3.4 KB	23:59:53
14	news.uzoreto.com	1.0 MB	0.0 KB	1.0 MB	0.0 KB/s	3.5 KB	23:59:50
15	dodin.fr.nf	391.4 KB	0.0 KB	391.4 KB	0.0 KB/s	9.5 KB	19:49:09
16	usenet.blueworldhosting.com	314.2 KB	0.0 KB	314.2 KB	0.0 KB/s	4.4 KB	23:59:53
17	weretis.net	211.1 KB	1.6 MB	1.8 MB	0.0 KB/s	2.1 KB	23:59:53
18	news.samoylyk.net	134.2 KB	178.0 KB	312.3 KB	0.0 KB/s	4.5 KB	23:59:53
19	eternal-september	125.6 KB	187.8 KB	313.4 KB	0.0 KB/s	4.6 KB	23:59:01
20	swapon.de	64.1 KB	2.4 KB	66.6 KB	0.0 KB/s	33.3 KB	22:49:47
TOTAL: 20		166.5 MB	12.0 MB	178.5 MB	0.1 KB/s	4.0 KB	474:34:08

Daily Usenet report

Dec 28 04:15:01 -- Dec 29 04:15:01