Daily Usenet report: Jan 28 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	17182	51.7%	4.1 MB	64.8%
innd	11343	34.2%	1.5 MB	24.1%
innfeed	4667	14.1%	714.1 KB	11.0%
nocem	17	0.1%	2.1 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	33210	100.0%	6.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	161081	56.9%
Negative hits	105251	37.2%
Do not exist	16780	5.9%
Cache misses	77	0.0%
TOTAL: 4	283189	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.012	0.0%	61	0.000	0.197	1.000
article cleanup	00:00:00.078	0.0%	16804	0.000	0.005	0.047
article logging	00:00:00.519	0.0%	17135	0.000	0.030	0.083
article parse	00:00:00.284	0.0%	30485	0.000	0.009	0.039
article write	00:00:05.380	0.0%	15468	0.021	0.348	12.068
artlog/artcncl	00:00:00.001	0.0%	51	0.000	0.020	0.500
artlog/artparse	00:00:00.000	0.0%	2	0.000	0.000	0.000
data move	00:00:00.109	0.0%	291849	0.000	0.000	0.003
hisgrep/artcncl	00:00:00.001	0.0%	59	0.000	0.017	0.167
hishave/artcncl	00:00:00.000	0.0%	61	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.189	0.0%	283331	0.000	0.004	0.011
history sync	00:00:00.016	0.0%	370	0.000	0.043	0.500
history write	00:00:00.802	0.0%	16791	0.000	0.048	0.643
hiswrite/artcncl	00:00:00.000	0.0%	2	0.000	0.000	0.000
idle	23:59:33.671	99.9%	293702	155.261	294.086	1095.684
nntp read	00:00:02.366	0.0%	293220	0.003	0.008	0.016
overview write	00:00:02.065	0.0%	15468	0.000	0.134	3.030
perl filter	00:00:19.736	0.0%	16789	0.863	1.176	3.679
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:01.159	0.0%	31012	0.000	0.037	0.100
TOTAL: 24:00:56.042	24:00:07.388	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.039	0.0%	20553	0.000	0.002	0.024
article prepare	00:00:00.012	0.0%	135108	0.000	0.000	0.003
article read	00:00:00.899	0.0%	15378	0.000	0.058	0.475
backlog stats	00:00:00.590	0.0%	420213	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.537	0.0%	274804	0.003	0.009	0.019
data write	00:00:02.264	0.0%	262861	0.002	0.009	0.018
idle	23:55:44.959	100.0%	420213	103.209	205.003	631.492
status file	00:00:04.116	0.0%	1095	0.200	3.759	228.636
TOTAL: 23:56:06.256	23:55:55.416	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	6	28108	6642	21216	250	23%	48:27:22
2	news-out.aioe.org	3	12456	3539	8858	59	28%	24:08:58
3	feeder.eternal-september.org	31	6765	2845	3429	491	42%	28:24:10
4	usenet.goja.nl.eu.org	13	14772	1025	13680	67	6%	26:10:15
5	paganini.bofh.team	2	12358	742	11558	58	6%	15:53:38
6	news.nntp4.net	3	16447	166	16156	125	1%	24:12:02
7	news-out.neodome.net	2	15468	159	15278	31	1%	23:59:55
8	news.niel.me	1	3533	130	3403	0	3%	23:59:54
9	i2pn-out.feed.uzoreto.com	1815	16721	82	16387	252	0%	70:22:38
10	news.swapon.de	6	1082	42	1039	1	3%	24:33:03
11	i2pn2.org	38	113	23	90	0	20%	09:21:39
12	news.bbs.nz	12	11422	20	11401	1	0%	29:20:50
13	news.samoylyk.net	1	13638	16	13549	73	0%	23:59:52
14	dodin.fr.nf	17	805	9	796	0	1%	20:06:29
15	novabbs.org	6	6184	5	6179	0	0%	22:05:13
16	kf5zxw.com	2	15029	2	15022	5	0%	23:59:52
17	localhost	28	0	0	0	0	0%	00:00:00
TOTAL: 17		1986	174901	15447	158041	1413	8%	439:05:50

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn-out.news.weretis.net	26.3 MB	0.0 KB	1.1 MB	27.3 MB	96%	4.1 KB
2	feeder.eternal-september.org	14.8 MB	0.0 KB	2.9 MB	17.7 MB	83%	5.4 KB
3	news-out.aioe.org	7.9 MB	2.0 KB	210.7 KB	8.1 MB	97%	2.3 KB
4	paganini.bofh.team	2.5 MB	0.0 KB	181.1 KB	2.7 MB	93%	3.4 KB
5	usenet.goja.nl.eu.org	2.4 MB	2.0 KB	163.8 KB	2.6 MB	93%	2.4 KB
6	news.nntp4.net	1020.3 KB	2.8 KB	2.0 MB	3.0 MB	33%	10.5 KB
7	news-out.neodome.net	589.0 KB	8.6 KB	170.0 KB	767.6 KB	76%	4.0 KB
8	news.niel.me	346.6 KB	0.0 KB	0.0 KB	346.6 KB	100%	2.7 KB
9	i2pn-out.feed.uzoreto.com	181.9 KB	0.0 KB	3.5 MB	3.7 MB	4%	11.4 KB
10	news.swapon.de	116.6 KB	2.9 KB	2.9 KB	122.4 KB	95%	2.8 KB
11	i2pn2.org	51.2 KB	0.0 KB	0.0 KB	51.2 KB	100%	2.2 KB
12	news.samoylyk.net	41.4 KB	70.4 KB	296.6 KB	408.4 KB	10%	4.6 KB
13	news.bbs.nz	38.6 KB	6.7 KB	6.7 KB	52.0 KB	74%	2.5 KB
14	novabbs.org	32.0 KB	0.0 KB	0.0 KB	32.0 KB	100%	6.4 KB
15	dodin.fr.nf	14.1 KB	0.0 KB	0.0 KB	14.1 KB	100%	1.6 KB
16	kf5zxw.com	2.6 KB	6.3 KB	19.4 KB	28.3 KB	9%	4.0 KB
17	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 17		56.3 MB	101.8 KB	10.5 MB	66.9 MB	84%	4.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 28 04:15:01 - 04:59:59	201	1.3%	0.07	614.8 KB	1.1%	0.23
Jan 28 05:00:00 - 05:59:59	312	2.0%	0.09	1.1 MB	1.9%	0.31
Jan 28 06:00:00 - 06:59:59	390	2.5%	0.11	1.1 MB	2.0%	0.32
Jan 28 07:00:00 - 07:59:59	423	2.7%	0.12	2.0 MB	3.6%	0.58
Jan 28 08:00:00 - 08:59:59	650	4.2%	0.18	2.2 MB	3.8%	0.62
Jan 28 09:00:00 - 09:59:59	818	5.3%	0.23	2.4 MB	4.3%	0.69
Jan 28 10:00:00 - 10:59:59	799	5.2%	0.22	2.6 MB	4.6%	0.74
Jan 28 11:00:00 - 11:59:59	727	4.7%	0.20	2.8 MB	4.9%	0.79
Jan 28 12:00:00 - 12:59:59	784	5.1%	0.22	2.3 MB	4.0%	0.65
Jan 28 13:00:00 - 13:59:59	727	4.7%	0.20	2.1 MB	3.7%	0.60
Jan 28 14:00:00 - 14:59:59	1012	6.5%	0.28	4.1 MB	7.2%	1.16
Jan 28 15:00:00 - 15:59:59	1100	7.1%	0.31	3.0 MB	5.4%	0.86
Jan 28 16:00:00 - 16:59:59	1015	6.6%	0.28	3.6 MB	6.3%	1.02
Jan 28 17:00:00 - 17:59:59	833	5.4%	0.23	3.0 MB	5.3%	0.86
Jan 28 18:00:00 - 18:59:59	735	4.8%	0.20	2.8 MB	4.9%	0.79
Jan 28 19:00:00 - 19:59:59	866	5.6%	0.24	4.0 MB	7.1%	1.15
Jan 28 20:00:00 - 20:59:59	713	4.6%	0.20	2.3 MB	4.0%	0.65
Jan 28 21:00:00 - 21:59:59	786	5.1%	0.22	2.1 MB	3.7%	0.59
Jan 28 22:00:00 - 22:59:59	660	4.3%	0.18	2.1 MB	3.8%	0.61
Jan 28 23:00:00 - 23:59:59	593	3.8%	0.16	3.0 MB	5.4%	0.86
Jan 29 00:00:00 - 00:59:59	372	2.4%	0.10	1.5 MB	2.6%	0.42
Jan 29 01:00:00 - 01:59:59	290	1.9%	0.08	2.3 MB	4.0%	0.65
Jan 29 02:00:00 - 02:59:59	312	2.0%	0.09	2.4 MB	4.2%	0.68
Jan 29 03:00:00 - 03:59:59	284	1.8%	0.08	967.1 KB	1.7%	0.27
Jan 29 04:00:00 - 04:15:01	60	0.4%	0.07	150.3 KB	0.3%	0.17
TOTAL: 24:00:00	15462	100.0%	0.18	56.5 MB	100.0%	0.67

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	feeder.eternal-september.org	495	5	0	490
2	i2pn-out.news.weretis.net	464	3	0	461
3	i2pn-out.feed.uzoreto.com	252	0	0	252
4	news-out.aioe.org	111	17	1	93
5	news.nntp4.net	87	0	1	86
6	paganini.bofh.team	78	6	0	72
7	news.samoylyk.net	73	0	7	66
8	usenet.goja.nl.eu.org	62	0	1	61
9	news-out.neodome.net	23	0	3	20
10	news.swapon.de	23	0	1	22
11	news.bbs.nz	1	0	1	0
TOTAL: 11		1669	31	15	1623

