Daily Usenet report: Jan 9 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	13997	47.6%	4.2 MB	65.1%
innd	11522	39.2%	1.6 MB	24.1%
innfeed	3873	13.2%	717.6 KB	10.8%
nocem	1	0.0%	0.2 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 5	29394	100.0%	6.5 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	145250	60.2%
Negative hits	76461	31.7%
Do not exist	13651	5.7%
Cache misses	6095	2.5%
TOTAL: 4	241457	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.002	0.0%	28	0.000	0.071	1.000
article cleanup	00:00:00.057	0.0%	13665	0.000	0.004	0.028
article logging	00:00:00.400	0.0%	13958	0.000	0.029	0.081
article parse	00:00:00.244	0.0%	23152	0.000	0.011	0.040
article write	00:00:01.008	0.0%	12773	0.000	0.079	0.539
artlog/artcncl	00:00:00.000	0.0%	28	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.077	0.0%	246016	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.001	0.0%	27	0.000	0.037	0.143
hishave/artcncl	00:00:00.000	0.0%	28	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.887	0.0%	241632	0.000	0.004	0.009
history sync	00:00:00.016	0.0%	315	0.000	0.051	1.000
history write	00:00:00.752	0.0%	13661	0.000	0.055	0.308
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
idle	23:59:01.675	99.9%	247960	61.953	348.208	982.008
nntp read	00:00:02.137	0.0%	247481	0.002	0.009	0.016
overview write	00:00:01.344	0.0%	12773	0.000	0.105	0.903
perl filter	00:00:27.442	0.0%	13660	1.363	2.009	6.623
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:01.269	0.0%	25617	0.000	0.050	0.171
TOTAL: 24:00:22.687	23:59:37.311	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.025	0.0%	15273	0.000	0.002	0.021
article prepare	00:00:00.016	0.0%	212744	0.000	0.000	0.002
article read	00:00:00.537	0.0%	13423	0.000	0.040	0.167
backlog stats	00:00:00.832	0.0%	466490	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.611	0.0%	303011	0.003	0.009	0.015
data write	00:00:02.875	0.0%	292435	0.005	0.010	0.018
idle	23:54:15.566	100.0%	466490	96.510	184.475	473.500
status file	00:00:00.553	0.0%	388	0.000	1.425	71.000
TOTAL: 23:54:36.794	23:54:23.015	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	i2pn-out.news.weretis.net	5	21859	3535	18229	95	16%	45:29:13
2	usenet.blueworldhosting.com	4	12878	3311	9332	235	25%	23:05:57
3	feeder.eternal-september.org	357	7516	2492	4602	422	33%	103:09:13
4	news-out.aioe.org	2	9966	2092	7863	11	20%	23:59:17
5	usenet.goja.nl.eu.org	12	12567	489	12042	36	3%	23:57:21
6	news.swapon.de	6	1108	210	898	0	18%	23:19:27
7	paganini.bofh.team	2	12352	187	12165	0	1%	23:34:03
8	news-out.neodome.net	2	11528	73	11422	33	0%	23:59:52
9	i2pn2.org	34	623	70	553	0	11%	21:35:15
10	nntp.alphanet.ch	25	7308	62	7246	0	0%	24:48:24
11	i2pn-out.feed.uzoreto.com	1471	21532	40	21471	21	0%	70:33:16
12	news.niel.me	1	2586	35	2549	2	1%	23:59:57
13	news.samoylyk.net	1	10822	19	10800	3	0%	23:59:53
14	news.nntp4.net	1	11270	16	11236	18	0%	23:59:58
15	dodin.fr.nf	26	407	10	397	0	2%	17:26:04
16	news.bbs.nz	6	10520	9	10511	0	0%	27:52:55
17	news.furie.org.uk	1	4072	1	4071	0	0%	17:23:38
18	novabbs.org	8	2875	0	2875	0	0%	25:44:04
19	localhost	25	0	0	0	0	0%	00:00:00
20	retrobbs.ddns.net	1	0	0	0	0	0%	00:10:00
TOTAL: 20		1990	161789	12651	148262	876	7%	568:07:47

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn-out.news.weretis.net	19.0 MB	0.0 KB	412.3 KB	19.4 MB	97%	5.5 KB
2	usenet.blueworldhosting.com	12.0 MB	4.0 KB	802.2 KB	12.8 MB	93%	3.7 KB
3	feeder.eternal-september.org	7.0 MB	0.0 KB	2.2 MB	9.2 MB	75%	3.2 KB
4	news-out.aioe.org	5.2 MB	0.0 KB	45.2 KB	5.3 MB	99%	2.6 KB
5	usenet.goja.nl.eu.org	1.8 MB	2.2 KB	135.3 KB	1.9 MB	92%	3.7 KB
6	paganini.bofh.team	878.8 KB	0.0 KB	0.0 KB	878.8 KB	100%	4.7 KB
7	news.swapon.de	533.8 KB	0.0 KB	0.0 KB	533.8 KB	100%	2.5 KB
8	news-out.neodome.net	306.8 KB	0.0 KB	384.2 KB	691.1 KB	44%	6.5 KB
9	i2pn2.org	278.3 KB	0.0 KB	0.0 KB	278.3 KB	100%	4.0 KB
10	nntp.alphanet.ch	123.0 KB	0.0 KB	0.0 KB	123.0 KB	100%	2.0 KB
11	news.niel.me	110.0 KB	0.0 KB	3.4 KB	113.5 KB	96%	3.1 KB
12	i2pn-out.feed.uzoreto.com	79.1 KB	0.0 KB	131.8 KB	210.9 KB	37%	3.5 KB
13	news.samoylyk.net	72.4 KB	7.3 KB	7.3 KB	87.0 KB	83%	4.0 KB
14	news.nntp4.net	50.9 KB	0.0 KB	73.5 KB	124.4 KB	40%	3.7 KB
15	dodin.fr.nf	17.9 KB	0.0 KB	0.0 KB	17.9 KB	100%	1.8 KB
16	news.bbs.nz	12.3 KB	0.0 KB	0.0 KB	12.3 KB	100%	1.4 KB
17	news.furie.org.uk	4.3 KB	0.0 KB	0.0 KB	4.3 KB	100%	4.3 KB
18	novabbs.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
19	localhost	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
TOTAL: 20		47.4 MB	13.4 KB	4.2 MB	51.6 MB	91%	3.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 9 04:15:01 - 04:59:59	193	1.5%	0.07	1.9 MB	3.9%	0.73
Jan 9 05:00:00 - 05:59:59	266	2.1%	0.07	992.0 KB	2.0%	0.28
Jan 9 06:00:00 - 06:59:59	279	2.2%	0.08	896.2 KB	1.8%	0.25
Jan 9 07:00:00 - 07:59:59	401	3.1%	0.11	1.0 MB	2.1%	0.29
Jan 9 08:00:00 - 08:59:59	533	4.2%	0.15	1.9 MB	3.9%	0.54
Jan 9 09:00:00 - 09:59:59	579	4.5%	0.16	3.3 MB	6.8%	0.95
Jan 9 10:00:00 - 10:59:59	716	5.6%	0.20	2.2 MB	4.5%	0.62
Jan 9 11:00:00 - 11:59:59	615	4.8%	0.17	2.0 MB	4.2%	0.58
Jan 9 12:00:00 - 12:59:59	650	5.1%	0.18	1.9 MB	4.0%	0.55
Jan 9 13:00:00 - 13:59:59	584	4.6%	0.16	1.7 MB	3.5%	0.49
Jan 9 14:00:00 - 14:59:59	712	5.6%	0.20	2.3 MB	4.8%	0.66
Jan 9 15:00:00 - 15:59:59	791	6.2%	0.22	4.1 MB	8.3%	1.15
Jan 9 16:00:00 - 16:59:59	763	6.0%	0.21	2.7 MB	5.5%	0.76
Jan 9 17:00:00 - 17:59:59	727	5.7%	0.20	2.5 MB	5.0%	0.70
Jan 9 18:00:00 - 18:59:59	753	5.9%	0.21	2.2 MB	4.5%	0.63
Jan 9 19:00:00 - 19:59:59	676	5.3%	0.19	2.0 MB	4.1%	0.58
Jan 9 20:00:00 - 20:59:59	564	4.4%	0.16	1.8 MB	3.7%	0.51
Jan 9 21:00:00 - 21:59:59	640	5.0%	0.18	3.6 MB	7.3%	1.02
Jan 9 22:00:00 - 22:59:59	492	3.9%	0.14	1.6 MB	3.2%	0.45
Jan 9 23:00:00 - 23:59:59	404	3.2%	0.11	1.1 MB	2.3%	0.31
Jan 10 00:00:00 - 00:59:59	381	3.0%	0.11	1.6 MB	3.3%	0.46
Jan 10 01:00:00 - 01:59:59	409	3.2%	0.11	1.2 MB	2.4%	0.34
Jan 10 02:00:00 - 02:59:59	279	2.2%	0.08	2.2 MB	4.5%	0.63
Jan 10 03:00:00 - 03:59:59	301	2.4%	0.08	1.5 MB	3.0%	0.42
Jan 10 04:00:00 - 04:15:02	66	0.5%	0.07	649.3 KB	1.3%	0.72
TOTAL: 24:00:01	12774	100.0%	0.15	48.7 MB	100.0%	0.58

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	feeder.eternal-september.org	454	6	0	448
2	usenet.blueworldhosting.com	247	14	1	232
3	i2pn-out.news.weretis.net	244	1	0	243
4	news.swapon.de	118	0	0	118
5	usenet.goja.nl.eu.org	38	0	1	37
6	news-out.neodome.net	35	0	0	35
7	i2pn-out.feed.uzoreto.com	21	1	0	20
8	news.nntp4.net	18	0	0	18
9	news-out.aioe.org	14	5	0	9
10	news.samoylyk.net	3	0	3	0
11	news.niel.me	2	0	0	2
12	paganini.bofh.team	1	0	0	1
TOTAL: 12		1195	27	5	1163

