Daily Usenet report for news.niel.me: Aug 30 04:15:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Aug 30 08:52:04 rpi-studio innd: filter: No Cancel-Key[sha1:fIITuEscHZYyNqa6pcgU2Pt90tc= sha256:mz1jQxqvW+Q8uF3X4+zCtGWzqq27dPYF5gKziRaLK3k=] matches Cancel-Lock[sha1:PraF+ym2Z44bgStCWt+UJe9aqNw= sha256:FviT44R0L+XNqDswPYnHqbrFlSXIf2svgKXUWhjg3Mc=] target=<1170jmp$3qkj7$6@dont-email.me>

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	2187	26.3%	247.0 KB	19.5%
inn	2049	24.7%	370.0 KB	29.2%
innd	2039	24.6%	345.3 KB	27.3%
innfeed	2025	24.4%	303.1 KB	23.9%
controlchan	1	0.0%	0.1 KB	0.0%
nocem	1	0.0%	0.1 KB	0.0%
TOTAL: 6	8302	100.0%	1.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	7748	52.4%
Negative hits	4995	33.8%
Do not exist	2030	13.7%
Cache misses	1	0.0%
TOTAL: 4	14774	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.006	0.0%	7	0.000	0.857	1.000
article cancel	00:00:00.000	0.0%	7	0.000	0.000	0.000
article cleanup	00:00:00.052	0.0%	2030	0.000	0.026	0.174
article logging	00:00:00.144	0.0%	2032	0.000	0.071	0.667
article parse	00:00:00.294	0.0%	5004	0.000	0.059	0.333
article write	00:00:00.944	0.0%	1842	0.000	0.512	1.429
artlog/artcncl	00:00:00.000	0.0%	7	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.000	0.0%	7	0.000	0.000	0.000
data move	00:00:00.112	0.0%	16075	0.000	0.007	0.056
hisgrep/artcncl	00:00:00.000	0.0%	7	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	7	0.000	0.000	0.000
hisgrep/perl	00:00:00.000	0.0%	8	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	7	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	7	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.273	0.0%	14767	0.000	0.018	0.062
history sync	00:00:00.046	0.0%	362	0.000	0.127	1.000
history write	00:00:00.304	0.0%	2030	0.000	0.150	1.200
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:24.840	100.0%	18056	1386.718	4786.489	54598.545
nntp read	00:00:00.492	0.0%	17177	0.000	0.029	0.200
overview write	00:00:00.565	0.0%	1842	0.000	0.307	3.000
perl filter	00:00:11.700	0.0%	2030	1.286	5.764	37.000
python filter	00:00:00.011	0.0%	2030	0.000	0.005	0.250
site send	00:00:00.715	0.0%	3725	0.000	0.192	0.714
TOTAL: 24:01:03.332	24:00:40.498	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.012	0.0%	1944	0.000	0.006	0.200
article prepare	00:00:00.000	0.0%	172	0.000	0.000	0.000
article read	00:00:00.012	0.0%	43	0.000	0.279	8.000
backlog stats	00:00:00.128	0.0%	23010	0.000	0.006	0.032
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.298	0.0%	11062	0.000	0.027	0.167
data write	00:00:00.558	0.0%	9651	0.000	0.058	0.200
idle	23:58:16.044	100.0%	23010	1445.733	3750.371	11553.365
status file	00:00:07.731	0.0%	401	0.000	19.279	83.000
TOTAL: 23:58:30.223	23:58:24.783	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:41.234	33.5%	1534	0.000	26.880	1980.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.132	0.1%	3572	0.000	0.037	1.000
TOTAL: 00:02:03.004	00:00:41.366	33.6%	-	-	-	-

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	7	1755	896	859	0	51%	23:11:42
2	news.nntp4.net	4	1862	470	1239	153	25%	22:08:57
3	news.glou.org	10	1136	130	986	20	11%	23:06:55
4	nntp.terraraq.uk	10	969	81	883	5	8%	20:25:22
5	news.samoylyk.net	6	1551	78	1472	1	5%	19:58:04
6	usenet.pasdenom.info	19	647	29	617	1	4%	22:42:17
7	gegeweb-out.news.tnetconsulting.net	9	270	6	264	0	2%	09:10:26
8	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 8		90	8190	1690	6320	180	20%	140:43:43

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	feed-out.gegeweb.org	3.3 MB	0.0 KB	3.3 MB	100%	3.7 KB
2	news.nntp4.net	2.2 MB	1.2 MB	3.4 MB	64%	5.5 KB
3	news.samoylyk.net	518.1 KB	1.9 KB	520.1 KB	99%	6.6 KB
4	news.glou.org	458.6 KB	67.5 KB	526.1 KB	87%	3.5 KB
5	nntp.terraraq.uk	432.8 KB	76.9 KB	509.7 KB	84%	5.9 KB
6	usenet.pasdenom.info	86.6 KB	1.3 KB	87.9 KB	98%	2.9 KB
7	gegeweb-out.news.tnetconsulting.net	14.5 KB	0.0 KB	14.5 KB	100%	2.4 KB
8	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 8		6.9 MB	1.3 MB	8.3 MB	83%	4.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 30 04:15:02 - 04:59:59	24	1.3%	0.01	92.7 KB	1.2%	0.03
Aug 30 05:00:00 - 05:59:59	22	1.2%	0.01	70.3 KB	0.9%	0.02
Aug 30 06:00:00 - 06:59:59	11	0.6%	0.00	46.4 KB	0.6%	0.01
Aug 30 07:00:00 - 07:59:59	19	1.0%	0.01	114.0 KB	1.5%	0.03
Aug 30 08:00:00 - 08:59:59	26	1.4%	0.01	82.5 KB	1.1%	0.02
Aug 30 09:00:00 - 09:59:59	69	3.7%	0.02	278.6 KB	3.6%	0.08
Aug 30 10:00:00 - 10:59:59	69	3.7%	0.02	236.2 KB	3.1%	0.07
Aug 30 11:00:00 - 11:59:59	121	6.6%	0.03	503.8 KB	6.5%	0.14
Aug 30 12:00:00 - 12:59:59	80	4.3%	0.02	364.9 KB	4.7%	0.10
Aug 30 13:00:00 - 13:59:59	93	5.0%	0.03	327.6 KB	4.3%	0.09
Aug 30 14:00:00 - 14:59:59	102	5.5%	0.03	398.9 KB	5.2%	0.11
Aug 30 15:00:00 - 15:59:59	88	4.8%	0.02	366.0 KB	4.8%	0.10
Aug 30 16:00:00 - 16:59:59	51	2.8%	0.01	209.9 KB	2.7%	0.06
Aug 30 17:00:00 - 17:59:59	112	6.1%	0.03	755.1 KB	9.8%	0.21
Aug 30 18:00:00 - 18:59:59	139	7.5%	0.04	628.3 KB	8.2%	0.17
Aug 30 19:00:00 - 19:59:59	90	4.9%	0.03	337.1 KB	4.4%	0.09
Aug 30 20:00:00 - 20:59:59	109	5.9%	0.03	407.6 KB	5.3%	0.11
Aug 30 21:00:00 - 21:59:59	103	5.6%	0.03	366.9 KB	4.8%	0.10
Aug 30 22:00:00 - 22:59:59	80	4.3%	0.02	380.3 KB	4.9%	0.11
Aug 30 23:00:00 - 23:59:59	90	4.9%	0.03	289.7 KB	3.8%	0.08
Aug 31 00:00:00 - 00:59:59	70	3.8%	0.02	285.8 KB	3.7%	0.08
Aug 31 01:00:00 - 01:59:59	68	3.7%	0.02	329.5 KB	4.3%	0.09
Aug 31 02:00:00 - 02:59:59	94	5.1%	0.03	473.7 KB	6.2%	0.13
Aug 31 03:00:00 - 03:59:59	91	4.9%	0.03	287.9 KB	3.7%	0.08
Aug 31 04:00:00 - 04:15:01	22	1.2%	0.02	62.2 KB	0.8%	0.07
TOTAL: 23:59:59	1843	100.0%	0.02	7.5 MB	100.0%	0.09

