Daily Usenet report for news.niel.me: Oct 21 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Oct 22 01:30:02 rpi-studio innd: filter: No Cancel-Key[sha1:6JKa2DxRwn7IWCli7zei7LZCGgM=] matches Cancel-Lock[sha1:ifSwbemjAu1JSGz9bR4fOd7QBwE=] target=<de-gruppen-finden-15.10.2022@dnqmail.priggish.de>

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	4098	41.8%	777.2 KB	47.1%
innd	2556	26.0%	438.5 KB	26.6%
innfeed	1704	17.4%	299.4 KB	18.1%
nnrpd	1452	14.8%	135.7 KB	8.2%
nocem	3	0.0%	0.4 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	9814	100.0%	1.6 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	26076	64.6%
Negative hits	10280	25.5%
Do not exist	3999	9.9%
Cache misses	4	0.0%
TOTAL: 4	40359	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.032	0.0%	29	0.667	1.103	4.000
article cancel	00:00:00.004	0.0%	32	0.000	0.125	1.000
article cleanup	00:00:00.085	0.0%	4012	0.000	0.021	0.143
article logging	00:00:00.321	0.0%	4027	0.000	0.080	2.417
article parse	00:00:00.749	0.0%	9322	0.000	0.080	0.235
article write	00:00:04.170	0.0%	3571	0.200	1.168	59.774
artlog/artcncl	00:00:00.000	0.0%	32	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.001	0.0%	29	0.000	0.034	1.000
data move	00:00:00.107	0.0%	45642	0.000	0.002	0.018
hisgrep/artcncl	00:00:00.000	0.0%	32	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.001	0.0%	29	0.000	0.034	1.000
hisgrep/perl	00:00:00.001	0.0%	30	0.000	0.033	0.200
hishave/artcncl	00:00:00.000	0.0%	32	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.001	0.0%	29	0.000	0.034	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:00.514	0.0%	40396	0.000	0.013	0.036
history sync	00:00:00.038	0.0%	379	0.000	0.100	0.667
history write	00:00:00.863	0.0%	4010	0.000	0.215	0.731
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:18.677	99.9%	45626	619.078	1894.066	10009.017
nntp read	00:00:01.438	0.0%	45742	0.000	0.031	0.074
overview write	00:00:02.513	0.0%	3571	0.138	0.704	6.600
perl filter	00:00:17.622	0.0%	4010	2.130	4.395	9.778
python filter	00:00:00.006	0.0%	4010	0.000	0.001	0.071
site send	00:00:01.328	0.0%	7223	0.000	0.184	0.515
TOTAL: 24:01:02.723	24:00:48.471	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.026	0.0%	3635	0.000	0.007	0.091
article prepare	00:00:00.000	0.0%	556	0.000	0.000	0.000
article read	00:00:00.018	0.0%	94	0.000	0.191	7.000
backlog stats	00:00:00.120	0.0%	56530	0.000	0.002	0.011
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.737	0.0%	34066	0.000	0.022	0.059
data write	00:00:01.913	0.0%	29921	0.020	0.064	0.128
idle	23:50:05.756	100.0%	56530	746.461	1517.880	5002.258
status file	00:00:00.470	0.0%	177	1.000	2.655	7.000
TOTAL: 23:50:12.234	23:50:09.040	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:32.150	42.7%	1443	10.800	22.280	10042.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.114	0.2%	3174	0.000	0.036	0.273
TOTAL: 00:01:15.357	00:00:32.264	42.8%	-	-	-	-

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	2	3518	1372	2107	39	38%	23:23:12
2	i2pn.org	1	3468	817	2421	230	23%	22:28:01
3	news.glou.org	2	3430	789	2633	8	23%	25:33:03
4	news.nntp4.net	2	3574	130	3329	115	3%	22:16:30
5	feed-out.gegeweb.org	3	2292	104	2188	0	4%	24:57:16
6	nntp.terraraq.uk	3	4600	69	4502	29	1%	33:35:19
7	gegeweb-out.news.tnetconsulting.net	2	3314	21	3290	3	0%	23:58:11
8	usenet.pasdenom.info	2	707	16	689	2	2%	08:32:29
9	news.samoylyk.net	1	249	3	246	0	1%	02:06:47
10	localhost	26	0	0	0	0	0%	00:00:00
TOTAL: 10		44	25152	3321	21405	426	13%	186:50:48

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.glou.org	5.4 MB	0.0 KB	361.9 KB	5.8 MB	93%	7.4 KB
2	news-out.aioe.org	4.4 MB	0.0 KB	103.0 KB	4.5 MB	97%	3.2 KB
3	i2pn.org	2.5 MB	0.0 KB	505.9 KB	3.0 MB	83%	2.9 KB
4	news.nntp4.net	2.4 MB	77.3 KB	721.7 KB	3.2 MB	75%	13.4 KB
5	news.samoylyk.net	713.4 KB	0.0 KB	0.0 KB	713.4 KB	100%	237.8 KB
6	nntp.terraraq.uk	394.9 KB	0.0 KB	53.8 KB	448.7 KB	88%	4.6 KB
7	feed-out.gegeweb.org	247.9 KB	0.0 KB	0.0 KB	247.9 KB	100%	2.4 KB
8	gegeweb-out.news.tnetconsulting.net	193.7 KB	0.0 KB	7.5 KB	201.2 KB	96%	8.4 KB
9	usenet.pasdenom.info	34.6 KB	0.0 KB	3.4 KB	38.0 KB	91%	2.1 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		16.3 MB	77.3 KB	1.7 MB	18.1 MB	90%	4.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 21 04:15:01 - 04:59:59	52	1.5%	0.02	201.2 KB	1.2%	0.07
Oct 21 05:00:00 - 05:59:59	78	2.2%	0.02	824.8 KB	4.9%	0.23
Oct 21 06:00:00 - 06:59:59	117	3.3%	0.03	697.4 KB	4.1%	0.19
Oct 21 07:00:00 - 07:59:59	123	3.4%	0.03	1.1 MB	6.6%	0.31
Oct 21 08:00:00 - 08:59:59	89	2.5%	0.02	274.2 KB	1.6%	0.08
Oct 21 09:00:00 - 09:59:59	79	2.2%	0.02	307.6 KB	1.8%	0.09
Oct 21 10:00:00 - 10:59:59	89	2.5%	0.02	242.2 KB	1.4%	0.07
Oct 21 11:00:00 - 11:59:59	137	3.8%	0.04	645.8 KB	3.8%	0.18
Oct 21 12:00:00 - 12:59:59	112	3.1%	0.03	722.1 KB	4.3%	0.20
Oct 21 13:00:00 - 13:59:59	142	4.0%	0.04	535.4 KB	3.2%	0.15
Oct 21 14:00:00 - 14:59:59	163	4.6%	0.05	586.6 KB	3.5%	0.16
Oct 21 15:00:00 - 15:59:59	190	5.3%	0.05	681.4 KB	4.0%	0.19
Oct 21 16:00:00 - 16:59:59	173	4.8%	0.05	1.4 MB	8.2%	0.39
Oct 21 17:00:00 - 17:59:59	228	6.4%	0.06	726.0 KB	4.3%	0.20
Oct 21 18:00:00 - 18:59:59	198	5.5%	0.06	620.7 KB	3.7%	0.17
Oct 21 19:00:00 - 19:59:59	188	5.3%	0.05	522.9 KB	3.1%	0.15
Oct 21 20:00:00 - 20:59:59	213	6.0%	0.06	1.7 MB	10.1%	0.47
Oct 21 21:00:00 - 21:59:59	240	6.7%	0.07	826.6 KB	4.9%	0.23
Oct 21 22:00:00 - 22:59:59	198	5.5%	0.06	755.5 KB	4.5%	0.21
Oct 21 23:00:00 - 23:59:59	205	5.7%	0.06	1.1 MB	6.6%	0.31
Oct 22 00:00:00 - 00:59:59	142	4.0%	0.04	582.7 KB	3.4%	0.16
Oct 22 01:00:00 - 01:59:59	112	3.1%	0.03	452.1 KB	2.7%	0.13
Oct 22 02:00:00 - 02:59:59	136	3.8%	0.04	788.2 KB	4.7%	0.22
Oct 22 03:00:00 - 03:59:59	143	4.0%	0.04	488.5 KB	2.9%	0.14
Oct 22 04:00:00 - 04:15:01	28	0.8%	0.03	114.4 KB	0.7%	0.13
TOTAL: 24:00:00	3575	100.0%	0.04	16.5 MB	100.0%	0.20

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	i2pn.org	263	0	0	263
2	news.nntp4.net	129	0	1	128
3	news-out.aioe.org	47	2	0	45
4	usenet.pasdenom.info	8	0	1	7
5	news.glou.org	4	0	0	4
6	nntp.terraraq.uk	3	0	0	3
7	news.samoylyk.net	3	0	0	3
8	gegeweb-out.news.tnetconsulting.net	1	0	0	1
TOTAL: 8		458	2	2	454

