Daily Usenet report: Feb 26 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	16985	53.4%	4.1 MB	66.1%
innd	11674	36.7%	1.6 MB	25.4%
innfeed	3155	9.9%	536.2 KB	8.5%
controlchan	4	0.0%	0.3 KB	0.0%
pgpverify	3	0.0%	0.4 KB	0.0%
nocem	1	0.0%	0.1 KB	0.0%
TOTAL: 6	31822	100.0%	6.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	144587	53.8%
Negative hits	107003	39.8%
Do not exist	16686	6.2%
Cache misses	657	0.2%
TOTAL: 4	268933	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.010	0.0%	47	0.000	0.213	1.000
article cleanup	00:00:00.088	0.0%	16697	0.000	0.005	0.045
article logging	00:00:00.442	0.0%	16936	0.000	0.026	0.078
article parse	00:00:00.265	0.0%	34794	0.000	0.008	0.043
article write	00:00:02.906	0.0%	15516	0.056	0.187	1.067
artlog/artcncl	00:00:00.002	0.0%	47	0.000	0.043	0.143
artlog/artparse	00:00:00.001	0.0%	4	0.000	0.250	0.500
data move	00:00:00.104	0.0%	280765	0.000	0.000	0.003
hisgrep/artcncl	00:00:00.000	0.0%	47	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	47	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.072	0.0%	269070	0.000	0.004	0.010
history sync	00:00:00.009	0.0%	383	0.000	0.023	0.500
history write	00:00:00.769	0.0%	16699	0.000	0.046	0.308
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:59:52.078	99.9%	284016	162.897	304.180	1672.290
nntp read	00:00:02.464	0.0%	283171	0.002	0.009	0.015
overview write	00:00:01.228	0.0%	15516	0.014	0.079	0.500
perl filter	00:00:20.015	0.0%	16695	0.817	1.199	4.800
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:01.080	0.0%	31080	0.000	0.035	0.099
TOTAL: 24:00:57.868	24:00:22.533	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.031	0.0%	18705	0.000	0.002	0.024
article prepare	00:00:00.012	0.0%	135888	0.000	0.000	0.002
article read	00:00:01.652	0.0%	17558	0.000	0.094	0.333
backlog stats	00:00:00.466	0.0%	373599	0.000	0.001	0.004
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.212	0.0%	254351	0.004	0.009	0.023
data write	00:00:02.110	0.0%	240126	0.003	0.009	0.018
idle	23:54:51.940	100.0%	373599	121.350	230.439	879.523
status file	00:00:00.327	0.0%	335	0.000	0.976	15.857
TOTAL: 23:55:09.647	23:54:58.750	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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
moderator@dana.de	0	0	0	3	0	0
TOTAL	0	0	0	3	0	0

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	i2pn-out.news.weretis.net	11	28569	5773	22631	165	20%	49:17:51
2	feeder.eternal-september.org	69	6358	3234	2864	260	50%	33:04:25
3	news-out.aioe.org	3	12240	2555	9650	35	20%	24:08:49
4	usenet.goja.nl.eu.org	12	14122	1776	12293	53	12%	24:07:14
5	paganini.bofh.team	4	15768	1262	14208	298	8%	22:47:54
6	news.swapon.de	8	1269	343	926	0	27%	23:19:05
7	news-out.neodome.net	1	15067	140	14849	78	0%	23:59:56
8	news.nntp4.net	2	16293	125	16032	136	0%	23:59:46
9	i2pn-out.feed.uzoreto.com	1926	16563	80	16309	174	0%	71:08:55
10	news.samoylyk.net	1	12258	61	12197	0	0%	23:59:52
11	news.niel.me	2	4323	51	4270	2	1%	23:59:08
12	i2pn2.org	43	279	38	241	0	13%	16:05:32
13	dodin.fr.nf	12	1050	21	1029	0	2%	21:16:40
14	news.bbs.nz	9	15200	11	15188	1	0%	33:34:03
15	novabbs.org	5	3384	6	3378	0	0%	21:28:45
16	kf5zxw.com	1	0	0	0	0	0%	00:10:03
17	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 17		2134	162743	15476	146065	1202	9%	436:27:58

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn-out.news.weretis.net	24.7 MB	0.0 KB	481.7 KB	25.2 MB	98%	4.3 KB
2	feeder.eternal-september.org	10.1 MB	0.0 KB	4.4 MB	14.6 MB	69%	4.3 KB
3	news-out.aioe.org	6.4 MB	0.0 KB	102.6 KB	6.5 MB	98%	2.6 KB
4	usenet.goja.nl.eu.org	4.3 MB	0.0 KB	190.0 KB	4.5 MB	95%	2.5 KB
5	paganini.bofh.team	3.5 MB	0.0 KB	1.3 MB	4.8 MB	72%	3.1 KB
6	news.swapon.de	880.5 KB	0.0 KB	0.0 KB	880.5 KB	100%	2.6 KB
7	news.nntp4.net	546.6 KB	0.0 KB	8.3 MB	8.8 MB	6%	34.5 KB
8	news-out.neodome.net	506.0 KB	4.7 KB	382.9 KB	893.6 KB	56%	4.1 KB
9	i2pn-out.feed.uzoreto.com	251.1 KB	0.0 KB	481.9 KB	733.0 KB	34%	2.9 KB
10	news.samoylyk.net	247.6 KB	0.0 KB	0.0 KB	247.6 KB	100%	4.1 KB
11	news.niel.me	125.6 KB	0.0 KB	2.3 KB	127.9 KB	98%	2.4 KB
12	i2pn2.org	73.3 KB	0.0 KB	0.0 KB	73.3 KB	100%	1.9 KB
13	novabbs.org	37.1 KB	0.0 KB	0.0 KB	37.1 KB	100%	6.2 KB
14	dodin.fr.nf	34.5 KB	0.0 KB	0.0 KB	34.5 KB	100%	1.6 KB
15	news.bbs.nz	16.7 KB	7.0 KB	7.0 KB	30.7 KB	54%	2.6 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		51.7 MB	11.7 KB	15.6 MB	67.3 MB	76%	4.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 26 04:15:01 - 04:59:59	179	1.2%	0.07	952.5 KB	1.8%	0.35
Feb 26 05:00:00 - 05:59:59	206	1.3%	0.06	962.6 KB	1.8%	0.27
Feb 26 06:00:00 - 06:59:59	343	2.2%	0.10	1011.9 KB	1.9%	0.28
Feb 26 07:00:00 - 07:59:59	520	3.4%	0.14	2.3 MB	4.4%	0.64
Feb 26 08:00:00 - 08:59:59	566	3.6%	0.16	2.3 MB	4.5%	0.66
Feb 26 09:00:00 - 09:59:59	672	4.3%	0.19	1.6 MB	3.1%	0.46
Feb 26 10:00:00 - 10:59:59	781	5.0%	0.22	2.0 MB	3.9%	0.57
Feb 26 11:00:00 - 11:59:59	754	4.9%	0.21	2.9 MB	5.5%	0.81
Feb 26 12:00:00 - 12:59:59	689	4.4%	0.19	2.3 MB	4.4%	0.65
Feb 26 13:00:00 - 13:59:59	758	4.9%	0.21	3.1 MB	5.9%	0.87
Feb 26 14:00:00 - 14:59:59	879	5.7%	0.24	3.0 MB	5.8%	0.86
Feb 26 15:00:00 - 15:59:59	842	5.4%	0.23	2.6 MB	5.1%	0.75
Feb 26 16:00:00 - 16:59:59	946	6.1%	0.26	2.7 MB	5.2%	0.77
Feb 26 17:00:00 - 17:59:59	990	6.4%	0.28	3.3 MB	6.4%	0.95
Feb 26 18:00:00 - 18:59:59	836	5.4%	0.23	2.6 MB	5.1%	0.75
Feb 26 19:00:00 - 19:59:59	965	6.2%	0.27	4.0 MB	7.8%	1.14
Feb 26 20:00:00 - 20:59:59	895	5.8%	0.25	2.3 MB	4.5%	0.66
Feb 26 21:00:00 - 21:59:59	882	5.7%	0.24	2.7 MB	5.1%	0.76
Feb 26 22:00:00 - 22:59:59	732	4.7%	0.20	2.2 MB	4.2%	0.62
Feb 26 23:00:00 - 23:59:59	570	3.7%	0.16	1.8 MB	3.4%	0.50
Feb 27 00:00:00 - 00:59:59	441	2.8%	0.12	1.8 MB	3.4%	0.51
Feb 27 01:00:00 - 01:59:59	361	2.3%	0.10	1.1 MB	2.1%	0.31
Feb 27 02:00:00 - 02:59:59	312	2.0%	0.09	975.9 KB	1.8%	0.27
Feb 27 03:00:00 - 03:59:59	325	2.1%	0.09	1.0 MB	2.0%	0.30
Feb 27 04:00:00 - 04:15:02	69	0.4%	0.08	360.9 KB	0.7%	0.40
TOTAL: 24:00:01	15513	100.0%	0.18	51.8 MB	100.0%	0.61

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	paganini.bofh.team	301	5	0	296
2	feeder.eternal-september.org	266	0	0	266
3	i2pn-out.news.weretis.net	213	1	0	212
4	i2pn-out.feed.uzoreto.com	174	1	0	173
5	news.nntp4.net	150	5	0	145
6	news.swapon.de	147	0	0	147
7	usenet.goja.nl.eu.org	59	0	0	59
8	news-out.neodome.net	59	0	1	58
9	news-out.aioe.org	53	13	0	40
10	news.niel.me	2	0	0	2
11	news.bbs.nz	1	0	1	0
TOTAL: 11		1425	25	2	1398

