Daily Usenet report: Mar 7 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	21475	52.9%	4.5 MB	63.9%
innd	15942	39.3%	2.0 MB	28.3%
innfeed	3149	7.8%	559.2 KB	7.8%
nocem	10	0.0%	1.2 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 5	40577	100.0%	7.0 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	142065	53.3%
Negative hits	103095	38.7%
Do not exist	21189	7.9%
Cache misses	196	0.1%
TOTAL: 4	266545	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.024	0.0%	61	0.000	0.393	3.000
article cleanup	00:00:00.122	0.0%	21219	0.000	0.006	0.042
article logging	00:00:00.785	0.0%	21419	0.000	0.037	0.711
article parse	00:00:00.292	0.0%	35311	0.000	0.008	0.061
article write	00:00:04.091	0.0%	15216	0.036	0.269	3.858
artlog/artcncl	00:00:00.000	0.0%	59	0.000	0.000	0.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:00.097	0.0%	275493	0.000	0.000	0.005
hisgrep/artcncl	00:00:00.001	0.0%	61	0.000	0.016	0.500
hishave/artcncl	00:00:00.001	0.0%	61	0.000	0.016	0.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:01.109	0.0%	266886	0.000	0.004	0.010
history sync	00:00:00.013	0.0%	310	0.000	0.042	1.000
history write	00:00:01.494	0.0%	21216	0.000	0.070	2.036
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:59:03.852	99.9%	277612	118.712	311.023	1293.274
nntp read	00:00:02.424	0.0%	276964	0.003	0.009	0.017
overview write	00:00:01.924	0.0%	15216	0.000	0.126	2.845
perl filter	00:00:21.675	0.0%	21216	0.606	1.022	3.161
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:01.417	0.0%	30484	0.000	0.046	0.128
TOTAL: 24:00:20.893	23:59:39.321	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.030	0.0%	15314	0.000	0.002	0.033
article prepare	00:00:00.019	0.0%	132302	0.000	0.000	0.002
article read	00:00:00.977	0.0%	14932	0.000	0.065	1.057
backlog stats	00:00:00.472	0.0%	377925	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.251	0.0%	252324	0.002	0.009	0.018
data write	00:00:02.217	0.0%	238324	0.003	0.009	0.020
idle	23:54:54.996	100.0%	377925	110.517	227.810	747.932
status file	00:00:00.179	0.0%	316	0.000	0.566	2.000
TOTAL: 23:55:11.255	23:55:01.141	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	27696	5011	22571	114	18%	46:52:30
2	feeder.eternal-september.org	20	6485	3230	3010	245	49%	28:18:26
3	news-out.aioe.org	2	11641	2852	8744	45	24%	24:08:58
4	usenet.goja.nl.eu.org	14	14073	2183	11692	198	15%	24:18:00
5	paganini.bofh.team	1	20192	1028	14211	4953	5%	22:48:04
6	news.swapon.de	10	1205	255	950	0	21%	22:42:25
7	news-out.neodome.net	1	14954	198	14547	209	1%	23:59:56
8	i2pn-out.feed.uzoreto.com	1841	16470	97	16159	214	0%	70:30:24
9	i2pn2.org	51	299	63	236	0	21%	17:02:06
10	news.nntp4.net	1	16436	56	16296	84	0%	23:59:53
11	news.niel.me	1	3881	44	3835	2	1%	23:59:54
12	news.samoylyk.net	2	11883	34	11848	1	0%	23:59:32
13	dodin.fr.nf	9	873	30	843	0	3%	20:21:41
14	news.bbs.nz	5	19262	15	19247	0	0%	38:34:21
15	novabbs.org	2	3701	2	3699	0	0%	20:33:15
16	kf5zxw.com	1	0	0	0	0	0%	00:10:00
17	localhost	28	0	0	0	0	0%	00:00:00
TOTAL: 17		1994	169051	15098	147888	6065	8%	432:19:25

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn-out.news.weretis.net	19.3 MB	2.4 KB	1016.9 KB	20.3 MB	95%	4.1 KB
2	feeder.eternal-september.org	11.7 MB	0.0 KB	3.1 MB	14.8 MB	79%	4.4 KB
3	news-out.aioe.org	7.1 MB	0.0 KB	154.5 KB	7.2 MB	97%	2.5 KB
4	usenet.goja.nl.eu.org	4.7 MB	0.0 KB	718.1 KB	5.4 MB	87%	2.3 KB
5	paganini.bofh.team	2.5 MB	0.0 KB	8.2 MB	10.7 MB	23%	1.8 KB
6	news.nntp4.net	655.9 KB	0.0 KB	2.9 MB	3.6 MB	17%	26.1 KB
7	news-out.neodome.net	607.0 KB	2.0 KB	1.2 MB	1.8 MB	33%	4.5 KB
8	news.swapon.de	599.8 KB	0.0 KB	0.0 KB	599.8 KB	100%	2.4 KB
9	i2pn-out.feed.uzoreto.com	259.2 KB	0.0 KB	3.9 MB	4.2 MB	6%	13.8 KB
10	news.samoylyk.net	128.4 KB	5.7 KB	5.7 KB	139.9 KB	91%	4.0 KB
11	i2pn2.org	123.6 KB	0.0 KB	0.0 KB	123.6 KB	100%	2.0 KB
12	news.niel.me	100.1 KB	0.0 KB	4.4 KB	104.5 KB	95%	2.3 KB
13	dodin.fr.nf	53.9 KB	0.0 KB	0.0 KB	53.9 KB	100%	1.8 KB
14	novabbs.org	28.0 KB	0.0 KB	0.0 KB	28.0 KB	100%	14.0 KB
15	news.bbs.nz	20.9 KB	0.0 KB	0.0 KB	20.9 KB	100%	1.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		47.8 MB	10.1 KB	21.2 MB	69.1 MB	69%	3.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 7 04:15:01 - 04:59:59	152	1.0%	0.06	1.4 MB	2.8%	0.52
Mar 7 05:00:00 - 05:59:59	302	2.0%	0.08	946.2 KB	1.9%	0.26
Mar 7 06:00:00 - 06:59:59	294	1.9%	0.08	993.5 KB	2.0%	0.28
Mar 7 07:00:00 - 07:59:59	454	3.0%	0.13	1.5 MB	3.1%	0.43
Mar 7 08:00:00 - 08:59:59	579	3.8%	0.16	1.6 MB	3.3%	0.45
Mar 7 09:00:00 - 09:59:59	739	4.9%	0.21	1.7 MB	3.5%	0.48
Mar 7 10:00:00 - 10:59:59	746	4.9%	0.21	2.3 MB	4.7%	0.64
Mar 7 11:00:00 - 11:59:59	677	4.4%	0.19	3.0 MB	6.2%	0.85
Mar 7 12:00:00 - 12:59:59	855	5.6%	0.24	2.1 MB	4.2%	0.58
Mar 7 13:00:00 - 13:59:59	794	5.2%	0.22	2.3 MB	4.8%	0.67
Mar 7 14:00:00 - 14:59:59	799	5.3%	0.22	2.3 MB	4.8%	0.66
Mar 7 15:00:00 - 15:59:59	1017	6.7%	0.28	3.8 MB	7.9%	1.09
Mar 7 16:00:00 - 16:59:59	867	5.7%	0.24	3.1 MB	6.4%	0.88
Mar 7 17:00:00 - 17:59:59	884	5.8%	0.25	2.6 MB	5.4%	0.74
Mar 7 18:00:00 - 18:59:59	877	5.8%	0.24	2.5 MB	5.2%	0.72
Mar 7 19:00:00 - 19:59:59	884	5.8%	0.25	2.3 MB	4.8%	0.67
Mar 7 20:00:00 - 20:59:59	742	4.9%	0.21	2.4 MB	4.9%	0.68
Mar 7 21:00:00 - 21:59:59	789	5.2%	0.22	2.1 MB	4.3%	0.59
Mar 7 22:00:00 - 22:59:59	858	5.6%	0.24	2.9 MB	6.0%	0.83
Mar 7 23:00:00 - 23:59:59	517	3.4%	0.14	1.5 MB	3.2%	0.44
Mar 8 00:00:00 - 00:59:59	366	2.4%	0.10	1.1 MB	2.2%	0.30
Mar 8 01:00:00 - 01:59:59	432	2.8%	0.12	1.4 MB	3.0%	0.41
Mar 8 02:00:00 - 02:59:59	292	1.9%	0.08	835.4 KB	1.7%	0.23
Mar 8 03:00:00 - 03:59:59	235	1.5%	0.07	1.5 MB	3.0%	0.42
Mar 8 04:00:00 - 04:15:01	66	0.4%	0.07	283.0 KB	0.6%	0.31
TOTAL: 24:00:00	15217	100.0%	0.18	48.4 MB	100.0%	0.57

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	paganini.bofh.team	4953	8	0	4945
2	feeder.eternal-september.org	253	11	0	242
3	i2pn-out.feed.uzoreto.com	214	11	0	203
4	usenet.goja.nl.eu.org	204	0	0	204
5	i2pn-out.news.weretis.net	160	4	1	155
6	news-out.neodome.net	147	0	1	146
7	news.swapon.de	121	0	0	121
8	news.nntp4.net	84	5	0	79
9	news-out.aioe.org	60	18	0	42
10	news.niel.me	2	0	0	2
11	news.samoylyk.net	1	0	1	0
TOTAL: 11		6199	57	3	6139

