Daily Usenet report: Feb 19 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	20123	52.1%	4.3 MB	63.3%
innd	15344	39.7%	1.9 MB	28.8%
innfeed	3145	8.1%	547.5 KB	7.9%
nocem	2	0.0%	0.2 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	38615	100.0%	6.7 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	138142	50.4%
Negative hits	115972	42.3%
Do not exist	19754	7.2%
Cache misses	69	0.0%
TOTAL: 4	273937	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.027	0.0%	54	0.000	0.500	5.000
article cleanup	00:00:00.098	0.0%	19970	0.000	0.005	0.028
article logging	00:00:00.562	0.0%	20214	0.000	0.028	0.133
article parse	00:00:00.294	0.0%	34325	0.000	0.009	0.031
article write	00:00:02.675	0.0%	14553	0.071	0.184	1.652
artlog/artcncl	00:00:00.000	0.0%	54	0.000	0.000	0.000
artlog/artparse	00:00:00.000	0.0%	2	0.000	0.000	0.000
data move	00:00:00.080	0.0%	281042	0.000	0.000	0.003
hisgrep/artcncl	00:00:00.000	0.0%	54	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	54	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.079	0.0%	274884	0.000	0.004	0.009
history sync	00:00:00.022	0.0%	386	0.000	0.057	0.667
history write	00:00:01.422	0.0%	19966	0.000	0.071	1.976
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:59:42.437	99.9%	283404	173.150	304.803	1051.951
nntp read	00:00:02.471	0.0%	282651	0.003	0.009	0.014
overview write	00:00:06.799	0.0%	14553	0.016	0.467	131.079
perl filter	00:00:21.410	0.0%	19963	0.619	1.072	3.867
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:01.213	0.0%	29171	0.000	0.042	0.105
TOTAL: 24:01:03.031	24:00:20.589	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.044	0.0%	14857	0.000	0.003	0.029
article prepare	00:00:00.006	0.0%	92960	0.000	0.000	0.002
article read	00:00:00.814	0.0%	14135	0.000	0.058	1.235
backlog stats	00:00:00.352	0.0%	310656	0.000	0.001	0.006
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.886	0.0%	220961	0.003	0.009	0.015
data write	00:00:01.911	0.0%	208986	0.003	0.009	0.018
idle	23:55:18.328	100.0%	310656	151.263	277.214	826.829
status file	00:00:00.401	0.0%	313	0.000	1.281	7.800
TOTAL: 23:55:34.619	23:55:23.742	100.0%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	5
flushlogs	2
go	2
logmode	2
mode	148
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	170

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	i2pn-out.news.weretis.net	3	25201	5908	19125	168	23%	46:15:25
2	feeder.eternal-september.org	16	4592	2927	1144	521	63%	29:39:01
3	news-out.aioe.org	2	12124	2516	9582	26	20%	23:59:52
4	usenet.goja.nl.eu.org	12	13048	1409	11604	35	10%	24:08:38
5	paganini.bofh.team	2	17692	808	12559	4325	4%	20:05:56
6	news.swapon.de	13	1032	288	744	0	27%	22:45:04
7	news-out.neodome.net	1	14202	257	13883	62	1%	23:59:57
8	i2pn-out.feed.uzoreto.com	1909	15374	81	15100	193	0%	70:47:50
9	news.niel.me	2	4412	80	4320	12	1%	23:57:48
10	i2pn2.org	47	216	45	171	0	20%	11:52:15
11	news.nntp4.net	1	15408	43	15288	77	0%	23:59:54
12	news.samoylyk.net	2	11990	36	11952	2	0%	23:59:13
13	dodin.fr.nf	12	867	20	847	0	2%	20:12:17
14	news.bbs.nz	6	20137	4	20132	1	0%	41:43:49
15	novabbs.org	1	448	1	447	0	0%	03:09:56
16	kf5zxw.com	1	0	0	0	0	0%	00:10:23
17	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 17		2055	156743	14423	136898	5422	9%	410:47:18

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn-out.news.weretis.net	28.4 MB	102.4 KB	565.5 KB	29.1 MB	97%	4.9 KB
2	feeder.eternal-september.org	11.1 MB	0.0 KB	3.7 MB	14.8 MB	74%	4.4 KB
3	news-out.aioe.org	6.4 MB	0.0 KB	96.3 KB	6.5 MB	98%	2.6 KB
4	usenet.goja.nl.eu.org	3.8 MB	0.0 KB	90.5 KB	3.9 MB	97%	2.8 KB
5	paganini.bofh.team	1.9 MB	0.0 KB	6.3 MB	8.2 MB	23%	1.6 KB
6	news-out.neodome.net	1.3 MB	5.4 KB	195.8 KB	1.5 MB	86%	4.7 KB
7	news.swapon.de	815.1 KB	0.0 KB	0.0 KB	815.1 KB	100%	2.8 KB
8	news.nntp4.net	402.2 KB	0.0 KB	1.9 MB	2.3 MB	17%	19.7 KB
9	i2pn-out.feed.uzoreto.com	208.8 KB	0.0 KB	2.6 MB	2.8 MB	7%	10.4 KB
10	news.niel.me	181.5 KB	0.0 KB	20.8 KB	202.3 KB	89%	2.2 KB
11	news.samoylyk.net	142.8 KB	7.5 KB	7.5 KB	157.9 KB	90%	4.2 KB
12	i2pn2.org	110.5 KB	0.0 KB	0.0 KB	110.5 KB	100%	2.5 KB
13	dodin.fr.nf	32.9 KB	0.0 KB	0.0 KB	32.9 KB	100%	1.6 KB
14	news.bbs.nz	5.5 KB	1.2 KB	1.2 KB	8.0 KB	69%	1.6 KB
15	novabbs.org	2.4 KB	0.0 KB	0.0 KB	2.4 KB	100%	2.4 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.8 MB	116.5 KB	15.4 MB	70.3 MB	77%	3.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 19 04:15:01 - 04:59:59	146	1.0%	0.05	731.4 KB	1.3%	0.27
Feb 19 05:00:00 - 05:59:59	266	1.8%	0.07	1.9 MB	3.5%	0.55
Feb 19 06:00:00 - 06:59:59	339	2.3%	0.09	2.4 MB	4.3%	0.67
Feb 19 07:00:00 - 07:59:59	417	2.9%	0.12	1.8 MB	3.4%	0.52
Feb 19 08:00:00 - 08:59:59	574	3.9%	0.16	2.2 MB	4.0%	0.63
Feb 19 09:00:00 - 09:59:59	653	4.5%	0.18	1.8 MB	3.4%	0.52
Feb 19 10:00:00 - 10:59:59	765	5.3%	0.21	2.3 MB	4.2%	0.66
Feb 19 11:00:00 - 11:59:59	783	5.4%	0.22	2.3 MB	4.2%	0.66
Feb 19 12:00:00 - 12:59:59	624	4.3%	0.17	2.1 MB	3.9%	0.61
Feb 19 13:00:00 - 13:59:59	833	5.7%	0.23	4.0 MB	7.3%	1.14
Feb 19 14:00:00 - 14:59:59	765	5.3%	0.21	2.8 MB	5.2%	0.80
Feb 19 15:00:00 - 15:59:59	850	5.8%	0.24	2.6 MB	4.7%	0.73
Feb 19 16:00:00 - 16:59:59	755	5.2%	0.21	2.1 MB	3.8%	0.59
Feb 19 17:00:00 - 17:59:59	889	6.1%	0.25	3.7 MB	6.8%	1.06
Feb 19 18:00:00 - 18:59:59	772	5.3%	0.21	2.7 MB	4.9%	0.77
Feb 19 19:00:00 - 19:59:59	932	6.4%	0.26	3.6 MB	6.5%	1.02
Feb 19 20:00:00 - 20:59:59	742	5.1%	0.21	2.3 MB	4.1%	0.64
Feb 19 21:00:00 - 21:59:59	758	5.2%	0.21	2.3 MB	4.2%	0.66
Feb 19 22:00:00 - 22:59:59	630	4.3%	0.17	2.0 MB	3.7%	0.57
Feb 19 23:00:00 - 23:59:59	486	3.3%	0.14	1.5 MB	2.7%	0.43
Feb 20 00:00:00 - 00:59:59	484	3.3%	0.13	3.4 MB	6.2%	0.97
Feb 20 01:00:00 - 01:59:59	365	2.5%	0.10	1.3 MB	2.4%	0.37
Feb 20 02:00:00 - 02:59:59	346	2.4%	0.10	1.2 MB	2.3%	0.35
Feb 20 03:00:00 - 03:59:59	307	2.1%	0.09	1.2 MB	2.2%	0.34
Feb 20 04:00:00 - 04:15:01	80	0.5%	0.09	505.6 KB	0.9%	0.56
TOTAL: 24:00:00	14561	100.0%	0.17	54.8 MB	100.0%	0.65

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	paganini.bofh.team	4218	2	1	4215
2	feeder.eternal-september.org	491	22	0	469
3	i2pn-out.news.weretis.net	221	1	2	218
4	i2pn-out.feed.uzoreto.com	193	2	0	191
5	news.swapon.de	161	0	0	161
6	news.nntp4.net	72	3	0	69
7	news-out.neodome.net	66	0	1	65
8	usenet.goja.nl.eu.org	40	0	0	40
9	news-out.aioe.org	32	13	0	19
10	news.niel.me	12	0	0	12
11	news.samoylyk.net	2	0	2	0
TOTAL: 11		5508	43	6	5459

