Daily Usenet report for news.niel.me: Feb 3 04:15:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Feb 4 01:06:56 rpi-studio innd: filter: No Cancel-Key[sha1:nPImNNMqKx2T9aMTKsU6B5pR5yA= sha256:YQgyGr5oxGtiHjjFKlwoR+DvUh+Vyg4HOTnw2mg5g7Q=] matches Cancel-Lock[sha1:oXb4d03hRY54QmzLoAQytCc1HYM= sha256:mIDlCgGqKzlthwEZClRfnQeiE+XUaTVTMJO0zRkpz/Y=] target=<10lu2f4$1664j$1@gwaiyur.mb-net.net>

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2127	26.9%	369.7 KB	30.6%
nnrpd	1988	25.1%	229.4 KB	19.0%
innd	1940	24.5%	338.4 KB	28.0%
innfeed	1850	23.4%	272.2 KB	22.5%
nocem	1	0.0%	0.2 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	7907	100.0%	1.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	7819	52.3%
Negative hits	5030	33.6%
Do not exist	2112	14.1%
Cache misses	2	0.0%
TOTAL: 4	14963	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.008	0.0%	6	1.000	1.333	2.000
article cancel	00:00:00.004	0.0%	7	0.000	0.571	2.000
article cleanup	00:00:00.039	0.0%	2113	0.000	0.018	0.174
article logging	00:00:00.180	0.0%	2113	0.000	0.085	0.500
article parse	00:00:00.418	0.0%	6079	0.000	0.069	0.222
article write	00:00:00.951	0.0%	1625	0.000	0.585	2.000
artlog/artcncl	00:00:00.000	0.0%	7	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.123	0.0%	18023	0.000	0.007	0.042
hisgrep/artcncl	00:00:00.001	0.0%	7	0.000	0.143	1.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	6	0.000	0.000	0.000
hisgrep/perl	00:00:00.001	0.0%	7	0.000	0.143	0.500
hishave/artcncl	00:00:00.000	0.0%	7	0.000	0.000	0.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.241	0.0%	14961	0.000	0.016	0.073
history sync	00:00:00.044	0.0%	350	0.000	0.126	1.000
history write	00:00:00.403	0.0%	2113	0.000	0.191	0.545
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:45.077	100.0%	19431	1432.883	4448.823	27288.727
nntp read	00:00:00.538	0.0%	18641	0.000	0.029	0.085
overview write	00:00:00.539	0.0%	1625	0.000	0.332	2.600
perl filter	00:00:08.638	0.0%	2113	1.684	4.088	15.000
python filter	00:00:00.008	0.0%	2113	0.000	0.004	0.250
site send	00:00:00.723	0.0%	3346	0.000	0.216	0.538
TOTAL: 24:01:04.492	24:00:57.936	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.020	0.0%	1643	0.000	0.012	0.333
article prepare	00:00:00.000	0.0%	56	0.000	0.000	0.000
article read	00:00:00.012	0.0%	14	0.000	0.857	8.000
backlog stats	00:00:00.142	0.0%	22194	0.000	0.006	0.063
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.306	0.0%	10499	0.000	0.029	0.091
data write	00:00:00.567	0.0%	8860	0.000	0.064	0.160
idle	23:57:22.961	100.0%	22194	1213.261	3885.868	9237.154
status file	00:00:01.794	0.0%	297	0.000	6.040	86.000
TOTAL: 23:57:29.341	23:57:25.802	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:45.818	45.8%	1498	0.000	30.586	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.122	0.1%	3373	0.000	0.036	0.500
TOTAL: 00:01:39.940	00:00:45.940	46.0%	-	-	-	-

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	news.nntp4.net	2	2009	553	1017	439	27%	22:18:11
2	feed-out.gegeweb.org	3	1599	541	1058	0	33%	23:59:00
3	news.samoylyk.net	1	1425	203	1221	1	14%	20:37:56
4	nntp.terraraq.uk	4	2420	116	2292	12	4%	41:33:48
5	gegeweb-out.news.tnetconsulting.net	5	2133	99	2030	4	4%	40:10:46
6	usenet.pasdenom.info	6	965	15	950	0	1%	27:37:13
7	localhost	25	0	0	0	0	0%	00:00:00
8	news.glou.org	2	120	0	116	4	0%	03:55:59
TOTAL: 8		48	10671	1527	8684	460	14%	180:12:53

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.nntp4.net	3.1 MB	4.2 MB	7.3 MB	42%	7.5 KB
2	feed-out.gegeweb.org	1.7 MB	0.0 KB	1.7 MB	100%	3.2 KB
3	nntp.terraraq.uk	1.6 MB	140.5 KB	1.7 MB	92%	13.7 KB
4	news.samoylyk.net	1.1 MB	2.5 KB	1.1 MB	99%	5.6 KB
5	gegeweb-out.news.tnetconsulting.net	554.9 KB	10.0 KB	564.8 KB	98%	5.5 KB
6	usenet.pasdenom.info	32.9 KB	0.0 KB	32.9 KB	100%	2.2 KB
7	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
8	news.glou.org	0.0 KB	10.2 KB	10.2 KB	0%	2.6 KB
TOTAL: 8		8.1 MB	4.4 MB	12.4 MB	64%	6.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 3 04:15:02 - 04:59:59	20	1.2%	0.01	121.2 KB	1.5%	0.04
Feb 3 05:00:00 - 05:59:59	35	2.2%	0.01	277.7 KB	3.3%	0.08
Feb 3 06:00:00 - 06:59:59	45	2.8%	0.01	223.9 KB	2.7%	0.06
Feb 3 07:00:00 - 07:59:59	34	2.1%	0.01	157.7 KB	1.9%	0.04
Feb 3 08:00:00 - 08:59:59	30	1.8%	0.01	190.2 KB	2.3%	0.05
Feb 3 09:00:00 - 09:59:59	75	4.6%	0.02	372.6 KB	4.5%	0.10
Feb 3 10:00:00 - 10:59:59	51	3.1%	0.01	270.6 KB	3.3%	0.08
Feb 3 11:00:00 - 11:59:59	55	3.4%	0.02	311.9 KB	3.8%	0.09
Feb 3 12:00:00 - 12:59:59	49	3.0%	0.01	220.2 KB	2.7%	0.06
Feb 3 13:00:00 - 13:59:59	75	4.6%	0.02	324.5 KB	3.9%	0.09
Feb 3 14:00:00 - 14:59:59	57	3.5%	0.02	278.7 KB	3.4%	0.08
Feb 3 15:00:00 - 15:59:59	89	5.5%	0.02	511.6 KB	6.2%	0.14
Feb 3 16:00:00 - 16:59:59	102	6.3%	0.03	409.1 KB	4.9%	0.11
Feb 3 17:00:00 - 17:59:59	97	6.0%	0.03	506.7 KB	6.1%	0.14
Feb 3 18:00:00 - 18:59:59	107	6.6%	0.03	517.8 KB	6.2%	0.14
Feb 3 19:00:00 - 19:59:59	80	4.9%	0.02	343.9 KB	4.1%	0.10
Feb 3 20:00:00 - 20:59:59	84	5.2%	0.02	446.3 KB	5.4%	0.12
Feb 3 21:00:00 - 21:59:59	83	5.1%	0.02	341.7 KB	4.1%	0.09
Feb 3 22:00:00 - 22:59:59	104	6.4%	0.03	663.6 KB	8.0%	0.18
Feb 3 23:00:00 - 23:59:59	70	4.3%	0.02	429.5 KB	5.2%	0.12
Feb 4 00:00:00 - 00:59:59	98	6.0%	0.03	469.8 KB	5.7%	0.13
Feb 4 01:00:00 - 01:59:59	52	3.2%	0.01	243.6 KB	2.9%	0.07
Feb 4 02:00:00 - 02:59:59	72	4.4%	0.02	423.0 KB	5.1%	0.12
Feb 4 03:00:00 - 03:59:59	47	2.9%	0.01	213.5 KB	2.6%	0.06
Feb 4 04:00:00 - 04:15:01	15	0.9%	0.02	34.4 KB	0.4%	0.04
TOTAL: 23:59:59	1626	100.0%	0.02	8.1 MB	100.0%	0.10

