Daily Usenet report for news.niel.me: Dec 5 04:15:02

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	49775	76.9%	9.5 MB	83.1%
innd	10962	16.9%	1.4 MB	12.1%
innfeed	2054	3.2%	353.9 KB	3.0%
nnrpd	1915	3.0%	210.0 KB	1.8%
nocem	1	0.0%	0.2 KB	0.0%
controlchan	1	0.0%	0.0 KB	0.0%
TOTAL: 6	64708	100.0%	11.4 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	63757	36.7%
Negative hits	61250	35.3%
Do not exist	48592	28.0%
Cache misses	48	0.0%
TOTAL: 4	173647	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.489	0.0%	457	0.662	1.070	5.000
article cancel	00:00:00.091	0.0%	457	0.000	0.199	1.000
article cleanup	00:00:01.034	0.0%	48886	0.000	0.021	0.051
article logging	00:00:03.597	0.0%	48886	0.040	0.074	0.117
article parse	00:00:13.993	0.0%	273905	0.037	0.051	0.075
article write	00:00:41.712	0.0%	40055	0.715	1.041	2.117
artlog/artcncl	00:00:00.019	0.0%	457	0.000	0.042	1.000
artlog/artcncl/perl	00:00:00.039	0.0%	457	0.000	0.085	1.000
data move	00:00:04.214	0.0%	465045	0.002	0.009	0.014
hisgrep/artcncl	00:00:00.015	0.0%	457	0.000	0.033	1.000
hisgrep/artcncl/perl	00:00:00.015	0.0%	457	0.000	0.033	0.500
hisgrep/perl	00:00:00.040	0.0%	458	0.000	0.087	1.500
hishave/artcncl	00:00:00.006	0.0%	457	0.000	0.013	0.167
hishave/artcncl/perl	00:00:00.006	0.0%	457	0.000	0.013	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:03.229	0.0%	173677	0.010	0.019	0.032
history sync	00:00:00.058	0.0%	387	0.000	0.150	1.667
history write	00:00:10.827	0.0%	48886	0.123	0.221	0.352
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:54:37.031	99.6%	396884	124.463	216.882	612.761
nntp read	00:00:12.211	0.0%	396901	0.018	0.031	0.054
overview write	00:00:15.601	0.0%	40055	0.217	0.389	4.120
perl filter	00:03:27.601	0.2%	48886	3.109	4.247	5.085
python filter	00:00:00.227	0.0%	48886	0.000	0.005	0.014
site send	00:00:10.746	0.0%	82019	0.049	0.131	0.253
TOTAL: 24:01:03.230	24:00:02.801	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.402	0.0%	41212	0.000	0.010	0.039
article prepare	00:00:00.087	0.0%	24372	0.000	0.004	0.025
article read	00:00:00.714	0.0%	5026	0.000	0.142	0.417
backlog stats	00:00:03.054	0.0%	649271	0.002	0.005	0.008
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:10.507	0.0%	434829	0.013	0.024	0.040
data write	00:00:17.337	0.0%	347822	0.038	0.050	0.061
idle	23:50:50.932	99.9%	649271	79.317	132.227	323.226
status file	00:00:00.519	0.0%	229	1.000	2.266	9.000
TOTAL: 23:51:52.981	23:51:23.552	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.061	0.0%	1555	0.015	0.039	0.079
idle	00:00:59.334	3.7%	1456	0.000	40.751	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.266	0.0%	6377	0.000	0.042	0.364
TOTAL: 00:26:26.454	00:00:59.661	3.8%	-	-	-	-

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.glou.org	4	27178	19671	5865	1642	72%	24:12:03
2	news.nntp4.net	2	47671	16436	24389	6846	34%	24:08:13
3	nntp.terraraq.uk	2	16757	1592	14886	279	9%	23:23:17
4	feed-out.gegeweb.org	3	3825	1182	2642	1	30%	22:43:58
5	usenet.pasdenom.info	2	3961	673	3251	37	16%	27:00:19
6	gegeweb-out.news.tnetconsulting.net	1	3573	239	3290	44	6%	22:54:16
7	i2pn.org	1	4116	142	3974	0	3%	23:59:56
8	news.samoylyk.net	1	4109	21	4088	0	0%	20:10:51
9	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 9		41	111190	39956	62385	8849	35%	188:32:53

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.glou.org	168.7 MB	11.0 MB	179.7 MB	93%	8.6 KB
2	news.nntp4.net	158.1 MB	62.7 MB	220.9 MB	71%	9.7 KB
3	feed-out.gegeweb.org	15.5 MB	2.1 KB	15.5 MB	99%	13.4 KB
4	nntp.terraraq.uk	7.5 MB	2.5 MB	10.0 MB	74%	5.5 KB
5	i2pn.org	2.4 MB	0.0 KB	2.4 MB	100%	17.5 KB
6	usenet.pasdenom.info	1.8 MB	47.0 KB	1.8 MB	97%	2.7 KB
7	gegeweb-out.news.tnetconsulting.net	633.3 KB	146.6 KB	779.9 KB	81%	2.8 KB
8	news.samoylyk.net	163.5 KB	0.0 KB	163.5 KB	100%	7.8 KB
9	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 9		354.8 MB	76.4 MB	431.2 MB	82%	9.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 5 04:15:02 - 04:59:59	946	2.4%	0.35	10.1 MB	2.8%	3.84
Dec 5 05:00:00 - 05:59:59	1496	3.7%	0.42	14.7 MB	4.1%	4.19
Dec 5 06:00:00 - 06:59:59	1551	3.9%	0.43	14.3 MB	4.0%	4.07
Dec 5 07:00:00 - 07:59:59	1675	4.2%	0.47	15.9 MB	4.4%	4.51
Dec 5 08:00:00 - 08:59:59	2257	5.6%	0.63	20.5 MB	5.7%	5.83
Dec 5 09:00:00 - 09:59:59	2324	5.8%	0.65	20.5 MB	5.7%	5.82
Dec 5 10:00:00 - 10:59:59	2174	5.4%	0.60	20.1 MB	5.6%	5.73
Dec 5 11:00:00 - 11:59:59	2289	5.7%	0.64	18.5 MB	5.2%	5.27
Dec 5 12:00:00 - 12:59:59	2174	5.4%	0.60	22.0 MB	6.2%	6.25
Dec 5 13:00:00 - 13:59:59	2431	6.1%	0.68	24.3 MB	6.8%	6.90
Dec 5 14:00:00 - 14:59:59	2277	5.7%	0.63	23.4 MB	6.6%	6.64
Dec 5 15:00:00 - 15:59:59	1919	4.8%	0.53	16.3 MB	4.6%	4.64
Dec 5 16:00:00 - 16:59:59	1666	4.2%	0.46	13.4 MB	3.8%	3.81
Dec 5 17:00:00 - 17:59:59	1500	3.7%	0.42	11.7 MB	3.3%	3.32
Dec 5 18:00:00 - 18:59:59	1606	4.0%	0.45	13.4 MB	3.8%	3.81
Dec 5 19:00:00 - 19:59:59	1546	3.9%	0.43	12.4 MB	3.5%	3.54
Dec 5 20:00:00 - 20:59:59	1464	3.7%	0.41	12.5 MB	3.5%	3.56
Dec 5 21:00:00 - 21:59:59	1174	2.9%	0.33	9.0 MB	2.5%	2.56
Dec 5 22:00:00 - 22:59:59	1232	3.1%	0.34	9.4 MB	2.6%	2.67
Dec 5 23:00:00 - 23:59:59	1349	3.4%	0.37	10.6 MB	3.0%	3.01
Dec 6 00:00:00 - 00:59:59	1148	2.9%	0.32	9.0 MB	2.5%	2.57
Dec 6 01:00:00 - 01:59:59	864	2.2%	0.24	7.4 MB	2.1%	2.10
Dec 6 02:00:00 - 02:59:59	1173	2.9%	0.33	10.0 MB	2.8%	2.86
Dec 6 03:00:00 - 03:59:59	1417	3.5%	0.39	13.5 MB	3.8%	3.85
Dec 6 04:00:00 - 04:15:02	379	0.9%	0.42	3.7 MB	1.0%	4.16
TOTAL: 24:00:00	40031	100.0%	0.46	356.6 MB	100.0%	4.23

