Daily Usenet report for news.niel.me: Oct 13 04:15:02

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Oct 13 08:03:08 rpi-studio innd: filter: No Cancel-Key[sha1:OXcTeUuOUMRH7HV0sK3VrA9EP4g= sha256:hXynLUTw/zIWtz97nM/2qHvMKWj0LrWhFFnVbqdXyJo=] matches Cancel-Lock[sha1:nefVnE8UHNmztb8B8m2nS0hnLNk= sha256:64xOlBIkteuy1OsH+O7tVP+CM8o/DS2g9QS6Em38+Fk=] target=<aolsfaq-1-1791007381@therockgarden.ca>
Oct 13 21:33:18 rpi-studio innd: filter: No Cancel-Key[sha1:bMEoRQCSnK4aUQj6RX8CWFPb+ik= sha256:CORdsRdck0r5lpGkIHQOmy25k7yDRY8/8P9oWbBCsWc=] matches Cancel-Lock[sha1:hZeIeQ3E2nY+XE7IEkChkAKSw4s= sha256:fAnWH5om4LRaXxucG/+HX46ndtNVQRfxhHXaS+ZMIwE=] target=<20261013121745.571@kylheku.com>

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2687	29.5%	457.8 KB	33.2%
nnrpd	2396	26.3%	292.7 KB	21.2%
innd	2072	22.8%	346.5 KB	25.1%
innfeed	1949	21.4%	282.5 KB	20.5%
controlchan	1	0.0%	0.2 KB	0.0%
nocem	1	0.0%	0.1 KB	0.0%
TOTAL: 6	9106	100.0%	1.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	8878	48.9%
Negative hits	6605	36.4%
Do not exist	2669	14.7%
Cache misses	2	0.0%
TOTAL: 4	18154	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.008	0.0%	8	1.000	1.000	1.000
article cancel	00:00:00.002	0.0%	9	0.000	0.222	1.000
article cleanup	00:00:00.075	0.0%	2691	0.000	0.028	0.333
article logging	00:00:00.232	0.0%	2691	0.000	0.086	0.500
article parse	00:00:00.601	0.0%	8108	0.000	0.074	0.250
article write	00:00:01.024	0.0%	1957	0.000	0.523	1.200
artlog/artcncl	00:00:00.001	0.0%	9	0.000	0.111	1.000
artlog/artcncl/perl	00:00:00.000	0.0%	8	0.000	0.000	0.000
data move	00:00:00.141	0.0%	22524	0.000	0.006	0.050
hisgrep/artcncl	00:00:00.000	0.0%	9	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	8	0.000	0.000	0.000
hisgrep/perl	00:00:00.002	0.0%	10	0.000	0.200	1.000
hishave/artcncl	00:00:00.001	0.0%	9	0.000	0.111	1.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.305	0.0%	18270	0.000	0.017	0.059
history sync	00:00:00.048	0.0%	355	0.000	0.135	1.000
history write	00:00:00.546	0.0%	2691	0.000	0.203	1.000
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:30.704	100.0%	23947	1024.874	3609.250	50026.167
nntp read	00:00:00.655	0.0%	23207	0.000	0.028	0.125
overview write	00:00:00.687	0.0%	1957	0.000	0.351	3.500
perl filter	00:00:13.340	0.0%	2691	1.684	4.957	31.500
python filter	00:00:00.022	0.0%	2691	0.000	0.008	0.200
site send	00:00:00.893	0.0%	3965	0.000	0.225	0.750
TOTAL: 24:01:06.925	24:00:49.287	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.017	0.0%	2007	0.000	0.008	0.143
article prepare	00:00:00.000	0.0%	24	0.000	0.000	0.000
article read	00:00:00.010	0.0%	6	0.000	1.667	8.000
backlog stats	00:00:00.158	0.0%	24567	0.000	0.006	0.045
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.295	0.0%	12312	0.000	0.024	0.167
data write	00:00:00.553	0.0%	10405	0.000	0.053	0.167
idle	23:49:50.856	100.0%	24567	1314.276	3492.118	9876.672
status file	00:00:06.791	0.0%	360	0.000	18.864	83.000
TOTAL: 23:50:02.243	23:49:58.680	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:36.633	26.0%	1466	7.800	24.988	9771.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.118	0.1%	3400	0.000	0.035	1.000
TOTAL: 00:02:20.771	00:00:36.751	26.1%	-	-	-	-

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	1962	588	1374	0	29%	23:52:23
2	news.samoylyk.net	3	1849	490	1358	1	26%	22:38:54
3	news.nntp4.net	2	2564	463	1432	669	18%	22:08:01
4	news.glou.org	5	3035	215	2766	54	7%	47:51:01
5	nntp.terraraq.uk	6	338	49	277	12	14%	08:23:59
6	usenet.pasdenom.info	11	815	31	783	1	3%	23:41:45
7	gegeweb-out.news.tnetconsulting.net	6	305	4	298	3	1%	07:58:53
8	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 8		63	10868	1840	8288	740	16%	156:34:56

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.samoylyk.net	2.9 MB	3.5 KB	2.9 MB	99%	6.1 KB
2	feed-out.gegeweb.org	2.0 MB	0.0 KB	2.0 MB	100%	3.6 KB
3	news.nntp4.net	1.8 MB	8.3 MB	10.2 MB	17%	9.2 KB
4	news.glou.org	638.7 KB	273.6 KB	912.2 KB	70%	3.4 KB
5	nntp.terraraq.uk	141.6 KB	23.3 KB	164.9 KB	85%	2.7 KB
6	usenet.pasdenom.info	76.4 KB	1.2 KB	77.7 KB	98%	2.4 KB
7	gegeweb-out.news.tnetconsulting.net	11.4 KB	9.8 KB	21.2 KB	53%	3.0 KB
8	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 8		7.6 MB	8.6 MB	16.2 MB	46%	6.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 13 04:15:02 - 04:59:59	28	1.4%	0.01	119.8 KB	1.5%	0.04
Oct 13 05:00:00 - 05:59:59	36	1.8%	0.01	158.7 KB	2.0%	0.04
Oct 13 06:00:00 - 06:59:59	21	1.1%	0.01	115.0 KB	1.4%	0.03
Oct 13 07:00:00 - 07:59:59	33	1.7%	0.01	140.9 KB	1.7%	0.04
Oct 13 08:00:00 - 08:59:59	47	2.4%	0.01	155.8 KB	1.9%	0.04
Oct 13 09:00:00 - 09:59:59	93	4.8%	0.03	378.1 KB	4.6%	0.11
Oct 13 10:00:00 - 10:59:59	67	3.4%	0.02	348.6 KB	4.3%	0.10
Oct 13 11:00:00 - 11:59:59	106	5.4%	0.03	438.8 KB	5.4%	0.12
Oct 13 12:00:00 - 12:59:59	97	5.0%	0.03	352.6 KB	4.3%	0.10
Oct 13 13:00:00 - 13:59:59	59	3.0%	0.02	177.6 KB	2.2%	0.05
Oct 13 14:00:00 - 14:59:59	88	4.5%	0.02	251.3 KB	3.1%	0.07
Oct 13 15:00:00 - 15:59:59	166	8.5%	0.05	769.8 KB	9.5%	0.21
Oct 13 16:00:00 - 16:59:59	95	4.9%	0.03	537.2 KB	6.6%	0.15
Oct 13 17:00:00 - 17:59:59	111	5.7%	0.03	375.5 KB	4.6%	0.10
Oct 13 18:00:00 - 18:59:59	96	4.9%	0.03	356.8 KB	4.4%	0.10
Oct 13 19:00:00 - 19:59:59	107	5.5%	0.03	496.2 KB	6.1%	0.14
Oct 13 20:00:00 - 20:59:59	167	8.6%	0.05	834.4 KB	10.3%	0.23
Oct 13 21:00:00 - 21:59:59	97	5.0%	0.03	455.2 KB	5.6%	0.13
Oct 13 22:00:00 - 22:59:59	59	3.0%	0.02	209.7 KB	2.6%	0.06
Oct 13 23:00:00 - 23:59:59	120	6.2%	0.03	411.7 KB	5.1%	0.11
Oct 14 00:00:00 - 00:59:59	88	4.5%	0.02	397.2 KB	4.9%	0.11
Oct 14 01:00:00 - 01:59:59	80	4.1%	0.02	353.7 KB	4.3%	0.10
Oct 14 02:00:00 - 02:59:59	45	2.3%	0.01	158.8 KB	2.0%	0.04
Oct 14 03:00:00 - 03:59:59	36	1.8%	0.01	129.4 KB	1.6%	0.04
Oct 14 04:00:00 - 04:15:01	4	0.2%	0.00	10.9 KB	0.1%	0.01
TOTAL: 23:59:59	1946	100.0%	0.02	7.9 MB	100.0%	0.09

