Daily Usenet report: Sep 16 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	19660	54.9%	3.7 MB	63.3%
innd	13860	38.7%	1.8 MB	29.9%
innfeed	2269	6.3%	407.0 KB	6.8%
nocem	27	0.1%	2.6 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	35817	100.0%	5.9 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	159324	61.2%
Negative hits	81778	31.4%
Do not exist	19224	7.4%
Cache misses	53	0.0%
TOTAL: 4	260379	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.039	0.0%	57	0.000	0.684	3.000
article cleanup	00:00:00.176	0.0%	19271	0.000	0.009	0.054
article logging	00:00:00.824	0.0%	19614	0.000	0.042	0.136
article parse	00:00:00.730	0.0%	32710	0.000	0.022	0.051
article write	00:00:05.988	0.0%	15812	0.143	0.379	1.046
artlog/artcncl	00:00:00.002	0.0%	50	0.000	0.040	0.200
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:00.180	0.0%	271639	0.000	0.001	0.004
hisgrep/artcncl	00:00:00.005	0.0%	57	0.000	0.088	1.000
hishave/artcncl	00:00:00.001	0.0%	57	0.000	0.018	0.200
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:01.389	0.0%	260891	0.002	0.005	0.045
history sync	00:00:00.017	0.0%	331	0.000	0.051	1.000
history write	00:00:03.539	0.0%	19271	0.018	0.184	5.058
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:58:44.703	99.9%	269470	187.518	320.350	1442.476
nntp read	00:00:03.773	0.0%	268786	0.005	0.014	0.023
overview write	00:00:04.683	0.0%	15812	0.057	0.296	4.450
perl filter	00:00:44.913	0.1%	19270	1.724	2.331	6.429
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:03.735	0.0%	31643	0.014	0.118	0.257
TOTAL: 24:00:41.058	23:59:54.697	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.045	0.0%	16065	0.000	0.003	0.026
article prepare	00:00:00.018	0.0%	84988	0.000	0.000	0.004
article read	00:00:01.352	0.0%	15555	0.000	0.087	0.709
backlog stats	00:00:00.366	0.0%	335753	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.982	0.0%	213828	0.006	0.014	0.023
data write	00:00:04.307	0.0%	198639	0.010	0.022	0.034
idle	23:56:25.637	100.0%	335753	141.529	256.694	840.172
status file	00:00:00.275	0.0%	224	0.000	1.228	14.667
TOTAL: 23:56:43.679	23:56:34.982	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	32343	9586	21858	899	29%	49:00:26
2	feeder.eternal-september.org	1	17089	2379	14385	325	13%	23:04:46
3	news-out.aioe.org	3	15235	2345	12866	24	15%	24:09:52
4	paganini.bofh.team	3	19332	1193	16252	1887	6%	24:16:24
5	news-out.neodome.net	2	18322	172	17844	306	0%	23:59:52
6	news.swapon.de	5	1505	64	1436	5	4%	23:30:33
7	i2pn-out.feed.uzoreto.com	2111	22753	36	22677	40	0%	70:51:35
8	news.bbs.nz	2	14261	9	14252	0	0%	23:59:48
9	news.samoylyk.net	1	15259	4	15255	0	0%	23:59:55
10	i2pn2	41	460	1	459	0	0%	20:10:36
11	localhost	33	0	0	0	0	0%	00:00:00
12	kf5zxw.com	1	3389	0	3389	0	0%	07:04:00
13	novabbs	1	0	0	0	0	0%	00:00:00
TOTAL: 13		2208	159948	15789	140673	3486	9%	314:07:47

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn-out.news.weretis.net	33.7 MB	2.5 MB	36.1 MB	93%	3.5 KB
2	feeder.eternal-september.org	7.8 MB	2.3 MB	10.1 MB	77%	3.8 KB
3	news-out.aioe.org	6.1 MB	63.2 KB	6.1 MB	98%	2.7 KB
4	paganini.bofh.team	4.0 MB	69.6 MB	73.5 MB	5%	24.5 KB
5	news-out.neodome.net	663.5 KB	1.0 MB	1.7 MB	38%	3.6 KB
6	news.swapon.de	393.3 KB	41.6 KB	434.9 KB	90%	6.3 KB
7	i2pn-out.feed.uzoreto.com	150.4 KB	124.4 KB	274.8 KB	54%	3.6 KB
8	news.bbs.nz	21.4 KB	0.0 KB	21.4 KB	100%	2.4 KB
9	news.samoylyk.net	7.8 KB	0.0 KB	7.8 KB	100%	2.0 KB
10	i2pn2	2.2 KB	0.0 KB	2.2 KB	100%	2.2 KB
11	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
12	kf5zxw.com	0.0 KB	0.0 KB	0.0 KB	0%	0
13	novabbs	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 13		52.7 MB	75.6 MB	128.3 MB	41%	6.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 16 04:15:01 - 04:59:59	243	1.5%	0.09	1.0 MB	2.0%	0.39
Sep 16 05:00:00 - 05:59:59	270	1.7%	0.07	734.4 KB	1.4%	0.20
Sep 16 06:00:00 - 06:59:59	475	3.0%	0.13	2.2 MB	4.2%	0.63
Sep 16 07:00:00 - 07:59:59	747	4.7%	0.21	2.0 MB	3.7%	0.56
Sep 16 08:00:00 - 08:59:59	808	5.1%	0.22	2.1 MB	4.0%	0.60
Sep 16 09:00:00 - 09:59:59	702	4.4%	0.20	2.2 MB	4.2%	0.63
Sep 16 10:00:00 - 10:59:59	760	4.8%	0.21	2.4 MB	4.5%	0.68
Sep 16 11:00:00 - 11:59:59	643	4.1%	0.18	3.4 MB	6.3%	0.96
Sep 16 12:00:00 - 12:59:59	829	5.2%	0.23	2.4 MB	4.6%	0.69
Sep 16 13:00:00 - 13:59:59	892	5.6%	0.25	3.1 MB	5.9%	0.89
Sep 16 14:00:00 - 14:59:59	850	5.4%	0.24	2.4 MB	4.6%	0.69
Sep 16 15:00:00 - 15:59:59	893	5.7%	0.25	3.9 MB	7.4%	1.12
Sep 16 16:00:00 - 16:59:59	891	5.6%	0.25	3.5 MB	6.6%	1.00
Sep 16 17:00:00 - 17:59:59	863	5.5%	0.24	2.7 MB	5.0%	0.76
Sep 16 18:00:00 - 18:59:59	928	5.9%	0.26	2.5 MB	4.8%	0.72
Sep 16 19:00:00 - 19:59:59	924	5.8%	0.26	2.9 MB	5.5%	0.84
Sep 16 20:00:00 - 20:59:59	945	6.0%	0.26	2.9 MB	5.4%	0.82
Sep 16 21:00:00 - 21:59:59	669	4.2%	0.19	1.8 MB	3.4%	0.51
Sep 16 22:00:00 - 22:59:59	570	3.6%	0.16	1.8 MB	3.4%	0.51
Sep 16 23:00:00 - 23:59:59	486	3.1%	0.14	1.4 MB	2.6%	0.40
Sep 17 00:00:00 - 00:59:59	397	2.5%	0.11	1.2 MB	2.3%	0.34
Sep 17 01:00:00 - 01:59:59	416	2.6%	0.12	1.9 MB	3.6%	0.54
Sep 17 02:00:00 - 02:59:59	331	2.1%	0.09	1.3 MB	2.5%	0.38
Sep 17 03:00:00 - 03:59:59	205	1.3%	0.06	854.2 KB	1.6%	0.24
Sep 17 04:00:00 - 04:15:01	68	0.4%	0.08	348.9 KB	0.6%	0.39
TOTAL: 24:00:00	15805	100.0%	0.18	53.1 MB	100.0%	0.63

