Daily Usenet report for news.niel.me: Nov 24 04:15:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Nov 25 01:30:02 rpi-studio innd: filter: No Cancel-Key[sha1:vYlSxd1o6rI38thwCBfVwRkkxhM=] matches Cancel-Lock[sha1:uywl/HE2lFW0ilpAWmWPwa+W7cE=] target=<de-gruppen-finden-18.11.2023@dnqmail.priggish.de>

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	54181	71.8%	9.7 MB	78.5%
innd	17129	22.7%	2.1 MB	16.9%
innfeed	2305	3.1%	386.7 KB	3.0%
nnrpd	1803	2.4%	196.3 KB	1.5%
controlchan	16	0.0%	2.5 KB	0.0%
nocem	5	0.0%	0.9 KB	0.0%
TOTAL: 6	75439	100.0%	12.4 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	63579	38.8%
Do not exist	53929	32.9%
Positive hits	46314	28.3%
Cache misses	5	0.0%
TOTAL: 4	163827	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.009	0.0%	12	0.000	0.750	1.000
article cancel	00:00:00.002	0.0%	13	0.000	0.154	1.000
article cleanup	00:00:01.084	0.0%	54163	0.000	0.020	0.052
article logging	00:00:04.195	0.0%	54163	0.028	0.077	0.133
article parse	00:00:15.165	0.0%	294384	0.028	0.052	0.080
article write	00:00:39.160	0.0%	39339	0.591	0.995	2.307
artlog/artcncl	00:00:00.001	0.0%	13	0.000	0.077	1.000
artlog/artcncl/perl	00:00:00.000	0.0%	12	0.000	0.000	0.000
data move	00:00:02.533	0.0%	475067	0.002	0.005	0.009
hisgrep/artcncl	00:00:00.000	0.0%	13	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	12	0.000	0.000	0.000
hisgrep/perl	00:00:00.004	0.0%	13	0.000	0.308	4.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:03.195	0.0%	164512	0.006	0.019	0.038
history sync	00:00:00.052	0.0%	379	0.000	0.137	1.000
history write	00:00:12.591	0.0%	54163	0.114	0.232	0.347
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:54:19.645	99.5%	403653	126.553	213.202	633.337
nntp read	00:00:12.313	0.0%	403307	0.020	0.031	0.048
overview write	00:00:12.046	0.0%	39339	0.142	0.306	5.067
perl filter	00:03:39.189	0.3%	54163	3.063	4.047	5.523
python filter	00:00:00.254	0.0%	54163	0.000	0.005	0.015
site send	00:00:10.401	0.0%	80141	0.044	0.130	0.227
TOTAL: 24:00:52.342	23:59:51.839	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.356	0.0%	39361	0.000	0.009	0.026
article prepare	00:00:00.120	0.0%	31032	0.000	0.004	0.042
article read	00:00:00.915	0.0%	5394	0.000	0.170	1.000
backlog stats	00:00:02.844	0.0%	637291	0.001	0.004	0.008
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:10.386	0.0%	427749	0.013	0.024	0.039
data write	00:00:17.327	0.0%	338829	0.040	0.051	0.070
idle	23:40:52.076	99.9%	637291	74.481	133.773	359.787
status file	00:00:00.522	0.0%	223	0.000	2.341	9.000
TOTAL: 23:41:53.402	23:41:24.546	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:01:10.396	45.0%	1454	19.000	48.415	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.089	0.1%	3206	0.000	0.028	0.273
TOTAL: 00:02:36.372	00:01:10.485	45.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
rmgroup	4
TOTAL: 12	175

Newsgroups removed:

