Daily Usenet report for news.niel.me: Sep 28 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	8017	53.0%	1.5 MB	59.4%
innd	3523	23.3%	534.9 KB	21.0%
nnrpd	1836	12.1%	191.9 KB	7.5%
innfeed	1730	11.4%	304.5 KB	12.0%
controlchan	6	0.0%	1.2 KB	0.0%
nocem	1	0.0%	0.1 KB	0.0%
TOTAL: 6	15113	100.0%	2.5 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	33741	56.2%
Negative hits	18305	30.5%
Do not exist	7964	13.3%
Cache misses	12	0.0%
TOTAL: 4	60022	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.033	0.0%	19	0.000	1.737	10.500
article cancel	00:00:00.002	0.0%	19	0.000	0.105	1.000
article cleanup	00:00:00.186	0.0%	7996	0.000	0.023	0.138
article logging	00:00:00.551	0.0%	7996	0.000	0.069	0.180
article parse	00:00:01.979	0.0%	36980	0.014	0.054	0.113
article write	00:00:03.587	0.0%	6406	0.283	0.560	0.972
artlog/artcncl	00:00:00.000	0.0%	19	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.002	0.0%	19	0.000	0.105	0.500
data move	00:00:00.507	0.0%	92948	0.000	0.005	0.014
hisgrep/artcncl	00:00:00.000	0.0%	19	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	19	0.000	0.000	0.000
hisgrep/perl	00:00:00.000	0.0%	19	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	19	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.001	0.0%	19	0.000	0.053	0.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:00.949	0.0%	60160	0.002	0.016	0.034
history sync	00:00:00.063	0.0%	404	0.000	0.156	0.667
history write	00:00:01.566	0.0%	7996	0.060	0.196	0.404
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:59:54.339	99.9%	88597	374.220	975.138	2928.698
nntp read	00:00:02.456	0.0%	88023	0.007	0.028	0.048
overview write	00:00:01.814	0.0%	6406	0.080	0.283	1.400
perl filter	00:00:33.866	0.0%	7996	2.517	4.235	7.256
python filter	00:00:00.042	0.0%	7996	0.000	0.005	0.048
site send	00:00:01.981	0.0%	13151	0.014	0.151	0.489
TOTAL: 24:01:01.402	24:00:43.924	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.062	0.0%	6769	0.000	0.009	0.081
article prepare	00:00:00.007	0.0%	1596	0.000	0.004	0.125
article read	00:00:00.048	0.0%	295	0.000	0.163	1.000
backlog stats	00:00:00.462	0.0%	96596	0.000	0.005	0.012
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.377	0.0%	63839	0.004	0.022	0.062
data write	00:00:02.648	0.0%	48512	0.024	0.055	0.089
idle	23:58:15.092	100.0%	96596	370.026	893.361	1749.292
status file	00:00:00.691	0.0%	189	0.000	3.656	14.000
TOTAL: 23:58:25.838	23:58:20.387	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:47.934	29.3%	1455	9.000	32.944	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.080	0.0%	3243	0.000	0.025	1.000
TOTAL: 00:02:43.331	00:00:48.014	29.4%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
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
news@hispagatos.org	0	0	1	0	0	1
TOTAL	0	0	1	0	0	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	i2pn.org	2	6740	2253	4241	246	33%	23:41:15
2	feed-out.gegeweb.org	3	2482	1592	890	0	64%	23:58:38
3	news.glou.org	1	4828	792	3726	310	16%	24:15:56
4	news.nntp4.net	2	7845	761	6219	865	9%	24:30:28
5	gegeweb-out.news.tnetconsulting.net	1	8313	629	7666	18	7%	28:09:40
6	usenet.pasdenom.info	2	2543	260	2272	11	10%	30:20:21
7	nntp.terraraq.uk	1	4065	211	3760	94	5%	18:25:00
8	news.samoylyk.net	2	13235	154	13080	1	1%	45:50:21
9	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 9		39	50051	6652	41854	1545	13%	219:11:39

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn.org	15.3 MB	1.9 MB	17.1 MB	88%	7.0 KB
2	gegeweb-out.news.tnetconsulting.net	7.8 MB	415.5 KB	8.3 MB	95%	13.1 KB
3	news.glou.org	7.5 MB	2.5 MB	10.0 MB	74%	9.3 KB
4	news.nntp4.net	7.0 MB	10.5 MB	17.5 MB	40%	11.0 KB
5	feed-out.gegeweb.org	5.2 MB	0.0 KB	5.2 MB	100%	3.4 KB
6	news.samoylyk.net	1.4 MB	1.6 KB	1.4 MB	99%	9.4 KB
7	nntp.terraraq.uk	1.2 MB	1.1 MB	2.3 MB	50%	7.8 KB
8	usenet.pasdenom.info	622.3 KB	18.4 KB	640.6 KB	97%	2.4 KB
9	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 9		46.1 MB	16.5 MB	62.6 MB	73%	7.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 28 04:15:01 - 04:59:59	205	3.2%	0.08	1.4 MB	3.3%	0.54
Sep 28 05:00:00 - 05:59:59	253	4.0%	0.07	1.4 MB	3.3%	0.41
Sep 28 06:00:00 - 06:59:59	244	3.8%	0.07	1.6 MB	3.7%	0.45
Sep 28 07:00:00 - 07:59:59	239	3.7%	0.07	2.1 MB	4.8%	0.60
Sep 28 08:00:00 - 08:59:59	258	4.0%	0.07	1.7 MB	3.9%	0.48
Sep 28 09:00:00 - 09:59:59	281	4.4%	0.08	3.2 MB	7.2%	0.90
Sep 28 10:00:00 - 10:59:59	305	4.8%	0.08	2.5 MB	5.8%	0.72
Sep 28 11:00:00 - 11:59:59	326	5.1%	0.09	2.1 MB	4.9%	0.60
Sep 28 12:00:00 - 12:59:59	383	6.0%	0.11	2.4 MB	5.6%	0.69
Sep 28 13:00:00 - 13:59:59	340	5.3%	0.09	2.4 MB	5.5%	0.69
Sep 28 14:00:00 - 14:59:59	239	3.7%	0.07	1.5 MB	3.4%	0.42
Sep 28 15:00:00 - 15:59:59	249	3.9%	0.07	1.8 MB	4.1%	0.50
Sep 28 16:00:00 - 16:59:59	274	4.3%	0.08	1.9 MB	4.4%	0.55
Sep 28 17:00:00 - 17:59:59	236	3.7%	0.07	2.1 MB	4.9%	0.61
Sep 28 18:00:00 - 18:59:59	261	4.1%	0.07	1.4 MB	3.2%	0.39
Sep 28 19:00:00 - 19:59:59	295	4.6%	0.08	1.4 MB	3.2%	0.40
Sep 28 20:00:00 - 20:59:59	281	4.4%	0.08	2.2 MB	5.1%	0.63
Sep 28 21:00:00 - 21:59:59	257	4.0%	0.07	1.5 MB	3.5%	0.43
Sep 28 22:00:00 - 22:59:59	239	3.7%	0.07	951.2 KB	2.1%	0.26
Sep 28 23:00:00 - 23:59:59	413	6.5%	0.11	2.5 MB	5.8%	0.72
Sep 29 00:00:00 - 00:59:59	201	3.1%	0.06	1.7 MB	3.9%	0.48
Sep 29 01:00:00 - 01:59:59	222	3.5%	0.06	1.7 MB	3.9%	0.48
Sep 29 02:00:00 - 02:59:59	162	2.5%	0.04	974.7 KB	2.2%	0.27
Sep 29 03:00:00 - 03:59:59	193	3.0%	0.05	887.4 KB	2.0%	0.25
Sep 29 04:00:00 - 04:15:01	39	0.6%	0.04	188.1 KB	0.4%	0.21
TOTAL: 24:00:00	6395	100.0%	0.07	43.5 MB	100.0%	0.52