Sites sending bad articles:

Server		Total	Group	Other
1	news.nntp4.net	463	347	116
2	news.glou.org	24	0	24
3	news.samoylyk.net	1	0	1
TOTAL: 3		488	347	141

Unwanted newsgroups [Top 20]:

Newsgroup	Count
linux.kernel.netdev	273
linux.kernel.git	73
news.test	1
TOTAL: 3	347

INND Perl filter [Top 20]:

Reason	Count
Too many newsgroups	63
Bad path (news.giganews.com.POSTED)	57
EMP (phn path)	19
Cancels abusifs	2
TOTAL: 4	141

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.tnetconsulting.net	2917	9	1611	4	18	0%	23:57:41
2	news.samoylyk.net	1542	1	1325	0	0	0%	23:59:55
3	i2pn.org	0	0	0	0	1605	0%	23:59:59
4	news.aioe.org	0	0	0	0	1397	0%	23:59:59
5	news.pasdenom.info	1285	0	1156	0	0	0%	23:59:51
6	nntp.terraraq.uk	943	0	892	0	0	0%	23:28:13
7	news.nntp4.net	1080	0	1024	0	0	0%	22:39:50
8	news.gegeweb.org	1155	0	1068	0	0	0%	23:59:50
TOTAL: 8		8922	10	7076	4	3020	0%	190:05:18

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.tnetconsulting.net	21.1 KB	27.0 KB	48.1 KB	3.7 KB	23:57:41
2	news.samoylyk.net	5.5 KB	0.0 KB	5.5 KB	5.5 KB	23:59:55
3	i2pn.org	0.0 KB	0.0 KB	0.0 KB	0	23:59:59
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:59:51
6	nntp.terraraq.uk	0.0 KB	0.0 KB	0.0 KB	0	23:28:13
7	news.nntp4.net	0.0 KB	0.0 KB	0.0 KB	0	22:39:50
8	news.gegeweb.org	0.0 KB	0.0 KB	0.0 KB	0	23:59:50
TOTAL: 8		26.6 KB	27.0 KB	53.6 KB	3.8 KB	190:05:18

