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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2237	27.8%	397.5 KB	31.9%
nnrpd	2007	24.9%	225.8 KB	18.1%
innd	1946	24.2%	347.6 KB	27.9%
innfeed	1859	23.1%	274.1 KB	22.0%
nocem	1	0.0%	0.1 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	8051	100.0%	1.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	8414	52.6%
Negative hits	5344	33.4%
Do not exist	2223	13.9%
Cache misses	2	0.0%
TOTAL: 4	15983	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.005	0.0%	6	0.500	0.833	1.000
article cancel	00:00:00.002	0.0%	6	0.000	0.333	1.000
article cleanup	00:00:00.062	0.0%	2234	0.000	0.028	0.333
article logging	00:00:00.185	0.0%	2234	0.000	0.083	0.333
article parse	00:00:00.364	0.0%	5505	0.000	0.066	0.357
article write	00:00:00.980	0.0%	1861	0.000	0.527	1.600
artlog/artcncl	00:00:00.000	0.0%	6	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.000	0.0%	6	0.000	0.000	0.000
data move	00:00:00.103	0.0%	18035	0.000	0.006	0.040
hisgrep/artcncl	00:00:00.000	0.0%	6	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	6	0.000	0.000	0.000
hisgrep/perl	00:00:00.000	0.0%	6	0.000	0.000	0.000
hishave/artcncl	00:00:00.001	0.0%	6	0.000	0.167	1.000
hishave/artcncl/perl	00:00:00.000	0.0%	6	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.291	0.0%	16067	0.000	0.018	0.088
history sync	00:00:00.056	0.0%	367	0.000	0.153	1.000
history write	00:00:00.441	0.0%	2234	0.000	0.197	0.700
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:24.740	100.0%	19823	1620.641	4359.821	37517.750
nntp read	00:00:00.532	0.0%	19066	0.000	0.028	0.077
overview write	00:00:00.629	0.0%	1861	0.000	0.338	3.000
perl filter	00:00:15.150	0.0%	2234	1.562	6.782	42.000
python filter	00:00:00.009	0.0%	2234	0.000	0.004	0.100
site send	00:00:00.839	0.0%	3775	0.000	0.222	0.667
TOTAL: 24:01:06.019	24:00:44.389	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.012	0.0%	1861	0.000	0.006	0.200
article prepare	00:00:00.002	0.0%	144	0.000	0.014	0.250
article read	00:00:00.012	0.0%	36	0.000	0.333	7.000
backlog stats	00:00:00.128	0.0%	23567	0.000	0.005	0.029
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.338	0.0%	11545	0.000	0.029	0.088
data write	00:00:00.592	0.0%	9901	0.000	0.060	0.143
idle	23:59:37.599	100.0%	23567	1641.639	3665.193	12038.720
status file	00:00:07.502	0.0%	293	1.000	25.604	86.000
TOTAL: 23:59:49.704	23:59:46.185	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:37.029	41.3%	1497	0.000	24.735	3932.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.128	0.1%	3425	0.000	0.037	1.000
TOTAL: 00:01:29.711	00:00:37.157	41.4%	-	-	-	-

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	feed-out.gegeweb.org	4	1853	801	1052	0	43%	23:52:08
2	news.nntp4.net	2	2132	505	1301	326	23%	22:08:06
3	nntp.terraraq.uk	5	297	40	256	1	13%	09:55:58
4	usenet.pasdenom.info	10	831	27	803	1	3%	23:11:26
5	news.samoylyk.net	3	537	18	519	0	3%	10:24:07
6	gegeweb-out.news.tnetconsulting.net	4	1410	12	1395	3	0%	28:35:00
7	news.glou.org	5	112	9	95	8	8%	04:18:40
8	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 8		58	7172	1412	5421	339	19%	122:25:25

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	feed-out.gegeweb.org	3.0 MB	0.0 KB	3.0 MB	100%	3.8 KB
2	news.nntp4.net	2.1 MB	3.0 MB	5.2 MB	41%	6.4 KB
3	nntp.terraraq.uk	108.9 KB	2.7 KB	111.6 KB	97%	2.7 KB
4	news.samoylyk.net	97.9 KB	0.0 KB	97.9 KB	100%	5.4 KB
5	usenet.pasdenom.info	70.3 KB	1.2 KB	71.5 KB	98%	2.6 KB
6	news.glou.org	27.7 KB	29.9 KB	57.6 KB	48%	3.4 KB
7	gegeweb-out.news.tnetconsulting.net	23.8 KB	10.1 KB	34.0 KB	70%	2.3 KB
8	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 8		5.4 MB	3.1 MB	8.5 MB	63%	5.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 27 04:15:01 - 04:59:59	29	1.6%	0.01	91.5 KB	1.2%	0.03
Aug 27 05:00:00 - 05:59:59	33	1.8%	0.01	81.6 KB	1.1%	0.02
Aug 27 06:00:00 - 06:59:59	25	1.4%	0.01	93.8 KB	1.3%	0.03
Aug 27 07:00:00 - 07:59:59	38	2.1%	0.01	236.9 KB	3.2%	0.07
Aug 27 08:00:00 - 08:59:59	44	2.4%	0.01	188.9 KB	2.6%	0.05
Aug 27 09:00:00 - 09:59:59	89	4.8%	0.02	373.6 KB	5.1%	0.10
Aug 27 10:00:00 - 10:59:59	81	4.4%	0.02	320.9 KB	4.3%	0.09
Aug 27 11:00:00 - 11:59:59	91	4.9%	0.03	383.5 KB	5.2%	0.11
Aug 27 12:00:00 - 12:59:59	86	4.6%	0.02	351.0 KB	4.7%	0.10
Aug 27 13:00:00 - 13:59:59	89	4.8%	0.02	267.4 KB	3.6%	0.07
Aug 27 14:00:00 - 14:59:59	103	5.6%	0.03	427.9 KB	5.8%	0.12
Aug 27 15:00:00 - 15:59:59	62	3.3%	0.02	218.6 KB	3.0%	0.06
Aug 27 16:00:00 - 16:59:59	76	4.1%	0.02	303.5 KB	4.1%	0.08
Aug 27 17:00:00 - 17:59:59	151	8.2%	0.04	732.2 KB	9.9%	0.20
Aug 27 18:00:00 - 18:59:59	115	6.2%	0.03	587.5 KB	7.9%	0.16
Aug 27 19:00:00 - 19:59:59	75	4.1%	0.02	227.2 KB	3.1%	0.06
Aug 27 20:00:00 - 20:59:59	79	4.3%	0.02	276.4 KB	3.7%	0.08
Aug 27 21:00:00 - 21:59:59	122	6.6%	0.03	466.9 KB	6.3%	0.13
Aug 27 22:00:00 - 22:59:59	97	5.2%	0.03	303.1 KB	4.1%	0.08
Aug 27 23:00:00 - 23:59:59	108	5.8%	0.03	388.3 KB	5.2%	0.11
Aug 28 00:00:00 - 00:59:59	90	4.9%	0.03	425.9 KB	5.8%	0.12
Aug 28 01:00:00 - 01:59:59	62	3.3%	0.02	196.6 KB	2.7%	0.05
Aug 28 02:00:00 - 02:59:59	55	3.0%	0.02	264.1 KB	3.6%	0.07
Aug 28 03:00:00 - 03:59:59	42	2.3%	0.01	170.6 KB	2.3%	0.05
Aug 28 04:00:00 - 04:15:01	9	0.5%	0.01	19.7 KB	0.3%	0.02
TOTAL: 24:00:00	1851	100.0%	0.02	7.2 MB	100.0%	0.09

