Daily Usenet report: Jan 21 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	18276	51.7%	4.3 MB	64.8%
innd	12327	34.9%	1.6 MB	24.7%
innfeed	4720	13.4%	721.0 KB	10.6%
controlchan	3	0.0%	0.3 KB	0.0%
nocem	2	0.0%	0.1 KB	0.0%
TOTAL: 5	35328	100.0%	6.7 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	168836	56.4%
Negative hits	112380	37.5%
Do not exist	17875	6.0%
Cache misses	195	0.1%
TOTAL: 4	299286	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.019	0.0%	43	0.000	0.442	1.000
article cleanup	00:00:00.096	0.0%	17924	0.000	0.005	0.033
article logging	00:00:00.531	0.0%	18237	0.000	0.029	0.095
article parse	00:00:00.294	0.0%	35913	0.000	0.008	0.039
article write	00:00:07.741	0.0%	16221	0.056	0.477	15.071
artlog/artcncl	00:00:00.001	0.0%	43	0.000	0.023	1.000
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:00:00.108	0.0%	311482	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.001	0.0%	42	0.000	0.024	0.333
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:01.195	0.0%	299914	0.001	0.004	0.013
history sync	00:00:00.041	0.0%	377	0.000	0.109	9.667
history write	00:00:02.837	0.0%	17915	0.000	0.158	10.371
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
idle	23:59:34.688	99.9%	312651	150.438	276.266	900.772
nntp read	00:00:02.505	0.0%	312142	0.002	0.008	0.016
overview write	00:00:02.696	0.0%	16221	0.000	0.166	4.524
perl filter	00:00:22.085	0.0%	17914	0.865	1.233	4.930
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:01.587	0.0%	32512	0.000	0.049	0.118
TOTAL: 24:00:56.934	24:00:16.425	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.048	0.0%	20576	0.000	0.002	0.021
article prepare	00:00:00.018	0.0%	135672	0.000	0.000	0.002
article read	00:00:00.922	0.0%	16026	0.000	0.058	0.451
backlog stats	00:00:00.474	0.0%	425977	0.000	0.001	0.005
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.455	0.0%	282202	0.003	0.009	0.015
data write	00:00:02.163	0.0%	269949	0.003	0.008	0.016
idle	23:53:46.227	100.0%	425977	113.045	201.950	798.259
status file	00:00:03.047	0.0%	1159	0.200	2.629	68.182
TOTAL: 23:54:10.424	23:53:55.354	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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
thh@thh.name	0	2	0	0	0	2
TOTAL	0	2	0	0	0	2

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	i2pn-out.news.weretis.net	8	28668	6431	22080	157	22%	45:00:50
2	news-out.aioe.org	2	12187	3214	8926	47	26%	24:09:01
3	feeder.eternal-september.org	21	6788	3116	2903	769	45%	29:17:59
4	paganini.bofh.team	2	19768	1397	18198	173	7%	29:20:04
5	usenet.goja.nl.eu.org	15	14495	1187	13275	33	8%	24:11:12
6	news.swapon.de	10	1022	245	777	0	23%	23:56:09
7	news.niel.me	1	3529	210	3308	11	5%	23:59:57
8	news-out.neodome.net	2	16150	175	15949	26	1%	23:59:56
9	i2pn-out.feed.uzoreto.com	1963	18039	94	17647	298	0%	70:44:58
10	news.nntp4.net	1	17276	92	17051	133	0%	23:59:56
11	news.bbs.nz	16	13796	23	13772	1	0%	37:54:24
12	i2pn2.org	44	327	22	305	0	6%	16:50:46
13	dodin.fr.nf	20	664	18	646	0	2%	20:54:46
14	news.samoylyk.net	2	14891	4	14802	85	0%	23:59:43
15	kf5zxw.com	1	15580	2	15578	0	0%	23:59:56
16	novabbs.org	2	47	0	47	0	0%	00:38:07
17	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 17		2135	183227	16230	165264	1733	8%	442:57:44

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn-out.news.weretis.net	27.0 MB	0.0 KB	534.4 KB	27.5 MB	98%	4.3 KB
2	feeder.eternal-september.org	24.4 MB	0.0 KB	3.8 MB	28.2 MB	86%	7.4 KB
3	news-out.aioe.org	8.0 MB	0.0 KB	187.2 KB	8.2 MB	97%	2.6 KB
4	paganini.bofh.team	3.2 MB	2.5 KB	570.3 KB	3.8 MB	85%	2.5 KB
5	usenet.goja.nl.eu.org	2.8 MB	4.2 KB	112.0 KB	2.9 MB	96%	2.4 KB
6	news.nntp4.net	905.2 KB	1.8 KB	849.9 KB	1.7 MB	51%	7.8 KB
7	news-out.neodome.net	776.0 KB	2.9 KB	94.4 KB	873.3 KB	88%	4.3 KB
8	news.swapon.de	598.7 KB	0.0 KB	0.0 KB	598.7 KB	100%	2.4 KB
9	news.niel.me	425.9 KB	0.0 KB	26.2 KB	452.0 KB	94%	2.0 KB
10	i2pn-out.feed.uzoreto.com	221.0 KB	0.0 KB	1.9 MB	2.2 MB	10%	5.6 KB
11	i2pn2.org	44.4 KB	0.0 KB	0.0 KB	44.4 KB	100%	2.0 KB
12	news.bbs.nz	39.6 KB	2.4 KB	2.4 KB	44.4 KB	89%	1.9 KB
13	dodin.fr.nf	31.4 KB	0.0 KB	0.0 KB	31.4 KB	100%	1.7 KB
14	news.samoylyk.net	10.5 KB	8.8 KB	347.0 KB	366.4 KB	2%	4.1 KB
15	kf5zxw.com	2.2 KB	0.0 KB	0.0 KB	2.2 KB	100%	1.1 KB
16	novabbs.org	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		68.4 MB	22.6 KB	8.4 MB	76.8 MB	89%	4.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 21 04:15:01 - 04:59:59	210	1.3%	0.08	922.1 KB	1.3%	0.34
Jan 21 05:00:00 - 05:59:59	377	2.3%	0.10	1.3 MB	2.0%	0.38
Jan 21 06:00:00 - 06:59:59	445	2.7%	0.12	2.0 MB	3.0%	0.58
Jan 21 07:00:00 - 07:59:59	447	2.8%	0.12	1.5 MB	2.2%	0.41
Jan 21 08:00:00 - 08:59:59	630	3.9%	0.17	1.8 MB	2.6%	0.50
Jan 21 09:00:00 - 09:59:59	823	5.1%	0.23	2.2 MB	3.3%	0.64
Jan 21 10:00:00 - 10:59:59	857	5.3%	0.24	3.4 MB	5.1%	0.98
Jan 21 11:00:00 - 11:59:59	958	5.9%	0.27	2.9 MB	4.3%	0.83
Jan 21 12:00:00 - 12:59:59	790	4.9%	0.22	2.2 MB	3.3%	0.63
Jan 21 13:00:00 - 13:59:59	899	5.5%	0.25	2.7 MB	4.0%	0.77
Jan 21 14:00:00 - 14:59:59	1032	6.4%	0.29	3.2 MB	4.8%	0.91
Jan 21 15:00:00 - 15:59:59	982	6.1%	0.27	2.9 MB	4.3%	0.82
Jan 21 16:00:00 - 16:59:59	1097	6.8%	0.30	5.1 MB	7.5%	1.44
Jan 21 17:00:00 - 17:59:59	1012	6.2%	0.28	2.9 MB	4.4%	0.84
Jan 21 18:00:00 - 18:59:59	920	5.7%	0.26	3.0 MB	4.4%	0.85
Jan 21 19:00:00 - 19:59:59	719	4.4%	0.20	2.3 MB	3.5%	0.67
Jan 21 20:00:00 - 20:59:59	760	4.7%	0.21	2.4 MB	3.6%	0.69
Jan 21 21:00:00 - 21:59:59	716	4.4%	0.20	2.5 MB	3.8%	0.72
Jan 21 22:00:00 - 22:59:59	699	4.3%	0.19	5.6 MB	8.3%	1.59
Jan 21 23:00:00 - 23:59:59	556	3.4%	0.15	2.4 MB	3.5%	0.68
Jan 22 00:00:00 - 00:59:59	359	2.2%	0.10	2.2 MB	3.3%	0.63
Jan 22 01:00:00 - 01:59:59	336	2.1%	0.09	3.5 MB	5.2%	1.00
Jan 22 02:00:00 - 02:59:59	255	1.6%	0.07	2.8 MB	4.1%	0.79
Jan 22 03:00:00 - 03:59:59	289	1.8%	0.08	5.1 MB	7.6%	1.45
Jan 22 04:00:00 - 04:15:01	50	0.3%	0.06	316.7 KB	0.5%	0.35
TOTAL: 24:00:00	16218	100.0%	0.19	67.3 MB	100.0%	0.80

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	feeder.eternal-september.org	777	13	0	764
2	i2pn-out.feed.uzoreto.com	302	3	0	299
3	i2pn-out.news.weretis.net	294	5	0	289
4	paganini.bofh.team	139	3	1	135
5	news.nntp4.net	134	4	1	129
6	news.swapon.de	123	0	0	123
7	news.samoylyk.net	85	0	2	83
8	news-out.aioe.org	75	17	0	58
9	usenet.goja.nl.eu.org	42	0	2	40
10	news-out.neodome.net	31	0	3	28
11	news.niel.me	11	0	0	11
12	kf5zxw.com	1	0	0	1
13	news.bbs.nz	1	0	1	0
TOTAL: 13		2015	45	10	1960

