Daily Usenet report for news.niel.me: Aug 19 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Aug 20 01:30:02 rpi-studio innd: filter: No Cancel-Key[sha1:k9i2eZTcz6UHqJH3Re4Hu32XojY=] matches Cancel-Lock[sha1:14gKY18/637vvhBNt22n3gcQUgc=] target=<de-gruppen-finden-13.08.2022@dnqmail.priggish.de>

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	4391	43.2%	814.7 KB	48.3%
innd	2562	25.2%	405.4 KB	24.0%
innfeed	1675	16.5%	318.1 KB	18.8%
nnrpd	1527	15.0%	148.0 KB	8.8%
nocem	14	0.1%	1.6 KB	0.1%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	10170	100.0%	1.6 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	23920	63.7%
Negative hits	9336	24.8%
Do not exist	4318	11.5%
Cache misses	4	0.0%
TOTAL: 4	37578	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.016	0.0%	19	0.000	0.842	2.000
article cancel	00:00:00.005	0.0%	32	0.000	0.156	1.000
article cleanup	00:00:00.076	0.0%	4332	0.000	0.018	0.111
article logging	00:00:00.307	0.0%	4349	0.000	0.071	0.263
article parse	00:00:00.773	0.0%	7544	0.000	0.102	0.310
article write	00:00:04.148	0.0%	3734	0.176	1.111	50.811
artlog/artcncl	00:00:00.002	0.0%	32	0.000	0.062	1.000
artlog/artcncl/perl	00:00:00.001	0.0%	19	0.000	0.053	0.500
data move	00:00:00.105	0.0%	40092	0.000	0.003	0.015
hisgrep/artcncl	00:00:00.001	0.0%	22	0.000	0.045	0.333
hisgrep/artcncl/perl	00:00:00.000	0.0%	19	0.000	0.000	0.000
hisgrep/perl	00:00:00.003	0.0%	22	0.000	0.136	1.000
hishave/artcncl	00:00:00.000	0.0%	32	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	19	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.476	0.0%	37698	0.000	0.013	0.057
history sync	00:00:00.038	0.0%	404	0.000	0.094	1.000
history write	00:00:01.077	0.0%	4331	0.000	0.249	2.121
hiswrite/artcncl	00:00:00.001	0.0%	10	0.000	0.100	0.500
idle	24:00:26.578	99.9%	40926	1070.655	2111.777	6823.534
nntp read	00:00:01.310	0.0%	40282	0.007	0.033	0.071
overview write	00:00:03.929	0.0%	3734	0.067	1.052	37.865
perl filter	00:00:19.203	0.0%	4331	2.792	4.434	56.889
python filter	00:00:00.006	0.0%	4331	0.000	0.001	0.091
site send	00:00:01.254	0.0%	7518	0.000	0.167	0.583
TOTAL: 24:01:13.782	24:00:59.309	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.042	0.0%	3718	0.000	0.011	0.083
article prepare	00:00:00.000	0.0%	340	0.000	0.000	0.000
article read	00:00:00.014	0.0%	75	0.000	0.187	7.000
backlog stats	00:00:00.115	0.0%	52346	0.000	0.002	0.012
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.683	0.0%	32400	0.000	0.021	0.054
data write	00:00:01.856	0.0%	28838	0.029	0.064	0.150
idle	23:50:03.212	100.0%	52346	842.442	1639.155	5183.622
status file	00:00:00.461	0.0%	168	1.000	2.744	8.000
TOTAL: 23:50:09.655	23:50:06.383	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:27.721	28.8%	1449	11.600	19.131	1409.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.102	0.1%	3202	0.000	0.032	0.500
TOTAL: 00:01:36.105	00:00:27.823	29.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-out.aioe.org	1	3847	1602	2172	73	41%	24:14:37
2	i2pn.org	1	3915	1348	2387	180	34%	24:07:48
3	feed-out.gegeweb.org	2	2494	329	2165	0	13%	23:59:16
4	usenet.pasdenom.info	1	2891	179	2642	70	6%	24:03:57
5	gegeweb-out.news.tnetconsulting.net	1	3621	126	3492	3	3%	23:59:57
6	nntp.terraraq.uk	1	3255	79	3118	58	2%	19:48:39
7	news.samoylyk.net	2	7413	25	7362	26	0%	47:40:01
8	news.nntp4.net	1	3539	21	3324	194	0%	19:01:00
9	localhost	28	0	0	0	0	0%	00:00:00
TOTAL: 9		38	30975	3709	26662	604	11%	206:55:15

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	news-out.aioe.org	5.3 MB	0.0 KB	228.5 KB	5.5 MB	95%	3.4 KB
2	i2pn.org	5.1 MB	42.9 KB	599.8 KB	5.7 MB	88%	3.8 KB
3	gegeweb-out.news.tnetconsulting.net	1.2 MB	0.0 KB	6.1 KB	1.3 MB	99%	9.9 KB
4	feed-out.gegeweb.org	1.1 MB	0.0 KB	0.0 KB	1.1 MB	100%	3.4 KB
5	news.samoylyk.net	864.2 KB	0.0 KB	27.0 KB	891.3 KB	96%	17.5 KB
6	nntp.terraraq.uk	554.4 KB	0.0 KB	122.2 KB	676.6 KB	81%	4.9 KB
7	usenet.pasdenom.info	499.5 KB	0.0 KB	153.6 KB	653.1 KB	76%	2.6 KB
8	news.nntp4.net	374.5 KB	0.0 KB	819.3 KB	1.2 MB	31%	5.6 KB
9	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 9		14.9 MB	42.9 KB	1.9 MB	16.9 MB	88%	4.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 19 04:15:01 - 04:59:59	57	1.5%	0.02	601.1 KB	3.8%	0.22
Aug 19 05:00:00 - 05:59:59	85	2.3%	0.02	485.9 KB	3.1%	0.13
Aug 19 06:00:00 - 06:59:59	106	2.8%	0.03	341.6 KB	2.2%	0.09
Aug 19 07:00:00 - 07:59:59	73	2.0%	0.02	233.5 KB	1.5%	0.06
Aug 19 08:00:00 - 08:59:59	106	2.8%	0.03	535.4 KB	3.4%	0.15
Aug 19 09:00:00 - 09:59:59	123	3.3%	0.03	441.4 KB	2.8%	0.12
Aug 19 10:00:00 - 10:59:59	112	3.0%	0.03	472.1 KB	3.0%	0.13
Aug 19 11:00:00 - 11:59:59	162	4.3%	0.04	699.1 KB	4.4%	0.19
Aug 19 12:00:00 - 12:59:59	146	3.9%	0.04	543.5 KB	3.5%	0.15
Aug 19 13:00:00 - 13:59:59	166	4.5%	0.05	1.2 MB	8.1%	0.35
Aug 19 14:00:00 - 14:59:59	145	3.9%	0.04	521.7 KB	3.3%	0.14
Aug 19 15:00:00 - 15:59:59	181	4.9%	0.05	718.6 KB	4.6%	0.20
Aug 19 16:00:00 - 16:59:59	233	6.2%	0.06	753.3 KB	4.8%	0.21
Aug 19 17:00:00 - 17:59:59	240	6.4%	0.07	920.5 KB	5.9%	0.26
Aug 19 18:00:00 - 18:59:59	227	6.1%	0.06	887.8 KB	5.6%	0.25
Aug 19 19:00:00 - 19:59:59	215	5.8%	0.06	658.3 KB	4.2%	0.18
Aug 19 20:00:00 - 20:59:59	214	5.7%	0.06	846.2 KB	5.4%	0.24
Aug 19 21:00:00 - 21:59:59	224	6.0%	0.06	925.9 KB	5.9%	0.26
Aug 19 22:00:00 - 22:59:59	230	6.2%	0.06	890.2 KB	5.7%	0.25
Aug 19 23:00:00 - 23:59:59	211	5.7%	0.06	813.9 KB	5.2%	0.23
Aug 20 00:00:00 - 00:59:59	102	2.7%	0.03	642.4 KB	4.1%	0.18
Aug 20 01:00:00 - 01:59:59	150	4.0%	0.04	588.0 KB	3.7%	0.16
Aug 20 02:00:00 - 02:59:59	88	2.4%	0.02	417.9 KB	2.7%	0.12
Aug 20 03:00:00 - 03:59:59	106	2.8%	0.03	423.9 KB	2.7%	0.12
Aug 20 04:00:00 - 04:15:02	27	0.7%	0.03	93.3 KB	0.6%	0.10
TOTAL: 24:00:01	3729	100.0%	0.04	15.4 MB	100.0%	0.18

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	news.nntp4.net	200	0	0	200
2	i2pn.org	183	0	1	182
3	news-out.aioe.org	83	1	0	82
4	nntp.terraraq.uk	82	0	0	82
5	usenet.pasdenom.info	54	0	0	54
6	gegeweb-out.news.tnetconsulting.net	5	2	0	3
7	news.samoylyk.net	3	0	0	3
8	feed-out.gegeweb.org	1	0	0	1
TOTAL: 8		611	3	1	607

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fr.petites-annonces.informatique.materiel	1
fr.petites-annonces.immobilier	1
news.test	1
TOTAL: 3	3