NNRP readership statistics:

System		Conn	Elapsed
1	52.188.189.7	2	00:00:10
2	o320.scanner.modat.io	1	00:00:00
3	66.61.98.95	6	00:00:04
4	2a06:4882:3000::46	1	00:00:02
5	205.210.31.186	1	00:00:04
6	157.149.216.162.bc.googleusercontent.com	1	00:00:00
7	2600:3c01::2000:e9ff:fe12:455e	1	00:00:01
8	205.210.31.48	1	00:00:03
9	113.153.132.66.censys-scanner.com	1	00:00:01
10	mail.gegeweb.eu	288	00:00:26
11	2603:6010:6800:36:1a03:73ff:fe28:be0f	8	00:00:13
12	107.149.216.162.bc.googleusercontent.com	1	00:00:00
13	o321.scanner.modat.io	4	00:00:00
14	86.150.216.162.bc.googleusercontent.com	2	00:00:01
15	n33.scanner.modat.io	4	00:00:01
16	ec2-44-248-127-199.us-west-2.compute.amazonaws.com	1	00:00:01
17	147.185.132.163	2	00:00:30
18	194.165.16.163	1	00:00:00
TOTAL: 18		326	00:01:45

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	unresolved	13	00:00:54
2	*.us-west-2.compute.amazonaws.com	1	00:00:01
3	*.gegeweb.eu	288	00:00:26
4	?	10	00:00:17
5	*.150.216.162.bc.googleusercontent.com	2	00:00:01
6	*.scanner.modat.io	9	00:00:01
7	*.149.216.162.bc.googleusercontent.com	2	00:00:01
8	*.153.132.66.censys-scanner.com	1	00:00:01
TOTAL: 8		326	00:01: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
147.185.132.163	0.239	0.059	0.000	00:00:30
mail.gegeweb.eu	5.041	4.264	1.638	00:00:26
2603:6010:6800:36:1a03:73ff:fe28:be0f	0.220	0.132	0.000	00:00:13
52.188.189.7	0.042	0.057	0.000	00:00:10
205.210.31.186	0.013	0.009	0.000	00:00:04
66.61.98.95	0.154	0.099	0.000	00:00:04
205.210.31.48	0.008	0.013	0.000	00:00:03
2a06:4882:3000::46	0.032	0.017	0.000	00:00:02
86.150.216.162.bc.googleusercontent.com	0.156	0.032	0.000	00:00:01
2600:3c01::2000:e9ff:fe12:455e	0.034	0.013	0.000	00:00:01
113.153.132.66.censys-scanner.com	0.012	0.016	0.000	00:00:01
n33.scanner.modat.io	0.084	0.046	0.000	00:00:01
ec2-44-248-127-199.us-west-2.compute.amazonaws.com	0.030	0.015	0.000	00:00:01
194.165.16.163	0.018	0.004	0.000	00:00:00
157.149.216.162.bc.googleusercontent.com	0.059	0.021	0.000	00:00:00
107.149.216.162.bc.googleusercontent.com	0.087	0.004	0.000	00:00:00
o321.scanner.modat.io	0.081	0.047	0.000	00:00:00
o320.scanner.modat.io	0.036	0.013	0.000	00:00:00
TOTAL: 18	6.346	4.861	1.638	00:01:45

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
147.185.132.163	4
86.150.216.162.bc.googleusercontent.com	4
107.149.216.162.bc.googleusercontent.com	4
157.149.216.162.bc.googleusercontent.com	4
n33.scanner.modat.io	1
194.165.16.163	1
113.153.132.66.censys-scanner.com	1
52.188.189.7	1
TOTAL: 8	20

NNRP unrecognized commands (by command):

Command	Count
Host: 45.13.105.36:563	4
GET / HTTP/1.1	4
Accept-Encoding: gzip	2
Accept: /	2
User-Agent: Hello from Palo Alto Network...	2
User-Agent: curl/7.68.0	2
HELO	1
MGLNDD_45.13.105.36_119	1
#003	1
EHLO www.censys.io	1
TOTAL: 10	20

NNRP client timeouts [Top 20]:

System	Conn	Peer
86.150.216.162.bc.googleusercontent.com	1	2
147.185.132.163	1	2
194.165.16.163	1	1
TOTAL: 3	3	7

Daily Usenet report for news.niel.me

Feb 3 04:15:02 -- Feb 4 04:15:01