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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	2067	25.9%	239.9 KB	19.7%
innd	2032	25.4%	347.8 KB	28.5%
innfeed	1983	24.8%	290.2 KB	23.8%
inn	1907	23.9%	342.3 KB	28.0%
nocem	1	0.0%	0.2 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	7991	100.0%	1.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	7189	51.0%
Negative hits	5016	35.6%
Do not exist	1896	13.4%
Cache misses	2	0.0%
TOTAL: 4	14103	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.003	0.0%	4	0.000	0.750	2.000
article cancel	00:00:00.000	0.0%	4	0.000	0.000	0.000
article cleanup	00:00:00.038	0.0%	1899	0.000	0.020	0.333
article logging	00:00:00.145	0.0%	1899	0.000	0.076	0.400
article parse	00:00:00.306	0.0%	4576	0.000	0.067	0.417
article write	00:00:00.860	0.0%	1590	0.000	0.541	1.400
artlog/artcncl	00:00:00.000	0.0%	4	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.001	0.0%	4	0.000	0.250	1.000
data move	00:00:00.077	0.0%	15229	0.000	0.005	0.056
hisgrep/artcncl	00:00:00.000	0.0%	4	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	4	0.000	0.000	0.000
hisgrep/perl	00:00:00.000	0.0%	4	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	4	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	4	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.244	0.0%	14135	0.000	0.017	0.049
history sync	00:00:00.049	0.0%	356	0.000	0.138	1.000
history write	00:00:00.337	0.0%	1899	0.000	0.177	0.750
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:34.006	100.0%	17322	1768.764	4989.840	27290.864
nntp read	00:00:00.477	0.0%	16600	0.000	0.029	0.076
overview write	00:00:00.526	0.0%	1590	0.000	0.331	4.000
perl filter	00:00:12.612	0.0%	1899	1.760	6.641	27.250
python filter	00:00:00.009	0.0%	1899	0.000	0.005	0.333
site send	00:00:00.653	0.0%	3219	0.000	0.203	0.500
TOTAL: 24:01:07.684	24:00:50.343	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.017	0.0%	1594	0.000	0.011	0.333
article prepare	00:00:00.000	0.0%	12	0.000	0.000	0.000
article read	00:00:00.008	0.0%	2	0.000	4.000	8.000
backlog stats	00:00:00.136	0.0%	21220	0.000	0.006	0.030
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.281	0.0%	10159	0.000	0.028	0.158
data write	00:00:00.502	0.0%	8582	0.000	0.058	0.222
idle	23:55:37.779	99.7%	21220	1643.978	4059.273	10712.107
status file	00:00:07.517	0.0%	364	1.000	20.651	71.000
TOTAL: 23:59:15.443	23:55:46.240	99.8%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:25.830	36.5%	1492	10.800	17.312	487.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.126	0.2%	3404	0.000	0.037	1.000
TOTAL: 00:01:10.727	00:00:25.956	36.7%	-	-	-	-

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	5	1593	717	874	2	45%	23:57:08
2	news.glou.org	8	2119	271	1759	89	12%	38:47:05
3	news.samoylyk.net	2	872	246	624	2	28%	15:09:37
4	news.nntp4.net	2	1979	203	1504	272	10%	25:34:34
5	nntp.terraraq.uk	6	1143	134	1008	1	11%	25:44:58
6	usenet.pasdenom.info	17	781	28	751	2	3%	27:51:33
7	gegeweb-out.news.tnetconsulting.net	5	2159	16	2138	5	0%	40:09:27
8	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 8		70	10646	1615	8658	373	15%	197:14:22

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	feed-out.gegeweb.org	2.2 MB	3.7 KB	2.2 MB	99%	3.2 KB
2	news.samoylyk.net	1.3 MB	11.6 KB	1.3 MB	99%	5.3 KB
3	news.nntp4.net	929.4 KB	2.2 MB	3.1 MB	29%	6.7 KB
4	news.glou.org	855.7 KB	237.8 KB	1.1 MB	78%	3.0 KB
5	nntp.terraraq.uk	342.7 KB	3.0 KB	345.7 KB	99%	2.6 KB
6	gegeweb-out.news.tnetconsulting.net	82.3 KB	10.4 KB	92.6 KB	88%	4.4 KB
7	usenet.pasdenom.info	63.0 KB	2.4 KB	65.4 KB	96%	2.2 KB
8	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 8		5.7 MB	2.5 MB	8.2 MB	69%	4.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 22 04:15:01 - 04:59:59	28	1.8%	0.01	122.4 KB	2.1%	0.05
Aug 22 05:00:00 - 05:59:59	18	1.1%	0.01	157.7 KB	2.7%	0.04
Aug 22 06:00:00 - 06:59:59	35	2.2%	0.01	126.1 KB	2.1%	0.04
Aug 22 07:00:00 - 07:59:59	35	2.2%	0.01	108.0 KB	1.8%	0.03
Aug 22 08:00:00 - 08:59:59	23	1.4%	0.01	92.0 KB	1.6%	0.03
Aug 22 09:00:00 - 09:59:59	31	1.9%	0.01	96.1 KB	1.6%	0.03
Aug 22 10:00:00 - 10:59:59	55	3.5%	0.02	229.7 KB	3.9%	0.06
Aug 22 11:00:00 - 11:59:59	57	3.6%	0.02	197.1 KB	3.3%	0.05
Aug 22 12:00:00 - 12:59:59	108	6.8%	0.03	374.0 KB	6.3%	0.10
Aug 22 13:00:00 - 13:59:59	65	4.1%	0.02	260.3 KB	4.4%	0.07
Aug 22 14:00:00 - 14:59:59	72	4.5%	0.02	337.4 KB	5.7%	0.09
Aug 22 15:00:00 - 15:59:59	85	5.3%	0.02	271.1 KB	4.6%	0.08
Aug 22 16:00:00 - 16:59:59	100	6.3%	0.03	318.4 KB	5.4%	0.09
Aug 22 17:00:00 - 17:59:59	81	5.1%	0.02	333.1 KB	5.6%	0.09
Aug 22 18:00:00 - 18:59:59	96	6.0%	0.03	281.0 KB	4.7%	0.08
Aug 22 19:00:00 - 19:59:59	96	6.0%	0.03	348.2 KB	5.9%	0.10
Aug 22 20:00:00 - 20:59:59	90	5.7%	0.03	327.6 KB	5.5%	0.09
Aug 22 21:00:00 - 21:59:59	92	5.8%	0.03	354.1 KB	6.0%	0.10
Aug 22 22:00:00 - 22:59:59	96	6.0%	0.03	303.0 KB	5.1%	0.08
Aug 22 23:00:00 - 23:59:59	77	4.8%	0.02	257.4 KB	4.3%	0.07
Aug 23 00:00:00 - 00:59:59	76	4.8%	0.02	273.5 KB	4.6%	0.08
Aug 23 01:00:00 - 01:59:59	84	5.3%	0.02	368.1 KB	6.2%	0.10
Aug 23 02:00:00 - 02:59:59	35	2.2%	0.01	184.2 KB	3.1%	0.05
Aug 23 03:00:00 - 03:59:59	44	2.8%	0.01	159.8 KB	2.7%	0.04
Aug 23 04:00:00 - 04:15:01	11	0.7%	0.01	37.5 KB	0.6%	0.04
TOTAL: 24:00:00	1590	100.0%	0.02	5.8 MB	100.0%	0.07