Group
fr.lettres.langue.allemande
fr.lettres.langue.arabe
fr.lettres.langue.espagnole
fr.lettres.langues-slaves
TOTAL: 4

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
control@usenet-fr.news.eu.org	0	4	1	0	5	5
TOTAL	0	4	1	0	5	5

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	news.nntp4.net	6	52607	20777	18760	13070	39%	24:29:11
2	news.glou.org	11	21184	15984	3844	1356	75%	24:18:50
3	feed-out.gegeweb.org	7	3209	1111	2098	0	34%	24:01:47
4	nntp.terraraq.uk	6	10708	689	9713	306	6%	22:32:48
5	gegeweb-out.news.tnetconsulting.net	2	3457	255	3118	84	7%	28:50:45
6	usenet.pasdenom.info	5	2206	253	1948	5	11%	22:51:44
7	news.samoylyk.net	2	5903	35	5868	0	0%	40:11:10
8	i2pn.org	1	206	16	190	0	7%	01:53:47
9	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 9		65	99480	39120	45539	14821	39%	189:10:02

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.nntp4.net	184.8 MB	105.0 MB	289.9 MB	63%	8.8 KB
2	news.glou.org	157.3 MB	7.0 MB	164.4 MB	95%	9.7 KB
3	feed-out.gegeweb.org	14.6 MB	0.0 KB	14.6 MB	100%	13.5 KB
4	nntp.terraraq.uk	4.3 MB	1.9 MB	6.2 MB	68%	6.4 KB
5	usenet.pasdenom.info	1.3 MB	15.9 KB	1.3 MB	98%	5.1 KB
6	gegeweb-out.news.tnetconsulting.net	704.3 KB	275.7 KB	980.1 KB	71%	2.9 KB
7	news.samoylyk.net	356.8 KB	0.0 KB	356.8 KB	100%	10.2 KB
8	i2pn.org	283.8 KB	0.0 KB	283.8 KB	100%	17.7 KB
9	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 9		363.7 MB	114.3 MB	478.0 MB	76%	9.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 24 04:15:02 - 04:59:59	980	2.5%	0.36	9.7 MB	2.6%	3.66
Nov 24 05:00:00 - 05:59:59	1396	3.5%	0.39	12.2 MB	3.3%	3.46
Nov 24 06:00:00 - 06:59:59	1676	4.3%	0.47	15.0 MB	4.1%	4.28
Nov 24 07:00:00 - 07:59:59	1811	4.6%	0.50	16.9 MB	4.6%	4.81
Nov 24 08:00:00 - 08:59:59	2108	5.4%	0.59	20.4 MB	5.5%	5.79
Nov 24 09:00:00 - 09:59:59	2543	6.5%	0.71	24.3 MB	6.6%	6.90
Nov 24 10:00:00 - 10:59:59	2345	6.0%	0.65	23.1 MB	6.3%	6.56
Nov 24 11:00:00 - 11:59:59	2292	5.8%	0.64	20.1 MB	5.5%	5.72
Nov 24 12:00:00 - 12:59:59	2046	5.2%	0.57	15.4 MB	4.2%	4.39
Nov 24 13:00:00 - 13:59:59	2135	5.4%	0.59	19.2 MB	5.2%	5.47
Nov 24 14:00:00 - 14:59:59	2219	5.6%	0.62	21.3 MB	5.8%	6.06
Nov 24 15:00:00 - 15:59:59	2051	5.2%	0.57	22.5 MB	6.1%	6.40
Nov 24 16:00:00 - 16:59:59	1851	4.7%	0.51	20.2 MB	5.5%	5.74
Nov 24 17:00:00 - 17:59:59	1764	4.5%	0.49	19.4 MB	5.3%	5.53
Nov 24 18:00:00 - 18:59:59	1723	4.4%	0.48	17.9 MB	4.9%	5.08
Nov 24 19:00:00 - 19:59:59	1457	3.7%	0.40	15.4 MB	4.2%	4.37
Nov 24 20:00:00 - 20:59:59	1267	3.2%	0.35	12.7 MB	3.5%	3.62
Nov 24 21:00:00 - 21:59:59	935	2.4%	0.26	7.4 MB	2.0%	2.10
Nov 24 22:00:00 - 22:59:59	975	2.5%	0.27	7.0 MB	1.9%	1.98
Nov 24 23:00:00 - 23:59:59	853	2.2%	0.24	5.8 MB	1.6%	1.66
Nov 25 00:00:00 - 00:59:59	1058	2.7%	0.29	8.2 MB	2.2%	2.34
Nov 25 01:00:00 - 01:59:59	1092	2.8%	0.30	8.8 MB	2.4%	2.51
Nov 25 02:00:00 - 02:59:59	935	2.4%	0.26	7.2 MB	2.0%	2.06
Nov 25 03:00:00 - 03:59:59	1416	3.6%	0.39	13.1 MB	3.6%	3.71
Nov 25 04:00:00 - 04:15:01	408	1.0%	0.45	4.4 MB	1.2%	4.98
TOTAL: 23:59:59	39336	100.0%	0.46	367.4 MB	100.0%	4.35

Sites sending bad articles:

Server		Total	Group	Other
1	news.nntp4.net	13064	18	13046
2	news.glou.org	1375	0	1375
3	nntp.terraraq.uk	331	0	331
4	gegeweb-out.news.tnetconsulting.net	44	0	44
5	usenet.pasdenom.info	6	0	6
TOTAL: 5		14820	18	14802

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fr.lettres.langue.allemande	15
fr.petites-annonces.informatique.materiel	2
fr.education.superieur	1
TOTAL: 3	18

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	14449
EMP (phl)	150
Too many newsgroups	119
Bad path (news.giganews.com.POSTED)	61
EMP (phn path)	16
Cancel for rejected article	6
Cancels abusifs	1
TOTAL: 7	14802

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	nntp.terraraq.uk	46059	1559	34731	1382	6	3%	23:59:46
2	news.nntp4.net	26759	881	17667	3	5	3%	23:59:46
3	i2pn.org	63562	103	36617	2405	413	0%	23:59:42
4	news.samoylyk.net	59982	31	38462	821	95	0%	23:59:45
5	news.tnetconsulting.net	59845	19	38733	580	26	0%	23:59:46
6	news.pasdenom.info	45549	1	38846	10	5	0%	23:59:07
7	news.gegeweb.org	38900	0	38209	0	0	0%	23:59:46
8	news.aioe.org	0	0	0	0	5557	0%	23:59:39
TOTAL: 8		340656	2594	243265	5201	6107	0%	191:57:17

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	nntp.terraraq.uk	18.1 MB	12.0 MB	30.1 MB	0.4 KB/s	10.5 KB	23:59:46
2	news.nntp4.net	10.6 MB	39.1 KB	10.6 MB	0.1 KB/s	12.3 KB	23:59:46
3	i2pn.org	1.0 MB	24.6 MB	25.6 MB	0.3 KB/s	10.5 KB	23:59:42
4	news.tnetconsulting.net	156.1 KB	6.9 MB	7.1 MB	0.1 KB/s	12.1 KB	23:59:46
5	news.samoylyk.net	137.0 KB	9.3 MB	9.4 MB	0.1 KB/s	11.3 KB	23:59:45
6	news.pasdenom.info	24.9 KB	73.1 KB	97.9 KB	0.0 KB/s	8.9 KB	23:59:07
7	news.gegeweb.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:46
8	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:39
TOTAL: 8		30.0 MB	52.9 MB	82.9 MB	0.1 KB/s	10.9 KB	191:57:17

NNRP readership statistics:

System		Conn	Elapsed
1	cool.monitoring.internet-measurement.com	1	00:00:05
2	2604:a880:2:d0::4d:b001	2	00:00:04
3	192.241.226.25	1	00:00:01
4	celebrated.monitoring.internet-measurement.com	1	00:00:00
5	194.165.16.76	1	00:00:00
6	fortunate.monitoring.internet-measurement.com	1	00:00:00
7	buoyant.monitoring.internet-measurement.com	1	00:00:03
8	192.241.235.26	1	00:00:09
9	sky.census.shodan.io	1	00:00:01
10	128.14.237.130	3	00:00:11
11	staunch.monitoring.internet-measurement.com	1	00:00:00
12	mail.gegeweb.eu	288	00:01:58
TOTAL: 12		302	00:02:35

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	unresolved	6	00:00:22
2	?	2	00:00:04
3	*.gegeweb.eu	288	00:01:58
4	*.census.shodan.io	1	00:00:01
5	*.monitoring.internet-measurement.com	5	00:00:09
TOTAL: 5		302	00:02:35

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.479	4.438	1.638	00:01:58
128.14.237.130	0.027	0.044	0.000	00:00:11
192.241.235.26	0.016	0.008	0.000	00:00:09
cool.monitoring.internet-measurement.com	0.042	0.019	0.000	00:00:05
2604:a880:2:d0::4d:b001	0.037	0.041	0.000	00:00:04
buoyant.monitoring.internet-measurement.com	0.025	0.027	0.000	00:00:03
sky.census.shodan.io	0.021	0.032	0.000	00:00:01
192.241.226.25	0.034	0.019	0.000	00:00:01
fortunate.monitoring.internet-measurement.com	0.047	0.016	0.000	00:00:00
194.165.16.76	0.037	0.017	0.000	00:00:00
staunch.monitoring.internet-measurement.com	0.020	0.008	0.000	00:00:00
celebrated.monitoring.internet-measurement.com	0.017	0.010	0.000	00:00:00
TOTAL: 12	4.802	4.679	1.638	00:02:35

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
128.14.237.130	2
194.165.16.76	1
192.241.226.25	1
TOTAL: 3	4

NNRP unrecognized commands (by command):

Command	Count
#003	1
MGLNDD_45.13.105.36_119	1
À#024	1
#026#003#001#001#027#001	1
TOTAL: 4	4

NNRP client timeouts [Top 20]:

System	Conn	Peer
194.165.16.76	1	1
TOTAL: 1	1	1

Daily Usenet report for news.niel.me

Nov 24 04:15:02 -- Nov 25 04:15:01