Daily Usenet report: May 11 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	14729	53.1%	3.5 MB	64.9%
innd	9789	35.3%	1.3 MB	25.1%
innfeed	3201	11.5%	548.7 KB	10.0%
nocem	7	0.0%	0.7 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 5	27727	100.0%	5.4 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	118929	55.6%
Negative hits	80531	37.7%
Do not exist	14316	6.7%
Cache misses	45	0.0%
TOTAL: 4	213821	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.131	0.0%	98	0.000	1.337	16.000
article cleanup	00:00:00.073	0.0%	14349	0.000	0.005	0.039
article logging	00:00:00.452	0.0%	14638	0.000	0.031	0.102
article parse	00:00:00.228	0.0%	27079	0.000	0.008	0.039
article write	00:00:12.833	0.0%	12904	0.022	0.994	38.360
artlog/artcncl	00:00:00.002	0.0%	98	0.000	0.020	0.250
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:00.085	0.0%	219717	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.000	0.0%	98	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	98	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:00.818	0.0%	213943	0.000	0.004	0.010
history sync	00:00:00.018	0.0%	305	0.000	0.059	0.500
history write	00:00:05.884	0.0%	14332	0.000	0.411	73.710
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:58:59.825	99.9%	222705	205.418	387.687	1147.663
nntp read	00:00:01.770	0.0%	222148	0.002	0.008	0.018
overview write	00:00:04.933	0.0%	12904	0.000	0.382	19.530
perl filter	00:00:16.852	0.0%	14332	0.759	1.176	2.754
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.778	0.0%	25932	0.000	0.030	0.082
TOTAL: 24:00:21.410	23:59:44.682	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.029	0.0%	12995	0.000	0.002	0.020
article prepare	00:00:00.009	0.0%	119012	0.000	0.000	0.003
article read	00:00:01.620	0.0%	12628	0.000	0.128	7.000
backlog stats	00:00:00.367	0.0%	333723	0.000	0.001	0.004
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.859	0.0%	215672	0.004	0.009	0.016
data write	00:00:01.726	0.0%	203853	0.001	0.008	0.017
idle	23:54:46.547	100.0%	333723	130.304	257.958	667.109
status file	00:00:02.737	0.0%	341	0.000	8.026	309.167
TOTAL: 23:55:05.077	23:54:54.894	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	23555	5384	18071	100	22%	48:39:47
2	news-out.aioe.org	8	11440	3647	7747	46	31%	24:16:07
3	feeder.eternal-september.org	34	5851	2163	3442	246	36%	32:51:31
4	paganini.bofh.team	2	13882	531	13323	28	3%	25:22:19
5	usenet.goja.nl.eu.org	11	12952	498	12316	138	3%	23:28:28
6	news.swapon.de	8	980	274	706	0	27%	22:55:44
7	news-out.neodome.net	1	12283	173	12081	29	1%	23:59:57
8	i2pn2.org	18	82	78	4	0	95%	05:15:13
9	news.nntp4.net	2	11925	74	11816	35	0%	23:59:44
10	i2pn-out.feed.uzoreto.com	1646	14459	56	13545	858	0%	70:42:13
11	news.samoylyk.net	2	11271	43	11224	4	0%	23:59:53
12	dodin.fr.nf	23	751	27	724	0	3%	21:20:51
13	news.niel.me	2	3247	14	3232	1	0%	23:59:55
14	news.bbs.nz	10	11080	10	11065	5	0%	29:09:20
15	novabbs.org	17	79	4	75	0	5%	05:01:16
16	kf5zxw.com	1	0	0	0	0	0%	00:10:03
17	localhost	28	0	0	0	0	0%	00:00:00
TOTAL: 17		1817	133837	12976	119371	1490	9%	405:12:21

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn-out.news.weretis.net	24.7 MB	11.5 KB	443.2 KB	25.1 MB	98%	4.7 KB
2	feeder.eternal-september.org	8.8 MB	2.7 KB	3.4 MB	12.2 MB	71%	5.2 KB
3	news-out.aioe.org	8.4 MB	1.7 KB	175.9 KB	8.6 MB	97%	2.4 KB
4	paganini.bofh.team	2.0 MB	3.4 KB	269.2 KB	2.3 MB	88%	4.1 KB
5	usenet.goja.nl.eu.org	1.3 MB	8.9 KB	604.5 KB	1.9 MB	69%	3.1 KB
6	news-out.neodome.net	715.6 KB	3.2 KB	291.9 KB	1010.7 KB	70%	5.0 KB
7	news.swapon.de	700.5 KB	0.0 KB	0.0 KB	700.5 KB	100%	2.6 KB
8	news.nntp4.net	607.6 KB	8.9 KB	1.3 MB	1.9 MB	31%	17.8 KB
9	i2pn-out.feed.uzoreto.com	316.6 KB	0.0 KB	3.5 MB	3.9 MB	8%	4.3 KB
10	news.samoylyk.net	165.5 KB	6.8 KB	9.4 KB	181.7 KB	91%	3.9 KB
11	i2pn2.org	158.6 KB	0.0 KB	0.0 KB	158.6 KB	100%	2.0 KB
12	dodin.fr.nf	53.4 KB	0.0 KB	0.0 KB	53.4 KB	100%	2.0 KB
13	news.niel.me	35.3 KB	2.6 KB	2.6 KB	40.5 KB	87%	2.7 KB
14	novabbs.org	34.0 KB	0.0 KB	0.0 KB	34.0 KB	100%	8.5 KB
15	news.bbs.nz	14.6 KB	14.0 KB	15.9 KB	44.5 KB	32%	3.0 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.9 MB	63.8 KB	10.1 MB	58.0 MB	82%	4.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 11 04:15:01 - 04:59:59	151	1.2%	0.06	439.8 KB	0.9%	0.16
May 11 05:00:00 - 05:59:59	297	2.3%	0.08	859.1 KB	1.8%	0.24
May 11 06:00:00 - 06:59:59	414	3.2%	0.12	2.0 MB	4.1%	0.56
May 11 07:00:00 - 07:59:59	481	3.7%	0.13	1.4 MB	2.9%	0.39
May 11 08:00:00 - 08:59:59	559	4.3%	0.16	1.5 MB	3.2%	0.44
May 11 09:00:00 - 09:59:59	624	4.8%	0.17	2.0 MB	4.1%	0.56
May 11 10:00:00 - 10:59:59	526	4.1%	0.15	1.4 MB	2.9%	0.39
May 11 11:00:00 - 11:59:59	582	4.5%	0.16	3.2 MB	6.7%	0.90
May 11 12:00:00 - 12:59:59	612	4.7%	0.17	1.5 MB	3.2%	0.43
May 11 13:00:00 - 13:59:59	662	5.1%	0.18	1.8 MB	3.7%	0.50
May 11 14:00:00 - 14:59:59	798	6.2%	0.22	2.2 MB	4.6%	0.63
May 11 15:00:00 - 15:59:59	767	5.9%	0.21	2.1 MB	4.4%	0.60
May 11 16:00:00 - 16:59:59	785	6.1%	0.22	3.1 MB	6.5%	0.88
May 11 17:00:00 - 17:59:59	773	6.0%	0.21	2.6 MB	5.5%	0.75
May 11 18:00:00 - 18:59:59	711	5.5%	0.20	2.3 MB	5.0%	0.67
May 11 19:00:00 - 19:59:59	774	6.0%	0.21	2.1 MB	4.5%	0.60
May 11 20:00:00 - 20:59:59	668	5.2%	0.19	2.1 MB	4.5%	0.60
May 11 21:00:00 - 21:59:59	599	4.6%	0.17	2.8 MB	5.9%	0.79
May 11 22:00:00 - 22:59:59	551	4.3%	0.15	2.9 MB	6.1%	0.83
May 11 23:00:00 - 23:59:59	348	2.7%	0.10	1.8 MB	3.7%	0.50
May 12 00:00:00 - 00:59:59	330	2.6%	0.09	1.7 MB	3.6%	0.48
May 12 01:00:00 - 01:59:59	323	2.5%	0.09	2.1 MB	4.5%	0.61
May 12 02:00:00 - 02:59:59	285	2.2%	0.08	2.3 MB	4.8%	0.65
May 12 03:00:00 - 03:59:59	213	1.7%	0.06	1.1 MB	2.2%	0.30
May 12 04:00:00 - 04:15:01	70	0.5%	0.08	256.8 KB	0.5%	0.29
TOTAL: 24:00:00	12903	100.0%	0.15	47.4 MB	100.0%	0.56

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	i2pn-out.feed.uzoreto.com	859	705	0	2	152
2	i2pn-out.news.weretis.net	223	12	2	0	209
3	feeder.eternal-september.org	211	6	1	0	204
4	usenet.goja.nl.eu.org	144	0	2	0	142
5	news.swapon.de	108	0	0	0	108
6	news-out.aioe.org	80	9	1	0	70
7	news.nntp4.net	37	0	1	0	36
8	paganini.bofh.team	28	3	1	0	24
9	news-out.neodome.net	27	0	1	0	26
10	news.bbs.nz	5	1	4	0	0
11	news.samoylyk.net	4	0	3	0	1
12	news.niel.me	1	0	1	0	0
TOTAL: 12		1727	736	17	2	972

