Daily Usenet report for news.niel.me: Jul 5 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jul 6 01:30:02 rpi-studio innd: filter: No Cancel-Key[sha1:vS6uulPYjdQcvGDyG4cjtSQwHzc=] matches Cancel-Lock[sha1:mEP4HCEtJGQace0H74GOAATdOdU=] target=<de-gruppen-finden-29.06.2024@dnqmail.priggish.de>

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2624	29.8%	493.6 KB	34.9%
innd	2250	25.5%	378.5 KB	26.7%
nnrpd	2170	24.6%	241.7 KB	17.1%
innfeed	1769	20.1%	302.0 KB	21.3%
controlchan	1	0.0%	0.2 KB	0.0%
nocem	1	0.0%	0.1 KB	0.0%
TOTAL: 6	8815	100.0%	1.4 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	14195	58.0%
Negative hits	7662	31.3%
Do not exist	2597	10.6%
Cache misses	3	0.0%
TOTAL: 4	24457	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.021	0.0%	12	0.000	1.750	2.600
article cancel	00:00:00.003	0.0%	13	0.000	0.231	1.000
article cleanup	00:00:00.068	0.0%	2598	0.000	0.026	0.182
article logging	00:00:00.189	0.0%	2598	0.000	0.073	0.375
article parse	00:00:00.318	0.0%	6098	0.000	0.052	0.238
article write	00:00:01.161	0.0%	2267	0.143	0.512	1.048
artlog/artcncl	00:00:00.000	0.0%	13	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.003	0.0%	12	0.000	0.250	1.000
data move	00:00:00.135	0.0%	25683	0.000	0.005	0.022
hisgrep/artcncl	00:00:00.001	0.0%	13	0.000	0.077	0.200
hisgrep/artcncl/perl	00:00:00.000	0.0%	12	0.000	0.000	0.000
hisgrep/perl	00:00:00.001	0.0%	22	0.000	0.045	1.000
hishave/artcncl	00:00:00.000	0.0%	13	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	12	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.366	0.0%	24441	0.000	0.015	0.065
history sync	00:00:00.042	0.0%	358	0.000	0.117	1.000
history write	00:00:00.495	0.0%	2598	0.000	0.191	0.611
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:38.130	100.0%	28659	1333.124	3016.090	14636.537
nntp read	00:00:00.724	0.0%	27776	0.000	0.026	0.128
overview write	00:00:00.911	0.0%	2267	0.000	0.402	4.000
perl filter	00:00:11.183	0.0%	2598	2.739	4.304	9.333
python filter	00:00:00.016	0.0%	2598	0.000	0.006	0.182
site send	00:00:00.916	0.0%	4619	0.000	0.198	0.529
TOTAL: 24:01:03.173	24:00:54.683	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.021	0.0%	2275	0.000	0.009	0.143
article prepare	00:00:00.004	0.0%	680	0.000	0.006	0.250
article read	00:00:00.030	0.0%	165	0.000	0.182	3.000
backlog stats	00:00:00.161	0.0%	34399	0.000	0.005	0.023
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.423	0.0%	18680	0.000	0.023	0.088
data write	00:00:00.873	0.0%	16494	0.000	0.053	0.107
idle	23:58:47.730	100.0%	34399	1116.200	2509.600	9094.985
status file	00:00:00.411	0.0%	212	0.000	1.939	6.000
TOTAL: 23:58:54.065	23:58:49.653	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:01:27.249	35.9%	1838	7.500	47.470	3194.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.148	0.1%	4508	0.000	0.033	1.000
readart	00:00:00.027	0.0%	177	0.153	0.153	0.153
TOTAL: 00:04:03.344	00:01:27.424	35.9%	-	-	-	-

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	2	2169	878	1291	0	40%	23:59:24
2	i2pn.org	2	2479	282	2194	3	11%	25:56:33
3	gegeweb-out.news.tnetconsulting.net	2	1775	275	1458	42	15%	22:08:25
4	news.samoylyk.net	1	1756	243	1508	5	13%	19:39:50
5	news.nntp4.net	2	2463	221	2154	88	8%	24:38:05
6	usenet.pasdenom.info	2	1754	122	1596	36	6%	23:59:11
7	news.glou.org	1	2196	87	1962	147	3%	25:04:50
8	nntp.terraraq.uk	1	2340	77	2263	0	3%	23:59:55
9	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 9		38	16932	2185	14426	321	12%	189:26:13

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	feed-out.gegeweb.org	2.7 MB	0.0 KB	2.7 MB	100%	3.1 KB
2	news.samoylyk.net	1.5 MB	24.5 KB	1.5 MB	98%	6.1 KB
3	news.nntp4.net	905.3 KB	328.1 KB	1.2 MB	73%	4.0 KB
4	i2pn.org	812.7 KB	6.1 KB	818.8 KB	99%	2.9 KB
5	gegeweb-out.news.tnetconsulting.net	794.3 KB	139.5 KB	933.8 KB	85%	2.9 KB
6	nntp.terraraq.uk	348.4 KB	0.0 KB	348.4 KB	100%	4.5 KB
7	news.glou.org	321.0 KB	580.4 KB	901.4 KB	35%	3.9 KB
8	usenet.pasdenom.info	291.8 KB	53.0 KB	344.8 KB	84%	2.2 KB
9	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 9		7.5 MB	1.1 MB	8.6 MB	87%	3.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jul 5 04:15:01 - 04:59:59	44	1.9%	0.02	119.2 KB	1.5%	0.04
Jul 5 05:00:00 - 05:59:59	69	3.0%	0.02	218.3 KB	2.8%	0.06
Jul 5 06:00:00 - 06:59:59	45	2.0%	0.01	161.6 KB	2.1%	0.04
Jul 5 07:00:00 - 07:59:59	54	2.4%	0.01	173.8 KB	2.3%	0.05
Jul 5 08:00:00 - 08:59:59	49	2.2%	0.01	134.7 KB	1.7%	0.04
Jul 5 09:00:00 - 09:59:59	94	4.1%	0.03	331.4 KB	4.3%	0.09
Jul 5 10:00:00 - 10:59:59	74	3.3%	0.02	209.7 KB	2.7%	0.06
Jul 5 11:00:00 - 11:59:59	97	4.3%	0.03	325.8 KB	4.2%	0.09
Jul 5 12:00:00 - 12:59:59	88	3.9%	0.02	253.8 KB	3.3%	0.07
Jul 5 13:00:00 - 13:59:59	98	4.3%	0.03	251.7 KB	3.3%	0.07
Jul 5 14:00:00 - 14:59:59	98	4.3%	0.03	428.3 KB	5.6%	0.12
Jul 5 15:00:00 - 15:59:59	114	5.0%	0.03	309.2 KB	4.0%	0.09
Jul 5 16:00:00 - 16:59:59	130	5.7%	0.04	381.4 KB	4.9%	0.11
Jul 5 17:00:00 - 17:59:59	119	5.2%	0.03	350.9 KB	4.6%	0.10
Jul 5 18:00:00 - 18:59:59	129	5.7%	0.04	364.2 KB	4.7%	0.10
Jul 5 19:00:00 - 19:59:59	140	6.2%	0.04	532.4 KB	6.9%	0.15
Jul 5 20:00:00 - 20:59:59	120	5.3%	0.03	351.9 KB	4.6%	0.10
Jul 5 21:00:00 - 21:59:59	133	5.9%	0.04	436.3 KB	5.7%	0.12
Jul 5 22:00:00 - 22:59:59	133	5.9%	0.04	406.0 KB	5.3%	0.11
Jul 5 23:00:00 - 23:59:59	110	4.9%	0.03	435.4 KB	5.6%	0.12
Jul 6 00:00:00 - 00:59:59	99	4.4%	0.03	323.3 KB	4.2%	0.09
Jul 6 01:00:00 - 01:59:59	76	3.4%	0.02	525.7 KB	6.8%	0.15
Jul 6 02:00:00 - 02:59:59	63	2.8%	0.02	250.5 KB	3.2%	0.07
Jul 6 03:00:00 - 03:59:59	77	3.4%	0.02	320.1 KB	4.2%	0.09
Jul 6 04:00:00 - 04:15:01	15	0.7%	0.02	114.7 KB	1.5%	0.13
TOTAL: 24:00:00	2268	100.0%	0.03	7.5 MB	100.0%	0.09

