Daily Usenet report for news.niel.me: Apr 22 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	5034	45.6%	873.3 KB	49.7%
innd	2373	21.5%	393.1 KB	22.4%
nnrpd	2075	18.8%	216.1 KB	12.3%
innfeed	1553	14.1%	276.2 KB	15.7%
nocem	1	0.0%	0.1 KB	0.0%
controlchan	1	0.0%	0.0 KB	0.0%
TOTAL: 6	11037	100.0%	1.7 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	26000	67.4%
Negative hits	7620	19.7%
Do not exist	4969	12.9%
Cache misses	3	0.0%
TOTAL: 4	38592	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.025	0.0%	18	0.000	1.389	3.500
article cancel	00:00:00.002	0.0%	18	0.000	0.111	1.000
article cleanup	00:00:00.080	0.0%	4980	0.000	0.016	0.083
article logging	00:00:00.393	0.0%	5002	0.000	0.079	0.267
article parse	00:00:01.138	0.0%	10043	0.000	0.113	0.250
article write	00:00:03.580	0.0%	4443	0.143	0.806	12.150
artlog/artcncl	00:00:00.000	0.0%	18	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.001	0.0%	18	0.000	0.056	0.500
data move	00:00:00.134	0.0%	44042	0.000	0.003	0.015
hisgrep/artcncl	00:00:00.000	0.0%	18	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	18	0.000	0.000	0.000
hisgrep/perl	00:00:00.002	0.0%	37	0.000	0.054	1.000
hishave/artcncl	00:00:00.000	0.0%	18	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	18	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.536	0.0%	38656	0.000	0.014	0.040
history sync	00:00:00.049	0.0%	417	0.000	0.118	1.667
history write	00:00:01.136	0.0%	4980	0.043	0.228	0.828
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:19.418	99.9%	44168	830.976	1956.607	8965.940
nntp read	00:00:01.472	0.0%	43569	0.008	0.034	0.065
overview write	00:00:03.676	0.0%	4443	0.105	0.827	35.250
perl filter	00:00:25.244	0.0%	4980	2.632	5.069	12.794
python filter	00:00:00.020	0.0%	8335	0.000	0.002	0.042
site send	00:00:01.004	0.0%	8890	0.000	0.113	0.438
TOTAL: 24:01:11.464	24:00:57.910	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.050	0.0%	4464	0.000	0.011	0.154
article prepare	00:00:00.007	0.0%	2048	0.000	0.003	0.083
article read	00:00:00.067	0.0%	434	0.000	0.154	8.000
backlog stats	00:00:00.147	0.0%	65659	0.000	0.002	0.009
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.911	0.0%	37754	0.000	0.024	0.059
data write	00:00:02.419	0.0%	33258	0.037	0.073	0.116
idle	23:51:06.307	100.0%	65659	570.554	1307.761	3912.665
status file	00:00:00.379	0.0%	166	0.000	2.283	6.000
TOTAL: 23:51:13.763	23:51:10.287	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:06:03.675	95.5%	1575	6.400	230.905	9475.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.130	0.0%	3991	0.000	0.033	0.273
readart	00:00:00.013	0.0%	14	0.000	0.929	2.500
TOTAL: 00:06:20.895	00:06:03.818	95.5%	-	-	-	-

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	4	4078	2108	1890	80	51%	25:09:32
2	feed-out.gegeweb.org	2	3335	948	2386	1	28%	23:59:29
3	usenet.pasdenom.info	7	6960	568	6388	4	8%	49:11:04
4	nntp.terraraq.uk	4	3243	440	2508	295	13%	20:40:35
5	news.nntp4.net	6	1683	68	1572	43	4%	12:11:03
6	gegeweb-out.news.tnetconsulting.net	3	4633	27	4575	31	0%	27:49:43
7	i2pn.org	3	1354	11	1334	9	0%	10:51:04
8	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 8		54	25286	4170	20653	463	16%	169:52:30

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news-out.aioe.org	6.8 MB	349.0 KB	7.1 MB	95%	3.3 KB
2	nntp.terraraq.uk	6.4 MB	715.2 KB	7.1 MB	90%	9.9 KB
3	feed-out.gegeweb.org	4.1 MB	1.2 KB	4.2 MB	99%	4.5 KB
4	news.nntp4.net	2.0 MB	109.0 KB	2.1 MB	95%	19.7 KB
5	usenet.pasdenom.info	1.6 MB	14.2 KB	1.6 MB	99%	2.8 KB
6	gegeweb-out.news.tnetconsulting.net	341.7 KB	159.0 KB	500.7 KB	68%	8.6 KB
7	i2pn.org	29.0 KB	54.9 KB	83.9 KB	34%	4.2 KB
8	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 8		21.3 MB	1.4 MB	22.6 MB	93%	5.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 22 04:15:01 - 04:59:59	118	2.7%	0.04	2.3 MB	8.5%	0.85
Apr 22 05:00:00 - 05:59:59	121	2.7%	0.03	484.5 KB	1.8%	0.13
Apr 22 06:00:00 - 06:59:59	95	2.1%	0.03	313.8 KB	1.2%	0.09
Apr 22 07:00:00 - 07:59:59	149	3.4%	0.04	962.7 KB	3.6%	0.27
Apr 22 08:00:00 - 08:59:59	90	2.0%	0.03	435.7 KB	1.6%	0.12
Apr 22 09:00:00 - 09:59:59	86	1.9%	0.02	256.8 KB	1.0%	0.07
Apr 22 10:00:00 - 10:59:59	108	2.4%	0.03	382.4 KB	1.4%	0.11
Apr 22 11:00:00 - 11:59:59	125	2.8%	0.03	336.3 KB	1.2%	0.09
Apr 22 12:00:00 - 12:59:59	137	3.1%	0.04	401.1 KB	1.5%	0.11
Apr 22 13:00:00 - 13:59:59	199	4.5%	0.06	684.4 KB	2.5%	0.19
Apr 22 14:00:00 - 14:59:59	166	3.7%	0.05	570.0 KB	2.1%	0.16
Apr 22 15:00:00 - 15:59:59	166	3.7%	0.05	525.7 KB	1.9%	0.15
Apr 22 16:00:00 - 16:59:59	259	5.8%	0.07	1.3 MB	4.9%	0.36
Apr 22 17:00:00 - 17:59:59	285	6.4%	0.08	845.0 KB	3.1%	0.23
Apr 22 18:00:00 - 18:59:59	258	5.8%	0.07	939.0 KB	3.5%	0.26
Apr 22 19:00:00 - 19:59:59	251	5.7%	0.07	1.0 MB	3.8%	0.29
Apr 22 20:00:00 - 20:59:59	308	6.9%	0.09	1.0 MB	3.9%	0.29
Apr 22 21:00:00 - 21:59:59	233	5.2%	0.06	1.4 MB	5.3%	0.40
Apr 22 22:00:00 - 22:59:59	196	4.4%	0.05	2.8 MB	10.6%	0.79
Apr 22 23:00:00 - 23:59:59	239	5.4%	0.07	2.1 MB	8.0%	0.60
Apr 23 00:00:00 - 00:59:59	258	5.8%	0.07	2.5 MB	9.6%	0.72
Apr 23 01:00:00 - 01:59:59	180	4.1%	0.05	1.3 MB	4.9%	0.36
Apr 23 02:00:00 - 02:59:59	209	4.7%	0.06	2.1 MB	7.9%	0.59
Apr 23 03:00:00 - 03:59:59	173	3.9%	0.05	1.5 MB	5.8%	0.44
Apr 23 04:00:00 - 04:15:01	30	0.7%	0.03	114.9 KB	0.4%	0.13
TOTAL: 24:00:00	4439	100.0%	0.05	26.3 MB	100.0%	0.31