INND Perl filter [Top 20]:

Reason	Count
EMP (phl)	191
EMP (md5)	156
Bad path (news.giganews.com.POSTED)	94
EMP (phn path)	60
Too many newsgroups	46
EMP (phn nph)	38
User-issued spam cancel	3
Cancel of <tdnbmb$aqd$4@shakotay.alphanet.ch> without Cancel-Key	1
Cancels abusifs	1
TOTAL: 9	590

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	11	0	11	11
TOTAL: 1	11	0	11	11

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news-out.aioe.org	13
	news.samoylyk.net	3
	feed-out.gegeweb.org	1
	TOTAL: 3	17
TOTAL: 1		17

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn.org	4381	29	2340	2	4	0%	23:59:22
2	news.tnetconsulting.net	5667	19	3707	2	3	0%	23:59:15
3	news.gegeweb.org	3486	12	3370	18	0	0%	23:59:57
4	nntp.terraraq.uk	2694	2	2505	0	0	0%	23:59:57
5	news.nntp4.net	4062	1	3698	0	0	0%	23:59:45
6	news.samoylyk.net	4025	0	3712	0	0	0%	23:59:41
7	news.aioe.org	1615	0	1528	0	0	0%	23:59:57
8	news.pasdenom.info	3309	0	3213	0	0	0%	23:59:57
TOTAL: 8		29239	63	24073	22	7	0%	191:57:51

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.tnetconsulting.net	88.9 KB	27.1 KB	116.1 KB	5.5 KB	23:59:15
2	i2pn.org	68.7 KB	27.1 KB	95.9 KB	3.1 KB	23:59:22
3	news.gegeweb.org	31.2 KB	78.5 KB	109.8 KB	3.7 KB	23:59:57
4	nntp.terraraq.uk	13.3 KB	0.0 KB	13.3 KB	6.7 KB	23:59:57
5	news.nntp4.net	3.2 KB	0.0 KB	3.2 KB	3.2 KB	23:59:45
6	news.samoylyk.net	0.0 KB	0.0 KB	0.0 KB	0	23:59:41
7	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	23:59:57
8	news.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0	23:59:57
TOTAL: 8		205.4 KB	132.8 KB	338.2 KB	4.0 KB	191:57:51