Unwanted newsgroups [Top 20]:

Newsgroup	Count
talk.ukrainian.tg	553
talk.english.tg	67
talk.english.tw	32
talk.generic.ua.ws	22
comp.hackers	15
alt.math	10
list.postfix.users	7
att.jobs	6
0.0ssptest	4
talk.from.diary	2
talk.from.war.diary	2
alt.jobs.search.tw	2
aus.jobs	2
ee.arvutid	2
rec.travel.resorts.all	1
alt.info-science	1
alt.christnet.bible-thumpers.convert.convert.convert	1
alt.biz.misc	1
alt.ads	1
fr.petites-annonces.immobilier	1
TOTAL: 24	736

Supposedly-moderated groups with unmoderated postings [Top 20]:

Groups	Count
it.scienza.astronomia	2
TOTAL: 1	2

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	365
Too many newsgroups	203
Poison newsgroup	92
User-issued cancel	6
Scoring filter (11)	5
HTML Multipart	4
Scoring filter (9)	3
MID-Bot	3
User-issued spam cancel	1
HTML post	1
TOTAL: 10	683

NoCeM on Spool:

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

INND no permission servers:

System	Conn
172.105.87.91	23
89.248.165.24	2
TOTAL: 2	25

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	i2pn-out.news.weretis.net	128
	news.swapon.de	108
	news-out.aioe.org	35
	usenet.goja.nl.eu.org	11
	feeder.eternal-september.org	4
	news.nntp4.net	1
	news-out.neodome.net	1
	i2pn-out.feed.uzoreto.com	1
	TOTAL: 8	289
