Daily Usenet report for news.niel.me: May 18 04:15:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

May 18 20:16:17 rpi-studio innd: filter: No Cancel-Key[sha1:9JUrmJvlPihQvlVE0Sbs7QouZQ0=] matches Cancel-Lock[sha1:bVZssF98wyKLzSLzHlFEGDOxUEY= sha256:76aPJGFydWIuzlXVr10GYxM7Z6mkV2VnJrNP+rnSmjw=] target=<slrn110mlr9.2hc.olmia2b+news@lenovux.my.domain>

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2306	28.3%	390.1 KB	31.5%
innd	2045	25.1%	350.0 KB	28.3%
innfeed	1923	23.6%	274.9 KB	22.2%
nnrpd	1863	22.9%	221.7 KB	17.9%
nocem	1	0.0%	0.1 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	8139	100.0%	1.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	7970	50.3%
Negative hits	5603	35.4%
Do not exist	2275	14.4%
Cache misses	1	0.0%
TOTAL: 4	15849	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.013	0.0%	8	0.000	1.625	5.000
article cancel	00:00:00.002	0.0%	8	0.000	0.250	1.000
article cleanup	00:00:00.052	0.0%	2281	0.000	0.023	0.167
article logging	00:00:00.188	0.0%	2281	0.000	0.082	0.308
article parse	00:00:00.522	0.0%	6657	0.000	0.078	0.250
article write	00:00:00.894	0.0%	1712	0.000	0.522	1.500
artlog/artcncl	00:00:00.001	0.0%	8	0.000	0.125	1.000
artlog/artcncl/perl	00:00:00.002	0.0%	8	0.000	0.250	1.000
data move	00:00:00.129	0.0%	19612	0.000	0.007	0.048
hisgrep/artcncl	00:00:00.001	0.0%	8	0.000	0.125	1.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	8	0.000	0.000	0.000
hisgrep/perl	00:00:00.000	0.0%	9	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	8	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	8	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.264	0.0%	15894	0.000	0.017	0.115
history sync	00:00:00.051	0.0%	353	0.000	0.144	1.000
history write	00:00:00.410	0.0%	2281	0.000	0.180	0.692
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:41.779	100.0%	20174	1375.505	4284.811	23075.385
nntp read	00:00:00.586	0.0%	19449	0.000	0.030	0.088
overview write	00:00:00.534	0.0%	1712	0.000	0.312	2.429
perl filter	00:00:11.687	0.0%	2281	1.109	5.124	36.000
python filter	00:00:00.009	0.0%	2281	0.000	0.004	0.125
site send	00:00:00.710	0.0%	3490	0.000	0.203	0.500
TOTAL: 24:01:05.334	24:00:57.834	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.013	0.0%	2022	0.000	0.006	0.333
article prepare	00:00:00.000	0.0%	156	0.000	0.000	0.000
article read	00:00:00.008	0.0%	39	0.000	0.205	3.000
backlog stats	00:00:00.123	0.0%	21806	0.000	0.006	0.036
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.258	0.0%	10320	0.000	0.025	0.105
data write	00:00:00.558	0.0%	8760	0.000	0.064	0.222
idle	23:56:57.054	100.0%	21806	1450.403	3953.823	8850.721
status file	00:00:07.550	0.0%	332	0.000	22.741	82.000
TOTAL: 23:57:09.985	23:57:05.564	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:41.240	27.5%	1462	11.400	28.208	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.114	0.1%	3345	0.000	0.034	0.500
TOTAL: 00:02:29.825	00:00:41.354	27.6%	-	-	-	-

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.nntp4.net	3	2130	894	741	495	41%	22:14:45
2	feed-out.gegeweb.org	2	1695	336	1359	0	19%	23:59:52
3	news.samoylyk.net	3	1959	246	1712	1	12%	27:24:22
4	news.glou.org	6	1082	85	976	21	7%	21:19:15
5	nntp.terraraq.uk	3	1396	64	1328	4	4%	25:16:41
6	gegeweb-out.news.tnetconsulting.net	7	2293	61	2232	0	2%	38:44:37
7	usenet.pasdenom.info	13	749	22	725	2	2%	23:19:03
8	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 8		62	11304	1708	9073	523	15%	182:18:35

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.nntp4.net	4.7 MB	5.3 MB	10.0 MB	47%	7.4 KB
2	news.samoylyk.net	2.0 MB	3.1 KB	2.0 MB	99%	8.3 KB
3	feed-out.gegeweb.org	1.0 MB	0.0 KB	1.0 MB	100%	3.1 KB
4	nntp.terraraq.uk	509.2 KB	10.2 KB	519.4 KB	98%	7.6 KB
5	news.glou.org	248.9 KB	116.9 KB	365.8 KB	68%	3.5 KB
6	gegeweb-out.news.tnetconsulting.net	185.3 KB	0.0 KB	185.3 KB	100%	3.0 KB
7	usenet.pasdenom.info	60.6 KB	2.4 KB	63.0 KB	96%	2.6 KB
8	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 8		8.7 MB	5.4 MB	14.1 MB	61%	6.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 18 04:15:02 - 04:59:59	42	2.4%	0.02	497.0 KB	5.6%	0.18
May 18 05:00:00 - 05:59:59	23	1.3%	0.01	354.9 KB	4.0%	0.10
May 18 06:00:00 - 06:59:59	31	1.8%	0.01	104.8 KB	1.2%	0.03
May 18 07:00:00 - 07:59:59	237	13.8%	0.07	896.6 KB	10.1%	0.25
May 18 08:00:00 - 08:59:59	62	3.6%	0.02	509.3 KB	5.7%	0.14
May 18 09:00:00 - 09:59:59	49	2.9%	0.01	262.9 KB	2.9%	0.07
May 18 10:00:00 - 10:59:59	48	2.8%	0.01	204.2 KB	2.3%	0.06
May 18 11:00:00 - 11:59:59	41	2.4%	0.01	147.5 KB	1.7%	0.04
May 18 12:00:00 - 12:59:59	91	5.3%	0.03	349.5 KB	3.9%	0.10
May 18 13:00:00 - 13:59:59	71	4.1%	0.02	637.2 KB	7.1%	0.18
May 18 14:00:00 - 14:59:59	65	3.8%	0.02	339.2 KB	3.8%	0.09
May 18 15:00:00 - 15:59:59	91	5.3%	0.03	278.8 KB	3.1%	0.08
May 18 16:00:00 - 16:59:59	61	3.6%	0.02	330.4 KB	3.7%	0.09
May 18 17:00:00 - 17:59:59	70	4.1%	0.02	510.6 KB	5.7%	0.14
May 18 18:00:00 - 18:59:59	92	5.4%	0.03	477.0 KB	5.3%	0.13
May 18 19:00:00 - 19:59:59	94	5.5%	0.03	349.8 KB	3.9%	0.10
May 18 20:00:00 - 20:59:59	90	5.2%	0.03	273.0 KB	3.1%	0.08
May 18 21:00:00 - 21:59:59	54	3.1%	0.01	153.8 KB	1.7%	0.04
May 18 22:00:00 - 22:59:59	79	4.6%	0.02	344.2 KB	3.9%	0.10
May 18 23:00:00 - 23:59:59	86	5.0%	0.02	342.6 KB	3.8%	0.10
May 19 00:00:00 - 00:59:59	65	3.8%	0.02	504.5 KB	5.7%	0.14
May 19 01:00:00 - 01:59:59	60	3.5%	0.02	625.0 KB	7.0%	0.17
May 19 02:00:00 - 02:59:59	44	2.6%	0.01	164.1 KB	1.8%	0.05
May 19 03:00:00 - 03:59:59	53	3.1%	0.01	209.9 KB	2.4%	0.06
May 19 04:00:00 - 04:15:01	19	1.1%	0.02	54.9 KB	0.6%	0.06
TOTAL: 23:59:59	1718	100.0%	0.02	8.7 MB	100.0%	0.10