Unwanted newsgroups [Top 20]:

Newsgroup	Count
att.jobs	8
aus.jobs	5
alt.religion.buddhism	5
de.soc.dateschutz	2
alt.music.pink-floyd.publius	2
alt.math	1
a.b.comp	1
a.b.nzbpirates	1
it-alt.discussioni.ebay	1
alt.linux	1
TOTAL: 10	27

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	485
Too many newsgroups	220
Poison newsgroup	113
EMP (fsl)	40
Binary: misplaced rar	3
User-issued cancel	3
Binary: misplaced PAR2	1
Scoring filter (8)	1
Scoring filter (9)	1
Scoring filter (15)	1
HTML Image Tags	1
TOTAL: 11	869

INND no permission servers:

System	Conn
47.190.124.28	54
45.227.254.36	2
107.170.226.23	1
192.241.193.43	1
104.152.52.100	1
2a06:4880:7000::47	1
146.190.125.99	1
104.152.52.201	1
TOTAL: 8	62

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	i2pn-out.news.weretis.net	151
	news.swapon.de	118
	feeder.eternal-september.org	12
	usenet.blueworldhosting.com	4
	news-out.aioe.org	3
	news-out.neodome.net	2
	usenet.goja.nl.eu.org	2
	paganini.bofh.team	1
	TOTAL: 8	293