Unwanted newsgroups [Top 20]:

Newsgroup	Count
att.jobs	12
alt.culture.underwear	6
aus.jobs	5
alt.startrek	1
alt.pl.voip	1
TOTAL: 5	25

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	548
Too many newsgroups	377
Poison newsgroup	93
User-issued cancel	78
Excessive Supersedes (88.165.5.23)	29
User-issued spam cancel	11
Scoring filter (8)	8
HTML Multipart	6
Binary: misplaced par2	3
Binary: misplaced PAR2	2
TOTAL: 10	1155

INND no permission servers:

System	Conn
123.160.221.19	3
23.129.64.250	1
TOTAL: 2	4

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news.swapon.de	147
	i2pn-out.news.weretis.net	57
	news-out.aioe.org	15
	usenet.goja.nl.eu.org	8
	news-out.neodome.net	6
	feeder.eternal-september.org	3
	paganini.bofh.team	2
	news.nntp4.net	1
	TOTAL: 8	239
No colon-space in header
	i2pn-out.feed.uzoreto.com	4
	TOTAL: 1	4
TOTAL: 2		243

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	i2pn2	15383	13469	213	1469	1	6	87%	23:59:54
2	novabbs	18884	10289	3626	1380	1	32	54%	23:59:54
3	eternal-september	16682	2326	12257	58	4	521	13%	23:56:25
4	aioe	12649	1327	11141	5	0	0	10%	23:59:54
5	news.samoylyk.net	16265	1051	14281	10	0	0	6%	23:59:54
6	news.niel.me	5279	708	4386	67	0	0	13%	23:59:41
7	news.bbs.nz	30426	326	15103	65	0	88	1%	23:59:54
8	paganini.bofh.team	15892	87	14120	0	0	8	0%	23:59:54
9	neodome	17152	76	15175	0	0	0	0%	23:59:53
10	weretis.net	16238	75	8699	953	0	1	0%	23:59:53
11	dodin.fr.nf	1660	56	1035	0	0	0	3%	22:52:02
12	news.nntp4.net	17255	54	15327	4	0	0	0%	23:59:41
13	usenet.goja.nl.eu.org	15408	52	13506	71	0	15	0%	23:59:54
14	news.uzoreto.com	16298	39	14375	0	0	0	0%	23:59:46
15	kf5zxw.com	0	0	0	0	0	15513	0%	23:57:45
16	swapon.de	1272	0	1136	0	0	0	0%	23:11:27
TOTAL: 16		216743	29935	144380	4082	6	16184	13%	381:55:51

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	i2pn2	35.9 MB	4.1 MB	40.0 MB	0.5 KB/s	2.7 KB	23:59:54
2	novabbs	35.8 MB	4.6 MB	40.4 MB	0.5 KB/s	3.5 KB	23:59:54
3	eternal-september	9.0 MB	360.6 KB	9.3 MB	0.1 KB/s	4.0 KB	23:56:25
4	aioe	4.6 MB	34.8 KB	4.7 MB	0.1 KB/s	3.6 KB	23:59:54
5	news.samoylyk.net	3.4 MB	47.1 KB	3.4 MB	0.0 KB/s	3.3 KB	23:59:54
6	news.niel.me	2.5 MB	216.9 KB	2.7 MB	0.0 KB/s	3.6 KB	23:59:41
7	news.bbs.nz	1.8 MB	478.2 KB	2.2 MB	0.0 KB/s	5.8 KB	23:59:54
8	dodin.fr.nf	247.1 KB	0.0 KB	247.1 KB	0.0 KB/s	4.4 KB	22:52:02
9	paganini.bofh.team	217.7 KB	0.0 KB	217.7 KB	0.0 KB/s	2.5 KB	23:59:54
10	news.nntp4.net	192.5 KB	33.5 KB	226.0 KB	0.0 KB/s	3.9 KB	23:59:41
11	neodome	180.2 KB	0.0 KB	180.2 KB	0.0 KB/s	2.4 KB	23:59:53
12	weretis.net	157.3 KB	1.7 MB	1.8 MB	0.0 KB/s	1.8 KB	23:59:53
13	usenet.goja.nl.eu.org	149.4 KB	135.5 KB	284.9 KB	0.0 KB/s	2.3 KB	23:59:54
14	news.uzoreto.com	134.1 KB	0.0 KB	134.1 KB	0.0 KB/s	3.4 KB	23:59:46
15	kf5zxw.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:45
16	swapon.de	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:11:27
TOTAL: 16		94.2 MB	11.6 MB	105.8 MB	0.1 KB/s	3.2 KB	381:55:51

Daily Usenet report

Feb 26 04:15:01 -- Feb 27 04:15:02