Sites sending bad articles:

Server		Total	Group	Unapp	Other
1	news.nntp4.net	270	173	0	97
2	news.glou.org	30	0	1	29
3	gegeweb-out.news.tnetconsulting.net	2	0	0	2
4	feed-out.gegeweb.org	2	0	0	2
5	news.samoylyk.net	2	0	0	2
6	usenet.pasdenom.info	2	0	0	2
7	nntp.terraraq.uk	1	0	0	1
TOTAL: 7		309	173	1	135

Unwanted newsgroups [Top 20]:

Newsgroup	Count
linux.kernel.netdev	163
linux.kernel.git	10
TOTAL: 2	173

Supposedly-moderated groups with unmoderated postings [Top 20]:

Groups	Count
soc.culture.hawaii	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
Too many newsgroups	96
Bad path (news.giganews.com.POSTED)	33
EMP (phn path)	3
Cancels abusifs	2
Too many newsgroups (meow)	1
TOTAL: 5	135

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.nntp4.net	1444	1	1387	0	0	0%	23:53:22
2	news.samoylyk.net	1241	1	1139	0	0	0%	23:53:39
3	nntp.terraraq.uk	931	0	906	0	0	0%	23:02:37
4	news.tnetconsulting.net	2710	0	1589	0	4	0%	23:57:24
5	news.pasdenom.info	1225	0	1195	1	0	0%	23:38:19
6	i2pn.org	0	0	0	0	1589	0%	24:00:00
7	news.aioe.org	0	0	0	0	1309	0%	24:00:00
8	news.gegeweb.org	973	0	883	0	0	0%	23:19:09
TOTAL: 8		8524	2	7099	1	2902	0%	189:44:30

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.samoylyk.net	7.9 KB	0.0 KB	7.9 KB	7.9 KB	23:53:39
2	news.nntp4.net	1.3 KB	0.0 KB	1.3 KB	1.3 KB	23:53:22
3	nntp.terraraq.uk	0.0 KB	0.0 KB	0.0 KB	0	23:02:37
4	news.tnetconsulting.net	0.0 KB	0.0 KB	0.0 KB	0	23:57:24
5	news.pasdenom.info	0.0 KB	1.3 KB	1.3 KB	1.3 KB	23:38:19
6	i2pn.org	0.0 KB	0.0 KB	0.0 KB	0	24:00:00
7	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	24:00:00
8	news.gegeweb.org	0.0 KB	0.0 KB	0.0 KB	0	23:19:09
TOTAL: 8		9.2 KB	1.3 KB	10.5 KB	3.5 KB	189:44:30