Sites sending bad articles:

Server		Total	Group	Unapp	Other
1	paganini.bofh.team	1848	1	0	1847
2	i2pn-out.news.weretis.net	1199	39	0	1160
3	feeder.eternal-september.org	340	1	0	339
4	news-out.neodome.net	308	0	0	308
5	i2pn-out.feed.uzoreto.com	40	0	1	39
6	news.swapon.de	35	0	0	35
7	news-out.aioe.org	34	1	0	33
8	novabbs	1	0	0	1
TOTAL: 8		3805	42	1	3762

Unwanted newsgroups [Top 20]:

Newsgroup	Count
ba.forsale	8
alt.music.pink-floyd.publius	4
alt.forsale.seattle	2
bburg.forsale	2
aol.neighborhood.ca.fresno.marketplace	2
nc.charlotte.forsale	2
att.jobs	2
mozilla.tools.bmo	1
weblogic.developer.interest.workshop	1
mozilla.tools.taskcluster	1
alt.penthouse.sex.femdom	1
clari.web.local.texas	1
ifi.test.boa	1
alt.math.undergrad	1
aol.neighborhood.az.jobs	1
mailing.freebsd.questions	1
aus.jobs	1
clari.web.local.oklahoma	1
fr.rec.photo.labo.numerique	1
aol.neighborhood.ca.san-francisco.jobs	1
TOTAL: 27	42

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