Unwanted newsgroups [Top 20]:

Newsgroup	Count
att.jobs	12
alt.education.higher	8
alt.education.student.government	5
alt.test.foo	3
ulm.uni.stuve	3
newsreader.test	2
aus.jobs	2
0.test	2
trollnet.cinema	2
tottenham.hotspurs	2
mozilla.dev.apps.seamonkey	1
rocksolid.test.test	1
alt.games.video.sony-playstation	1
alt.sex.erotica.stories	1
fr.petites-annonces.informatique.logiciel	1
fido.belg.kuleuven	1
news.news.groups	1
alt.games.test2	1
alt.society.high-school	1
a.b.kleverig	1
TOTAL: 26	57

INND Perl filter [Top 20]:

Reason	Count
Binary: misplaced par2	3678
Too many newsgroups	812
Binary: misplaced rar	733
EMP (md5)	516
Poison newsgroup	141
User-issued spam cancel	22
User-issued cancel	15
HTML Multipart	10
Scoring filter (16)	6
Scoring filter (8)	4
Scoring filter (9)	1
HTML Image Tags	1
TOTAL: 12	5939

NoCeM on Spool:

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

INND no permission servers:

System	Conn
172.104.140.107	32
23.225.163.165	5
71.6.135.131	2
91.241.19.108	1
192.241.219.58	1
206.189.158.62	1
TOTAL: 6	42

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	i2pn-out.feed.uzoreto.com	2
	TOTAL: 1	2
