Daily Usenet report: Aug 21 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	14261	49.9%	4.1 MB	66.5%
innd	10403	36.4%	1.4 MB	22.8%
innfeed	3891	13.6%	681.5 KB	10.7%
nocem	2	0.0%	0.2 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 5	28558	100.0%	6.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	133986	56.1%
Negative hits	78045	32.7%
Do not exist	13808	5.8%
Cache misses	12989	5.4%
TOTAL: 4	238828	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.042	0.0%	74	0.000	0.568	3.429
article cleanup	00:00:00.076	0.0%	13834	0.000	0.005	0.034
article logging	00:00:00.467	0.0%	14178	0.000	0.033	0.098
article parse	00:00:00.227	0.0%	23298	0.000	0.010	0.043
article write	00:00:23.676	0.0%	12241	0.091	1.934	62.681
artlog/artcncl	00:00:00.000	0.0%	74	0.000	0.000	0.000
artlog/artparse	00:00:00.000	0.0%	2	0.000	0.000	0.000
data move	00:00:00.085	0.0%	242388	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.000	0.0%	74	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	74	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.003	0.0%	239086	0.000	0.004	0.010
history sync	00:00:00.015	0.0%	310	0.000	0.048	0.667
history write	00:00:04.807	0.0%	13828	0.000	0.348	17.415
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:58:40.778	99.9%	242805	44.796	355.515	1106.633
nntp read	00:00:02.243	0.0%	243423	0.004	0.009	0.016
overview write	00:00:04.342	0.0%	12241	0.000	0.355	13.625
perl filter	00:00:16.825	0.0%	13826	0.859	1.217	3.519
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.873	0.0%	24524	0.000	0.036	0.126
TOTAL: 24:00:29.122	23:59:35.459	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.031	0.0%	12417	0.000	0.002	0.028
article prepare	00:00:00.009	0.0%	155528	0.000	0.000	0.001
article read	00:00:10.199	0.0%	12153	0.000	0.839	61.387
backlog stats	00:00:00.686	0.0%	378821	0.000	0.002	0.005
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.704	0.0%	247546	0.006	0.011	0.078
data write	00:00:02.237	0.0%	236938	0.004	0.009	0.018
idle	23:55:30.547	100.0%	378821	113.456	227.365	691.806
status file	00:00:02.036	0.0%	431	0.000	4.724	78.500
TOTAL: 23:56:03.207	23:55:48.449	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	4	21066	2968	18072	26	14%	45:20:48
2	usenet.blueworldhosting.com	8	12816	2954	9207	655	23%	24:33:23
3	news-out.aioe.org	1	8449	2729	5705	15	32%	23:59:54
4	feeder.eternal-september.org	13	7754	1989	5126	639	25%	26:20:17
5	paganini.bofh.team	2	12150	343	11797	10	2%	24:03:30
6	news.swapon.de	11	1168	325	842	1	27%	23:22:23
7	usenet.goja.nl.eu.org	11	11748	256	11341	151	2%	24:20:27
8	news-out.neodome.net	2	9968	154	9777	37	1%	23:59:55
9	nntp.alphanet.ch	24	6517	108	6408	1	1%	24:43:41
10	news.nntp4.net	1	11366	74	11281	11	0%	23:59:56
11	dodin.fr.nf	13	756	54	700	2	7%	19:31:40
12	i2pn-out.feed.uzoreto.com	1562	27683	47	27546	90	0%	70:57:25
13	i2pn2.org	26	41	41	0	0	100%	04:59:05
14	news.niel.me	1	2519	35	2484	0	1%	23:59:56
15	news.samoylyk.net	3	10531	13	10516	2	0%	23:59:26
16	news.bbs.nz	8	9365	5	9358	2	0%	24:59:08
17	news.furie.org.uk	1	5215	2	5211	2	0%	23:59:56
18	retrobbs.ddns.net	1	0	0	0	0	0%	00:10:00
19	localhost	26	0	0	0	0	0%	00:00:00
20	kf5zxw.com	1	0	0	0	0	0%	00:10:00
21	novabbs.org	18	26	0	26	0	0%	03:04:50
TOTAL: 21		1737	159138	12097	145397	1644	7%	460:35:40

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn-out.news.weretis.net	19.8 MB	0.0 KB	126.7 KB	19.9 MB	99%	6.8 KB
2	usenet.blueworldhosting.com	10.0 MB	4.6 KB	1.6 MB	11.5 MB	86%	3.3 KB
3	news-out.aioe.org	6.6 MB	2.3 KB	32.0 KB	6.6 MB	99%	2.5 KB
4	feeder.eternal-september.org	6.0 MB	0.0 KB	3.7 MB	9.7 MB	62%	3.8 KB
5	paganini.bofh.team	1023.7 KB	0.0 KB	80.2 KB	1.1 MB	92%	3.1 KB
6	news.swapon.de	811.6 KB	0.0 KB	0.8 KB	812.5 KB	99%	2.5 KB
7	usenet.goja.nl.eu.org	700.3 KB	2.3 KB	460.3 KB	1.1 MB	60%	2.9 KB
8	nntp.alphanet.ch	592.1 KB	4.0 KB	4.0 KB	600.1 KB	98%	5.5 KB
9	news-out.neodome.net	528.3 KB	5.9 KB	133.7 KB	667.9 KB	79%	3.5 KB
10	news.nntp4.net	341.2 KB	2.4 KB	192.5 KB	536.1 KB	63%	6.3 KB
11	i2pn2.org	208.1 KB	0.0 KB	0.0 KB	208.1 KB	100%	5.1 KB
12	dodin.fr.nf	114.3 KB	0.0 KB	1.5 KB	115.9 KB	98%	2.1 KB
13	news.niel.me	100.6 KB	0.0 KB	0.0 KB	100.6 KB	100%	2.9 KB
14	i2pn-out.feed.uzoreto.com	85.6 KB	0.0 KB	231.4 KB	317.0 KB	26%	2.3 KB
15	news.samoylyk.net	41.1 KB	6.4 KB	6.4 KB	53.9 KB	76%	3.6 KB
16	news.bbs.nz	8.9 KB	8.2 KB	8.2 KB	25.3 KB	35%	3.6 KB
17	news.furie.org.uk	6.4 KB	2.5 KB	5.4 KB	14.3 KB	44%	3.6 KB
18	retrobbs.ddns.net	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	kf5zxw.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
21	novabbs.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 21		46.8 MB	38.6 KB	6.5 MB	53.3 MB	87%	4.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 21 04:15:01 - 04:59:59	228	1.9%	0.08	742.8 KB	1.4%	0.28
Aug 21 05:00:00 - 05:59:59	263	2.1%	0.07	1.8 MB	3.5%	0.50
Aug 21 06:00:00 - 06:59:59	384	3.1%	0.11	1.2 MB	2.4%	0.34
Aug 21 07:00:00 - 07:59:59	476	3.9%	0.13	1.7 MB	3.4%	0.48
Aug 21 08:00:00 - 08:59:59	512	4.2%	0.14	1.7 MB	3.5%	0.49
Aug 21 09:00:00 - 09:59:59	498	4.1%	0.14	1.5 MB	3.1%	0.44
Aug 21 10:00:00 - 10:59:59	541	4.4%	0.15	1.8 MB	3.6%	0.52
Aug 21 11:00:00 - 11:59:59	653	5.3%	0.18	1.8 MB	3.5%	0.50
Aug 21 12:00:00 - 12:59:59	578	4.7%	0.16	1.6 MB	3.1%	0.45
Aug 21 13:00:00 - 13:59:59	699	5.7%	0.19	3.2 MB	6.4%	0.91
Aug 21 14:00:00 - 14:59:59	706	5.8%	0.20	3.0 MB	5.9%	0.84
Aug 21 15:00:00 - 15:59:59	660	5.4%	0.18	2.0 MB	4.0%	0.57
Aug 21 16:00:00 - 16:59:59	647	5.3%	0.18	2.0 MB	3.9%	0.56
Aug 21 17:00:00 - 17:59:59	702	5.7%	0.20	2.4 MB	4.8%	0.69
Aug 21 18:00:00 - 18:59:59	802	6.6%	0.22	5.6 MB	11.2%	1.59
Aug 21 19:00:00 - 19:59:59	624	5.1%	0.17	3.2 MB	6.4%	0.91
Aug 21 20:00:00 - 20:59:59	580	4.7%	0.16	2.0 MB	4.0%	0.58
Aug 21 21:00:00 - 21:59:59	616	5.0%	0.17	2.1 MB	4.3%	0.61
Aug 21 22:00:00 - 22:59:59	437	3.6%	0.12	1.4 MB	2.8%	0.40
Aug 21 23:00:00 - 23:59:59	387	3.2%	0.11	2.1 MB	4.1%	0.59
Aug 22 00:00:00 - 00:59:59	292	2.4%	0.08	1.0 MB	2.0%	0.29
Aug 22 01:00:00 - 01:59:59	355	2.9%	0.10	2.5 MB	5.0%	0.72
Aug 22 02:00:00 - 02:59:59	207	1.7%	0.06	891.5 KB	1.7%	0.25
Aug 22 03:00:00 - 03:59:59	296	2.4%	0.08	2.2 MB	4.4%	0.63
Aug 22 04:00:00 - 04:15:01	100	0.8%	0.11	720.8 KB	1.4%	0.80
TOTAL: 24:00:00	12243	100.0%	0.14	50.2 MB	100.0%	0.59

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	usenet.blueworldhosting.com	671	270	1	400
2	feeder.eternal-september.org	604	1	0	603
3	news.swapon.de	175	0	0	175
4	i2pn-out.news.weretis.net	152	0	0	152
5	usenet.goja.nl.eu.org	147	0	0	147
6	i2pn-out.feed.uzoreto.com	90	33	0	57
7	news-out.neodome.net	41	0	1	40
8	news-out.aioe.org	32	1	0	31
9	paganini.bofh.team	12	0	0	12
10	news.nntp4.net	10	0	0	10
11	news.bbs.nz	3	0	3	0
12	news.furie.org.uk	2	0	1	1
13	news.samoylyk.net	2	0	1	1
14	dodin.fr.nf	2	0	0	2
15	nntp.alphanet.ch	1	0	1	0
TOTAL: 15		1944	305	8	1631