Sites sending bad articles:

Server		Total	Group	Other
1	news.nntp4.net	681	519	162
2	news.glou.org	27	0	27
3	nntp.terraraq.uk	9	0	9
4	gegeweb-out.news.tnetconsulting.net	4	0	4
5	news.samoylyk.net	2	0	2
6	usenet.pasdenom.info	1	0	1
TOTAL: 6		724	519	205

Unwanted newsgroups [Top 20]:

Newsgroup	Count
linux.kernel.netdev	440
linux.kernel.git	79
TOTAL: 2	519

INND Perl filter [Top 20]:

Reason	Count
Too many newsgroups	159
Bad path (news.giganews.com.POSTED)	44
Cancels abusifs	1
No Cancel-Key matches Cancel-Lock. target=<20261013121745.571@kylheku.com>	1
TOTAL: 4	205

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.tnetconsulting.net	3452	2	1940	3	62	0%	23:52:35
2	nntp.terraraq.uk	1012	1	972	0	0	0%	23:09:22
3	news.gegeweb.org	1516	0	1366	0	1	0%	23:42:00
4	news.aioe.org	0	0	0	0	1507	0%	23:59:59
5	news.pasdenom.info	1435	0	1402	0	0	0%	23:41:06
6	i2pn.org	0	0	0	0	1942	0%	23:59:59
7	news.samoylyk.net	1603	0	1370	0	0	0%	23:39:16
8	news.nntp4.net	1500	0	1432	0	0	0%	23:36:12
TOTAL: 8		10518	3	8482	3	3512	0%	189:40:29

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.tnetconsulting.net	3.5 KB	93.9 KB	97.4 KB	19.5 KB	23:52:35
2	nntp.terraraq.uk	2.0 KB	0.0 KB	2.0 KB	2.0 KB	23:09:22
3	news.gegeweb.org	0.0 KB	0.0 KB	0.0 KB	0	23:42:00
4	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	23:59:59
5	news.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0	23:41:06
6	i2pn.org	0.0 KB	0.0 KB	0.0 KB	0	23:59:59
7	news.samoylyk.net	0.0 KB	0.0 KB	0.0 KB	0	23:39:16
8	news.nntp4.net	0.0 KB	0.0 KB	0.0 KB	0	23:36:12
TOTAL: 8		5.5 KB	93.9 KB	99.4 KB	16.6 KB	189:40:29