Sites sending bad articles:

Server		Total	Group	Unapp	Other
1	news.nntp4.net	161	104	0	57
2	news.glou.org	20	0	1	19
3	nntp.terraraq.uk	5	0	0	5
4	feed-out.gegeweb.org	2	0	0	2
5	gegeweb-out.news.tnetconsulting.net	2	0	0	2
6	usenet.pasdenom.info	1	0	0	1
7	news.samoylyk.net	1	0	0	1
TOTAL: 7		192	104	1	87

Unwanted newsgroups [Top 20]:

Newsgroup	Count
linux.kernel.netdev	82
linux.kernel.git	22
TOTAL: 2	104

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

Groups	Count
rec.food.recipes	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
Too many newsgroups	52
Bad path (news.giganews.com.POSTED)	30
HTML Multipart	1
No Cancel-Key matches Cancel-Lock. target=<1170jmp$3qkj7$6@dont-email.me>	1
Cancels abusifs	1
TOTAL: 5	85

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	feed-out.gegeweb.org	2
	TOTAL: 1	2
TOTAL: 1		2

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.samoylyk.net	2466	5	1672	37	56	0%	23:28:48
2	news.tnetconsulting.net	3150	1	1841	0	46	0%	23:41:56
3	nntp.terraraq.uk	904	0	877	0	1	0%	22:34:54
4	news.aioe.org	0	0	0	0	1604	0%	23:59:59
5	i2pn.org	0	0	0	0	1840	0%	23:59:59
6	news.gegeweb.org	933	0	909	0	0	0%	22:56:38
7	news.pasdenom.info	1200	0	1162	0	0	0%	23:06:49
8	news.nntp4.net	1342	0	1298	0	0	0%	23:31:08
TOTAL: 8		9995	6	7759	37	3547	0%	187:20:11

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.samoylyk.net	15.9 KB	138.7 KB	154.6 KB	3.7 KB	23:28:48
2	news.tnetconsulting.net	7.7 KB	0.0 KB	7.7 KB	7.7 KB	23:41:56
3	nntp.terraraq.uk	0.0 KB	0.0 KB	0.0 KB	0	22:34:54
4	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	23:59:59
5	i2pn.org	0.0 KB	0.0 KB	0.0 KB	0	23:59:59
6	news.gegeweb.org	0.0 KB	0.0 KB	0.0 KB	0	22:56:38
7	news.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0	23:06:49
8	news.nntp4.net	0.0 KB	0.0 KB	0.0 KB	0	23:31:08
TOTAL: 8		23.6 KB	138.7 KB	162.3 KB	3.8 KB	187:20:11