TOTAL: 1		289

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn2	12748	11413	307	679	5	89%	23:59:09
2	novabbs	13029	11214	509	858	0	86%	23:59:28
3	news.nntp4.net	14297	1581	11247	5	0	11%	23:59:52
4	aioe	9998	1412	7238	7	16	14%	23:59:42
5	news.niel.me	4699	776	3352	109	0	16%	23:59:52
6	news.bbs.nz	25178	314	12467	99	59	1%	23:59:52
7	paganini.bofh.team	15184	148	12229	1	0	0%	23:59:52
8	news.uzoreto.com	13666	141	10719	0	0	1%	23:59:52
9	neodome	15459	128	12489	1	0	0%	23:59:52
10	eternal-september	13574	102	10577	5	0	0%	23:59:52
11	usenet.goja.nl.eu.org	15048	92	12108	50	19	0%	23:59:52
12	weretis.net	12589	63	6990	445	4	0%	23:59:52
13	news.samoylyk.net	15645	56	12644	54	0	0%	23:59:52
14	dodin.fr.nf	1248	45	718	0	0	3%	21:10:04
15	swapon.de	1114	4	885	0	0	0%	23:33:01
16	kf5zxw.com	0	0	0	0	12903	0%	23:57:42
TOTAL: 16		183476	27489	114479	2313	13006	14%	380:37:46

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	novabbs	39.8 MB	5.0 MB	44.7 MB	0.5 KB/s	3.8 KB	23:59:28
2	i2pn2	32.7 MB	2.5 MB	35.2 MB	0.4 KB/s	3.0 KB	23:59:09
3	aioe	4.1 MB	51.4 KB	4.1 MB	0.0 KB/s	3.0 KB	23:59:42
4	news.nntp4.net	3.8 MB	46.8 KB	3.8 MB	0.0 KB/s	2.5 KB	23:59:52
5	news.niel.me	2.7 MB	403.6 KB	3.1 MB	0.0 KB/s	3.5 KB	23:59:52
6	news.bbs.nz	882.2 KB	551.0 KB	1.4 MB	0.0 KB/s	3.5 KB	23:59:52
7	dodin.fr.nf	384.6 KB	0.0 KB	384.6 KB	0.0 KB/s	8.5 KB	21:10:04
8	paganini.bofh.team	381.1 KB	1.7 KB	382.9 KB	0.0 KB/s	2.6 KB	23:59:52
9	news.uzoreto.com	339.8 KB	0.0 KB	339.8 KB	0.0 KB/s	2.4 KB	23:59:52
10	neodome	337.5 KB	6.4 KB	343.8 KB	0.0 KB/s	2.7 KB	23:59:52
11	usenet.goja.nl.eu.org	255.9 KB	121.8 KB	377.7 KB	0.0 KB/s	2.7 KB	23:59:52
12	eternal-september	210.1 KB	35.6 KB	245.7 KB	0.0 KB/s	2.3 KB	23:59:52
13	weretis.net	143.2 KB	1.3 MB	1.5 MB	0.0 KB/s	3.0 KB	23:59:52
14	news.samoylyk.net	115.2 KB	144.2 KB	259.4 KB	0.0 KB/s	2.4 KB	23:59:52
15	swapon.de	11.4 KB	0.0 KB	11.4 KB	0.0 KB/s	2.8 KB	23:33:01
16	kf5zxw.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:42
TOTAL: 16		85.9 MB	10.2 MB	96.1 MB	0.1 KB/s	3.3 KB	380:37:46

Daily Usenet report

May 11 04:15:01 -- May 12 04:15:01