Sites sending bad articles:

Server		Total	Group	Other
1	news.nntp4.net	868	0	868
2	news.glou.org	301	0	301
3	i2pn.org	250	0	250
4	nntp.terraraq.uk	141	0	141
5	gegeweb-out.news.tnetconsulting.net	13	3	10
6	usenet.pasdenom.info	10	0	10
7	news.samoylyk.net	1	0	1
TOTAL: 7		1584	3	1581

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fr.petites-annonces.informatique.materiel	3
TOTAL: 1	3

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1169
EMP (phr nph)	167
EMP (phn path)	98
Bad path (news.giganews.com.POSTED)	96
Too many newsgroups	38
EMP (phl)	5
Cancels abusifs	2
Too many newsgroups (meow)	2
Binary: misplaced binary	2
Cancel for rejected article	2
TOTAL: 10	1581

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.samoylyk.net	10039	54	6255	16	108	0%	23:59:56
2	nntp.terraraq.uk	5674	45	5087	13	0	0%	23:59:57
3	news.nntp4.net	6032	45	5499	2	0	0%	23:59:57
4	i2pn.org	6667	30	4026	10	113	0%	23:59:27
5	news.tnetconsulting.net	9225	23	6355	17	76	0%	23:59:56
6	news.gegeweb.org	5020	9	4663	119	0	0%	23:59:57
7	news.pasdenom.info	6160	9	5876	8	81	0%	23:59:57
8	news.aioe.org	0	0	0	0	3764	0%	23:59:57
TOTAL: 8		48817	215	37761	185	4142	0%	191:59:04

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	nntp.terraraq.uk	1022.8 KB	309.6 KB	1.3 MB	23.0 KB	23:59:57
2	news.nntp4.net	543.6 KB	6.7 KB	550.2 KB	11.7 KB	23:59:57
3	news.samoylyk.net	389.4 KB	108.0 KB	497.5 KB	7.1 KB	23:59:56
4	news.tnetconsulting.net	200.4 KB	87.6 KB	288.1 KB	7.2 KB	23:59:56
5	i2pn.org	132.8 KB	71.8 KB	204.6 KB	5.1 KB	23:59:27
6	news.pasdenom.info	65.3 KB	69.5 KB	134.8 KB	7.9 KB	23:59:57
7	news.gegeweb.org	21.9 KB	1.3 MB	1.4 MB	10.9 KB	23:59:57
8	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	23:59:57
TOTAL: 8		2.3 MB	2.0 MB	4.3 MB	11.0 KB	191:59:04