NNRP readership statistics:

System		Conn	Elapsed
1	r3-36-24.monitoring.internet-measurement.com	2	00:00:01
2	r3-28-1c.monitoring.internet-measurement.com	1	00:00:01
3	r5-56-38.monitoring.internet-measurement.com	1	00:00:00
4	r5-32-20.monitoring.internet-measurement.com	1	00:00:01
5	104.152.52.201	1	00:00:01
6	r4-125-7d.monitoring.internet-measurement.com	1	00:00:00
7	170.186.132.66.censys-scanner.com	3	00:00:02
8	2607:ff10:c8:594::5	1	00:00:02
9	104.152.52.238	1	00:00:01
10	2603:6010:6802:4ca5:1a03:73ff:fe28:be0f	6	00:00:05
11	104.152.52.240	4	00:00:00
12	172-235-41-203.ip.linodeusercontent.com	2	00:00:00
13	r5-63-3f.monitoring.internet-measurement.com	1	00:00:00
14	104.152.52.243	1	00:00:01
15	r5-50-32.monitoring.internet-measurement.com	1	00:00:00
16	r4-23-17.monitoring.internet-measurement.com	1	00:00:00
17	r4-19-13.monitoring.internet-measurement.com	1	00:00:00
18	104.152.52.230	2	00:00:00
19	104.152.52.232	3	00:00:00
20	104.152.52.203	1	00:00:00
21	azpdcsvgr96z.stretchoid.com	2	00:00:00
22	r3-61-3d.monitoring.internet-measurement.com	1	00:00:00
23	147.185.132.242	4	00:00:56
24	r5-37-25.monitoring.internet-measurement.com	2	00:00:01
25	104.152.52.204	1	00:00:03
26	r3-77-4d.monitoring.internet-measurement.com	1	00:00:03
27	104.152.52.231	1	00:00:00
28	104.152.52.237	1	00:00:01
29	81.19.216.123	1	00:00:00
30	mail.gegeweb.eu	288	00:00:37
31	r4-34-22.monitoring.internet-measurement.com	2	00:00:01
32	45-79-207-111.ip.linodeusercontent.com	1	00:00:00
33	147.185.133.33	1	00:00:03
34	45-33-109-8.ip.linodeusercontent.com	1	00:00:00
35	r4-9-9.monitoring.internet-measurement.com	1	00:00:01
36	194-50-235-146.infrawat.ch	1	00:00:00
37	66.61.98.95	6	00:00:09
38	r5-103-67.monitoring.internet-measurement.com	1	00:00:06
39	104.152.52.202	1	00:00:00
40	173-255-221-189.ip.linodeusercontent.com	1	00:00:01
41	r5-133-85.monitoring.internet-measurement.com	1	00:00:00
42	197.172.132.66.censys-scanner.com	1	00:00:01
43	r4-94-5e.monitoring.internet-measurement.com	1	00:00:01
44	r3-127-7f.monitoring.internet-measurement.com	1	00:00:00
TOTAL: 44		357	00:02:37

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.ip.linodeusercontent.com	5	00:00:02
2	*.186.132.66.censys-scanner.com	3	00:00:02
3	?	7	00:00:07
4	*.monitoring.internet-measurement.com	21	00:00:21
5	*.infrawat.ch	1	00:00:00
6	unresolved	29	00:01:23
7	*.gegeweb.eu	288	00:00:37
8	*.stretchoid.com	2	00:00:00
9	*.172.132.66.censys-scanner.com	1	00:00:01
TOTAL: 9		357	00:02:37

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
147.185.132.242	0.429	0.150	0.000	00:00:56
mail.gegeweb.eu	5.131	4.526	1.753	00:00:37
66.61.98.95	0.170	0.126	0.000	00:00:09
r5-103-67.monitoring.internet-measurement.com	0.180	0.049	0.000	00:00:06
2603:6010:6802:4ca5:1a03:73ff:fe28:be0f	0.105	0.149	0.000	00:00:05
104.152.52.204	0.011	0.011	0.000	00:00:03
147.185.133.33	0.064	0.026	0.000	00:00:03
r3-77-4d.monitoring.internet-measurement.com	0.016	0.016	0.000	00:00:03
170.186.132.66.censys-scanner.com	0.074	0.028	0.000	00:00:02
2607:ff10:c8:594::5	0.035	0.015	0.000	00:00:02
r4-94-5e.monitoring.internet-measurement.com	0.033	0.021	0.000	00:00:01
r3-36-24.monitoring.internet-measurement.com	0.094	0.048	0.000	00:00:01
r5-37-25.monitoring.internet-measurement.com	0.147	0.033	0.000	00:00:01
104.152.52.237	0.041	0.008	0.000	00:00:01
104.152.52.243	0.016	0.016	0.000	00:00:01
104.152.52.238	0.031	0.022	0.000	00:00:01
104.152.52.201	0.013	0.013	0.000	00:00:01
197.172.132.66.censys-scanner.com	0.040	0.020	0.000	00:00:01
r4-34-22.monitoring.internet-measurement.com	0.164	0.074	0.000	00:00:01
173-255-221-189.ip.linodeusercontent.com	0.014	0.009	0.000	00:00:01
TOTAL: 43	7.929	5.866	1.753	00:02:37

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
172-235-41-203.ip.linodeusercontent.com	8
147.185.132.242	8
104.152.52.237	5
104.152.52.201	5
147.185.133.33	4
104.152.52.203	2
104.152.52.202	2
104.152.52.232	2
azpdcsvgr96z.stretchoid.com	1
170.186.132.66.censys-scanner.com	1
104.152.52.204	1
197.172.132.66.censys-scanner.com	1
TOTAL: 12	40