No colon-space in header
	i2pn-out.feed.uzoreto.com	1
	TOTAL: 1	1
TOTAL: 2		294

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	retrobbs.ddns.net	12550	12089	0	456	0	0	96%	23:58:41
2	i2pn2	12788	11180	572	739	0	314	87%	24:03:24
3	novabbs	15190	9012	2825	708	0	163	59%	23:59:53
4	kf5zxw.com	22558	4787	9499	293	2	47	21%	24:09:53
5	aioe	10525	2209	7679	38	0	0	20%	24:08:11
6	news.nntp4.net	14384	2127	10586	41	0	14	14%	23:59:48
7	nntp.alphanet.ch	13753	1731	10205	651	0	0	12%	23:59:53
8	news.niel.me	4174	1272	2550	108	0	0	30%	23:59:45
9	news.furie.org.uk	9700	934	5647	104	0	2	9%	23:59:53
10	paganini.bofh.team	15132	887	11691	5	0	0	5%	23:59:53
11	neodome	15155	779	11802	0	0	0	5%	23:59:53
12	usenet.goja.nl.eu.org	14287	718	11417	26	0	13	5%	24:04:23
13	news.bbs.nz	24483	668	11815	279	0	118	2%	24:03:17
14	news.uzoreto.com	15095	222	11670	0	0	0	1%	23:59:53
15	weretis.net	12327	90	8205	821	0	0	0%	23:59:53
16	usenet.blueworldhosting.com	16491	84	9100	6	0	51	0%	23:59:53
17	eternal-september	13987	83	10172	44	0	17	0%	24:07:59
18	news.samoylyk.net	16044	71	12549	7	0	0	0%	23:59:03
19	dodin.fr.nf	779	57	449	0	0	0	7%	18:52:35
20	swapon.de	1216	2	1012	0	0	0	0%	23:45:43
TOTAL: 20		260618	49002	149445	4326	2	739	18%	475:11:46

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	retrobbs.ddns.net	45.0 MB	2.7 MB	47.7 MB	0.6 KB/s	3.9 KB	23:58:41
2	i2pn2	40.0 MB	5.0 MB	45.0 MB	0.5 KB/s	3.9 KB	24:03:24
3	novabbs	34.8 MB	4.5 MB	39.3 MB	0.5 KB/s	4.1 KB	23:59:53
4	kf5zxw.com	16.4 MB	961.4 KB	17.3 MB	0.2 KB/s	3.5 KB	24:09:53
5	aioe	7.8 MB	139.0 KB	8.0 MB	0.1 KB/s	3.6 KB	24:08:11
6	news.nntp4.net	6.9 MB	486.6 KB	7.4 MB	0.1 KB/s	3.5 KB	23:59:48
7	nntp.alphanet.ch	5.8 MB	2.6 MB	8.4 MB	0.1 KB/s	3.6 KB	23:59:53
8	news.niel.me	4.1 MB	390.6 KB	4.5 MB	0.1 KB/s	3.3 KB	23:59:45
9	paganini.bofh.team	3.2 MB	293.0 KB	3.5 MB	0.0 KB/s	4.0 KB	23:59:53
10	news.furie.org.uk	2.9 MB	357.5 KB	3.2 MB	0.0 KB/s	3.2 KB	23:59:53
11	news.bbs.nz	2.8 MB	1.2 MB	4.0 MB	0.0 KB/s	4.3 KB	24:03:17
12	neodome	2.5 MB	0.0 KB	2.5 MB	0.0 KB/s	3.3 KB	23:59:53
13	usenet.goja.nl.eu.org	2.2 MB	277.6 KB	2.5 MB	0.0 KB/s	3.4 KB	24:04:23
14	news.uzoreto.com	740.6 KB	0.0 KB	740.6 KB	0.0 KB/s	3.3 KB	23:59:53
15	dodin.fr.nf	576.2 KB	0.0 KB	576.2 KB	0.0 KB/s	10.1 KB	18:52:35
16	usenet.blueworldhosting.com	320.1 KB	13.4 KB	333.5 KB	0.0 KB/s	3.7 KB	23:59:53
17	eternal-september	210.3 KB	263.8 KB	474.1 KB	0.0 KB/s	3.7 KB	24:07:59
18	weretis.net	207.0 KB	1.4 MB	1.6 MB	0.0 KB/s	1.8 KB	23:59:53
19	news.samoylyk.net	169.4 KB	129.7 KB	299.1 KB	0.0 KB/s	3.8 KB	23:59:03
20	swapon.de	10.6 KB	0.0 KB	10.6 KB	0.0 KB/s	5.3 KB	23:45:43
TOTAL: 20		176.6 MB	20.7 MB	197.2 MB	0.1 KB/s	3.8 KB	475:11:46

Daily Usenet report

Jan 9 04:15:01 -- Jan 10 04:15:02