Sites sending bad articles:

Server		Total	Group	Other
1	news.nntp4.net	542	386	156
2	news.glou.org	21	0	21
3	nntp.terraraq.uk	6	0	6
4	usenet.pasdenom.info	2	0	2
5	news.samoylyk.net	1	0	1
TOTAL: 5		572	386	186

Unwanted newsgroups [Top 20]:

Newsgroup	Count
linux.kernel.netdev	336
linux.kernel.git	49
news.test	1
TOTAL: 3	386

INND Perl filter [Top 20]:

Reason	Count
Too many newsgroups	80
Bad path (news.giganews.com.POSTED)	56
EMP (phn path)	43
HTML Multipart	3
Cancels abusifs	3
No Cancel-Key matches Cancel-Lock. target=<slrn110mlr9.2hc.olmia2b+news@lenovux.my.domain>	1
TOTAL: 6	186

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.tnetconsulting.net	3078	6	1693	10	148	0%	23:59:57
2	news.pasdenom.info	1114	1	1074	0	0	0%	23:51:28
3	news.nntp4.net	767	0	734	0	0	0%	22:58:49
4	news.aioe.org	0	0	0	0	1468	0%	23:59:59
5	news.samoylyk.net	1837	0	1411	22	157	0%	23:56:05
6	news.gegeweb.org	1407	0	1370	0	0	0%	23:55:57
7	i2pn.org	0	0	0	0	1711	0%	23:59:59
8	nntp.terraraq.uk	930	0	892	0	0	0%	23:45:50
TOTAL: 8		9133	7	7174	32	3484	0%	190:28:04

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.tnetconsulting.net	24.8 KB	56.2 KB	81.0 KB	5.1 KB	23:59:57
2	news.pasdenom.info	1.8 KB	0.0 KB	1.8 KB	1.8 KB	23:51:28
3	news.nntp4.net	0.0 KB	0.0 KB	0.0 KB	0	22:58:49
4	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	23:59:59
5	news.samoylyk.net	0.0 KB	344.0 KB	344.0 KB	15.6 KB	23:56:05
6	news.gegeweb.org	0.0 KB	0.0 KB	0.0 KB	0	23:55:57
7	i2pn.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:45:50
TOTAL: 8		26.6 KB	400.2 KB	426.9 KB	10.9 KB	190:28:04

