Daily Usenet report: Dec 23 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	257076	94.4%	32.0 MB	93.4%
innd	11309	4.2%	1.6 MB	4.6%
innfeed	3872	1.4%	702.7 KB	2.0%
controlchan	12	0.0%	2.5 KB	0.0%
nocem	1	0.0%	0.2 KB	0.0%
TOTAL: 5	272270	100.0%	34.3 MB	100.0%

History cache:

Reason	Count	%Count
Cache misses	382589	35.1%
Negative hits	317260	29.1%
Do not exist	257866	23.7%
Positive hits	132352	12.1%
TOTAL: 4	1090067	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.001	0.0%	21	0.000	0.048	1.000
article cleanup	00:00:01.819	0.0%	256922	0.000	0.007	0.033
article logging	00:00:06.759	0.0%	257062	0.000	0.026	0.106
article parse	00:00:05.579	0.0%	858294	0.000	0.007	0.048
article write	00:00:01.718	0.0%	11701	0.000	0.147	18.955
artlog/artcncl	00:00:00.001	0.0%	21	0.000	0.048	1.000
artlog/artparse	00:00:00.001	0.0%	1	1.000	1.000	1.000
data move	00:00:00.667	0.0%	572634	0.000	0.001	0.003
hisgrep/artcncl	00:00:00.000	0.0%	21	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	21	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:03.017	0.0%	1090511	0.000	0.003	0.013
history sync	00:00:00.028	0.0%	394	0.000	0.071	2.333
history write	00:00:10.289	0.0%	256921	0.000	0.040	0.174
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:58:35.077	99.8%	926288	5.626	93.184	1501.203
nntp read	00:00:10.057	0.0%	937150	0.003	0.011	0.018
overview write	00:00:01.267	0.0%	11701	0.019	0.108	3.605
perl filter	00:00:25.252	0.0%	12480	1.281	2.023	7.580
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:01.513	0.0%	23463	0.000	0.064	0.208
TOTAL: 24:00:57.325	23:59:43.045	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:02.561	0.0%	4178938	0.000	0.001	0.016
article prepare	00:00:00.471	0.0%	7709834	0.000	0.000	0.002
article read	00:00:22.183	0.0%	3547935	0.000	0.006	0.116
backlog stats	00:00:02.035	0.0%	2495426	0.000	0.001	0.005
callbacks	00:00:00.905	0.0%	430717	0.000	0.002	0.004
data read	00:00:08.029	0.0%	1575343	0.004	0.005	0.014
data write	00:00:16.678	0.0%	1649721	0.002	0.010	0.073
idle	23:53:37.866	99.9%	2495426	2.076	34.470	639.114
newart/cb	00:00:00.000	0.0%	1	0.000	0.000	0.000
prepart/cb	00:00:00.000	0.0%	10	0.000	0.000	0.000
readart/cb	00:00:00.000	0.0%	3	0.000	0.000	0.000
status file	00:00:01.653	0.0%	389	0.000	4.249	92.000
TOTAL: 23:55:19.390	23:54:32.381	99.9%	-	-	-	-

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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
bofh-control@killfile.org	1	0	1	0	0	2
TOTAL	1	0	1	0	0	2

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	usenet.blueworldhosting.com	5	12090	3105	8758	227	25%	24:34:14
2	i2pn-out.news.weretis.net	6	21028	2955	18010	63	14%	47:39:04
3	news-out.aioe.org	3	8917	2575	6323	19	28%	24:09:34
4	feeder.eternal-september.org	12	6409	1904	4204	301	29%	26:03:49
5	usenet.goja.nl.eu.org	11	11765	567	11111	87	4%	24:04:51
6	paganini.bofh.team	1	10986	203	10780	3	1%	20:20:47
7	news.nntp4.net	1	11747	162	11562	23	1%	23:59:58
8	news.swapon.de	11	1015	83	932	0	8%	23:09:14
9	news-out.neodome.net	2	11117	83	11017	17	0%	24:05:56
10	i2pn2.org	42	239	35	204	0	14%	14:10:22
11	nntp.alphanet.ch	25	6762	33	6729	0	0%	22:59:50
12	i2pn-out.feed.uzoreto.com	1429	12559	29	12469	61	0%	71:20:21
13	news.samoylyk.net	2	9941	20	9920	1	0%	23:59:48
14	news.niel.me	3	2269	16	2252	1	0%	23:58:22
15	dodin.fr.nf	25	441	9	432	0	2%	17:58:15
16	news.bbs.nz	3	11779	2	11777	0	0%	29:15:21
17	novabbs.org	12	1830	1	1829	0	0%	18:48:35
18	retrobbs.ddns.net	1	0	0	0	0	0%	00:10:00
19	localhost	25	0	0	0	0	0%	00:00:00
20	news.furie.org.uk	13	5026	0	5026	0	0%	24:25:59
21	kf5zxw.com	7	297912	0	53616	244296	0%	06:09:20
TOTAL: 21		1639	443832	11782	186951	245099	2%	491:23:40

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn-out.news.weretis.net	18.3 MB	0.0 KB	204.9 KB	18.5 MB	98%	6.3 KB
2	usenet.blueworldhosting.com	10.4 MB	0.0 KB	910.9 KB	11.3 MB	92%	3.5 KB
3	feeder.eternal-september.org	7.0 MB	0.0 KB	1.9 MB	8.9 MB	78%	4.1 KB
4	news-out.aioe.org	6.7 MB	0.0 KB	81.7 KB	6.8 MB	98%	2.7 KB
5	usenet.goja.nl.eu.org	1.5 MB	0.0 KB	309.4 KB	1.8 MB	83%	2.8 KB
6	paganini.bofh.team	829.1 KB	1.6 KB	10.8 KB	841.5 KB	98%	4.1 KB
7	news.nntp4.net	737.4 KB	0.0 KB	74.8 KB	812.2 KB	90%	4.4 KB
8	news-out.neodome.net	281.7 KB	0.0 KB	481.9 KB	763.7 KB	36%	7.6 KB
9	i2pn2.org	217.2 KB	0.0 KB	0.0 KB	217.2 KB	100%	6.2 KB
10	news.swapon.de	179.4 KB	0.0 KB	0.0 KB	179.4 KB	100%	2.2 KB
11	nntp.alphanet.ch	151.9 KB	0.0 KB	0.0 KB	151.9 KB	100%	4.6 KB
12	news.samoylyk.net	80.5 KB	1.5 KB	1.5 KB	83.6 KB	96%	4.0 KB
13	i2pn-out.feed.uzoreto.com	46.0 KB	0.0 KB	318.8 KB	364.9 KB	12%	4.1 KB
14	news.niel.me	37.7 KB	0.0 KB	1.4 KB	39.1 KB	96%	2.3 KB
15	dodin.fr.nf	17.8 KB	0.0 KB	0.0 KB	17.8 KB	100%	2.0 KB
16	news.bbs.nz	1.9 KB	0.0 KB	0.0 KB	1.9 KB	100%	0.9 KB
17	novabbs.org	0.8 KB	0.0 KB	0.0 KB	0.8 KB	100%	0.8 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	news.furie.org.uk	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
21	kf5zxw.com	0.0 KB	0.0 KB	1.1 GB	1.1 GB	0%	4.8 KB
TOTAL: 21		46.4 MB	3.1 KB	1.1 GB	1.2 GB	3%	4.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 23 04:15:01 - 04:59:59	146	1.2%	0.05	627.0 KB	1.3%	0.23
Dec 23 05:00:00 - 05:59:59	300	2.6%	0.08	3.3 MB	7.1%	0.94
Dec 23 06:00:00 - 06:59:59	282	2.4%	0.08	779.9 KB	1.6%	0.22
Dec 23 07:00:00 - 07:59:59	389	3.3%	0.11	1.5 MB	3.2%	0.43
Dec 23 08:00:00 - 08:59:59	450	3.8%	0.12	1.4 MB	3.0%	0.39
Dec 23 09:00:00 - 09:59:59	549	4.7%	0.15	2.0 MB	4.2%	0.56
Dec 23 10:00:00 - 10:59:59	665	5.7%	0.18	2.0 MB	4.4%	0.58
Dec 23 11:00:00 - 11:59:59	623	5.3%	0.17	2.1 MB	4.5%	0.59
Dec 23 12:00:00 - 12:59:59	511	4.4%	0.14	1.3 MB	2.8%	0.36
Dec 23 13:00:00 - 13:59:59	638	5.5%	0.18	2.0 MB	4.3%	0.56
Dec 23 14:00:00 - 14:59:59	750	6.4%	0.21	3.9 MB	8.4%	1.11
Dec 23 15:00:00 - 15:59:59	781	6.7%	0.22	2.7 MB	5.8%	0.76
Dec 23 16:00:00 - 16:59:59	717	6.1%	0.20	2.0 MB	4.4%	0.58
Dec 23 17:00:00 - 17:59:59	698	6.0%	0.19	3.1 MB	6.7%	0.88
Dec 23 18:00:00 - 18:59:59	577	4.9%	0.16	2.9 MB	6.2%	0.83
Dec 23 19:00:00 - 19:59:59	585	5.0%	0.16	2.3 MB	4.9%	0.65
Dec 23 20:00:00 - 20:59:59	526	4.5%	0.15	2.7 MB	5.8%	0.76
Dec 23 21:00:00 - 21:59:59	532	4.6%	0.15	2.7 MB	5.7%	0.76
Dec 23 22:00:00 - 22:59:59	496	4.2%	0.14	1.7 MB	3.6%	0.48
Dec 23 23:00:00 - 23:59:59	411	3.5%	0.11	1.2 MB	2.7%	0.35
Dec 24 00:00:00 - 00:59:59	329	2.8%	0.09	1009.6 KB	2.1%	0.28
Dec 24 01:00:00 - 01:59:59	249	2.1%	0.07	2.0 MB	4.4%	0.58
Dec 24 02:00:00 - 02:59:59	246	2.1%	0.07	694.0 KB	1.5%	0.19
Dec 24 03:00:00 - 03:59:59	207	1.8%	0.06	640.4 KB	1.3%	0.18
Dec 24 04:00:00 - 04:15:01	34	0.3%	0.04	94.0 KB	0.2%	0.10
TOTAL: 24:00:00	11691	100.0%	0.14	46.4 MB	100.0%	0.55

