Daily Usenet report for news.niel.me: Sep 21 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Sep 21 22:14:51 rpi-studio innd: filter: No Cancel-Key[sha1:lBZvYgsZcPHnbGtJzCllTFyzLiA= sha256:nvvEkBhWIXvQP0va28w6ienOoDoah0X+7VuFfj92QHg=] matches Cancel-Lock[sha1:NxnPxi5HxHKeI/ksY+c5l6DTtis= sha256:VZ8af1Es1kwJM1J28dtjdU5Osw+E9PvH+MWU9QA05y0=] target=<118s367$a170$1@dont-email.me>

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2601	29.8%	433.0 KB	33.0%
innd	2085	23.9%	354.6 KB	27.0%
nnrpd	2078	23.8%	233.1 KB	17.8%
innfeed	1950	22.4%	290.7 KB	22.2%
nocem	1	0.0%	0.1 KB	0.0%
controlchan	1	0.0%	0.0 KB	0.0%
TOTAL: 6	8716	100.0%	1.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	7508	46.0%
Negative hits	6222	38.1%
Do not exist	2596	15.9%
Cache misses	2	0.0%
TOTAL: 4	16328	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.003	0.0%	2	1.000	1.500	2.000
article cancel	00:00:00.001	0.0%	2	0.000	0.500	1.000
article cleanup	00:00:00.064	0.0%	2596	0.000	0.025	0.250
article logging	00:00:00.227	0.0%	2597	0.000	0.087	0.833
article parse	00:00:00.600	0.0%	8008	0.000	0.075	0.400
article write	00:00:00.941	0.0%	1755	0.000	0.536	2.000
artlog/artcncl	00:00:00.001	0.0%	2	0.000	0.500	1.000
artlog/artcncl/perl	00:00:00.000	0.0%	2	0.000	0.000	0.000
data move	00:00:00.145	0.0%	20746	0.000	0.007	0.048
hisgrep/artcncl	00:00:00.000	0.0%	2	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	2	0.000	0.000	0.000
hisgrep/perl	00:00:00.000	0.0%	3	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	2	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	2	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.295	0.0%	16324	0.000	0.018	0.222
history sync	00:00:00.059	0.0%	359	0.000	0.164	1.000
history write	00:00:00.594	0.0%	2596	0.000	0.229	1.000
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:27.398	100.0%	21790	1354.079	3966.379	50036.917
nntp read	00:00:00.664	0.0%	20992	0.000	0.032	0.143
overview write	00:00:00.597	0.0%	1755	0.000	0.340	3.750
perl filter	00:00:12.828	0.0%	2596	1.618	4.941	19.000
python filter	00:00:00.022	0.0%	2596	0.000	0.008	0.182
site send	00:00:00.851	0.0%	3543	0.000	0.240	0.917
TOTAL: 24:01:05.149	24:00:45.290	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.016	0.0%	1832	0.000	0.009	0.222
article prepare	00:00:00.000	0.0%	28	0.000	0.000	0.000
article read	00:00:00.010	0.0%	7	0.000	1.429	4.000
backlog stats	00:00:00.137	0.0%	21753	0.000	0.006	0.034
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.280	0.0%	10549	0.000	0.027	0.154
data write	00:00:00.560	0.0%	8894	0.000	0.063	0.333
idle	23:59:23.621	100.0%	21753	1676.615	3970.194	11124.444
status file	00:00:09.034	0.0%	375	0.000	24.091	83.000
TOTAL: 23:59:38.084	23:59:33.658	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:49.380	44.6%	1492	11.000	33.097	10008.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.110	0.1%	3528	0.000	0.031	1.000
TOTAL: 00:01:50.653	00:00:49.490	44.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	1763	601	1162	0	34%	23:42:41
2	news.samoylyk.net	4	1500	442	1058	0	29%	18:47:57
3	news.nntp4.net	3	2541	439	1305	797	17%	23:16:57
4	news.glou.org	10	779	88	671	20	11%	15:51:54
5	nntp.terraraq.uk	9	608	60	548	0	9%	14:29:15
6	usenet.pasdenom.info	21	676	12	664	0	1%	24:08:57
7	gegeweb-out.news.tnetconsulting.net	7	608	5	603	0	0%	14:37:46
8	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 8		84	8475	1647	6011	817	19%	134:55:27

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.samoylyk.net	3.8 MB	0.0 KB	3.8 MB	100%	8.8 KB
2	feed-out.gegeweb.org	1.9 MB	0.0 KB	1.9 MB	100%	3.3 KB
3	news.nntp4.net	1.8 MB	8.4 MB	10.2 MB	17%	8.5 KB
4	news.glou.org	276.2 KB	59.9 KB	336.1 KB	82%	3.1 KB
5	nntp.terraraq.uk	185.6 KB	0.0 KB	185.6 KB	100%	3.1 KB
6	usenet.pasdenom.info	23.9 KB	0.0 KB	23.9 KB	100%	2.0 KB
7	gegeweb-out.news.tnetconsulting.net	11.4 KB	0.0 KB	11.4 KB	100%	2.3 KB
8	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 8		8.1 MB	8.4 MB	16.5 MB	48%	6.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 21 04:15:01 - 04:59:59	27	1.5%	0.01	171.4 KB	2.0%	0.06
Sep 21 05:00:00 - 05:59:59	23	1.3%	0.01	92.2 KB	1.1%	0.03
Sep 21 06:00:00 - 06:59:59	20	1.1%	0.01	81.5 KB	0.9%	0.02
Sep 21 07:00:00 - 07:59:59	32	1.8%	0.01	101.8 KB	1.2%	0.03
Sep 21 08:00:00 - 08:59:59	36	2.1%	0.01	132.6 KB	1.5%	0.04
Sep 21 09:00:00 - 09:59:59	63	3.6%	0.02	286.5 KB	3.3%	0.08
Sep 21 10:00:00 - 10:59:59	82	4.7%	0.02	384.1 KB	4.4%	0.11
Sep 21 11:00:00 - 11:59:59	71	4.0%	0.02	927.1 KB	10.7%	0.26
Sep 21 12:00:00 - 12:59:59	106	6.0%	0.03	310.7 KB	3.6%	0.09
Sep 21 13:00:00 - 13:59:59	114	6.5%	0.03	428.6 KB	5.0%	0.12
Sep 21 14:00:00 - 14:59:59	62	3.5%	0.02	226.4 KB	2.6%	0.06
Sep 21 15:00:00 - 15:59:59	161	9.2%	0.04	1.1 MB	13.5%	0.32
Sep 21 16:00:00 - 16:59:59	64	3.6%	0.02	208.3 KB	2.4%	0.06
Sep 21 17:00:00 - 17:59:59	102	5.8%	0.03	636.6 KB	7.4%	0.18
Sep 21 18:00:00 - 18:59:59	99	5.6%	0.03	390.2 KB	4.5%	0.11
Sep 21 19:00:00 - 19:59:59	115	6.6%	0.03	536.2 KB	6.2%	0.15
Sep 21 20:00:00 - 20:59:59	117	6.7%	0.03	550.4 KB	6.4%	0.15
Sep 21 21:00:00 - 21:59:59	109	6.2%	0.03	480.6 KB	5.6%	0.13
Sep 21 22:00:00 - 22:59:59	66	3.8%	0.02	311.1 KB	3.6%	0.09
Sep 21 23:00:00 - 23:59:59	75	4.3%	0.02	505.8 KB	5.9%	0.14
Sep 22 00:00:00 - 00:59:59	79	4.5%	0.02	314.5 KB	3.6%	0.09
Sep 22 01:00:00 - 01:59:59	53	3.0%	0.01	161.0 KB	1.9%	0.04
Sep 22 02:00:00 - 02:59:59	34	1.9%	0.01	110.5 KB	1.3%	0.03
Sep 22 03:00:00 - 03:59:59	32	1.8%	0.01	86.5 KB	1.0%	0.02
Sep 22 04:00:00 - 04:15:01	13	0.7%	0.01	39.9 KB	0.5%	0.04
TOTAL: 24:00:00	1755	100.0%	0.02	8.4 MB	100.0%	0.10