Sites sending bad articles:

Server		Total	Group	Unapp	Other
1	news.nntp4.net	335	265	0	70
2	news.glou.org	30	0	1	29
3	nntp.terraraq.uk	5	0	0	5
4	gegeweb-out.news.tnetconsulting.net	2	0	0	2
5	usenet.pasdenom.info	1	0	0	1
6	news.samoylyk.net	1	0	0	1
TOTAL: 6		374	265	1	108

Unwanted newsgroups [Top 20]:

Newsgroup	Count
linux.kernel.netdev	207
linux.kernel.git	58
TOTAL: 2	265

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	67
Bad path (news.giganews.com.POSTED)	40
Cancels abusifs	1
TOTAL: 3	108

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.samoylyk.net	2172	1	1626	34	5	0%	23:52:15
2	news.pasdenom.info	1341	1	1298	0	0	0%	23:52:12
3	news.gegeweb.org	1112	0	1054	0	0	0%	23:39:07
4	i2pn.org	0	0	0	0	1850	0%	24:00:00
5	news.nntp4.net	1330	0	1286	0	0	0%	23:42:59
6	nntp.terraraq.uk	937	0	910	0	0	0%	23:42:27
7	news.aioe.org	0	0	0	0	1572	0%	24:00:00
8	news.tnetconsulting.net	3189	0	1850	0	5	0%	23:52:23
TOTAL: 8		10081	2	8024	34	3432	0%	190:41:23

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.samoylyk.net	2.8 KB	147.1 KB	149.9 KB	4.3 KB	23:52:15
2	news.pasdenom.info	1.8 KB	0.0 KB	1.8 KB	1.8 KB	23:52:12
3	news.gegeweb.org	0.0 KB	0.0 KB	0.0 KB	0	23:39:07
4	i2pn.org	0.0 KB	0.0 KB	0.0 KB	0	24:00:00
5	news.nntp4.net	0.0 KB	0.0 KB	0.0 KB	0	23:42:59
6	nntp.terraraq.uk	0.0 KB	0.0 KB	0.0 KB	0	23:42:27
7	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	24:00:00
8	news.tnetconsulting.net	0.0 KB	0.0 KB	0.0 KB	0	23:52:23
TOTAL: 8		4.6 KB	147.1 KB	151.7 KB	4.2 KB	190:41:23