Unwanted newsgroups [Top 20]:

Newsgroup	Count
newsreader.test	19
att.jobs	9
aus.jobs	4
gun.general	3
comp.os.linux	1
alt.abg.test	1
bit.test	1
list.postfix.users	1
misc.health	1
alt.info-science	1
lucky.freebsd.test	1
ga.jobs	1
TOTAL: 12	43

INND Perl filter [Top 20]:

Reason	Count
Binary: misplaced par2	4058
EMP (md5)	682
Too many newsgroups	285
Poison newsgroup	70
User-issued spam cancel	52
User-issued cancel	40
Binary: misplaced rar	22
HTML Multipart	2
Scoring filter (8)	1
HTML post	1
TOTAL: 10	5213

INND no permission servers:

System	Conn
167.248.133.62	1
TOTAL: 1	1

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	161
	i2pn-out.news.weretis.net	58
	news-out.neodome.net	8
	news-out.aioe.org	7
	usenet.goja.nl.eu.org	6
	paganini.bofh.team	1
	i2pn-out.feed.uzoreto.com	1
	feeder.eternal-september.org	1
	TOTAL: 8	243
No colon-space in header
	i2pn-out.feed.uzoreto.com	2
	TOTAL: 1	2
TOTAL: 3		248

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn2	14400	12626	285	1154	27	87%	23:59:52
2	novabbs	22454	5272	8191	770	49	23%	23:59:52
3	aioe	11575	427	10992	6	0	3%	23:59:52
4	news.samoylyk.net	14653	419	13973	7	0	2%	23:59:48
5	paganini.bofh.team	13963	396	13317	1	0	2%	23:59:34
6	news.bbs.nz	28680	234	14231	89	193	0%	23:59:52
7	news.niel.me	4828	204	4484	88	0	4%	23:59:52
8	news.nntp4.net	15163	150	14357	4	2	0%	23:59:43
9	usenet.goja.nl.eu.org	13778	112	12838	52	48	0%	23:59:52
10	weretis.net	10639	75	7438	975	3	0%	23:59:24
11	neodome	14762	74	14080	0	0	0%	23:59:52
12	news.uzoreto.com	13964	66	13085	0	0	0%	23:59:52
13	eternal-september	12127	61	11511	6	0	0%	23:59:52
14	dodin.fr.nf	1267	14	855	0	0	1%	20:08:19
15	swapon.de	980	5	915	1	0	0%	22:58:42
16	kf5zxw.com	0	0	0	0	14561	0%	23:57:43
TOTAL: 16		193233	20135	140552	3153	14883	10%	379:02:01

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	i2pn2	35.2 MB	4.6 MB	39.8 MB	0.5 KB/s	3.0 KB	23:59:52
2	novabbs	27.4 MB	3.4 MB	30.8 MB	0.4 KB/s	5.2 KB	23:59:52
3	aioe	1.5 MB	33.5 KB	1.5 MB	0.0 KB/s	3.6 KB	23:59:52
4	news.samoylyk.net	1.4 MB	40.7 KB	1.5 MB	0.0 KB/s	3.5 KB	23:59:48
5	paganini.bofh.team	1.0 MB	100.2 KB	1.1 MB	0.0 KB/s	2.9 KB	23:59:34
6	news.bbs.nz	869.4 KB	889.5 KB	1.7 MB	0.0 KB/s	5.4 KB	23:59:52
7	news.niel.me	768.2 KB	312.4 KB	1.1 MB	0.0 KB/s	3.7 KB	23:59:52
8	dodin.fr.nf	460.2 KB	0.0 KB	460.2 KB	0.0 KB/s	32.9 KB	20:08:19
9	usenet.goja.nl.eu.org	419.4 KB	107.6 KB	527.0 KB	0.0 KB/s	3.2 KB	23:59:52
10	news.nntp4.net	371.2 KB	127.9 KB	499.1 KB	0.0 KB/s	3.2 KB	23:59:43
11	weretis.net	222.2 KB	2.0 MB	2.2 MB	0.0 KB/s	2.2 KB	23:59:24
12	neodome	192.0 KB	0.0 KB	192.0 KB	0.0 KB/s	2.6 KB	23:59:52
13	news.uzoreto.com	167.7 KB	0.0 KB	167.7 KB	0.0 KB/s	2.5 KB	23:59:52
14	eternal-september	136.9 KB	131.0 KB	267.8 KB	0.0 KB/s	4.0 KB	23:59:52
15	swapon.de	9.8 KB	1.8 KB	11.6 KB	0.0 KB/s	1.9 KB	22:58:42
16	kf5zxw.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:43
TOTAL: 16		70.1 MB	11.7 MB	81.8 MB	0.1 KB/s	3.6 KB	379:02:01

Daily Usenet report

Feb 19 04:15:01 -- Feb 20 04:15:01