NNRP unrecognized commands (by command):

Command	Count
GET / HTTP/1.1	6
Accept: /	5
Host: 45.13.105.36:563	3
Accept-Encoding: gzip	2
User-Agent: curl/7.61.1	2
Connection: close	2
EHLO www.censys.io	2
Host: 45.13.105.36	2
MAIL FROM:<relaycheck_please_ignore@prot...	2
EHLO 45.13.105.36	2
User-Agent: curl/7.68.0	2
Host: 45.13.105.36:119	1
#026#003#001	1
#001	1
Ã:(À\|Ð#022±¡ô!ï4·oÑ}{¿-âì#003#002ž	1
User-Agent: Hello from Palo Alto Network...	1
À#024#023#001#023#002#023#003#001	1
#026#003#001#005Ê#001	1
MGLNDD_45.13.105.36_119	1
SSH-2.0-Go	1
User-Agent: Mozilla/5.0 (Macintosh; Inte...	1
TOTAL: 21	40

NNRP client timeouts [Top 20]:

System	Conn	Peer
147.185.132.242	2	4
81.19.216.123	1	1
170.186.132.66.censys-scanner.com	1	2
TOTAL: 3	4	10

Daily Usenet report for news.niel.me

Aug 30 04:15:02 -- Aug 31 04:15:01