Daily Usenet report for news.niel.me: Jul 27 04:15:02

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2471	29.8%	454.6 KB	34.2%
innd	2242	27.1%	385.2 KB	29.0%
nnrpd	1824	22.0%	189.9 KB	14.3%
innfeed	1749	21.1%	298.4 KB	22.5%
controlchan	1	0.0%	0.0 KB	0.0%
nocem	1	0.0%	0.1 KB	0.0%
TOTAL: 6	8288	100.0%	1.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	12904	57.3%
Negative hits	7162	31.8%
Do not exist	2460	10.9%
Cache misses	1	0.0%
TOTAL: 4	22527	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.005	0.0%	5	0.500	1.000	2.000
article cancel	00:00:00.001	0.0%	5	0.000	0.200	0.500
article cleanup	00:00:00.059	0.0%	2467	0.000	0.024	0.286
article logging	00:00:00.194	0.0%	2467	0.000	0.079	0.333
article parse	00:00:00.386	0.0%	6902	0.000	0.056	0.208
article write	00:00:01.221	0.0%	2151	0.000	0.568	1.231
artlog/artcncl	00:00:00.000	0.0%	5	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.000	0.0%	5	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.148	0.0%	24386	0.000	0.006	0.037
hisgrep/artcncl	00:00:00.001	0.0%	5	0.000	0.200	0.500
hisgrep/artcncl/perl	00:00:00.000	0.0%	5	0.000	0.000	0.000
hisgrep/perl	00:00:00.000	0.0%	7	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	5	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	5	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.351	0.0%	22561	0.000	0.016	0.052
history sync	00:00:00.053	0.0%	345	0.000	0.154	1.000
history write	00:00:00.440	0.0%	2466	0.000	0.178	0.500
idle	24:00:41.952	100.0%	27010	1238.118	3200.368	15003.600
nntp read	00:00:00.695	0.0%	26330	0.000	0.026	0.093
overview write	00:00:00.723	0.0%	2151	0.000	0.336	2.250
perl filter	00:00:09.626	0.0%	2466	1.769	3.903	8.000
python filter	00:00:00.018	0.0%	2466	0.000	0.007	0.091
site send	00:00:01.049	0.0%	4377	0.000	0.240	0.583
TOTAL: 24:01:04.467	24:00:56.922	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.013	0.0%	2279	0.000	0.006	0.143
article prepare	00:00:00.003	0.0%	504	0.000	0.006	0.250
article read	00:00:00.030	0.0%	123	0.000	0.244	2.000
backlog stats	00:00:00.195	0.0%	31394	0.000	0.006	0.028
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.447	0.0%	16875	0.000	0.026	0.091
data write	00:00:00.876	0.0%	14968	0.000	0.059	0.138
idle	23:58:42.660	100.0%	31394	1185.150	2749.655	6742.281
status file	00:00:00.422	0.0%	211	0.000	2.000	6.000
TOTAL: 23:58:49.832	23:58:44.646	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:01:09.693	40.6%	1479	10.000	47.122	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.186	0.1%	3464	0.000	0.054	0.430
readart	00:00:00.548	0.3%	11025	0.050	0.050	0.050
TOTAL: 00:02:51.648	00:01:10.427	41.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	2063	767	1292	4	37%	23:57:57
2	news.samoylyk.net	3	3099	623	2471	5	20%	31:38:37
3	gegeweb-out.news.tnetconsulting.net	2	2075	336	1668	71	16%	23:59:03
4	news.nntp4.net	1	2400	257	1990	153	10%	25:31:17
5	i2pn.org	1	2643	159	2434	50	6%	23:59:49
6	news.glou.org	2	1701	70	1568	63	4%	23:59:25
7	nntp.terraraq.uk	1	1960	55	1904	1	2%	20:20:54
8	usenet.pasdenom.info	4	359	28	326	5	7%	12:24:23
9	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 9		42	16300	2295	13653	352	14%	185:51:25

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.samoylyk.net	4.4 MB	0.0 KB	22.7 KB	4.4 MB	99%	7.2 KB
2	feed-out.gegeweb.org	2.7 MB	0.0 KB	6.7 KB	2.7 MB	99%	3.6 KB
3	news.nntp4.net	1.0 MB	0.0 KB	1.5 MB	2.5 MB	41%	6.2 KB
4	gegeweb-out.news.tnetconsulting.net	1.0 MB	7.9 KB	256.8 KB	1.3 MB	79%	3.2 KB
5	i2pn.org	520.5 KB	0.0 KB	554.6 KB	1.0 MB	48%	5.1 KB
6	news.glou.org	242.2 KB	0.0 KB	410.1 KB	652.2 KB	37%	4.9 KB
7	nntp.terraraq.uk	203.1 KB	0.0 KB	9.4 KB	212.5 KB	95%	3.8 KB
8	usenet.pasdenom.info	76.1 KB	0.0 KB	10.2 KB	86.4 KB	88%	2.6 KB
9	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 9		10.2 MB	7.9 KB	2.7 MB	12.9 MB	78%	5.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jul 27 04:15:02 - 04:59:59	59	2.7%	0.02	210.1 KB	2.4%	0.08
Jul 27 05:00:00 - 05:59:59	55	2.6%	0.02	222.0 KB	2.6%	0.06
Jul 27 06:00:00 - 06:59:59	60	2.8%	0.02	240.3 KB	2.8%	0.07
Jul 27 07:00:00 - 07:59:59	46	2.1%	0.01	155.5 KB	1.8%	0.04
Jul 27 08:00:00 - 08:59:59	51	2.4%	0.01	192.5 KB	2.2%	0.05
Jul 27 09:00:00 - 09:59:59	39	1.8%	0.01	139.1 KB	1.6%	0.04
Jul 27 10:00:00 - 10:59:59	73	3.4%	0.02	451.5 KB	5.2%	0.13
Jul 27 11:00:00 - 11:59:59	80	3.7%	0.02	280.0 KB	3.3%	0.08
Jul 27 12:00:00 - 12:59:59	79	3.7%	0.02	456.9 KB	5.3%	0.13
Jul 27 13:00:00 - 13:59:59	74	3.4%	0.02	260.7 KB	3.0%	0.07
Jul 27 14:00:00 - 14:59:59	125	5.8%	0.03	469.6 KB	5.5%	0.13
Jul 27 15:00:00 - 15:59:59	121	5.6%	0.03	447.1 KB	5.2%	0.12
Jul 27 16:00:00 - 16:59:59	111	5.2%	0.03	444.9 KB	5.2%	0.12
Jul 27 17:00:00 - 17:59:59	72	3.3%	0.02	238.0 KB	2.8%	0.07
Jul 27 18:00:00 - 18:59:59	98	4.6%	0.03	363.5 KB	4.2%	0.10
Jul 27 19:00:00 - 19:59:59	132	6.1%	0.04	541.8 KB	6.3%	0.15
Jul 27 20:00:00 - 20:59:59	188	8.7%	0.05	816.9 KB	9.5%	0.23
Jul 27 21:00:00 - 21:59:59	112	5.2%	0.03	390.7 KB	4.5%	0.11
Jul 27 22:00:00 - 22:59:59	94	4.4%	0.03	408.6 KB	4.7%	0.11
Jul 27 23:00:00 - 23:59:59	155	7.2%	0.04	633.6 KB	7.4%	0.18
Jul 28 00:00:00 - 00:59:59	78	3.6%	0.02	292.7 KB	3.4%	0.08
Jul 28 01:00:00 - 01:59:59	80	3.7%	0.02	304.1 KB	3.5%	0.08
Jul 28 02:00:00 - 02:59:59	65	3.0%	0.02	214.2 KB	2.5%	0.06
Jul 28 03:00:00 - 03:59:59	76	3.5%	0.02	307.7 KB	3.6%	0.09
Jul 28 04:00:00 - 04:15:01	27	1.3%	0.03	121.1 KB	1.4%	0.13
TOTAL: 23:59:59	2150	100.0%	0.02	8.4 MB	100.0%	0.10