Groups	Count
uk.radio.amateur.moderated	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1742
EMP (phn path)	744
Binary: misplaced rar	451
Scoring filter (s5)	157
EMP (phn nph)	89
Scoring filter (s6)	77
EMP (phl)	71
Scoring filter (n4)	26
HTML Multipart	13
User-issued cancel	10
User-issued spam cancel	7
Scoring filter (10)	6
Scoring filter (13)	5
Scoring filter (9)	5
Scoring filter (12)	4
Scoring filter (n11)	3
Scoring filter (8)	3
Binary Image: misplaced jpg	1
Too many newsgroups (meow)	1
Scoring filter (ts1)	1
TOTAL: 21	3417

NoCeM on Spool:

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

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	i2pn-out.feed.uzoreto.com	1
	TOTAL: 1	1
Bad Message-ID's offered
	i2pn-out.feed.uzoreto.com	1
	TOTAL: 1	1
Including strange strings
	i2pn-out.news.weretis.net	301
	news.swapon.de	30
	news-out.aioe.org	9
	paganini.bofh.team	2
	i2pn-out.feed.uzoreto.com	1
	news-out.neodome.net	1
	TOTAL: 6	344
TOTAL: 3		346

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn2	15612	14742	52	749	0	94%	23:59:44
2	kf5zxw.com	29013	2042	13762	0	99	7%	23:59:56
3	news.uzoreto.com	15811	1578	12785	1022	0	9%	23:59:44
4	aioe	15745	414	12534	8	0	2%	23:59:55
5	news.bbs.nz	30135	302	15481	18	151	1%	23:59:46
6	news.samoylyk.net	19139	59	15679	1	18	0%	23:59:56
7	weretis.net	9284	44	6012	169	0	0%	23:59:53
8	paganini.bofh.team	18113	41	14572	0	0	0%	23:59:46
9	neodome	18845	35	15535	0	0	0%	23:59:49
10	eternal-september	16454	27	13247	4	0	0%	23:59:15
11	swapon.de	1915	0	1590	0	0	0%	23:56:16
TOTAL: 11		190066	19284	121249	1971	268	10%	263:54:00

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	i2pn2	43.6 MB	2.6 MB	46.1 MB	0.5 KB/s	3.0 KB	23:59:44
2	kf5zxw.com	8.8 MB	0.0 KB	8.8 MB	0.1 KB/s	4.4 KB	23:59:56
3	news.uzoreto.com	5.3 MB	3.3 MB	8.5 MB	0.1 KB/s	3.4 KB	23:59:44
4	news.bbs.nz	1.2 MB	35.6 KB	1.3 MB	0.0 KB/s	4.1 KB	23:59:46
5	aioe	1017.6 KB	37.9 KB	1.0 MB	0.0 KB/s	2.5 KB	23:59:55
6	news.samoylyk.net	164.9 KB	1.3 KB	166.2 KB	0.0 KB/s	2.8 KB	23:59:56
7	paganini.bofh.team	151.7 KB	0.0 KB	151.7 KB	0.0 KB/s	3.7 KB	23:59:46
8	weretis.net	102.9 KB	329.9 KB	432.8 KB	0.0 KB/s	2.0 KB	23:59:53
9	neodome	71.0 KB	0.0 KB	71.0 KB	0.0 KB/s	2.0 KB	23:59:49
10	eternal-september	57.2 KB	3.1 KB	60.3 KB	0.0 KB/s	1.9 KB	23:59:15
11	swapon.de	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:56:16
TOTAL: 11		60.4 MB	6.2 MB	66.6 MB	0.1 KB/s	3.2 KB	263:54:00

Daily Usenet report

Sep 16 04:15:01 -- Sep 17 04:15:01