Daily Usenet report for news.niel.me: Oct 7 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2791	31.2%	520.1 KB	36.0%
nnrpd	2222	24.8%	253.0 KB	17.5%
innd	2129	23.8%	370.0 KB	25.6%
innfeed	1809	20.2%	301.0 KB	20.8%
nocem	1	0.0%	0.1 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	8953	100.0%	1.4 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	15160	60.3%
Negative hits	7195	28.6%
Do not exist	2764	11.0%
Cache misses	4	0.0%
TOTAL: 4	25123	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.018	0.0%	11	0.000	1.636	3.500
article cancel	00:00:00.002	0.0%	11	0.000	0.182	1.000
article cleanup	00:00:00.052	0.0%	2772	0.000	0.019	0.167
article logging	00:00:00.195	0.0%	2772	0.000	0.070	0.500
article parse	00:00:00.551	0.0%	9060	0.000	0.061	0.286
article write	00:00:01.327	0.0%	2585	0.000	0.513	1.333
artlog/artcncl	00:00:00.000	0.0%	11	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.000	0.0%	11	0.000	0.000	0.000
artlog/artwrite	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:00.170	0.0%	29425	0.000	0.006	0.036
hisgrep/artcncl	00:00:00.001	0.0%	11	0.000	0.091	1.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	11	0.000	0.000	0.000
hisgrep/perl	00:00:00.000	0.0%	35	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	11	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	11	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.423	0.0%	25138	0.000	0.017	0.083
history sync	00:00:00.049	0.0%	397	0.000	0.123	1.000
history write	00:00:00.469	0.0%	2769	0.000	0.169	0.857
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:49.829	100.0%	31024	327.181	2786.547	30048.800
nntp read	00:00:00.803	0.0%	30042	0.000	0.027	0.078
overview write	00:00:00.867	0.0%	2585	0.000	0.335	4.667
perl filter	00:00:09.833	0.0%	2769	1.455	3.551	6.833
python filter	00:00:00.015	0.0%	2769	0.000	0.005	0.143
site send	00:00:01.056	0.0%	5221	0.000	0.202	0.500
TOTAL: 24:01:13.828	24:01:05.660	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.021	0.0%	2947	0.000	0.007	0.500
article prepare	00:00:00.003	0.0%	800	0.000	0.004	0.250
article read	00:00:00.038	0.0%	195	0.000	0.195	8.000
backlog stats	00:00:00.208	0.0%	36000	0.000	0.006	0.022
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.502	0.0%	19617	0.000	0.026	0.079
data write	00:00:00.994	0.0%	17576	0.000	0.057	0.108
idle	23:49:54.360	100.0%	36000	688.322	2383.177	9235.431
status file	00:00:00.502	0.0%	231	0.000	2.173	5.000
TOTAL: 23:50:02.086	23:49:56.628	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:01:21.188	33.0%	1582	3.000	51.320	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.105	0.0%	3693	0.000	0.028	0.667
TOTAL: 00:04:06.124	00:01:21.293	33.0%	-	-	-	-

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	feed-out.gegeweb.org	3	2452	956	1495	1	38%	23:59:02
2	news.nntp4.net	2	2803	434	2254	115	15%	25:59:24
3	i2pn.org	2	3964	390	3574	0	9%	40:09:53
4	news.samoylyk.net	2	2168	276	1891	1	12%	21:52:39
5	gegeweb-out.news.tnetconsulting.net	2	1973	267	1678	28	13%	21:47:25
6	news.glou.org	1	1955	150	1790	15	7%	27:00:28
7	usenet.pasdenom.info	6	1312	122	1171	19	9%	22:19:25
8	nntp.terraraq.uk	2	2465	42	2423	0	1%	27:43:40
9	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 9		45	19092	2637	16276	179	13%	210:51:56

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.samoylyk.net	5.1 MB	4.6 KB	4.6 KB	5.1 MB	99%	18.9 KB
2	feed-out.gegeweb.org	3.6 MB	4.7 KB	4.7 KB	3.6 MB	99%	3.9 KB
3	news.nntp4.net	3.0 MB	0.0 KB	348.8 KB	3.3 MB	89%	6.2 KB
4	gegeweb-out.news.tnetconsulting.net	1.3 MB	2.9 KB	124.2 KB	1.4 MB	91%	4.8 KB
5	i2pn.org	1.0 MB	0.0 KB	0.0 KB	1.0 MB	100%	2.7 KB
6	news.glou.org	633.2 KB	0.0 KB	134.7 KB	767.8 KB	82%	4.7 KB
7	usenet.pasdenom.info	301.9 KB	0.0 KB	20.1 KB	322.0 KB	93%	2.3 KB
8	nntp.terraraq.uk	98.2 KB	0.0 KB	0.0 KB	98.2 KB	100%	2.3 KB
9	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 9		15.0 MB	12.2 KB	637.1 KB	15.6 MB	95%	5.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 7 04:15:01 - 04:59:59	33	1.3%	0.01	163.2 KB	1.0%	0.06
Oct 7 05:00:00 - 05:59:59	33	1.3%	0.01	88.1 KB	0.5%	0.02
Oct 7 06:00:00 - 06:59:59	35	1.4%	0.01	136.9 KB	0.9%	0.04
Oct 7 07:00:00 - 07:59:59	63	2.4%	0.02	295.2 KB	1.8%	0.08
Oct 7 08:00:00 - 08:59:59	62	2.4%	0.02	168.4 KB	1.0%	0.05
Oct 7 09:00:00 - 09:59:59	40	1.5%	0.01	120.9 KB	0.8%	0.03
Oct 7 10:00:00 - 10:59:59	250	9.7%	0.07	5.9 MB	37.3%	1.67
Oct 7 11:00:00 - 11:59:59	77	3.0%	0.02	308.3 KB	1.9%	0.09
Oct 7 12:00:00 - 12:59:59	109	4.2%	0.03	424.8 KB	2.6%	0.12
Oct 7 13:00:00 - 13:59:59	156	6.0%	0.04	679.0 KB	4.2%	0.19
Oct 7 14:00:00 - 14:59:59	155	6.0%	0.04	978.0 KB	6.1%	0.27
Oct 7 15:00:00 - 15:59:59	126	4.9%	0.04	500.5 KB	3.1%	0.14
Oct 7 16:00:00 - 16:59:59	165	6.4%	0.05	551.8 KB	3.4%	0.15
Oct 7 17:00:00 - 17:59:59	107	4.1%	0.03	469.3 KB	2.9%	0.13
Oct 7 18:00:00 - 18:59:59	166	6.4%	0.05	725.6 KB	4.5%	0.20
Oct 7 19:00:00 - 19:59:59	109	4.2%	0.03	379.5 KB	2.4%	0.11
Oct 7 20:00:00 - 20:59:59	138	5.3%	0.04	738.9 KB	4.6%	0.21
Oct 7 21:00:00 - 21:59:59	164	6.4%	0.05	599.0 KB	3.7%	0.17
Oct 7 22:00:00 - 22:59:59	171	6.6%	0.05	547.2 KB	3.4%	0.15
Oct 7 23:00:00 - 23:59:59	93	3.6%	0.03	251.1 KB	1.6%	0.07
Oct 8 00:00:00 - 00:59:59	99	3.8%	0.03	616.8 KB	3.8%	0.17
Oct 8 01:00:00 - 01:59:59	69	2.7%	0.02	751.9 KB	4.7%	0.21
Oct 8 02:00:00 - 02:59:59	70	2.7%	0.02	258.2 KB	1.6%	0.07
Oct 8 03:00:00 - 03:59:59	78	3.0%	0.02	304.4 KB	1.9%	0.08
Oct 8 04:00:00 - 04:15:02	14	0.5%	0.02	43.3 KB	0.3%	0.05
TOTAL: 24:00:01	2582	100.0%	0.03	15.7 MB	100.0%	0.19