Sites sending bad articles:

Server		Total	Group	Other
1	nntp.terraraq.uk	341	0	341
2	news-out.aioe.org	91	6	85
3	news.nntp4.net	56	2	54
4	gegeweb-out.news.tnetconsulting.net	40	0	40
5	i2pn.org	24	0	24
6	usenet.pasdenom.info	4	0	4
7	feed-out.gegeweb.org	3	0	3
TOTAL: 7		559	8	551

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fr.petites-annonces.informatique.materiel	7
news.test	1
TOTAL: 2	8

INND Perl filter [Top 20]:

Reason	Count
Too many newsgroups	221
Bad path (news.giganews.com.POSTED)	143
EMP (phl)	81
EMP (md5)	31
EMP (phn nph)	25
EMP (phn path)	7
Too many newsgroups (meow)	2
Cancel of non-existing ID <hx3gI.93859$ST2.65997@fx47.iad>	1
Cancel of non-existing ID <hx3gI.93858$ST2.66556@fx47.iad>	1
Cancel of non-existing ID <hELeI.21354$lyv9.20691@fx35.iad>	1
Cancel of non-existing ID <s5shq1$4re$1@vmserveur.novazur.fr>	1
Cancel of non-existing ID <V%JeI.17365$gq3.527@fx04.iad>	1
Cancel of non-existing ID <iCKeI.21353$lyv9.18501@fx35.iad>	1
Cancel of non-existing ID <OeOeI.10069$RC2.3380@fx27.iad>	1
Cancel of non-existing ID <hx3gI.43678$2A5.33903@fx45.iad>	1
Cancel of non-existing ID <hx3gI.43675$2A5.30412@fx45.iad>	1
Cancel of non-existing ID <hx3gI.43670$2A5.11743@fx45.iad>	1
Cancel of non-existing ID <ix3gI.43680$2A5.42685@fx45.iad>	1
Cancel of non-existing ID <XfOeI.10070$RC2.4287@fx27.iad>	1
Cancel of non-existing ID <hx3gI.43671$2A5.15497@fx45.iad>	1
TOTAL: 26	529

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news-out.aioe.org	19
	feed-out.gegeweb.org	2
	nntp.terraraq.uk	1
	TOTAL: 3	22