NNRP readership statistics:

System		Conn	Elapsed
1	45.227.254.8	1	00:00:00
2	zl-ams-nl-gp1-wk128.internet-census.org	1	00:00:12
3	mail.gegeweb.eu	288	00:01:36
4	172.245.90.197	1	00:00:11
5	152.32.227.23	3	00:00:31
6	enviable.monitoring.internet-measurement.com	1	00:00:00
7	stupendous.monitoring.internet-measurement.com	1	00:00:00
8	ns31410048.ip-145-239-154.eu	2	00:00:01
9	194.165.16.73	1	00:00:00
10	prudent.monitoring.internet-measurement.com	1	00:00:05
11	212.102.40.218	3	00:00:00
12	prague.scan.bufferover.run	1	00:00:00
13	152.89.198.113	1	00:00:00
14	jubilant.monitoring.internet-measurement.com	1	00:00:00
TOTAL: 14		306	00:02:42

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.gegeweb.eu	288	00:01:36
2	*.scan.bufferover.run	1	00:00:00
3	*.monitoring.internet-measurement.com	4	00:00:05
4	*.internet-census.org	1	00:00:12
5	unresolved	10	00:00:45
6	*.ip-145-239-154.eu	2	00:00:01
TOTAL: 6		306	00:02:42

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	4.396	4.059	1.562	00:01:36
152.32.227.23	0.059	0.057	0.000	00:00:31
zl-ams-nl-gp1-wk128.internet-census.org	0.016	0.008	0.000	00:00:12
172.245.90.197	0.016	0.008	0.000	00:00:11
prudent.monitoring.internet-measurement.com	0.050	0.009	0.000	00:00:05
ns31410048.ip-145-239-154.eu	0.036	0.027	0.000	00:00:01
prague.scan.bufferover.run	0.042	0.031	0.000	00:00:00
212.102.40.218	0.055	0.029	0.000	00:00:00
194.165.16.73	0.019	0.005	0.000	00:00:00
stupendous.monitoring.internet-measurement.com	0.016	0.012	0.000	00:00:00
enviable.monitoring.internet-measurement.com	0.041	0.022	0.000	00:00:00
jubilant.monitoring.internet-measurement.com	0.025	0.004	0.000	00:00:00
45.227.254.8	0.015	0.012	0.000	00:00:00
152.89.198.113	0.031	0.020	0.000	00:00:00
TOTAL: 14	4.817	4.303	1.562	00:02:42

NNRP gethostbyaddr failures [Top 20]:

System	Conn
? (can't getpeername)	14
TOTAL: 1	14

NNRP unrecognized commands (by host):

System	Conn
152.32.227.23	2
ns31410048.ip-145-239-154.eu	1
194.165.16.73	1
152.89.198.113	1
TOTAL: 4	5

NNRP unrecognized commands (by command):

Command	Count
#003	2
#026#003#001#001#011#001	1
#026#003	1
#023#003#023#001#023#002#001	1
TOTAL: 4	5

NNRP client timeouts [Top 20]:

System	Conn	Peer
152.89.198.113	1	1
194.165.16.73	1	1
TOTAL: 2	2	2

Daily Usenet report for news.niel.me

Sep 28 04:15:01 -- Sep 29 04:15:01