Including strange strings
	news.swapon.de	121
	i2pn-out.news.weretis.net	52
	news-out.aioe.org	17
	usenet.goja.nl.eu.org	7
	feeder.eternal-september.org	2
	paganini.bofh.team	1
	TOTAL: 6	200
TOTAL: 2		202

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	i2pn2	14982	13340	139	1331	1	0	89%	23:59:43
2	novabbs	18966	9747	4050	1167	0	10	51%	23:59:54
3	aioe	12168	1968	9936	25	0	0	16%	23:59:46
4	news.samoylyk.net	16232	1517	13547	27	0	0	9%	23:59:54
5	news.niel.me	5040	1022	3888	41	0	0	20%	23:59:54
6	news.bbs.nz	29106	936	14167	90	0	98	3%	23:59:43
7	paganini.bofh.team	16513	154	14014	1	0	1	0%	23:59:31
8	news.nntp4.net	17569	154	14985	2	0	1	0%	23:59:35
9	news.uzoreto.com	16178	151	13491	0	0	1	0%	23:59:54
10	neodome	17421	118	14797	0	0	1	0%	23:59:54
11	usenet.goja.nl.eu.org	15283	112	12749	68	0	12	0%	23:59:54
12	eternal-september	14349	89	11823	5	0	1	0%	23:59:54
13	weretis.net	16523	81	8991	924	0	3	0%	23:59:12
14	dodin.fr.nf	1545	64	869	0	0	0	4%	20:37:26
15	swapon.de	1264	6	1118	0	0	0	0%	23:31:44
16	kf5zxw.com	0	0	0	0	0	15217	0%	23:57:43
TOTAL: 16		213139	29459	138564	3681	1	15345	13%	380:03:41

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	i2pn2	34.2 MB	4.2 MB	38.4 MB	0.5 KB/s	2.7 KB	23:59:43
2	novabbs	32.6 MB	4.0 MB	36.6 MB	0.4 KB/s	3.4 KB	23:59:54
3	aioe	6.3 MB	70.5 KB	6.3 MB	0.1 KB/s	3.3 KB	23:59:46
4	news.samoylyk.net	4.2 MB	75.7 KB	4.3 MB	0.1 KB/s	2.9 KB	23:59:54
5	news.niel.me	3.7 MB	163.6 KB	3.9 MB	0.0 KB/s	3.7 KB	23:59:54
6	news.bbs.nz	3.2 MB	278.3 KB	3.5 MB	0.0 KB/s	3.4 KB	23:59:43
7	news.nntp4.net	542.4 KB	28.0 KB	570.4 KB	0.0 KB/s	3.7 KB	23:59:35
8	news.uzoreto.com	533.8 KB	0.0 KB	533.8 KB	0.0 KB/s	3.5 KB	23:59:54
9	usenet.goja.nl.eu.org	469.7 KB	127.7 KB	597.4 KB	0.0 KB/s	3.3 KB	23:59:54
10	paganini.bofh.team	438.8 KB	2.9 KB	441.8 KB	0.0 KB/s	2.9 KB	23:59:31
11	neodome	328.5 KB	0.0 KB	328.5 KB	0.0 KB/s	2.8 KB	23:59:54
12	dodin.fr.nf	277.7 KB	0.0 KB	277.7 KB	0.0 KB/s	4.3 KB	20:37:26
13	weretis.net	183.9 KB	1.5 MB	1.7 MB	0.0 KB/s	1.7 KB	23:59:12
14	eternal-september	172.0 KB	31.7 KB	203.7 KB	0.0 KB/s	2.2 KB	23:59:54
15	swapon.de	16.4 KB	0.0 KB	16.4 KB	0.0 KB/s	2.7 KB	23:31:44
16	kf5zxw.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:43
TOTAL: 16		87.1 MB	10.5 MB	97.6 MB	0.1 KB/s	3.0 KB	380:03:41

Daily Usenet report

Mar 7 04:15:01 -- Mar 8 04:15:01