TOTAL: 1		22

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn.org	7901	203	3887	175	20	2%	23:59:56
2	news.tnetconsulting.net	7950	68	4323	47	22	0%	23:59:56
3	nntp.terraraq.uk	3006	8	2699	0	0	0%	23:59:18
4	news.gegeweb.org	3658	5	3486	0	0	0%	23:59:56
5	news.nntp4.net	5269	3	4314	0	2	0%	23:59:36
6	news.aioe.org	1998	2	1843	0	0	0%	23:58:22
7	news.pasdenom.info	3409	0	3304	1	0	0%	23:59:56
TOTAL: 7		33191	289	23856	223	44	0%	167:57:00

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	i2pn.org	500.4 KB	381.2 KB	881.6 KB	2.3 KB	23:59:56
2	news.tnetconsulting.net	258.4 KB	124.7 KB	383.1 KB	3.3 KB	23:59:56
3	nntp.terraraq.uk	46.5 KB	0.0 KB	46.5 KB	5.8 KB	23:59:18
4	news.aioe.org	29.0 KB	0.0 KB	29.0 KB	14.5 KB	23:58:22
5	news.nntp4.net	12.0 KB	0.0 KB	12.0 KB	4.0 KB	23:59:36
6	news.gegeweb.org	11.3 KB	0.0 KB	11.3 KB	2.3 KB	23:59:56
7	news.pasdenom.info	0.0 KB	1.4 KB	1.4 KB	1.4 KB	23:59:56
TOTAL: 7		857.6 KB	507.3 KB	1.3 MB	2.7 KB	167:57:00

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	192.168.1.41	5	14	30.6 KB	8	0	0	00:05:42
TOTAL: 1		5	14	30.6 KB	8	0	0	00:06:20

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	10	14	30.6 KB	8	00:05:53
2	*.w90-2.abo.wanadoo.fr	1	0	0.0 KB	0	00:00:01
3	*.gegeweb.eu	288	0	0.0 KB	0	00:00:24
4	*.ch1.censys-scanner.com	1	0	0.0 KB	0	00:00:01
TOTAL: 4		300	14	30.6 KB	8	00:06:20

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
192.168.1.41	0.230	0.155	0.000	00:05:42
mail.gegeweb.eu	8.170	8.530	3.145	00:00:24
192.241.221.22	0.035	0.023	0.000	00:00:09
amontsouris-654-1-81-197.w90-2.abo.wanadoo.fr	0.021	0.032	0.000	00:00:01
88.165.5.23	0.143	0.098	0.000	00:00:01
scanner-05.ch1.censys-scanner.com	0.025	0.050	0.000	00:00:01
TOTAL: 6	8.624	8.888	3.145	00:06:20

Curious NNRP server explorers [Top 20]:

System	Conn
mail.gegeweb.eu	288
88.165.5.23	4
amontsouris-654-1-81-197.w90-2.abo.wanadoo.fr	1
192.241.221.22	1
scanner-05.ch1.censys-scanner.com	1
TOTAL: 5	295

NNRP unrecognized commands (by host):

System	Conn
scanner-05.ch1.censys-scanner.com	1
TOTAL: 1	1

NNRP unrecognized commands (by command):

Command	Count
EHLO www.censys.io	1
TOTAL: 1	1

Newsgroup request counts (by category):

Category		Count	Pct
1	fr	8	57.1%
2	comp	5	35.7%
3	grisbi	1	7.1%
TOTAL: 3		14	100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

Newsgroup		Count
1	comp.sys.raspberry-pi	5
2	fr.comp.lang.c	4
3	fr.comp.usenet.lecteurs-de-news	3
4	fr.misc.transport.velo	1
5	grisbi.test	1
TOTAL: 5		14

Daily Usenet report for news.niel.me

Apr 22 04:15:01 -- Apr 23 04:15:01