Sites sending bad articles:

Server		Total	Group	Other
1	news.nntp4.net	817	687	130
2	news.glou.org	21	0	21
3	nntp.terraraq.uk	3	0	3
4	feed-out.gegeweb.org	1	0	1
TOTAL: 4		842	687	155

Unwanted newsgroups [Top 20]:

Newsgroup	Count
linux.kernel.netdev	644
linux.kernel.git	43
TOTAL: 2	687

INND Perl filter [Top 20]:

Reason	Count
Too many newsgroups	128
Bad path (news.giganews.com.POSTED)	25
No Cancel-Key matches Cancel-Lock. target=<118s367$a170$1@dont-email.me>	1
TOTAL: 3	154

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.tnetconsulting.net	3056	2	1742	4	77	0%	23:43:49
2	news.samoylyk.net	1311	1	1195	0	0	0%	23:30:17
3	news.aioe.org	0	0	0	0	1403	0%	24:00:00
4	news.pasdenom.info	1169	0	1127	0	0	0%	23:31:50
5	nntp.terraraq.uk	912	0	877	0	0	0%	23:22:46
6	i2pn.org	0	0	0	0	1745	0%	24:00:00
7	news.nntp4.net	1343	0	1295	0	0	0%	23:20:22
8	news.gegeweb.org	1196	0	1164	0	0	0%	23:18:53
TOTAL: 8		8987	3	7400	4	3225	0%	188:47:57

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.tnetconsulting.net	3.4 KB	22.6 KB	26.0 KB	4.3 KB	23:43:49
2	news.samoylyk.net	2.8 KB	0.0 KB	2.8 KB	2.8 KB	23:30:17
3	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	24:00:00
4	news.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0	23:31:50
5	nntp.terraraq.uk	0.0 KB	0.0 KB	0.0 KB	0	23:22:46
6	i2pn.org	0.0 KB	0.0 KB	0.0 KB	0	24:00:00
7	news.nntp4.net	0.0 KB	0.0 KB	0.0 KB	0	23:20:22
8	news.gegeweb.org	0.0 KB	0.0 KB	0.0 KB	0	23:18:53
TOTAL: 8		6.2 KB	22.6 KB	28.8 KB	4.1 KB	188:47:57