Sites sending bad articles:

Server		Total	Duplic	Other
1	news.nntp4.net	152	0	152
2	news.glou.org	63	0	63
3	gegeweb-out.news.tnetconsulting.net	61	1	60
4	i2pn.org	18	0	18
5	usenet.pasdenom.info	8	0	8
6	news.samoylyk.net	5	0	5
7	feed-out.gegeweb.org	4	0	4
TOTAL: 7		311	1	310

INND Perl filter [Top 20]:

Reason	Count
Too many newsgroups	124
Bad path (news.giganews.com.POSTED)	62
EMP (md5)	61
EMP (phn path)	57
Cancels abusifs	4
Cancel of <185cfa8fe52bc8e44d3fa1a41a1f388c087df89d@i2pn2.org> without Cancel-Key	1
Cancel of <0001HW.2C54C62F00A7330870000639F38F@news.eternal-september.org> without Cancel-Key	1
TOTAL: 7	310

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn.org	3201	53	1929	15	72	1%	23:59:50
2	news.gegeweb.org	1420	46	1309	0	0	3%	23:57:12
3	news.tnetconsulting.net	3512	7	2139	3	53	0%	23:59:57
4	news.nntp4.net	2064	1	1897	0	0	0%	23:59:57
5	news.samoylyk.net	1951	1	1681	0	4	0%	23:58:37
6	news.pasdenom.info	1749	0	1580	0	0	0%	23:58:40
7	news.aioe.org	0	0	0	0	1729	0%	23:59:59
8	nntp.terraraq.uk	1452	0	1374	0	0	0%	23:59:00
TOTAL: 8		15349	108	11909	18	1858	0%	191:53:12

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.gegeweb.org	175.2 KB	0.0 KB	175.2 KB	3.8 KB	23:57:12
2	i2pn.org	141.2 KB	97.7 KB	239.0 KB	3.5 KB	23:59:50
3	news.tnetconsulting.net	22.9 KB	9.8 KB	32.6 KB	3.3 KB	23:59:57
4	news.nntp4.net	13.5 KB	0.0 KB	13.5 KB	13.5 KB	23:59:57
5	news.samoylyk.net	3.0 KB	0.0 KB	3.0 KB	3.0 KB	23:58:37
6	news.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0	23:58:40
7	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	23:59:59
8	nntp.terraraq.uk	0.0 KB	0.0 KB	0.0 KB	0	23:59:00
TOTAL: 8		355.8 KB	107.5 KB	463.3 KB	3.7 KB	191:53:12