Sites sending bad articles:

Server		Total	Group	Duplic	TooOld	Other
1	kf5zxw.com	244441	0	0	244440	1
2	feeder.eternal-september.org	309	0	0	0	309
3	usenet.blueworldhosting.com	249	40	0	0	209
4	i2pn-out.news.weretis.net	113	0	0	0	113
5	usenet.goja.nl.eu.org	88	0	0	0	88
6	i2pn-out.feed.uzoreto.com	61	1	0	0	60
7	news.swapon.de	31	0	0	0	31
8	news.nntp4.net	24	0	1	0	23
9	news-out.aioe.org	24	12	0	0	12
10	news-out.neodome.net	17	0	0	0	17
11	news.samoylyk.net	3	0	2	0	1
12	paganini.bofh.team	3	1	1	0	1
13	news.niel.me	1	0	0	0	1
TOTAL: 13		245364	54	4	244440	866

Unwanted newsgroups [Top 20]:

Newsgroup	Count
att.jobs	11
alt.forsale.seattle	8
aus.jobs	6
ba.forsale	5
atl.forsale	5
harvard.forsale	4
upenn.forsale	2
bburg.forsale	1
tor.forsale	1
bofh.pets	1
alt.music.pink-floyd.publius	1
mailing.openssl.users	1
tahoe.forsale	1
af.philo	1
alt.silly-group.radish-therapy	1
trollnet.cinema	1
alt.non.racism	1
1.test	1
fr.petites-annonces.informatique.materiel	1
maine.forsale	1
TOTAL: 20	54

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	393
Too many newsgroups	211
Poison newsgroup	89
Binary: misplaced rar	14
Scoring filter (12)	5
User-issued cancel	5
Scoring filter (11)	5
Scoring filter (9)	1
HTML Multipart	1
U2 violation - invalid distribution	1
TOTAL: 10	725