NNRP readership statistics:

System		Conn	Elapsed
1	104.152.52.101	2	00:00:00
2	o013.scanner.modat.io	1	00:00:00
3	16.5.0.242	1	00:00:03
4	2a01:4020:31:0:102::509	1	00:00:00
5	104.152.52.106	1	00:00:00
6	72-14-178-148.ip.linodeusercontent.com	1	00:00:00
7	104.152.52.117	2	00:00:01
8	185-223-235-38.infrawat.ch	1	00:00:00
9	173-255-221-189.ip.linodeusercontent.com	1	00:00:00
10	69-164-214-31.ip.linodeusercontent.com	11	00:00:00
11	222.211.203.35.bc.googleusercontent.com	1	00:00:00
12	200.186.132.66.censys-scanner.com	3	00:00:02
13	104.152.52.118	1	00:00:01
14	o058.scanner.modat.io	1	00:00:00
15	40.124.176.147	2	00:00:10
16	45-33-14-5.ip.linodeusercontent.com	1	00:00:00
17	104.152.52.103	5	00:00:02
18	69-5-169-182.infrawat.ch	1	00:00:00
19	2603:6010:6802:4ca5:1a03:73ff:fe28:be0f	4	00:00:04
20	201.172.132.66.censys-scanner.com	3	00:00:04
21	r5-244-f4.monitoring.internet-measurement.com	1	00:00:01
22	36.255.97.195	2	00:00:08
23	o021.scanner.modat.io	1	00:00:30
24	soda.census.shodan.io	1	00:00:00
25	2a01:4020:2:b:101::7	1	00:00:00
26	194.187.176.58	1	00:00:06
27	45-33-12-122.ip.linodeusercontent.com	2	00:00:00
28	mail.gegeweb.eu	288	00:00:24
29	173-255-225-15.ip.linodeusercontent.com	2	00:00:00
30	104.152.52.123	2	00:00:00
TOTAL: 30		345	00:01:50

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.ip.linodeusercontent.com	18	00:00:03
2	*.infrawat.ch	2	00:00:00
3	*.186.132.66.censys-scanner.com	3	00:00:02
4	*.211.203.35.bc.googleusercontent.com	1	00:00:00
5	*.scanner.modat.io	3	00:00:30
6	?	6	00:00:04
7	unresolved	19	00:00:36
8	*.census.shodan.io	1	00:00:00
9	*.gegeweb.eu	288	00:00:24
10	*.172.132.66.censys-scanner.com	3	00:00:04
11	*.monitoring.internet-measurement.com	1	00:00:01
TOTAL: 11		345	00:01:50

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
o021.scanner.modat.io	0.034	0.030	0.000	00:00:30
mail.gegeweb.eu	5.038	4.661	1.704	00:00:24
40.124.176.147	0.050	0.042	0.000	00:00:10
36.255.97.195	0.064	0.020	0.000	00:00:08
194.187.176.58	0.027	0.018	0.000	00:00:06
2603:6010:6802:4ca5:1a03:73ff:fe28:be0f	0.117	0.080	0.000	00:00:04
201.172.132.66.censys-scanner.com	0.053	0.049	0.000	00:00:04
16.5.0.242	0.024	0.028	0.000	00:00:03
200.186.132.66.censys-scanner.com	0.082	0.056	0.000	00:00:02
104.152.52.103	0.130	0.056	0.000	00:00:02
r5-244-f4.monitoring.internet-measurement.com	0.028	0.024	0.000	00:00:01
104.152.52.117	0.056	0.017	0.000	00:00:01
104.152.52.118	0.011	0.015	0.000	00:00:01
72-14-178-148.ip.linodeusercontent.com	0.023	0.027	0.000	00:00:00
69-164-214-31.ip.linodeusercontent.com	0.233	0.101	0.000	00:00:00
104.152.52.101	0.069	0.004	0.000	00:00:00
soda.census.shodan.io	0.028	0.021	0.000	00:00:00
173-255-221-189.ip.linodeusercontent.com	0.034	0.013	0.000	00:00:00
173-255-225-15.ip.linodeusercontent.com	0.050	0.024	0.000	00:00:00
69-5-169-182.infrawat.ch	0.022	0.027	0.000	00:00:00
TOTAL: 30	6.624	5.528	1.704	00:01:50

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
104.152.52.103	5
173-255-225-15.ip.linodeusercontent.com	5
222.211.203.35.bc.googleusercontent.com	4
104.152.52.101	2
40.124.176.147	1
200.186.132.66.censys-scanner.com	1
201.172.132.66.censys-scanner.com	1
TOTAL: 7	19

NNRP unrecognized commands (by command):

Command	Count
GET / HTTP/1.1	3
Accept-Encoding: gzip	2
EHLO www.censys.io	2
Accept: /	2
Host: 45.13.105.36:563	2
Connection: close	1
Host: 45.13.105.36	1
EHLO 45.13.105.36	1
User-Agent: Hello from Palo Alto Network...	1
MAIL FROM:<relaycheck_please_ignore@prot...	1
MGLNDD_45.13.105.36_119	1
User-Agent: curl/7.61.1	1
User-Agent: Mozilla/5.0 (Macintosh; Inte...	1
TOTAL: 13	19

NNRP client timeouts [Top 20]:

System	Conn	Peer
185-223-235-38.infrawat.ch	1	1
200.186.132.66.censys-scanner.com	1	2
2a01:4020:31:0:102::509	1	1
201.172.132.66.censys-scanner.com	1	2
TOTAL: 4	4	10

Daily Usenet report for news.niel.me

Sep 21 04:15:01 -- Sep 22 04:15:01