Unwanted newsgroups [Top 20]:

Newsgroup	Count
att.jobs	10
aus.jobs	9
fr.petites-annonces.divers	2
wolfsburg.test	2
free.it.vacanze.camper	1
newsguy.test	1
teranews.test	1
gov.usenet.test	1
lucky.freebsd.jobs	1
alt.belgique.test	1
trollnet.cinema	1
fr.petites-annonces.informatique.materiel	1
TOTAL: 12	31

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	752
Too many newsgroups	282
Poison newsgroup	204
User-issued spam cancel	24
User-issued cancel	21
Scoring filter (10)	5
HTML Multipart	2
TOTAL: 7	1290

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	14	0	14	14
TOTAL: 1	14	0	14	14

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	227
	news-out.aioe.org	46
	news.swapon.de	22
	usenet.goja.nl.eu.org	21
	paganini.bofh.team	6
	feeder.eternal-september.org	5
	i2pn-out.feed.uzoreto.com	2
	news-out.neodome.net	2
	TOTAL: 8	331
No colon-space in header
	i2pn-out.feed.uzoreto.com	2
	TOTAL: 1	2
TOTAL: 3		334

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn2	15278	13837	141	1119	0	90%	23:59:53
2	novabbs	21938	7805	6635	840	20	35%	23:59:53
3	aioe	11651	2625	8804	10	0	22%	23:59:38
4	news.samoylyk.net	15912	2308	12963	10	0	14%	23:59:53
5	news.niel.me	4878	1249	3466	103	0	25%	23:59:53
6	kf5zxw.com	25997	1107	14360	0	4964	4%	23:59:26
7	news.bbs.nz	30140	577	14786	60	89	1%	23:59:50
8	paganini.bofh.team	17173	383	14218	0	0	2%	23:59:53
9	news.nntp4.net	18248	75	15226	2	0	0%	23:59:53
10	dodin.fr.nf	1487	67	786	0	0	4%	20:24:08
11	neodome	18107	66	15082	0	0	0%	23:59:53
12	weretis.net	12963	54	7568	1051	0	0%	23:59:53
13	news.uzoreto.com	16954	46	13614	0	1	0%	23:59:27
14	usenet.goja.nl.eu.org	17291	44	14243	36	12	0%	23:59:53
15	eternal-september	15488	38	12527	2	1	0%	23:59:53
16	swapon.de	1436	2	1171	0	0	0%	23:35:58
TOTAL: 16		244941	30283	155590	3233	5087	12%	379:57:17

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	novabbs	36.0 MB	3.6 MB	39.6 MB	0.5 KB/s	4.7 KB	23:59:53
2	i2pn2	35.8 MB	4.5 MB	40.2 MB	0.5 KB/s	2.8 KB	23:59:53
3	aioe	8.5 MB	113.4 KB	8.6 MB	0.1 KB/s	3.3 KB	23:59:38
4	news.samoylyk.net	6.8 MB	63.6 KB	6.9 MB	0.1 KB/s	3.1 KB	23:59:53
5	news.niel.me	5.1 MB	364.7 KB	5.5 MB	0.1 KB/s	4.1 KB	23:59:53
6	kf5zxw.com	3.3 MB	0.0 KB	3.3 MB	0.0 KB/s	3.1 KB	23:59:26
7	news.bbs.nz	2.2 MB	209.8 KB	2.4 MB	0.0 KB/s	3.9 KB	23:59:50
8	dodin.fr.nf	1004.8 KB	0.0 KB	1004.8 KB	0.0 KB/s	15.0 KB	20:24:08
9	paganini.bofh.team	890.7 KB	0.0 KB	890.7 KB	0.0 KB/s	2.3 KB	23:59:53
10	news.nntp4.net	230.6 KB	23.3 KB	253.9 KB	0.0 KB/s	3.3 KB	23:59:53
11	neodome	217.2 KB	0.0 KB	217.2 KB	0.0 KB/s	3.3 KB	23:59:53
12	usenet.goja.nl.eu.org	170.1 KB	76.1 KB	246.3 KB	0.0 KB/s	3.1 KB	23:59:53
13	news.uzoreto.com	119.9 KB	0.0 KB	119.9 KB	0.0 KB/s	2.6 KB	23:59:27
14	weretis.net	112.2 KB	2.6 MB	2.7 MB	0.0 KB/s	2.5 KB	23:59:53
15	eternal-september	83.5 KB	23.3 KB	106.8 KB	0.0 KB/s	2.7 KB	23:59:53
16	swapon.de	2.2 KB	0.0 KB	2.2 KB	0.0 KB/s	1.1 KB	23:35:58
TOTAL: 16		100.5 MB	11.5 MB	111.9 MB	0.1 KB/s	3.4 KB	379:57:17

Daily Usenet report

Jan 28 04:15:01 -- Jan 29 04:15:01