NNRP readership statistics:

System		Conn	Elapsed
1	172-104-215-178.ip.linodeusercontent.com	2	00:00:00
2	104.152.52.120	2	00:00:00
3	104.152.52.105	1	00:00:00
4	185-223-235-16.infrawat.ch	1	00:00:01
5	172-236-228-220.ip.linodeusercontent.com	2	00:00:00
6	2603:6010:6802:4ca5:1a03:73ff:fe28:be0f	6	00:00:05
7	r4-129-81.monitoring.internet-measurement.com	1	00:00:00
8	r3-43-2b.monitoring.internet-measurement.com	1	00:00:00
9	104.152.52.102	1	00:00:00
10	104.152.52.124	2	00:00:00
11	r3-54-36.monitoring.internet-measurement.com	1	00:00:06
12	r5-141-8d.monitoring.internet-measurement.com	1	00:00:00
13	r3-38-26.monitoring.internet-measurement.com	1	00:00:00
14	r5-122-7a.monitoring.internet-measurement.com	1	00:00:00
15	r4-145-91.monitoring.internet-measurement.com	1	00:00:00
16	45-79-8-221.ip.linodeusercontent.com	1	00:00:00
17	104.152.52.119	1	00:00:01
18	r5-130-82.monitoring.internet-measurement.com	1	00:00:00
19	r5-140-8c.monitoring.internet-measurement.com	1	00:00:00
20	66.61.98.95	4	00:00:04
21	mail.gegeweb.eu	288	00:00:34
22	r3-116-74.monitoring.internet-measurement.com	1	00:00:01
23	r3-127-7f.monitoring.internet-measurement.com	1	00:00:00
24	204.172.132.66.censys-scanner.com	1	00:00:00
25	r5-44-2c.monitoring.internet-measurement.com	1	00:00:03
26	r4-133-85.monitoring.internet-measurement.com	1	00:00:01
27	r3-139-8b.monitoring.internet-measurement.com	1	00:00:01
28	104.152.52.123	1	00:00:01
29	r3-134-86.monitoring.internet-measurement.com	1	00:00:01
30	r3-120-78.monitoring.internet-measurement.com	1	00:00:00
31	r3-111-6f.monitoring.internet-measurement.com	1	00:00:00
32	45-56-79-53.ip.linodeusercontent.com	1	00:00:00
33	r3-46-2e.monitoring.internet-measurement.com	1	00:00:00
34	r5-63-3f.monitoring.internet-measurement.com	1	00:00:00
35	104.152.52.100	1	00:00:01
36	193-124-20-228.infrawat.ch	1	00:00:00
37	r4-142-8e.monitoring.internet-measurement.com	1	00:00:01
38	104.152.52.108	4	00:00:01
39	45-79-207-252.ip.linodeusercontent.com	1	00:00:00
TOTAL: 39		341	00:01:16

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.gegeweb.eu	288	00:00:34
2	*.monitoring.internet-measurement.com	20	00:00:18
3	?	6	00:00:05
4	unresolved	17	00:00:13
5	*.infrawat.ch	2	00:00:01
6	*.ip.linodeusercontent.com	7	00:00:01
7	*.172.132.66.censys-scanner.com	1	00:00:00
TOTAL: 7		341	00:01:16

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.082	4.502	1.761	00:00:34
r3-54-36.monitoring.internet-measurement.com	0.148	0.052	0.000	00:00:06
2603:6010:6802:4ca5:1a03:73ff:fe28:be0f	0.165	0.153	0.000	00:00:05
66.61.98.95	0.095	0.074	0.000	00:00:04
r5-44-2c.monitoring.internet-measurement.com	0.048	0.012	0.000	00:00:03
104.152.52.108	0.168	0.033	0.000	00:00:01
104.152.52.123	0.015	0.015	0.000	00:00:01
104.152.52.100	0.016	0.012	0.000	00:00:01
104.152.52.119	0.043	0.004	0.000	00:00:01
r3-139-8b.monitoring.internet-measurement.com	0.150	0.032	0.000	00:00:01
r4-133-85.monitoring.internet-measurement.com	0.104	0.070	0.000	00:00:01
r3-134-86.monitoring.internet-measurement.com	0.079	0.016	0.000	00:00:01
r4-142-8e.monitoring.internet-measurement.com	0.073	0.022	0.000	00:00:01
r3-116-74.monitoring.internet-measurement.com	0.072	0.024	0.000	00:00:01
185-223-235-16.infrawat.ch	0.016	0.008	0.000	00:00:01
193-124-20-228.infrawat.ch	0.026	0.018	0.000	00:00:00
104.152.52.105	0.063	0.028	0.000	00:00:00
204.172.132.66.censys-scanner.com	0.015	0.015	0.000	00:00:00
172-236-228-220.ip.linodeusercontent.com	0.052	0.024	0.000	00:00:00
r5-140-8c.monitoring.internet-measurement.com	0.044	0.004	0.000	00:00:00
TOTAL: 38	7.139	5.430	1.761	00:01:16

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
172-104-215-178.ip.linodeusercontent.com	7
104.152.52.119	5
172-236-228-220.ip.linodeusercontent.com	5
104.152.52.105	2
204.172.132.66.censys-scanner.com	1
TOTAL: 5	20

NNRP unrecognized commands (by command):

Command	Count
Accept: /	3
GET / HTTP/1.1	3
Accept-Encoding: gzip	2
User-Agent: Mozilla/5.0 (Macintosh; Inte...	2
MAIL FROM:<relaycheck_please_ignore@prot...	1
#026#003#001	1
Connection: close	1
EHLO www.censys.io	1
Host: 45.13.105.36	1
EHLO 45.13.105.36	1
Host: 45.13.105.36:119	1
User-Agent: curl/7.61.1	1
Host: 45.13.105.36:563	1
#001	1
TOTAL: 14	20

NNRP client timeouts [Top 20]:

System	Conn	Peer
185-223-235-16.infrawat.ch	1	1
TOTAL: 1	1	3

Daily Usenet report for news.niel.me

Aug 22 04:15:01 -- Aug 23 04:15:01