INND no permission servers:

System	Conn
178.79.150.147	80
193.118.55.162	8
159.203.224.9	1
2a06:4880:7000::4b	1
193.118.55.164	1
TOTAL: 5	91

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	i2pn-out.news.weretis.net	60
	news.swapon.de	31
	usenet.blueworldhosting.com	26
	feeder.eternal-september.org	10
	news-out.aioe.org	10
	news-out.neodome.net	1
	usenet.goja.nl.eu.org	1
	news.samoylyk.net	1
	TOTAL: 8	140
No colon-space in header
	kf5zxw.com	1
	TOTAL: 1	1
TOTAL: 2		141

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	kf5zxw.com	4171300	235038	621966	2573	3299214	19959	5%	23:57:42
2	retrobbs.ddns.net	11561	11077	0	480	0	0	95%	23:59:52
3	i2pn2	11676	10869	147	502	0	4	93%	23:59:52
4	novabbs	13482	9134	1951	471	0	10	67%	23:59:52
5	aioe	9009	2039	6504	73	0	0	22%	23:59:52
6	news.niel.me	3558	884	2275	117	0	0	24%	23:59:52
7	news.furie.org.uk	8379	702	5001	44	0	16	8%	23:59:52
8	nntp.alphanet.ch	13379	662	10454	410	0	7	4%	23:59:42
9	paganini.bofh.team	14202	350	11121	0	0	1	2%	23:59:43
10	news.nntp4.net	14201	323	11168	12	0	0	2%	23:59:52
11	news.bbs.nz	22742	279	11165	237	0	101	1%	23:59:46
12	neodome	14196	279	11188	0	0	0	1%	23:59:52
13	usenet.goja.nl.eu.org	13584	261	10690	27	0	10	1%	23:59:52
14	news.uzoreto.com	13892	86	10718	0	0	0	0%	23:59:52
15	usenet.blueworldhosting.com	15399	75	8447	1	0	33	0%	23:59:24
16	weretis.net	12979	52	7973	692	0	9	0%	23:59:52
17	eternal-september	13131	49	9693	18	0	4	0%	23:59:52
18	news.samoylyk.net	14694	45	11478	14	0	0	0%	23:59:36
19	dodin.fr.nf	805	34	434	0	0	0	4%	17:53:27
20	swapon.de	1128	0	963	0	0	0	0%	22:52:12
TOTAL: 20		4393297	272238	753336	5671	3299214	20154	6%	472:39:56

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	kf5zxw.com	876.3 MB	14.7 MB	891.0 MB	10.6 KB/s	3.8 KB	23:57:42
2	retrobbs.ddns.net	42.2 MB	1.7 MB	43.9 MB	0.5 KB/s	3.9 KB	23:59:52
3	i2pn2	40.9 MB	2.1 MB	43.0 MB	0.5 KB/s	3.9 KB	23:59:52
4	novabbs	36.9 MB	1.3 MB	38.2 MB	0.5 KB/s	4.1 KB	23:59:52
5	aioe	6.7 MB	258.1 KB	6.9 MB	0.1 KB/s	3.4 KB	23:59:52
6	news.niel.me	2.7 MB	315.3 KB	3.0 MB	0.0 KB/s	3.1 KB	23:59:52
7	nntp.alphanet.ch	2.3 MB	1.4 MB	3.8 MB	0.0 KB/s	3.6 KB	23:59:42
8	news.furie.org.uk	2.1 MB	215.6 KB	2.4 MB	0.0 KB/s	3.2 KB	23:59:52
9	paganini.bofh.team	1.3 MB	0.0 KB	1.3 MB	0.0 KB/s	3.9 KB	23:59:43
10	news.bbs.nz	1.2 MB	1.6 MB	2.8 MB	0.0 KB/s	5.6 KB	23:59:46
11	news.nntp4.net	1.1 MB	145.8 KB	1.3 MB	0.0 KB/s	3.9 KB	23:59:52
12	neodome	1.1 MB	0.0 KB	1.1 MB	0.0 KB/s	4.1 KB	23:59:52
13	usenet.goja.nl.eu.org	869.1 KB	210.0 KB	1.1 MB	0.0 KB/s	3.7 KB	23:59:52
14	news.uzoreto.com	346.3 KB	0.0 KB	346.3 KB	0.0 KB/s	4.0 KB	23:59:52
15	usenet.blueworldhosting.com	308.3 KB	24.3 KB	332.6 KB	0.0 KB/s	4.4 KB	23:59:24
16	weretis.net	166.6 KB	1.4 MB	1.6 MB	0.0 KB/s	2.2 KB	23:59:52
17	dodin.fr.nf	160.7 KB	0.0 KB	160.7 KB	0.0 KB/s	4.7 KB	17:53:27
18	eternal-september	138.7 KB	461.3 KB	600.0 KB	0.0 KB/s	9.0 KB	23:59:52
19	news.samoylyk.net	119.2 KB	161.3 KB	280.5 KB	0.0 KB/s	4.8 KB	23:59:36
20	swapon.de	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:52:12
TOTAL: 20		1017.0 MB	26.0 MB	1.0 GB	0.6 KB/s	3.8 KB	472:39:56

Daily Usenet report

Dec 23 04:15:01 -- Dec 24 04:15:01