Daily Usenet report for news.niel.me: Oct 17 04:15:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Oct 17 16:47:01 rpi-studio innd: filter: No Cancel-Key[sha1:9SNqNY5rjx+3keTpMG+nPei8hi8=] matches Cancel-Lock[sha1:3WwYu/EAa77v0HGmUu6gOv7iKjs=] target=<634d5ca2$0$3016$426a34cc@news.free.fr>

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3855	40.3%	724.9 KB	45.4%
innd	2490	26.1%	420.0 KB	26.3%
innfeed	1741	18.2%	303.6 KB	19.0%
nnrpd	1469	15.4%	147.1 KB	9.2%
nocem	1	0.0%	0.2 KB	0.0%
controlchan	1	0.0%	0.0 KB	0.0%
TOTAL: 6	9557	100.0%	1.6 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	24223	65.4%
Negative hits	8987	24.3%
Do not exist	3804	10.3%
Cache misses	1	0.0%
TOTAL: 4	37015	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.009	0.0%	7	1.000	1.286	2.000
article cancel	00:00:00.003	0.0%	8	0.000	0.375	1.000
article cleanup	00:00:00.075	0.0%	3807	0.000	0.020	0.136
article logging	00:00:00.254	0.0%	3827	0.000	0.066	0.222
article parse	00:00:00.673	0.0%	7360	0.000	0.091	0.333
article write	00:00:01.963	0.0%	3367	0.222	0.583	3.462
artlog/artcncl	00:00:00.001	0.0%	8	0.000	0.125	1.000
artlog/artcncl/perl	00:00:00.000	0.0%	7	0.000	0.000	0.000
data move	00:00:00.087	0.0%	39705	0.000	0.002	0.030
hisgrep/artcncl	00:00:00.000	0.0%	8	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	7	0.000	0.000	0.000
hisgrep/perl	00:00:00.001	0.0%	9	0.000	0.111	1.000
hishave/artcncl	00:00:00.000	0.0%	8	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	7	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.465	0.0%	37031	0.000	0.013	0.033
history sync	00:00:00.322	0.0%	396	0.000	0.813	90.000
history write	00:00:00.825	0.0%	3807	0.000	0.217	0.611
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:50:26.692	100.0%	40204	887.027	2134.780	8831.868
nntp read	00:00:01.256	0.0%	39988	0.000	0.031	0.073
overview write	00:00:02.285	0.0%	3367	0.091	0.679	6.231
perl filter	00:00:16.679	0.0%	3807	2.222	4.381	9.042
python filter	00:00:00.003	0.0%	3807	0.000	0.001	0.077
site send	00:00:00.906	0.0%	6775	0.000	0.134	0.429
TOTAL: 23:51:07.437	23:50:52.499	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.035	0.0%	3452	0.000	0.010	0.091
article prepare	00:00:00.001	0.0%	548	0.000	0.002	0.042
article read	00:00:00.017	0.0%	91	0.000	0.187	3.500
backlog stats	00:00:00.116	0.0%	52274	0.000	0.002	0.018
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.681	0.0%	30943	0.000	0.022	0.063
data write	00:00:01.639	0.0%	27698	0.016	0.059	0.094
idle	23:49:53.274	100.0%	52274	887.735	1641.223	4057.493
status file	00:00:00.824	0.0%	194	1.000	4.247	37.000
TOTAL: 23:49:59.881	23:49:56.587	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:22.362	20.8%	1445	11.200	15.475	80.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.120	0.1%	3184	0.000	0.038	0.500
TOTAL: 00:01:47.724	00:00:22.482	20.9%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
mode	148
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	170

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	news-out.aioe.org	2	3418	1567	1812	39	45%	23:21:39
2	i2pn.org	2	3572	771	2611	190	21%	23:29:56
3	news.glou.org	1	2411	410	1991	10	17%	19:32:23
4	feed-out.gegeweb.org	4	2416	251	2165	0	10%	23:58:30
5	usenet.pasdenom.info	3	2988	168	2818	2	5%	29:18:42
6	news.nntp4.net	2	3896	77	3646	173	1%	25:42:13
7	news.samoylyk.net	2	6797	20	6777	0	0%	46:25:28
8	gegeweb-out.news.tnetconsulting.net	1	1335	13	1320	2	0%	10:59:08
9	nntp.terraraq.uk	1	762	8	753	1	1%	05:47:44
10	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 10		43	27595	3285	23893	417	11%	208:35:43

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news-out.aioe.org	5.4 MB	94.9 KB	5.5 MB	98%	3.5 KB
2	news.glou.org	2.6 MB	21.8 KB	2.6 MB	99%	6.3 KB
3	i2pn.org	2.4 MB	423.3 KB	2.8 MB	85%	3.0 KB
4	news.nntp4.net	1.2 MB	798.9 KB	2.0 MB	60%	8.1 KB
5	news.samoylyk.net	1.1 MB	0.0 KB	1.1 MB	100%	56.1 KB
6	feed-out.gegeweb.org	724.8 KB	0.0 KB	724.8 KB	100%	2.9 KB
7	usenet.pasdenom.info	431.7 KB	3.0 KB	434.7 KB	99%	2.6 KB
8	gegeweb-out.news.tnetconsulting.net	114.4 KB	3.7 KB	118.1 KB	96%	7.9 KB
9	nntp.terraraq.uk	26.6 KB	1.8 KB	28.4 KB	93%	3.2 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		13.9 MB	1.3 MB	15.3 MB	91%	4.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 17 04:15:02 - 04:59:59	65	1.9%	0.02	328.1 KB	2.3%	0.12
Oct 17 05:00:00 - 05:59:59	108	3.2%	0.03	397.9 KB	2.8%	0.11
Oct 17 06:00:00 - 06:59:59	106	3.1%	0.03	608.1 KB	4.3%	0.17
Oct 17 07:00:00 - 07:59:59	122	3.6%	0.03	1.0 MB	7.5%	0.29
Oct 17 08:00:00 - 08:59:59	96	2.8%	0.03	321.8 KB	2.3%	0.09
Oct 17 09:00:00 - 09:59:59	104	3.1%	0.03	342.0 KB	2.4%	0.10
Oct 17 10:00:00 - 10:59:59	135	4.0%	0.04	449.2 KB	3.2%	0.12
Oct 17 11:00:00 - 11:59:59	146	4.3%	0.04	453.4 KB	3.2%	0.13
Oct 17 12:00:00 - 12:59:59	81	2.4%	0.02	235.8 KB	1.7%	0.07
Oct 17 13:00:00 - 13:59:59	151	4.5%	0.04	574.9 KB	4.1%	0.16
Oct 17 14:00:00 - 14:59:59	157	4.6%	0.04	701.8 KB	5.0%	0.19
Oct 17 15:00:00 - 15:59:59	145	4.3%	0.04	457.1 KB	3.2%	0.13
Oct 17 16:00:00 - 16:59:59	195	5.8%	0.05	818.3 KB	5.8%	0.23
Oct 17 17:00:00 - 17:59:59	200	5.9%	0.06	842.3 KB	5.9%	0.23
Oct 17 18:00:00 - 18:59:59	214	6.3%	0.06	889.0 KB	6.3%	0.25
Oct 17 19:00:00 - 19:59:59	160	4.7%	0.04	723.4 KB	5.1%	0.20
Oct 17 20:00:00 - 20:59:59	141	4.2%	0.04	525.5 KB	3.7%	0.15
Oct 17 21:00:00 - 21:59:59	175	5.2%	0.05	667.5 KB	4.7%	0.19
Oct 17 22:00:00 - 22:59:59	198	5.9%	0.06	752.9 KB	5.3%	0.21
Oct 17 23:00:00 - 23:59:59	168	5.0%	0.05	520.7 KB	3.7%	0.14
Oct 18 00:00:00 - 00:59:59	156	4.6%	0.04	735.3 KB	5.2%	0.20
Oct 18 01:00:00 - 01:59:59	134	4.0%	0.04	436.4 KB	3.1%	0.12
Oct 18 02:00:00 - 02:59:59	116	3.4%	0.03	642.3 KB	4.5%	0.18
Oct 18 03:00:00 - 03:59:59	88	2.6%	0.02	596.7 KB	4.2%	0.17
Oct 18 04:00:00 - 04:15:01	19	0.6%	0.02	88.8 KB	0.6%	0.10
TOTAL: 23:59:59	3380	100.0%	0.04	13.8 MB	100.0%	0.16