NNRP readership statistics:

System		Conn	Elapsed
1	energetic.monitoring.internet-measurement.com	1	00:00:02
2	178.210.203.35.bc.googleusercontent.com	1	00:00:00
3	88.214.25.64	1	00:00:00
4	45.129.14.224	1	00:00:00
5	88.214.25.61	1	00:00:01
6	pool-100-38-239-226.nycmny.fios.verizon.net	1	00:00:11
7	198.235.24.236	1	00:00:11
8	mail.gegeweb.eu	288	00:01:58
9	91.238.181.71	1	00:00:00
10	95.210.203.35.bc.googleusercontent.com	1	00:00:02
11	97.210.203.35.bc.googleusercontent.com	1	00:00:00
12	205.210.31.155	1	00:00:10
13	199.45.154.157	3	00:00:09
TOTAL: 13		302	00:02:51

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.210.203.35.bc.googleusercontent.com	3	00:00:03
2	*.gegeweb.eu	288	00:01:58
3	*.monitoring.internet-measurement.com	1	00:00:02
4	unresolved	9	00:00:34
5	*.nycmny.fios.verizon.net	1	00:00:11
TOTAL: 5		302	00:02:51

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.072	4.027	1.618	00:01:58
pool-100-38-239-226.nycmny.fios.verizon.net	0.341	0.588	0.000	00:00:11
198.235.24.236	0.026	0.022	0.000	00:00:11
205.210.31.155	0.020	0.028	0.000	00:00:10
199.45.154.157	0.095	0.058	0.000	00:00:09
energetic.monitoring.internet-measurement.com	0.025	0.025	0.000	00:00:02
95.210.203.35.bc.googleusercontent.com	0.054	0.021	0.000	00:00:02
88.214.25.61	0.022	0.022	0.000	00:00:01
45.129.14.224	0.031	0.019	0.000	00:00:00
97.210.203.35.bc.googleusercontent.com	0.016	0.024	0.000	00:00:00
178.210.203.35.bc.googleusercontent.com	0.033	0.016	0.000	00:00:00
91.238.181.71	0.041	0.021	0.000	00:00:00
88.214.25.64	0.035	0.015	0.000	00:00:00
TOTAL: 13	5.811	4.886	1.618	00:02:51

NNRP unrecognized commands (by host):

System	Conn
95.210.203.35.bc.googleusercontent.com	4
178.210.203.35.bc.googleusercontent.com	4
97.210.203.35.bc.googleusercontent.com	4
88.214.25.61	1
45.129.14.224	1
88.214.25.64	1
199.45.154.157	1
TOTAL: 7	16

NNRP unrecognized commands (by command):

Command	Count
#003	3
Accept-Encoding: gzip	3
GET / HTTP/1.1	3
User-Agent: Expanse, a Palo Alto Network...	3
Host: 45.13.105.36:563	2
EHLO www.censys.io	1
Host: 45.13.105.36:119	1
TOTAL: 7	16

NNRP client timeouts [Top 20]:

System	Conn	Peer
88.214.25.61	1	1
88.214.25.64	1	1
45.129.14.224	1	1
199.45.154.157	1	2
TOTAL: 4	4	5

Daily Usenet report for news.niel.me

Jul 27 04:15:02 -- Jul 28 04:15:01