Unwanted newsgroups [Top 20]:

Newsgroup	Count
att.jobs	11
aus.jobs	7
free.it.satellite.skyitalia	4
gun.general	2
alt.makemoney	2
lucky.test	1
bit.test	1
redhat.test	1
bit.listserv.test	1
alt.sixty.plus	1
alt.test.foo	1
houston.test	1
muenster.test	1
alt.va.personals	1
alt.economics	1
rhein.test	1
alt.penthouse.sex.first-time	1
ibm.software.japan.test	1
ga.jobs	1
alt.music.pink-floyd.publius	1
TOTAL: 24	45

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1150
Too many newsgroups	296
Poison newsgroup	126
User-issued cancel	37
User-issued spam cancel	23
HTML Multipart	7
hierarchy violation - crosspost outside netscape	3
Binary: misplaced rar	2
Scoring filter (9)	1
Scoring filter (8)	1
HTML Image Tags	1
TOTAL: 11	1647

INND no permission servers:

System	Conn
185.220.100.252	1
167.94.138.42	1
212.90.61.180	1
TOTAL: 3	3

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	i2pn-out.feed.uzoreto.com	1
	TOTAL: 1	1
Including strange strings
	i2pn-out.news.weretis.net	137
	news.swapon.de	123
	news-out.aioe.org	30
	usenet.goja.nl.eu.org	9
	i2pn-out.feed.uzoreto.com	4
	news-out.neodome.net	4
	feeder.eternal-september.org	3
	paganini.bofh.team	2
	TOTAL: 8	312