NNRP readership statistics:

System		Conn	Elapsed
1	tor-exit-relay-2.anonymizing-proxy.digitalcourage.de	2	00:00:02
2	185.220.101.170	4	00:00:01
3	192.241.213.28	1	00:00:00
4	88.165.5.23	1	00:00:00
5	mail.gegeweb.eu	288	00:01:18
6	tor-exit-5.zbau.f3netze.de	1	00:00:00
7	exit.tor.uwaterloo.ca	1	00:00:06
8	tor-exit-4.zbau.f3netze.de	1	00:00:02
9	185.220.101.161	3	00:00:01
10	ns31410048.ip-145-239-154.eu	2	00:00:01
TOTAL: 10		304	00:01:35

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.anonymizing-proxy.digitalcourage.de	2	00:00:02
2	unresolved	9	00:00:04
3	*.ip-145-239-154.eu	2	00:00:01
4	*.gegeweb.eu	288	00:01:18
5	*.tor.uwaterloo.ca	1	00:00:06
6	*.zbau.f3netze.de	2	00:00:02
TOTAL: 6		304	00:01: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	7.889	8.203	2.369	00:01:18
exit.tor.uwaterloo.ca	0.072	0.012	0.000	00:00:06
tor-exit-relay-2.anonymizing-proxy.digitalcourage.de	0.036	0.018	0.000	00:00:02
tor-exit-4.zbau.f3netze.de	0.032	0.024	0.000	00:00:02
185.220.101.161	0.099	0.016	0.000	00:00:01
185.220.101.170	0.161	0.049	0.000	00:00:01
ns31410048.ip-145-239-154.eu	0.079	0.064	0.000	00:00:01
88.165.5.23	0.012	0.049	0.000	00:00:00
tor-exit-5.zbau.f3netze.de	0.133	0.010	0.000	00:00:00
192.241.213.28	0.034	0.017	0.000	00:00:00
TOTAL: 10	8.547	8.462	2.369	00:01:35

NNRP unrecognized commands (by host):

System	Conn
ns31410048.ip-145-239-154.eu	1
192.241.213.28	1
TOTAL: 2	2

NNRP unrecognized commands (by command):

Command	Count
#026#003	1
MGLNDD_45.13.105.36_119	1
TOTAL: 2	2

Daily Usenet report for news.niel.me

Aug 19 04:15:01 -- Aug 20 04:15:02