Sites sending bad articles:

Server		Total	Duplic	Other
1	news.nntp4.net	113	0	113
2	gegeweb-out.news.tnetconsulting.net	38	1	37
3	usenet.pasdenom.info	19	0	19
4	news.glou.org	15	0	15
5	news.samoylyk.net	1	1	0
6	feed-out.gegeweb.org	1	1	0
TOTAL: 6		187	3	184

INND Perl filter [Top 20]:

Reason	Count
Too many newsgroups	106
Bad path (news.giganews.com.POSTED)	47
Too many newsgroups (meow)	4
Cancels abusifs	2
Cancel of <0f46d1ec05fbf7278352179879d27eead431ec06@i2pn2.org> without Cancel-Key	1
Cancel of <46ac8368a374ab4888e83ed03b44c6f170ffeebe@i2pn2.org> without Cancel-Key	1
Cancel of <744558416e66022a9a54eb4b5296302a1ed92fd8@i2pn2.org> without Cancel-Key	1
Cancel of <077a0863dc7fac33eec817ae5717c4983f450330@i2pn2.org> without Cancel-Key	1
Cancel of <d51a2b3e318ebefc583c162cc27b2a5f312d9bff@i2pn2.org> without Cancel-Key	1
Cancel of <1052a49ef3153ce28f4fc8719a285fd17962d8fc@i2pn2.org> without Cancel-Key	1
EMP (md5)	1
Cancel of <141e93e065d74157dc7f43e1d203a82f2f30cbc4@i2pn2.org> without Cancel-Key	1
Cancel of <52d76564545afc71a5c5b55409536d156d85b01e@i2pn2.org> without Cancel-Key	1
Cancel of <154ea5cae8eabd41938bf7b02c9e16755a897d23@i2pn2.org> without Cancel-Key	1
Cancel of <4867a15de96af7b471d3487db7b5c5e8d69e8434@i2pn2.org> without Cancel-Key	1
Cancel of <ac1ea24d24371bb510cdfa1571ae7ac2ae5cde95@i2pn2.org> without Cancel-Key	1
Cancel of <180a5c438e416c698d09b3f0e3164fb897a5d6ce@i2pn2.org> without Cancel-Key	1
Cancel of <e2bca592b983315a0cdb7bab57bb024c613dbceb@i2pn2.org> without Cancel-Key	1
Cancel of <003bd2861ecacfd5a444e4b64bbc06a8a031bfb1@i2pn2.org> without Cancel-Key	1
Cancel of <79578e4fafb79420cf5474e4386ec7f10bcebed4@i2pn2.org> without Cancel-Key	1
TOTAL: 29	184

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn.org	3804	82	2198	29	204	2%	23:56:33
2	news.gegeweb.org	1775	76	1527	0	0	4%	23:35:23
3	news.tnetconsulting.net	4185	4	2563	1	101	0%	23:59:58
4	news.samoylyk.net	2766	4	2240	1	69	0%	23:59:49
5	news.pasdenom.info	2064	3	1806	0	0	0%	23:59:49
6	news.aioe.org	0	0	0	0	2140	0%	24:00:01
7	nntp.terraraq.uk	1371	0	1285	0	0	0%	23:55:53
8	news.nntp4.net	2229	0	2119	0	0	0%	23:59:40
TOTAL: 8		18194	169	13738	31	2514	0%	191:27:06

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	i2pn.org	391.4 KB	408.0 KB	799.5 KB	7.2 KB	23:56:33
2	news.gegeweb.org	232.0 KB	0.0 KB	232.0 KB	3.1 KB	23:35:23
3	news.samoylyk.net	14.5 KB	1.5 KB	15.9 KB	3.2 KB	23:59:49
4	news.tnetconsulting.net	10.5 KB	1.4 KB	11.9 KB	2.4 KB	23:59:58
5	news.pasdenom.info	7.7 KB	0.0 KB	7.7 KB	2.6 KB	23:59:49
6	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	24:00:01
7	nntp.terraraq.uk	0.0 KB	0.0 KB	0.0 KB	0	23:55:53
8	news.nntp4.net	0.0 KB	0.0 KB	0.0 KB	0	23:59:40
TOTAL: 8		656.1 KB	410.9 KB	1.0 MB	5.3 KB	191:27:06