Unwanted newsgroups [Top 20]:

Newsgroup	Count
news.test	1
soc.culture.russia	1
TOTAL: 2	2

INND Perl filter [Top 20]:

Reason	Count
EMP (phl)	143
Bad path (news.giganews.com.POSTED)	122
EMP (phn nph)	87
EMP (md5)	48
Too many newsgroups	28
HTML Multipart	10
EMP (phn path)	1
TOTAL: 7	439

NoCeM on Spool:

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

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news-out.aioe.org	7
	news.nntp4.net	5
	news.samoylyk.net	3
	TOTAL: 3	15
TOTAL: 1		15

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.nntp4.net	3981	28	3396	0	0	0%	23:59:56
2	i2pn.org	4568	28	2632	5	39	0%	23:59:56
3	news.tnetconsulting.net	5496	24	3536	4	36	0%	23:59:54
4	nntp.terraraq.uk	2901	14	2284	18	4	0%	23:55:07
5	news.aioe.org	1917	9	1693	0	0	0%	23:58:33
6	news.gegeweb.org	3520	4	3459	0	0	0%	23:59:56
7	news.samoylyk.net	4402	2	3563	4	0	0%	23:59:53
8	news.pasdenom.info	3540	1	3005	0	1	0%	23:59:56
TOTAL: 8		30325	110	23568	31	80	0%	191:53:11

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.nntp4.net	1.1 MB	0.0 KB	1.1 MB	40.8 KB	23:59:56
2	nntp.terraraq.uk	362.2 KB	1.2 MB	1.5 MB	49.2 KB	23:55:07
3	news.tnetconsulting.net	170.0 KB	12.8 KB	182.8 KB	6.5 KB	23:59:54
4	news.samoylyk.net	155.4 KB	190.4 KB	345.9 KB	57.6 KB	23:59:53
5	news.pasdenom.info	92.4 KB	0.0 KB	92.4 KB	92.4 KB	23:59:56
6	i2pn.org	73.0 KB	16.8 KB	89.9 KB	2.7 KB	23:59:56
7	news.aioe.org	62.0 KB	0.0 KB	62.0 KB	6.9 KB	23:58:33
8	news.gegeweb.org	14.8 KB	0.0 KB	14.8 KB	3.7 KB	23:59:56
TOTAL: 8		2.0 MB	1.4 MB	3.4 MB	24.8 KB	191:53:11

NNRP readership statistics:

System		Conn	Elapsed
1	192.3.251.168	1	00:00:10
2	192.241.196.48	1	00:00:00
3	mail.gegeweb.eu	288	00:01:04
TOTAL: 3		290	00:01:14

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	unresolved	2	00:00:10
2	*.gegeweb.eu	288	00:01:04
TOTAL: 2		290	00:01:14

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.737	8.397	2.422	00:01:04
192.3.251.168	0.012	0.012	0.000	00:00:10
192.241.196.48	0.033	0.022	0.000	00:00:00
TOTAL: 3	7.782	8.431	2.422	00:01:14

NNRP unrecognized commands (by host):

System	Conn
192.241.196.48	1
TOTAL: 1	1

NNRP unrecognized commands (by command):

Command	Count
MGLNDD_45.13.105.36_119	1
TOTAL: 1	1

Daily Usenet report for news.niel.me

Oct 21 04:15:01 -- Oct 22 04:15:01