Unwanted newsgroups [Top 20]:

Newsgroup	Count
talk.ukrainian.tg	217
talk.english.tg	58
talk.generic.ua.ws	12
news.oriens-occasus.ru	6
fr.petites-annonces.informatique.materiel	3
gun.general	2
talk.english.tw	2
news.software.newsreaders	1
1.test	1
talk.from.war.diary	1
talk.from.diary	1
alt.math.undergrad	1
TOTAL: 12	305

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	662
Too many newsgroups	471
Poison newsgroup	71
EMP (fsl)	50
User-issued cancel	14
Scoring filter (9)	4
Scoring filter (12)	3
Binary: misplaced rar	3
User-issued spam cancel	2
HTML Multipart	2
Scoring filter (8)	1
MID-Bot	1
Scoring filter (14)	1
TOTAL: 13	1285

NoCeM on Spool:

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

INND no permission servers:

System	Conn
192.241.219.206	1
192.241.213.79	1
TOTAL: 2	2

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news.swapon.de	174
	i2pn-out.news.weretis.net	127
	news-out.aioe.org	17
	usenet.blueworldhosting.com	11
	feeder.eternal-september.org	6
	news-out.neodome.net	5
	paganini.bofh.team	2
	usenet.goja.nl.eu.org	1
	news.samoylyk.net	1
	TOTAL: 9	344