NNRP readership statistics:

System		Conn	Elapsed
1	228.224.132.66.censys-scanner.com	3	00:00:05
2	198.235.24.108	1	00:00:00
3	r5-83-53.monitoring.internet-measurement.com	1	00:00:01
4	r3-77-4d.monitoring.internet-measurement.com	1	00:00:00
5	r5-74-4a.monitoring.internet-measurement.com	1	00:00:00
6	r3-86-56.monitoring.internet-measurement.com	1	00:00:01
7	o012.scanner.modat.io	1	00:00:00
8	151.243.11.14	1	00:00:04
9	r5-105-69.monitoring.internet-measurement.com	1	00:00:00
10	o061.scanner.modat.io	1	00:00:00
11	r4-252-fc.monitoring.internet-measurement.com	1	00:00:00
12	nyc1-64.boron.do.prod.binaryedge.ninja	1	00:00:02
13	r5-117-75.monitoring.internet-measurement.com	1	00:00:06
14	r5-141-8d.monitoring.internet-measurement.com	1	00:00:03
15	45.82.78.107	2	00:00:05
16	r5-104-68.monitoring.internet-measurement.com	2	00:00:01
17	o072.scanner.modat.io	1	00:00:01
18	r4-240-f0.monitoring.internet-measurement.com	1	00:00:00
19	r3-83-53.monitoring.internet-measurement.com	1	00:00:00
20	147.185.133.81	1	00:00:03
21	r3-82-52.monitoring.internet-measurement.com	2	00:00:01
22	r4-223-df.monitoring.internet-measurement.com	1	00:00:00
23	azpdwsc2stpl.stretchoid.com	2	00:00:01
24	2603:6010:6802:4ca5:1a03:73ff:fe28:be0f	6	00:00:05
25	r4-253-fd.monitoring.internet-measurement.com	1	00:00:00
26	r4-103-67.monitoring.internet-measurement.com	1	00:00:00
27	205.210.31.209	1	00:00:00
28	49.210.203.35.bc.googleusercontent.com	1	00:00:00
29	r5-229-e5.monitoring.internet-measurement.com	1	00:00:00
30	r5-251-fb.monitoring.internet-measurement.com	1	00:00:01
31	r3-251-fb.monitoring.internet-measurement.com	1	00:00:00
32	147.185.133.4	1	00:00:04
33	66.61.98.95	4	00:00:08
34	mail.gegeweb.eu	288	00:00:30
35	r3-246-f6.monitoring.internet-measurement.com	1	00:00:00
TOTAL: 35		336	00:01:33

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	unresolved	11	00:00:26
2	*.boron.do.prod.binaryedge.ninja	1	00:00:02
3	*.224.132.66.censys-scanner.com	3	00:00:05
4	*.210.203.35.bc.googleusercontent.com	1	00:00:00
5	?	6	00:00:05
6	*.gegeweb.eu	288	00:00:30
7	*.scanner.modat.io	3	00:00:02
8	*.monitoring.internet-measurement.com	21	00:00:18
9	*.stretchoid.com	2	00:00:01
TOTAL: 9		336	00:01:33

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.224	4.526	1.741	00:00:30
66.61.98.95	0.109	0.082	0.000	00:00:08
r5-117-75.monitoring.internet-measurement.com	0.110	0.052	0.000	00:00:06
45.82.78.107	0.114	0.041	0.000	00:00:05
2603:6010:6802:4ca5:1a03:73ff:fe28:be0f	0.144	0.114	0.000	00:00:05
228.224.132.66.censys-scanner.com	0.087	0.051	0.000	00:00:05
151.243.11.14	0.011	0.041	0.000	00:00:04
147.185.133.4	0.022	0.026	0.000	00:00:04
147.185.133.81	0.057	0.024	0.000	00:00:03
r5-141-8d.monitoring.internet-measurement.com	0.040	0.024	0.000	00:00:03
nyc1-64.boron.do.prod.binaryedge.ninja	0.034	0.017	0.000	00:00:02
r5-251-fb.monitoring.internet-measurement.com	0.034	0.017	0.000	00:00:01
azpdwsc2stpl.stretchoid.com	0.056	0.047	0.000	00:00:01
o072.scanner.modat.io	0.021	0.017	0.000	00:00:01
r5-104-68.monitoring.internet-measurement.com	0.104	0.023	0.000	00:00:01
r5-83-53.monitoring.internet-measurement.com	0.079	0.016	0.000	00:00:01
r3-86-56.monitoring.internet-measurement.com	0.076	0.018	0.000	00:00:01
r3-82-52.monitoring.internet-measurement.com	0.075	0.020	0.000	00:00:01
r4-103-67.monitoring.internet-measurement.com	0.043	0.004	0.000	00:00:00
r3-83-53.monitoring.internet-measurement.com	0.049	0.019	0.000	00:00:00
TOTAL: 32	6.969	5.340	1.741	00:01:33

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
147.185.133.4	4
147.185.133.81	4
49.210.203.35.bc.googleusercontent.com	4
o012.scanner.modat.io	1
azpdwsc2stpl.stretchoid.com	1
o061.scanner.modat.io	1
228.224.132.66.censys-scanner.com	1
TOTAL: 7	16

NNRP unrecognized commands (by command):

Command	Count
GET / HTTP/1.1	3
Accept-Encoding: gzip	3
User-Agent: Hello from Palo Alto Network...	3
Host: 45.13.105.36:563	2
HELO	2
Host: 45.13.105.36:119	1
EHLO www.censys.io	1
MGLNDD_45.13.105.36_119	1
TOTAL: 8	16

NNRP client timeouts [Top 20]:

System	Conn	Peer
228.224.132.66.censys-scanner.com	1	2
TOTAL: 1	1	4

Daily Usenet report for news.niel.me

Aug 27 04:15:01 -- Aug 28 04:15:01