Sites sending bad articles:

Server		Total	Group	Other
1	i2pn.org	195	0	195
2	news.nntp4.net	170	0	170
3	news-out.aioe.org	57	1	56
4	usenet.pasdenom.info	16	0	16
5	news.glou.org	10	0	10
6	gegeweb-out.news.tnetconsulting.net	6	1	5
7	nntp.terraraq.uk	5	0	5
8	news.samoylyk.net	1	0	1
TOTAL: 8		460	2	458

Unwanted newsgroups [Top 20]:

Newsgroup	Count
talk.politics	1
fr.petites-annonces.informatique.materiel	1
TOTAL: 2	2

INND Perl filter [Top 20]:

Reason	Count
EMP (phl)	185
Bad path (news.giganews.com.POSTED)	113
EMP (phn nph)	56
EMP (md5)	37
Too many newsgroups	34
HTML Multipart	7
EMP (phn path)	3
Too many newsgroups (meow)	1
No Cancel-Key matches Cancel-Lock. target=<634d5ca2$0$3016$426a34cc@news.free.fr>	1
Cancels abusifs	1
TOTAL: 10	438

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news-out.aioe.org	17
	i2pn.org	1
	news.samoylyk.net	1
	news.nntp4.net	1
	TOTAL: 4	20
TOTAL: 1		20

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn.org	4626	32	2521	6	41	0%	23:59:46
2	news.nntp4.net	3602	28	3246	0	0	0%	23:59:30
3	nntp.terraraq.uk	2577	16	2190	7	0	0%	23:58:27
4	news.tnetconsulting.net	5420	16	3357	5	35	0%	23:59:23
5	news.gegeweb.org	3201	8	3126	0	0	0%	23:57:31
6	news.aioe.org	1529	8	1296	2	9	0%	23:56:41
7	news.samoylyk.net	3923	2	3361	6	0	0%	23:59:09
8	news.pasdenom.info	3136	0	2820	1	0	0%	23:59:31
TOTAL: 8		28014	110	21917	27	85	0%	191:49:58

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.nntp4.net	551.9 KB	0.0 KB	551.9 KB	19.7 KB	23:59:30
2	nntp.terraraq.uk	419.4 KB	258.0 KB	677.5 KB	29.5 KB	23:58:27
3	news.tnetconsulting.net	112.8 KB	20.4 KB	133.2 KB	6.3 KB	23:59:23
4	i2pn.org	96.5 KB	22.4 KB	118.9 KB	3.1 KB	23:59:46
5	news.aioe.org	43.7 KB	4.3 KB	48.0 KB	4.8 KB	23:56:41
6	news.gegeweb.org	17.8 KB	0.0 KB	17.8 KB	2.2 KB	23:57:31
7	news.samoylyk.net	10.4 KB	22.3 KB	32.7 KB	4.1 KB	23:59:09
8	news.pasdenom.info	0.0 KB	3.6 KB	3.6 KB	3.6 KB	23:59:31
TOTAL: 8		1.2 MB	331.0 KB	1.5 MB	11.6 KB	191:49:58

NNRP readership statistics:

System		Conn	Elapsed
1	mail.gegeweb.eu	288	00:01:33
2	50.31.21.4	3	00:00:12
3	192.241.214.173	1	00:00:01
4	88.165.5.23	1	00:00:00
TOTAL: 4		293	00:01:47

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.gegeweb.eu	288	00:01:33
2	unresolved	5	00:00:14
TOTAL: 2		293	00:01:47

NNRP auth users [Top 20]:

User	Conn
mailman	288
TOTAL: 1	288

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
mail.gegeweb.eu	7.938	8.236	2.420	00:01:33
50.31.21.4	0.097	0.056	0.000	00:00:12
192.241.214.173	0.034	0.022	0.000	00:00:01
88.165.5.23	0.035	0.026	0.000	00:00:00
TOTAL: 4	8.104	8.340	2.420	00:01:47

NNRP unrecognized commands (by host):

System	Conn
192.241.214.173	1
TOTAL: 1	1

NNRP unrecognized commands (by command):

Command	Count
MGLNDD_45.13.105.36_119	1
TOTAL: 1	1

Daily Usenet report for news.niel.me

Oct 17 04:15:02 -- Oct 18 04:15:01