No colon-space in header
	i2pn-out.feed.uzoreto.com	2
	TOTAL: 1	2
TOTAL: 2		346

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn2	12293	11059	255	730	2	89%	23:59:50
2	novabbs	12365	11032	300	753	5	89%	23:59:50
3	aioe	9206	2621	6216	59	0	28%	23:59:44
4	nntp.alphanet.ch	12712	2034	9314	581	1	16%	23:59:50
5	news.nntp4.net	13712	1825	10309	28	0	13%	23:59:50
6	neodome	13393	1822	10090	0	1	13%	23:59:50
7	news.niel.me	4168	1341	2563	152	1	32%	23:59:50
8	usenet.goja.nl.eu.org	13582	1332	10421	16	15	9%	23:59:49
9	paganini.bofh.team	14222	1068	10827	5	21	7%	23:59:49
10	news.furie.org.uk	8057	545	5277	47	1	6%	23:59:25
11	news.uzoreto.com	14226	291	10978	0	1	2%	23:59:50
12	news.bbs.nz	23855	289	11819	112	108	1%	23:59:49
13	news.samoylyk.net	15212	140	11876	9	1	0%	23:59:39
14	eternal-september	13906	116	10056	9	9	0%	23:59:50
15	weretis.net	13341	106	8293	650	4	0%	23:59:47
16	usenet.blueworldhosting.com	15272	104	8983	0	38	0%	23:59:50
17	dodin.fr.nf	1174	77	716	0	0	6%	20:32:58
18	swapon.de	1118	0	885	0	0	0%	23:04:13
19	retrobbs.ddns.net	0	0	0	0	12086	0%	23:57:46
20	kf5zxw.com	0	0	0	0	12242	0%	23:57:42
TOTAL: 20		211814	35802	129178	3151	24536	16%	475:29:11

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	novabbs	41.3 MB	6.9 MB	48.2 MB	0.6 KB/s	4.2 KB	23:59:50
2	i2pn2	41.3 MB	7.0 MB	48.3 MB	0.6 KB/s	4.2 KB	23:59:50
3	aioe	8.6 MB	157.0 KB	8.7 MB	0.1 KB/s	3.3 KB	23:59:44
4	nntp.alphanet.ch	7.2 MB	2.0 MB	9.3 MB	0.1 KB/s	3.6 KB	23:59:50
5	news.nntp4.net	5.7 MB	315.0 KB	6.0 MB	0.1 KB/s	3.3 KB	23:59:50
6	neodome	5.6 MB	0.0 KB	5.6 MB	0.1 KB/s	3.1 KB	23:59:50
7	news.niel.me	4.5 MB	448.2 KB	5.0 MB	0.1 KB/s	3.4 KB	23:59:50
8	usenet.goja.nl.eu.org	4.0 MB	165.4 KB	4.1 MB	0.0 KB/s	3.2 KB	23:59:49
9	paganini.bofh.team	3.6 MB	296.6 KB	3.9 MB	0.0 KB/s	3.7 KB	23:59:49
10	news.furie.org.uk	2.6 MB	127.4 KB	2.8 MB	0.0 KB/s	4.8 KB	23:59:25
11	news.bbs.nz	1.9 MB	1.2 MB	3.1 MB	0.0 KB/s	7.8 KB	23:59:49
12	dodin.fr.nf	1.0 MB	0.0 KB	1.0 MB	0.0 KB/s	13.5 KB	20:32:58
13	news.uzoreto.com	882.1 KB	0.0 KB	882.1 KB	0.0 KB/s	3.0 KB	23:59:50
14	news.samoylyk.net	426.6 KB	129.6 KB	556.1 KB	0.0 KB/s	3.7 KB	23:59:39
15	usenet.blueworldhosting.com	359.9 KB	0.0 KB	359.9 KB	0.0 KB/s	3.5 KB	23:59:50
16	eternal-september	289.7 KB	143.4 KB	433.1 KB	0.0 KB/s	3.5 KB	23:59:50
17	weretis.net	254.4 KB	1.1 MB	1.3 MB	0.0 KB/s	1.8 KB	23:59:47
18	swapon.de	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:04:13
19	retrobbs.ddns.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:46
20	kf5zxw.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:42
TOTAL: 20		129.4 MB	20.0 MB	149.4 MB	0.1 KB/s	3.9 KB	475:29:11

Daily Usenet report

Aug 21 04:15:01 -- Aug 22 04:15:01