Sites sending bad articles:

Server		Total	Other
1	news.glou.org	146	146
2	news.nntp4.net	87	87
3	gegeweb-out.news.tnetconsulting.net	69	69
4	usenet.pasdenom.info	19	19
5	news.samoylyk.net	5	5
6	i2pn.org	3	3
7	nntp.terraraq.uk	2	2
TOTAL: 7		331	331

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	170
Bad path (news.giganews.com.POSTED)	78
Too many newsgroups	53
EMP (md5)	16
HTML Multipart	3
Cancels abusifs	2
Cancel of <11db98e6a8953d24a460b9c098ce7b06eaad048c@i2pn2.org> without Cancel-Key	1
Cancel of <ae9d4d421b72dbce100e45530d6fca748f0b7989@i2pn2.org> without Cancel-Key	1
Cancel of <2e0953353dc7759e12d1903bc8291cf49ebbcb9b@i2pn2.org> without Cancel-Key	1
Cancel of <fcd5232ab58006305a0a3683fd8574ebdc649eb5@i2pn2.org> without Cancel-Key	1
Cancel of <6672fbe8b04a4f557f05033b6272005a5b99b6e8@i2pn2.org> without Cancel-Key	1
Cancel of <ea9c855981e685e3272b0f96e600148a76f88131@i2pn2.org> without Cancel-Key	1
Cancel of <MPG.40f29d04edef511998a474@news.individual.net> without Cancel-Key	1
Cancel of <54a0699410604411cae6974b3a4f1de1f024dd65@i2pn2.org> without Cancel-Key	1
Cancel of <0334ba357755df84ea3b615f58623dbdc81ff85f@i2pn2.org> without Cancel-Key	1
TOTAL: 15	331

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.gegeweb.org	1470	75	1310	0	0	5%	23:58:08
2	i2pn.org	3267	74	1966	5	4	2%	23:59:57
3	news.tnetconsulting.net	3648	10	2254	2	3	0%	23:59:35
4	nntp.terraraq.uk	1540	2	1440	0	0	0%	23:54:23
5	news.samoylyk.net	2267	1	1961	0	0	0%	23:58:06
6	news.aioe.org	0	0	0	0	1859	0%	24:00:00
7	news.pasdenom.info	2141	0	1915	1	0	0%	23:59:57
8	news.nntp4.net	2134	0	2044	0	0	0%	23:59:23
TOTAL: 8		16467	162	12890	8	1866	0%	191:49:29

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.gegeweb.org	243.6 KB	0.0 KB	243.6 KB	3.2 KB	23:58:08
2	i2pn.org	182.8 KB	42.5 KB	225.3 KB	2.9 KB	23:59:57
3	news.tnetconsulting.net	25.4 KB	5.4 KB	30.8 KB	2.6 KB	23:59:35
4	nntp.terraraq.uk	4.3 KB	0.0 KB	4.3 KB	2.2 KB	23:54:23
5	news.samoylyk.net	1.6 KB	0.0 KB	1.6 KB	1.6 KB	23:58:06
6	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	24:00:00
7	news.pasdenom.info	0.0 KB	1.4 KB	1.4 KB	1.4 KB	23:59:57
8	news.nntp4.net	0.0 KB	0.0 KB	0.0 KB	0	23:59:23
TOTAL: 8		457.7 KB	49.3 KB	507.0 KB	3.0 KB	191:49:29

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	69.10.48.174	4	177	309.4 KB	9	0	0	00:00:45
TOTAL: 1		4	177	309.4 KB	9	0	0	00:04:02

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	11	177	309.4 KB	9	00:01:24
2	*.150.216.162.bc.googleusercontent.com	2	0	0.0 KB	0	00:00:01
3	*.monitoring.internet-measurement.com	1	0	0.0 KB	0	00:00:01
4	*.ip.linodeusercontent.com	106	0	0.0 KB	0	00:00:22
5	*.210.203.35.bc.googleusercontent.com	1	0	0.0 KB	0	00:00:00
6	*.gegeweb.eu	288	0	0.0 KB	0	00:02:10
TOTAL: 6		409	177	309.4 KB	9	00:04:02

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
mail.gegeweb.eu	4.355	4.135	1.488	00:02:10
69.10.48.174	0.132	0.181	0.000	00:00:45
47.91.30.193	0.032	0.008	0.000	00:00:29
172-104-137-47.ip.linodeusercontent.com	2.689	1.686	0.000	00:00:21
199.45.154.129	0.062	0.074	0.000	00:00:06
206.168.34.126	0.031	0.031	0.000	00:00:02
light.monitoring.internet-measurement.com	0.016	0.037	0.000	00:00:01
50.150.216.162.bc.googleusercontent.com	0.063	0.020	0.000	00:00:01
61.210.203.35.bc.googleusercontent.com	0.041	0.014	0.000	00:00:00
242.150.216.162.bc.googleusercontent.com	0.069	0.017	0.000	00:00:00
172-232-203-249.ip.linodeusercontent.com	0.016	0.008	0.000	00:00:00
45.227.254.49	0.017	0.010	0.000	00:00:00
80.66.76.130	0.012	0.012	0.000	00:00:00
?	0.012	0.008	0.000	00:00:00
TOTAL: 14	7.547	6.241	1.488	00:04:02