No colon-space in header
	i2pn-out.feed.uzoreto.com	1
	TOTAL: 1	1
TOTAL: 3		314

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn2	16074	14588	252	883	0	90%	23:59:24
2	novabbs	23317	8088	7244	631	41	34%	23:59:43
3	news.samoylyk.net	16265	2065	13918	8	0	12%	23:59:50
4	aioe	12796	1814	10568	8	0	14%	23:59:50
5	kf5zxw.com	27784	1379	14814	0	4116	4%	23:58:43
6	paganini.bofh.team	16320	959	13987	0	0	5%	23:59:40
7	news.niel.me	4593	950	3359	231	0	20%	23:59:16
8	news.bbs.nz	31732	443	15647	85	195	1%	23:59:49
9	news.nntp4.net	18322	135	15898	2	2	0%	23:59:50
10	neodome	18180	72	15748	0	0	0%	23:59:33
11	weretis.net	15804	63	8490	1010	34	0%	23:59:50
12	dodin.fr.nf	1156	53	640	0	0	4%	20:51:47
13	news.uzoreto.com	17208	46	14320	0	0	0%	23:59:49
14	eternal-september	15340	46	12978	4	0	0%	23:59:50
15	usenet.goja.nl.eu.org	16993	45	14718	23	12	0%	23:59:49
16	swapon.de	1089	19	916	0	0	1%	23:14:45
TOTAL: 16		252973	30765	163497	2885	4400	12%	380:01:28

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	novabbs	45.5 MB	2.5 MB	48.0 MB	0.6 KB/s	5.6 KB	23:59:43
2	i2pn2	37.4 MB	2.8 MB	40.3 MB	0.5 KB/s	2.7 KB	23:59:24
3	news.samoylyk.net	7.2 MB	44.2 KB	7.2 MB	0.1 KB/s	3.6 KB	23:59:50
4	aioe	6.0 MB	32.9 KB	6.0 MB	0.1 KB/s	3.4 KB	23:59:50
5	kf5zxw.com	4.7 MB	0.0 KB	4.7 MB	0.1 KB/s	3.5 KB	23:58:43
6	news.niel.me	3.3 MB	782.9 KB	4.1 MB	0.0 KB/s	3.5 KB	23:59:16
7	paganini.bofh.team	2.7 MB	0.0 KB	2.7 MB	0.0 KB/s	2.9 KB	23:59:40
8	dodin.fr.nf	2.1 MB	0.0 KB	2.1 MB	0.0 KB/s	40.6 KB	20:51:47
9	news.bbs.nz	1.6 MB	388.3 KB	2.0 MB	0.0 KB/s	3.9 KB	23:59:49
10	weretis.net	329.2 KB	2.2 MB	2.5 MB	0.0 KB/s	2.4 KB	23:59:50
11	news.nntp4.net	287.3 KB	24.6 KB	311.9 KB	0.0 KB/s	2.3 KB	23:59:50
12	neodome	201.2 KB	0.0 KB	201.2 KB	0.0 KB/s	2.8 KB	23:59:33
13	usenet.goja.nl.eu.org	118.8 KB	54.3 KB	173.1 KB	0.0 KB/s	2.5 KB	23:59:49
14	news.uzoreto.com	110.9 KB	0.0 KB	110.9 KB	0.0 KB/s	2.4 KB	23:59:49
15	eternal-september	92.7 KB	27.7 KB	120.5 KB	0.0 KB/s	2.4 KB	23:59:50
16	swapon.de	39.6 KB	0.0 KB	39.6 KB	0.0 KB/s	2.1 KB	23:14:45
TOTAL: 16		111.7 MB	8.8 MB	120.5 MB	0.1 KB/s	3.7 KB	380:01:28

Daily Usenet report

Jan 21 04:15:01 -- Jan 22 04:15:01