Daily Usenet report for news.niel.me: Jun 26 04:15:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Jun 26 10:00:44 rpi-studio innd: filter: No Cancel-Key[sha1:AN3mRVpgmOmjr1x5IRdXqPVeuc4=] matches Cancel-Lock[sha1:NXziQfZyOZRWSGxbImWpxBNP9/k=] target=<667baaee$0$3282$426a74cc@news.free.fr>
Jun 26 20:20:32 rpi-studio innd: filter: No Cancel-Key[sha1:D6DwNUtww3EXbI14Bt8PQj8I0dA=] matches Cancel-Lock[sha1:ihjW1ryU6FAPPEHp4Yi1PNtvrJY=] target=<667c5bbc$0$7989$426a74cc@news.free.fr>

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2782	32.2%	513.1 KB	36.9%
innd	2290	26.5%	391.6 KB	28.1%
nnrpd	1795	20.8%	213.1 KB	15.3%
innfeed	1761	20.4%	273.8 KB	19.7%
nocem	1	0.0%	0.2 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	8630	100.0%	1.4 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	14655	59.4%
Negative hits	7289	29.5%
Do not exist	2740	11.1%
Cache misses	6	0.0%
TOTAL: 4	24690	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.031	0.0%	18	0.000	1.722	6.000
article cancel	00:00:00.005	0.0%	19	0.000	0.263	1.000
article cleanup	00:00:00.079	0.0%	2750	0.000	0.029	0.200
article logging	00:00:00.213	0.0%	2750	0.000	0.077	0.312
article parse	00:00:00.359	0.0%	7230	0.000	0.050	0.222
article write	00:00:01.197	0.0%	2372	0.125	0.505	1.000
artlog/artcncl	00:00:00.000	0.0%	19	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.001	0.0%	18	0.000	0.056	0.500
data move	00:00:00.137	0.0%	26565	0.000	0.005	0.027
hisgrep/artcncl	00:00:00.004	0.0%	19	0.000	0.211	1.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	18	0.000	0.000	0.000
hisgrep/perl	00:00:00.005	0.0%	68	0.000	0.074	1.000
hishave/artcncl	00:00:00.001	0.0%	19	0.000	0.053	0.500
hishave/artcncl/perl	00:00:00.000	0.0%	18	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%	24709	0.000	0.015	0.039
history sync	00:00:00.048	0.0%	351	0.000	0.137	1.000
history write	00:00:00.413	0.0%	2750	0.000	0.150	0.545
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:34.615	100.0%	29362	1136.364	2943.758	13056.870
nntp read	00:00:00.810	0.0%	28683	0.000	0.028	0.071
overview write	00:00:00.816	0.0%	2372	0.000	0.344	4.727
perl filter	00:00:11.844	0.0%	2750	2.462	4.307	8.000
python filter	00:00:00.016	0.0%	2750	0.000	0.006	0.200
site send	00:00:00.895	0.0%	4835	0.000	0.185	0.500
TOTAL: 24:01:00.276	24:00:51.855	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.018	0.0%	2378	0.000	0.008	0.250
article prepare	00:00:00.003	0.0%	668	0.000	0.004	0.250
article read	00:00:00.035	0.0%	165	0.000	0.212	2.000
backlog stats	00:00:00.222	0.0%	35711	0.000	0.006	0.023
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.480	0.0%	19326	0.000	0.025	0.081
data write	00:00:00.945	0.0%	17195	0.000	0.055	0.129
idle	23:50:29.155	100.0%	35711	1195.582	2403.437	5777.817
status file	00:00:00.448	0.0%	216	0.000	2.074	6.000
TOTAL: 23:50:35.924	23:50:31.306	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:35.427	21.9%	1448	19.600	24.466	2904.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.088	0.1%	3262	0.000	0.027	0.364
TOTAL: 00:02:41.688	00:00:35.515	22.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	feed-out.gegeweb.org	3	2230	1184	1046	0	53%	23:56:06
2	i2pn.org	1	4240	396	3822	22	9%	42:39:54
3	gegeweb-out.news.tnetconsulting.net	1	2003	282	1665	56	14%	24:17:22
4	news.nntp4.net	1	1298	154	1061	83	11%	15:44:18
5	nntp.terraraq.uk	3	2039	67	1971	1	3%	25:25:53
6	news.glou.org	1	1871	62	1671	138	3%	21:04:43
7	news.samoylyk.net	2	703	39	664	0	5%	09:52:36
8	usenet.pasdenom.info	1	168	1	167	0	0%	04:18:43
9	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 9		38	14552	2185	12067	300	15%	167:19:35

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	feed-out.gegeweb.org	4.1 MB	0.0 KB	4.1 MB	100%	3.5 KB
2	i2pn.org	1.1 MB	136.7 KB	1.2 MB	89%	3.0 KB
3	gegeweb-out.news.tnetconsulting.net	841.1 KB	273.3 KB	1.1 MB	75%	3.3 KB
4	news.nntp4.net	737.7 KB	1.3 MB	2.0 MB	36%	8.6 KB
5	nntp.terraraq.uk	436.9 KB	2.1 KB	439.0 KB	99%	6.5 KB
6	news.glou.org	389.8 KB	346.4 KB	736.2 KB	52%	3.7 KB
7	news.samoylyk.net	354.6 KB	0.0 KB	354.6 KB	100%	9.1 KB
8	usenet.pasdenom.info	2.2 KB	0.0 KB	2.2 KB	100%	2.2 KB
9	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 9		7.9 MB	2.0 MB	9.9 MB	79%	4.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 26 04:15:01 - 04:59:59	42	1.8%	0.02	315.9 KB	3.5%	0.12
Jun 26 05:00:00 - 05:59:59	73	3.1%	0.02	294.1 KB	3.2%	0.08
Jun 26 06:00:00 - 06:59:59	62	2.6%	0.02	197.9 KB	2.2%	0.05
Jun 26 07:00:00 - 07:59:59	69	2.9%	0.02	317.9 KB	3.5%	0.09
Jun 26 08:00:00 - 08:59:59	56	2.4%	0.02	308.1 KB	3.4%	0.09
Jun 26 09:00:00 - 09:59:59	74	3.1%	0.02	240.1 KB	2.6%	0.07
Jun 26 10:00:00 - 10:59:59	95	4.0%	0.03	314.9 KB	3.4%	0.09
Jun 26 11:00:00 - 11:59:59	75	3.2%	0.02	308.2 KB	3.4%	0.09
Jun 26 12:00:00 - 12:59:59	83	3.5%	0.02	267.6 KB	2.9%	0.07
Jun 26 13:00:00 - 13:59:59	72	3.0%	0.02	220.1 KB	2.4%	0.06
Jun 26 14:00:00 - 14:59:59	83	3.5%	0.02	331.0 KB	3.6%	0.09
Jun 26 15:00:00 - 15:59:59	99	4.2%	0.03	440.8 KB	4.8%	0.12
Jun 26 16:00:00 - 16:59:59	104	4.4%	0.03	336.4 KB	3.7%	0.09
Jun 26 17:00:00 - 17:59:59	117	4.9%	0.03	402.7 KB	4.4%	0.11
Jun 26 18:00:00 - 18:59:59	159	6.7%	0.04	512.7 KB	5.6%	0.14
Jun 26 19:00:00 - 19:59:59	160	6.7%	0.04	522.1 KB	5.7%	0.15
Jun 26 20:00:00 - 20:59:59	114	4.8%	0.03	370.4 KB	4.1%	0.10
Jun 26 21:00:00 - 21:59:59	110	4.6%	0.03	407.8 KB	4.5%	0.11
Jun 26 22:00:00 - 22:59:59	155	6.5%	0.04	712.4 KB	7.8%	0.20
Jun 26 23:00:00 - 23:59:59	119	5.0%	0.03	363.5 KB	4.0%	0.10
Jun 27 00:00:00 - 00:59:59	111	4.7%	0.03	458.6 KB	5.0%	0.13
Jun 27 01:00:00 - 01:59:59	140	5.9%	0.04	518.2 KB	5.7%	0.14
Jun 27 02:00:00 - 02:59:59	71	3.0%	0.02	261.7 KB	2.9%	0.07
Jun 27 03:00:00 - 03:59:59	101	4.3%	0.03	582.0 KB	6.4%	0.16
Jun 27 04:00:00 - 04:15:01	28	1.2%	0.03	129.6 KB	1.4%	0.14
TOTAL: 24:00:00	2372	100.0%	0.03	8.9 MB	100.0%	0.11