Sites sending bad articles:

Server		Total	Group	Other
1	news.nntp4.net	6832	27	6805
2	news.glou.org	1642	0	1642
3	nntp.terraraq.uk	281	0	281
4	gegeweb-out.news.tnetconsulting.net	42	0	42
5	usenet.pasdenom.info	32	0	32
6	feed-out.gegeweb.org	1	0	1
TOTAL: 6		8830	27	8803

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fr.lettres.langue.allemande	20
fr.education.superieur	7
TOTAL: 2	27

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	8394
EMP (phl)	181
Too many newsgroups	77
Bad path (news.giganews.com.POSTED)	72
EMP (phn nph)	28
User-issued spam cancel	27
EMP (phn path)	18
Cancels abusifs	4
Cancel for rejected article	1
Cancel of non-existing ID <uko6i1$dl0p$1@dont-email.me>	1
TOTAL: 10	8803

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	news.nntp4.net	31833	585	22988	0	0	1	1%	23:59:57
2	nntp.terraraq.uk	47265	518	35518	403	0	2	1%	23:59:51
3	i2pn.org	64888	87	36089	3580	1	1087	0%	23:59:55
4	news.samoylyk.net	61449	46	39405	551	1	153	0%	23:59:57
5	news.tnetconsulting.net	59775	36	39690	297	0	122	0%	23:59:55
6	news.gegeweb.org	39364	3	38791	0	0	0	0%	23:59:57
7	news.pasdenom.info	46313	2	39267	8	0	17	0%	23:59:55
8	news.aioe.org	0	0	0	0	0	10305	0%	23:59:56
TOTAL: 8		350887	1277	251748	4839	2	11687	0%	191:59:23

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.nntp4.net	6.2 MB	0.0 KB	6.2 MB	0.1 KB/s	10.9 KB	23:59:57
2	nntp.terraraq.uk	5.1 MB	6.1 MB	11.1 MB	0.1 KB/s	12.4 KB	23:59:51
3	i2pn.org	721.3 KB	33.6 MB	34.3 MB	0.4 KB/s	9.6 KB	23:59:55
4	news.tnetconsulting.net	194.7 KB	3.6 MB	3.8 MB	0.0 KB/s	11.6 KB	23:59:55
5	news.samoylyk.net	136.7 KB	5.1 MB	5.3 MB	0.1 KB/s	9.1 KB	23:59:57
6	news.gegeweb.org	106.6 KB	0.0 KB	106.6 KB	0.0 KB/s	35.5 KB	23:59:57
7	news.pasdenom.info	20.7 KB	56.1 KB	76.8 KB	0.0 KB/s	7.7 KB	23:59:55
8	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:56
TOTAL: 8		12.4 MB	48.5 MB	60.9 MB	0.1 KB/s	10.2 KB	191:59:23