NNRP readership statistics:

System		Conn	Elapsed
1	mail.gegeweb.eu	288	00:00:22
2	r5-199-c7.monitoring.internet-measurement.com	1	00:00:03
3	198.235.24.167	1	00:00:00
4	104.152.52.122	1	00:00:00
5	elisha.probe.onyphe.net	1	00:00:03
6	o005.scanner.modat.io	1	00:00:00
7	r5-71-47.monitoring.internet-measurement.com	1	00:00:00
8	r3-136-88.monitoring.internet-measurement.com	1	00:00:00
9	194-50-235-146.infrawat.ch	1	00:00:00
10	198.235.24.33	1	00:00:00
11	r3-16-10.monitoring.internet-measurement.com	1	00:00:01
12	r5-145-91.monitoring.internet-measurement.com	1	00:00:00
13	r3-5-5.monitoring.internet-measurement.com	1	00:00:00
14	5-226-140-89.infrawat.ch	1	00:00:00
15	o033.scanner.modat.io	1	00:00:29
16	104.152.52.121	3	00:00:06
17	r4-22-16.monitoring.internet-measurement.com	1	00:00:00
18	r5-22-16.monitoring.internet-measurement.com	1	00:00:01
19	o003.scanner.modat.io	1	00:00:00
20	r4-27-1b.monitoring.internet-measurement.com	1	00:00:01
21	r5-73-49.monitoring.internet-measurement.com	2	00:00:00
22	sonia.probe.onyphe.net	1	00:00:00
23	azpdsghh1jc0.stretchoid.com	1	00:00:09
24	96-126-106-7.ip.linodeusercontent.com	85	00:00:16
25	r3-19-13.monitoring.internet-measurement.com	1	00:00:00
26	tori.probe.onyphe.net	1	00:00:00
27	2a01:4020:1:1:102::524	1	00:00:00
28	r5-56-38.monitoring.internet-measurement.com	1	00:00:00
29	r3-117-75.monitoring.internet-measurement.com	1	00:00:00
30	r3-21-15.monitoring.internet-measurement.com	1	00:00:00
31	r4-14-e.monitoring.internet-measurement.com	1	00:00:01
32	50.150.216.162.bc.googleusercontent.com	2	00:00:46
33	r4-2-2.monitoring.internet-measurement.com	1	00:00:01
34	r5-186-ba.monitoring.internet-measurement.com	1	00:00:04
35	jenna.probe.onyphe.net	1	00:00:02
36	195-206-182-200.infrawat.ch	1	00:00:01
37	r4-8-8.monitoring.internet-measurement.com	1	00:00:00
38	r5-33-21.monitoring.internet-measurement.com	1	00:00:00
39	69-5-169-160.infrawat.ch	1	00:00:00
40	2a01:4020:2:b:103::74e	1	00:00:00
41	233.224.132.66.censys-scanner.com	1	00:00:03
42	r4-31-1f.monitoring.internet-measurement.com	1	00:00:00
TOTAL: 42		417	00:02:45

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.infrawat.ch	4	00:00:03
2	*.stretchoid.com	1	00:00:09
3	*.probe.onyphe.net	4	00:00:06
4	?	2	00:00:00
5	unresolved	6	00:00:07
6	*.monitoring.internet-measurement.com	21	00:00:18
7	*.ip.linodeusercontent.com	85	00:00:16
8	*.gegeweb.eu	288	00:00:22
9	*.224.132.66.censys-scanner.com	1	00:00:03
10	*.150.216.162.bc.googleusercontent.com	2	00:00:46
11	*.scanner.modat.io	3	00:00:30
TOTAL: 11		417	00:02:45

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
50.150.216.162.bc.googleusercontent.com	0.341	0.078	0.000	00:00:46
o033.scanner.modat.io	0.044	0.018	0.000	00:00:29
mail.gegeweb.eu	5.187	4.512	1.735	00:00:22
96-126-106-7.ip.linodeusercontent.com	3.051	1.028	0.000	00:00:16
azpdsghh1jc0.stretchoid.com	0.032	0.020	0.000	00:00:09
104.152.52.121	0.035	0.034	0.000	00:00:06
r5-186-ba.monitoring.internet-measurement.com	0.076	0.004	0.000	00:00:04
233.224.132.66.censys-scanner.com	0.039	0.027	0.000	00:00:03
r5-199-c7.monitoring.internet-measurement.com	0.039	0.026	0.000	00:00:03
elisha.probe.onyphe.net	0.016	0.031	0.000	00:00:03
jenna.probe.onyphe.net	0.058	0.015	0.000	00:00:02
r4-14-e.monitoring.internet-measurement.com	0.014	0.009	0.000	00:00:01
195-206-182-200.infrawat.ch	0.014	0.010	0.000	00:00:01
r3-16-10.monitoring.internet-measurement.com	0.170	0.040	0.000	00:00:01
r5-22-16.monitoring.internet-measurement.com	0.082	0.010	0.000	00:00:01
r4-2-2.monitoring.internet-measurement.com	0.058	0.034	0.000	00:00:01
r4-27-1b.monitoring.internet-measurement.com	0.078	0.018	0.000	00:00:01
tori.probe.onyphe.net	0.027	0.023	0.000	00:00:00
194-50-235-146.infrawat.ch	0.036	0.020	0.000	00:00:00
r4-8-8.monitoring.internet-measurement.com	0.071	0.023	0.000	00:00:00
TOTAL: 40	10.225	6.347	1.735	00:02:45

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
104.152.52.121	6
50.150.216.162.bc.googleusercontent.com	4
tori.probe.onyphe.net	2
104.152.52.122	2
233.224.132.66.censys-scanner.com	1
TOTAL: 5	15

NNRP unrecognized commands (by command):

Command	Count
Accept: /	2
GET / HTTP/1.1	2
User-Agent: curl/7.68.0	1
Host: 45.13.105.36	1
SSH-2.0-Go	1
#026#003#003#002a#001	1
Host: 45.13.105.36:563	1
EHLO 45.13.105.36	1
Connection: close	1
À$ÀÀ¯À,ÀrÀsÌ©#023#002#023#001Ì#024À#007À#022À#023À'À/À#024À(À0À`Àa...	1
User-Agent: curl/7.61.1	1
EHLO www.censys.io	1
MAIL FROM:<relaycheck_please_ignore@prot...	1
TOTAL: 13	15

NNRP client timeouts [Top 20]:

System	Conn	Peer
50.150.216.162.bc.googleusercontent.com	1	2
2a01:4020:1:1:102::524	1	1
69-5-169-160.infrawat.ch	1	1
TOTAL: 3	3	8

Daily Usenet report for news.niel.me

Oct 13 04:15:02 -- Oct 14 04:15:01