NNRP readership statistics:

System		Conn	Elapsed
1	28.211.203.35.bc.googleusercontent.com	1	00:00:01
2	185.242.226.39	1	00:00:00
3	ec2-13-58-97-162.us-east-2.compute.amazonaws.com	4	00:00:00
4	172-105-246-139.ip.linodeusercontent.com	105	00:00:20
5	valued.monitoring.internet-measurement.com	1	00:00:00
6	intelligent.monitoring.internet-measurement.com	1	00:00:06
7	91.238.181.21	1	00:00:00
8	erudite.monitoring.internet-measurement.com	1	00:00:00
9	251.210.203.35.bc.googleusercontent.com	1	00:00:00
10	amicable.monitoring.internet-measurement.com	1	00:00:01
11	206.168.34.46	3	00:00:18
12	206.168.34.198	1	00:00:44
13	mail.gegeweb.eu	288	00:01:40
14	198.235.24.218	1	00:00:10
15	104.152.52.199	1	00:00:00
16	azpdcg11.stretchoid.com	1	00:00:01
17	104.152.52.120	1	00:00:10
18	205.210.31.102	1	00:00:10
19	147.185.132.156	1	00:00:01
20	88-165-5-23.subs.proxad.net	1	00:00:01
21	server-0-3.survey.inspici.com	1	00:00:04
22	azpdegb0.stretchoid.com	1	00:00:00
23	duncan.probe.onyphe.net	1	00:00:00
24	199.45.154.147	3	00:00:06
25	swift.monitoring.internet-measurement.com	1	00:00:00
26	91.238.181.35	2	00:00:01
TOTAL: 26		425	00:04:05

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	unresolved	16	00:01:44
2	*.211.203.35.bc.googleusercontent.com	1	00:00:01
3	*.210.203.35.bc.googleusercontent.com	1	00:00:00
4	*.us-east-2.compute.amazonaws.com	4	00:00:00
5	*.ip.linodeusercontent.com	105	00:00:20
6	*.survey.inspici.com	1	00:00:04
7	*.probe.onyphe.net	1	00:00:00
8	*.subs.proxad.net	1	00:00:01
9	*.gegeweb.eu	288	00:01:40
10	*.stretchoid.com	2	00:00:01
11	*.monitoring.internet-measurement.com	5	00:00:08
TOTAL: 11		425	00:04:05

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	5.199	4.416	1.749	00:01:40
206.168.34.198	0.041	0.018	0.000	00:00:44
172-105-246-139.ip.linodeusercontent.com	2.662	1.311	0.000	00:00:20
206.168.34.46	0.073	0.089	0.000	00:00:18
198.235.24.218	0.019	0.031	0.000	00:00:10
205.210.31.102	0.032	0.020	0.000	00:00:10
104.152.52.120	0.019	0.005	0.000	00:00:10
199.45.154.147	0.099	0.067	0.000	00:00:06
intelligent.monitoring.internet-measurement.com	0.052	0.039	0.000	00:00:06
server-0-3.survey.inspici.com	0.027	0.023	0.000	00:00:04
91.238.181.35	0.063	0.044	0.000	00:00:01
amicable.monitoring.internet-measurement.com	0.027	0.020	0.000	00:00:01
88-165-5-23.subs.proxad.net	0.024	0.032	0.000	00:00:01
147.185.132.156	0.021	0.029	0.000	00:00:01
azpdcg11.stretchoid.com	0.011	0.011	0.000	00:00:01
28.211.203.35.bc.googleusercontent.com	0.068	0.019	0.000	00:00:01
251.210.203.35.bc.googleusercontent.com	0.036	0.004	0.000	00:00:00
duncan.probe.onyphe.net	0.018	0.009	0.000	00:00:00
ec2-13-58-97-162.us-east-2.compute.amazonaws.com	0.083	0.034	0.000	00:00:00
185.242.226.39	0.034	0.030	0.000	00:00:00
TOTAL: 26	8.760	6.349	1.749	00:04:05

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
ec2-13-58-97-162.us-east-2.compute.amazonaws.com	9
28.211.203.35.bc.googleusercontent.com	4
251.210.203.35.bc.googleusercontent.com	4
azpdegb0.stretchoid.com	1
199.45.154.147	1
91.238.181.35	1
206.168.34.46	1
azpdcg11.stretchoid.com	1
TOTAL: 8	22

NNRP unrecognized commands (by command):

Command	Count
GET / HTTP/1.1	3
Accept-Encoding: gzip	3
EHLO www.censys.io	2
Host: 45.13.105.36:563	2
User-Agent: Expanse, a Palo Alto Network...	2
#001	2
MGLNDD_45.13.105.36_119	2
#026#003#001	2
Accept: /	1
#003	1
User-Agent: Mozilla/5.0 (Macintosh; Inte...	1
Host: 45.13.105.36:119	1
TOTAL: 12	22

NNRP client timeouts [Top 20]:

System	Conn	Peer
91.238.181.35	1	1
206.168.34.46	1	2
199.45.154.147	1	2
TOTAL: 3	3	6

Daily Usenet report for news.niel.me

Oct 7 04:15:01 -- Oct 8 04:15:02