NNRP readership statistics:

System		Conn	Elapsed
1	azpdesgg8ot1.stretchoid.com	2	00:00:10
2	r4-119-77.monitoring.internet-measurement.com	1	00:00:01
3	186.172.132.66.censys-scanner.com	3	00:00:07
4	finch.probe.onyphe.net	1	00:00:00
5	69.5.169.138	1	00:00:00
6	101.195.132.66.censys-scanner.com	1	00:00:00
7	84.155.45.199.censys-scanner.com	3	00:00:05
8	104.152.52.242	1	00:00:00
9	o329.scanner.modat.io	4	00:00:00
10	112.94.189.158	1	00:00:00
11	69.5.169.75	1	00:00:00
12	o314.scanner.modat.io	1	00:00:00
13	131.172.132.66.censys-scanner.com	1	00:00:30
14	205.210.31.6	1	00:00:00
15	mail.gegeweb.eu	288	00:00:26
16	194.165.16.166	1	00:00:00
17	58.195.132.66.censys-scanner.com	1	00:00:30
18	harry.probe.onyphe.net	1	00:00:02
19	93.224.132.66.censys-scanner.com	1	00:00:30
TOTAL: 19		314	00:02:29

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	unresolved	6	00:00:02
2	*.224.132.66.censys-scanner.com	1	00:00:30
3	*.stretchoid.com	2	00:00:10
4	*.gegeweb.eu	288	00:00:26
5	*.monitoring.internet-measurement.com	1	00:00:01
6	*.scanner.modat.io	5	00:00:00
7	*.probe.onyphe.net	2	00:00:03
8	*.172.132.66.censys-scanner.com	4	00:00:38
9	*.195.132.66.censys-scanner.com	2	00:00:30
10	*.155.45.199.censys-scanner.com	3	00:00:05
TOTAL: 10		314	00:02:29

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
93.224.132.66.censys-scanner.com	0.036	0.019	0.000	00:00:30
58.195.132.66.censys-scanner.com	0.039	0.026	0.000	00:00:30
131.172.132.66.censys-scanner.com	0.035	0.014	0.000	00:00:30
mail.gegeweb.eu	4.873	4.280	1.678	00:00:26
azpdesgg8ot1.stretchoid.com	0.052	0.021	0.000	00:00:10
186.172.132.66.censys-scanner.com	0.095	0.072	0.000	00:00:07
84.155.45.199.censys-scanner.com	0.072	0.055	0.000	00:00:05
harry.probe.onyphe.net	0.039	0.009	0.000	00:00:02
r4-119-77.monitoring.internet-measurement.com	0.042	0.008	0.000	00:00:01
112.94.189.158	0.027	0.023	0.000	00:00:00
205.210.31.6	0.028	0.024	0.000	00:00:00
101.195.132.66.censys-scanner.com	0.040	0.025	0.000	00:00:00
104.152.52.242	0.034	0.015	0.000	00:00:00
finch.probe.onyphe.net	0.079	0.028	0.000	00:00:00
69.5.169.138	0.034	0.019	0.000	00:00:00
o329.scanner.modat.io	0.129	0.061	0.000	00:00:00
69.5.169.75	0.030	0.021	0.000	00:00:00
194.165.16.166	0.050	0.012	0.000	00:00:00
o314.scanner.modat.io	0.024	0.028	0.000	00:00:00
TOTAL: 19	5.758	4.760	1.678	00:02:29

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
104.152.52.242	2
186.172.132.66.censys-scanner.com	1
o329.scanner.modat.io	1
azpdesgg8ot1.stretchoid.com	1
101.195.132.66.censys-scanner.com	1
84.155.45.199.censys-scanner.com	1
TOTAL: 6	7

NNRP unrecognized commands (by command):

Command	Count
EHLO www.censys.io	3
HELO	1
MAIL FROM:<relaycheck_please_ignore@prot...	1
MGLNDD_45.13.105.36_119	1
EHLO 45.13.105.36	1
TOTAL: 5	7

NNRP client timeouts [Top 20]:

System	Conn	Peer
84.155.45.199.censys-scanner.com	1	2
69.5.169.75	1	1
186.172.132.66.censys-scanner.com	1	2
TOTAL: 3	3	7

Daily Usenet report for news.niel.me

May 18 04:15:02 -- May 19 04:15:01