Sites sending bad articles:

Server		Total	Other
1	news.glou.org	158	158
2	news.nntp4.net	106	106
3	gegeweb-out.news.tnetconsulting.net	47	47
4	usenet.pasdenom.info	25	25
5	i2pn.org	23	23
6	news.samoylyk.net	10	10
7	nntp.terraraq.uk	4	4
TOTAL: 7		373	373

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	163
Too many newsgroups	73
Bad path (news.giganews.com.POSTED)	50
EMP (md5)	33
hierarchy violation - crosspost outside sdnet	3
Cancels abusifs	2
Cancel of non-existing ID <250620241157055801%Kuypers@address.invalid>	2
No Cancel-Key matches Cancel-Lock. target=<667c5bbc$0$7989$426a74cc@news.free.fr>	1
Cancel of <v2a1qp$2ojia$1@dont-email.me> without Cancel-Key	1
Cancel of <upt2nq$rgp4$1@dont-email.me> without Cancel-Key	1
Cancel of <uvller$tfi8$1@dont-email.me> without Cancel-Key	1
Cancel of <0001HW.2BC72006009732337000073D238F@news.eternal-september.org> without Cancel-Key	1
Cancel of <20240226102023.256@kylheku.com> without Cancel-Key	1
Cancel of <v5i400$2boom$3@dont-email.me> without Cancel-Key	1
Cancel of <v5i3nn$2bneg$1@dont-email.me> without Cancel-Key	1
Cancel of <uvllf2$tfjk$1@dont-email.me> without Cancel-Key	1
Cancel of <v5i4cn$2br94$1@dont-email.me> without Cancel-Key	1
Cancel of <v5hdr4$16efe$1@i2pn2.org> without Cancel-Key	1
Cancel of <v5i3p8$17bku$1@i2pn2.org> without Cancel-Key	1
Cancel of <v4sm3u$1g8on$2@dont-email.me> without Cancel-Key	1
TOTAL: 54	373

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.gegeweb.org	1214	85	1067	0	0	7%	23:42:03
2	i2pn.org	3495	59	2053	8	10	1%	23:59:39
3	news.tnetconsulting.net	3920	11	2357	3	4	0%	23:59:57
4	news.pasdenom.info	2276	1	1966	0	0	0%	23:59:05
5	news.samoylyk.net	2709	0	2292	0	3	0%	23:59:57
6	news.nntp4.net	2156	0	2082	0	0	0%	23:59:57
7	nntp.terraraq.uk	1630	0	1518	0	0	0%	23:57:11
8	news.aioe.org	0	0	0	0	1973	0%	23:59:59
TOTAL: 8		17400	156	13335	11	1990	0%	191:37:48

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.gegeweb.org	319.6 KB	0.0 KB	319.6 KB	3.8 KB	23:42:03
2	i2pn.org	139.7 KB	54.7 KB	194.3 KB	2.9 KB	23:59:39
3	news.tnetconsulting.net	43.4 KB	14.5 KB	57.9 KB	4.1 KB	23:59:57
4	news.pasdenom.info	0.8 KB	0.0 KB	0.8 KB	0.8 KB	23:59:05
5	news.samoylyk.net	0.0 KB	0.0 KB	0.0 KB	0	23:59:57
6	news.nntp4.net	0.0 KB	0.0 KB	0.0 KB	0	23:59:57
7	nntp.terraraq.uk	0.0 KB	0.0 KB	0.0 KB	0	23:57:11
8	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	23:59:59
TOTAL: 8		503.5 KB	69.1 KB	572.6 KB	3.4 KB	191:37:48