Curious NNRP server explorers [Top 20]:

System	Conn
mail.gegeweb.eu	288
172-104-137-47.ip.linodeusercontent.com	105
199.45.154.129	3
light.monitoring.internet-measurement.com	1
172-232-203-249.ip.linodeusercontent.com	1
206.168.34.126	1
242.150.216.162.bc.googleusercontent.com	1
47.91.30.193	1
45.227.254.49	1
61.210.203.35.bc.googleusercontent.com	1
50.150.216.162.bc.googleusercontent.com	1
80.66.76.130	1
TOTAL: 12	405

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
47.91.30.193	4
242.150.216.162.bc.googleusercontent.com	4
50.150.216.162.bc.googleusercontent.com	4
61.210.203.35.bc.googleusercontent.com	4
80.66.76.130	1
199.45.154.129	1
206.168.34.126	1
TOTAL: 7	19

NNRP unrecognized commands (by command):

Command	Count
GET / HTTP/1.1	4
Host: 45.13.105.36:563	3
Accept-Encoding: gzip	3
User-Agent: Expanse, a Palo Alto Network...	3
EHLO www.censys.io	2
Accept: /	1
User-Agent: curl/7.64.1	1
#003	1
Host: 45.13.105.36:119	1
TOTAL: 9	19

NNRP client timeouts [Top 20]:

System	Conn	Peer
80.66.76.130	1	1
199.45.154.129	1	2
TOTAL: 2	2	3

Newsgroup request counts (by category):

Category		Count	Pct
1	grisbi	132	74.6%
2	local	45	25.4%
TOTAL: 2		177	100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

Newsgroup		Count
1	local.test	23
2	grisbi.cvs	22
3	grisbi.user.french	22
4	grisbi.devel	22
5	local.gegeweb.support	22
6	grisbi.bugsreports	22
7	grisbi.test	22
8	grisbi.user	20
9	grisbi.admin	2
TOTAL: 9		177

Daily Usenet report for news.niel.me

Jul 5 04:15:01 -- Jul 6 04:15:01