NNRP readership statistics:

System		Conn	Elapsed
1	gutsy.monitoring.internet-measurement.com	1	00:00:02
2	thriving.monitoring.internet-measurement.com	1	00:00:00
3	exalted.monitoring.internet-measurement.com	1	00:00:06
4	2607:ff10:c8:594::6	3	00:00:09
5	sweet.monitoring.internet-measurement.com	1	00:00:01
6	104.152.52.120	1	00:00:10
7	generous.monitoring.internet-measurement.com	1	00:00:00
8	cheerful.monitoring.internet-measurement.com	1	00:00:00
9	meritorious.monitoring.internet-measurement.com	1	00:00:00
10	mail.gegeweb.eu	288	00:01:58
11	45.227.254.48	1	00:00:00
12	194.165.16.73	1	00:00:00
13	192.241.226.6	1	00:00:00
14	dependable.monitoring.internet-measurement.com	1	00:00:00
15	198.199.116.82	1	00:00:00
16	ec2-18-237-121-220.us-west-2.compute.amazonaws.com	1	00:00:00
17	138.199.29.3	16	00:23:51
TOTAL: 17		321	00:26:25

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.monitoring.internet-measurement.com	8	00:00:11
2	unresolved	21	00:24:05
3	?	3	00:00:09
4	*.gegeweb.eu	288	00:01:58
5	*.us-west-2.compute.amazonaws.com	1	00:00:00
TOTAL: 5		321	00:26:25

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
138.199.29.3	0.667	0.459	0.000	00:23:51
mail.gegeweb.eu	4.485	4.369	1.564	00:01:58
104.152.52.120	0.014	0.011	0.000	00:00:10
2607:ff10:c8:594::6	0.082	0.070	0.000	00:00:09
exalted.monitoring.internet-measurement.com	0.029	0.013	0.000	00:00:06
gutsy.monitoring.internet-measurement.com	0.024	0.024	0.000	00:00:02
sweet.monitoring.internet-measurement.com	0.033	0.022	0.000	00:00:01
198.199.116.82	0.035	0.018	0.000	00:00:00
192.241.226.6	0.033	0.020	0.000	00:00:00
194.165.16.73	0.037	0.016	0.000	00:00:00
ec2-18-237-121-220.us-west-2.compute.amazonaws.com	0.010	0.014	0.000	00:00:00
45.227.254.48	0.016	0.012	0.000	00:00:00
dependable.monitoring.internet-measurement.com	0.027	0.031	0.000	00:00:00
generous.monitoring.internet-measurement.com	0.014	0.014	0.000	00:00:00
cheerful.monitoring.internet-measurement.com	0.030	0.025	0.000	00:00:00
TOTAL: 15	5.536	5.118	1.564	00:26:25

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
2607:ff10:c8:594::6	7
198.199.116.82	1
192.241.226.6	1
194.165.16.73	1
TOTAL: 4	10

NNRP unrecognized commands (by command):

Command	Count
MGLNDD_45.13.105.36_119	2
User-Agent: Mozilla/5.0 (Windows NT 10.0...	1
#026#003#001	1
Accept-Encoding: gzip	1
GET / HTTP/1.1	1
#003	1
Accept: /	1
#023#003#023#001#023#002#001	1
Host: [2a0e:e701:1154:0:4e10:5c89:4af0:d...	1
TOTAL: 9	10

NNRP client timeouts [Top 20]:

System	Conn	Peer
194.165.16.73	1	1
TOTAL: 1	1	1

Daily Usenet report for news.niel.me

Dec 5 04:15:02 -- Dec 6 04:15:02