NNRP readership statistics:

System		Conn	Elapsed
1	206.168.34.45	3	00:00:13
2	231.211.203.35.bc.googleusercontent.com	1	00:00:00
3	208.100.26.232	4	00:00:13
4	mail.gegeweb.eu	288	00:01:59
5	147.185.133.9	1	00:00:10
6	azpdwgb84.stretchoid.com	1	00:00:01
7	civilized.monitoring.internet-measurement.com	1	00:00:01
TOTAL: 7		299	00:02:41

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.monitoring.internet-measurement.com	1	00:00:01
2	unresolved	8	00:00:36
3	*.211.203.35.bc.googleusercontent.com	1	00:00:00
4	*.stretchoid.com	1	00:00:01
5	*.gegeweb.eu	288	00:01:59
TOTAL: 5		299	00:02:41

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.353	4.207	1.488	00:01:59
206.168.34.45	0.115	0.053	0.000	00:00:13
208.100.26.232	0.163	0.086	0.000	00:00:13
147.185.133.9	0.033	0.007	0.000	00:00:10
azpdwgb84.stretchoid.com	0.028	0.024	0.000	00:00:01
civilized.monitoring.internet-measurement.com	0.034	0.019	0.000	00:00:01
231.211.203.35.bc.googleusercontent.com	0.036	0.004	0.000	00:00:00
TOTAL: 7	4.762	4.400	1.488	00:02:41

NNRP unrecognized commands (by host):

System	Conn
147.185.133.9	4
231.211.203.35.bc.googleusercontent.com	4
206.168.34.45	1
azpdwgb84.stretchoid.com	1
TOTAL: 4	10

NNRP unrecognized commands (by command):

Command	Count
Host: 45.13.105.36:563	2
Accept-Encoding: gzip	2
User-Agent: Expanse, a Palo Alto Network...	2
GET / HTTP/1.1	2
MGLNDD_45.13.105.36_119	1
EHLO www.censys.io	1
TOTAL: 6	10

NNRP client timeouts [Top 20]:

System	Conn	Peer
206.168.34.45	1	2
TOTAL: 1	1	2

Daily Usenet report for news.niel.me

Jun 26 04:15:01 -- Jun 27 04:15:01