Daily Usenet report for news.niel.me: Jan 20 04:15:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jan 21 01:30:02 rpi-studio innd: filter: No Cancel-Key[sha1:sPsOado4mCv5OaFNzUePqhXAwSg=] matches Cancel-Lock[sha1:FGv4KVjk32CFfaPZnNlaJf3Jj+M=] target=<de-gruppen-finden-14.01.2023@dnqmail.priggish.de>

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3988	38.1%	776.0 KB	44.2%
nnrpd	2451	23.4%	286.8 KB	16.3%
innd	2314	22.1%	399.9 KB	22.8%
innfeed	1704	16.3%	292.5 KB	16.7%
nocem	1	0.0%	0.1 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	10459	100.0%	1.7 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	26641	66.8%
Negative hits	9315	23.3%
Do not exist	3944	9.9%
Cache misses	4	0.0%
TOTAL: 4	39904	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.011	0.0%	10	1.000	1.100	2.000
article cancel	00:00:00.003	0.0%	11	0.000	0.273	1.500
article cleanup	00:00:00.084	0.0%	3951	0.000	0.021	0.167
article logging	00:00:00.289	0.0%	3964	0.000	0.073	0.333
article parse	00:00:00.675	0.0%	8660	0.000	0.078	0.250
article write	00:00:04.543	0.0%	3716	0.167	1.223	2.708
artlog/artcncl	00:00:00.000	0.0%	11	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.001	0.0%	10	0.000	0.100	1.000
data move	00:00:00.137	0.0%	43583	0.000	0.003	0.015
hisgrep/artcncl	00:00:00.000	0.0%	11	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	10	0.000	0.000	0.000
hisgrep/perl	00:00:00.002	0.0%	11	0.000	0.182	1.000
hishave/artcncl	00:00:00.000	0.0%	11	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	10	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.457	0.0%	39951	0.000	0.011	0.038
history sync	00:00:00.055	0.0%	402	0.000	0.137	1.000
history write	00:00:00.787	0.0%	3950	0.000	0.199	0.483
idle	24:00:33.320	100.0%	44583	836.678	1938.706	9235.662
nntp read	00:00:01.346	0.0%	43758	0.000	0.031	0.070
overview write	00:00:01.945	0.0%	3716	0.000	0.523	3.636
perl filter	00:00:15.408	0.0%	3950	2.547	3.901	7.625
python filter	00:00:00.007	0.0%	3950	0.000	0.002	0.077
site send	00:00:01.352	0.0%	7503	0.000	0.180	0.529
TOTAL: 24:01:12.247	24:01:00.422	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.026	0.0%	3774	0.000	0.007	0.077
article prepare	00:00:00.000	0.0%	184	0.000	0.000	0.000
article read	00:00:00.011	0.0%	31	0.000	0.355	8.000
backlog stats	00:00:00.123	0.0%	55562	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.772	0.0%	33677	0.000	0.023	0.064
data write	00:00:01.703	0.0%	30121	0.017	0.057	0.115
idle	23:59:41.005	100.0%	55562	666.528	1554.678	4957.047
status file	00:00:00.354	0.0%	173	0.769	2.046	12.000
TOTAL: 23:59:47.658	23:59:43.994	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:56.657	34.1%	1644	12.400	34.463	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.133	0.1%	3799	0.000	0.035	1.000
TOTAL: 00:02:46.340	00:00:56.790	34.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
TOTAL: 11	171

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	news-out.aioe.org	1	3924	1820	2057	47	46%	25:18:00
2	i2pn.org	1	3723	820	2817	86	22%	23:12:49
3	news.glou.org	2	3302	542	2721	39	16%	24:41:21
4	feed-out.gegeweb.org	2	2481	247	2234	0	9%	23:59:46
5	nntp.terraraq.uk	2	3708	100	3606	2	2%	26:02:08
6	gegeweb-out.news.tnetconsulting.net	3	6097	39	6053	5	0%	37:21:04
7	news.nntp4.net	1	3862	32	3767	63	0%	23:59:56
8	news.samoylyk.net	2	7322	27	7293	2	0%	47:35:16
9	usenet.pasdenom.info	2	271	1	270	0	0%	03:48:26
10	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 10		41	34690	3628	30818	244	10%	235:58:46

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	news-out.aioe.org	6.3 MB	0.0 KB	184.7 KB	6.5 MB	97%	3.5 KB
2	news.glou.org	3.8 MB	0.0 KB	109.4 KB	3.9 MB	97%	6.8 KB
3	i2pn.org	2.8 MB	0.0 KB	284.0 KB	3.1 MB	91%	3.5 KB
4	news.samoylyk.net	1.5 MB	0.0 KB	6.4 KB	1.5 MB	99%	52.8 KB
5	news.nntp4.net	1.1 MB	0.0 KB	177.3 KB	1.3 MB	86%	14.2 KB
6	feed-out.gegeweb.org	860.8 KB	0.0 KB	0.0 KB	860.8 KB	100%	3.5 KB
7	nntp.terraraq.uk	431.4 KB	0.0 KB	19.4 KB	450.8 KB	95%	4.4 KB
8	gegeweb-out.news.tnetconsulting.net	292.4 KB	2.6 KB	11.1 KB	306.0 KB	95%	7.0 KB
9	usenet.pasdenom.info	2.6 KB	0.0 KB	0.0 KB	2.6 KB	100%	2.6 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		17.1 MB	2.6 KB	792.2 KB	17.8 MB	95%	4.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 20 04:15:02 - 04:59:59	72	1.9%	0.03	223.2 KB	1.4%	0.08
Jan 20 05:00:00 - 05:59:59	61	1.6%	0.02	263.0 KB	1.6%	0.07
Jan 20 06:00:00 - 06:59:59	55	1.5%	0.02	216.1 KB	1.3%	0.06
Jan 20 07:00:00 - 07:59:59	109	2.9%	0.03	359.1 KB	2.2%	0.10
Jan 20 08:00:00 - 08:59:59	120	3.2%	0.03	465.2 KB	2.8%	0.13
Jan 20 09:00:00 - 09:59:59	126	3.4%	0.04	862.2 KB	5.2%	0.24
Jan 20 10:00:00 - 10:59:59	145	3.9%	0.04	784.1 KB	4.8%	0.22
Jan 20 11:00:00 - 11:59:59	162	4.4%	0.04	735.1 KB	4.5%	0.20
Jan 20 12:00:00 - 12:59:59	184	5.0%	0.05	1.0 MB	6.3%	0.29
Jan 20 13:00:00 - 13:59:59	174	4.7%	0.05	719.2 KB	4.4%	0.20
Jan 20 14:00:00 - 14:59:59	176	4.7%	0.05	559.9 KB	3.4%	0.16
Jan 20 15:00:00 - 15:59:59	198	5.3%	0.06	796.1 KB	4.8%	0.22
Jan 20 16:00:00 - 16:59:59	197	5.3%	0.05	976.6 KB	5.9%	0.27
Jan 20 17:00:00 - 17:59:59	258	6.9%	0.07	1.1 MB	6.8%	0.31
Jan 20 18:00:00 - 18:59:59	202	5.4%	0.06	1.1 MB	6.8%	0.31
Jan 20 19:00:00 - 19:59:59	181	4.9%	0.05	568.6 KB	3.5%	0.16
Jan 20 20:00:00 - 20:59:59	201	5.4%	0.06	649.7 KB	3.9%	0.18
Jan 20 21:00:00 - 21:59:59	147	4.0%	0.04	459.0 KB	2.8%	0.13
Jan 20 22:00:00 - 22:59:59	158	4.3%	0.04	543.0 KB	3.3%	0.15
Jan 20 23:00:00 - 23:59:59	216	5.8%	0.06	759.3 KB	4.6%	0.21
Jan 21 00:00:00 - 00:59:59	147	4.0%	0.04	729.1 KB	4.4%	0.20
Jan 21 01:00:00 - 01:59:59	139	3.7%	0.04	430.2 KB	2.6%	0.12
Jan 21 02:00:00 - 02:59:59	151	4.1%	0.04	1.6 MB	9.7%	0.45
Jan 21 03:00:00 - 03:59:59	111	3.0%	0.03	404.2 KB	2.5%	0.11
Jan 21 04:00:00 - 04:15:01	27	0.7%	0.03	67.0 KB	0.4%	0.07
TOTAL: 23:59:59	3717	100.0%	0.04	16.1 MB	100.0%	0.19

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	i2pn.org	76	0	0	76
2	news.nntp4.net	63	0	0	63
3	news-out.aioe.org	60	1	0	59
4	news.glou.org	37	0	0	37
5	usenet.pasdenom.info	6	0	0	6
6	nntp.terraraq.uk	4	0	0	4
7	news.samoylyk.net	2	0	0	2
8	gegeweb-out.news.tnetconsulting.net	2	0	1	1
TOTAL: 8		250	1	1	248

Unwanted newsgroups [Top 20]:

Newsgroup	Count
news.test	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
Bad path (news.giganews.com.POSTED)	93
EMP (md5)	84
EMP (phn path)	26
Too many newsgroups	21
EMP (phn nph)	9
EMP (phl)	2
TOTAL: 6	235

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news-out.aioe.org	11
	i2pn.org	2
	TOTAL: 2	13
TOTAL: 1		13

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.nntp4.net	3921	8	3652	0	0	0%	23:59:54
2	news.gegeweb.org	3573	7	3455	1	0	0%	23:59:56
3	nntp.terraraq.uk	2660	6	2421	2	1	0%	23:59:56
4	i2pn.org	5133	5	2827	4	32	0%	23:59:53
5	news.tnetconsulting.net	6003	3	3704	3	24	0%	23:59:56
6	news.aioe.org	1681	0	1541	4	0	0%	23:59:52
7	news.pasdenom.info	3285	0	3034	1	0	0%	23:59:56
8	news.samoylyk.net	4267	0	3696	2	0	0%	23:59:56
TOTAL: 8		30523	29	24330	17	57	0%	191:59:19

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.nntp4.net	164.3 KB	0.0 KB	164.3 KB	20.5 KB	23:59:54
2	news.tnetconsulting.net	24.9 KB	7.4 KB	32.2 KB	5.4 KB	23:59:56
3	i2pn.org	23.9 KB	9.7 KB	33.7 KB	3.7 KB	23:59:53
4	news.gegeweb.org	13.6 KB	3.1 KB	16.7 KB	2.1 KB	23:59:56
5	nntp.terraraq.uk	13.0 KB	189.9 KB	202.9 KB	25.4 KB	23:59:56
6	news.aioe.org	0.0 KB	13.4 KB	13.4 KB	3.3 KB	23:59:52
7	news.pasdenom.info	0.0 KB	8.2 KB	8.2 KB	8.2 KB	23:59:56
8	news.samoylyk.net	0.0 KB	5.6 KB	5.6 KB	2.8 KB	23:59:56
TOTAL: 8		239.7 KB	237.2 KB	477.0 KB	10.4 KB	191:59:19

NNRP readership statistics:

System		Conn	Elapsed
1	mail.gegeweb.eu	288	00:01:25
2	175.178.191.129	2	00:00:01
3	supportive.monitoring.internet-measurement.com	1	00:00:00
4	sprightly.monitoring.internet-measurement.com	1	00:00:00
5	commended.monitoring.internet-measurement.com	1	00:00:00
6	proud.monitoring.internet-measurement.com	1	00:00:00
7	intelligent.monitoring.internet-measurement.com	1	00:00:00
8	prudent.monitoring.internet-measurement.com	1	00:00:00
9	magnanimous.monitoring.internet-measurement.com	1	00:00:00
10	hopeful.monitoring.internet-measurement.com	1	00:00:00
11	encouraging.monitoring.internet-measurement.com	1	00:00:00
12	jubilant.monitoring.internet-measurement.com	1	00:00:00
13	famous.monitoring.internet-measurement.com	1	00:00:05
14	happy.monitoring.internet-measurement.com	1	00:00:00
15	192.241.239.25	1	00:00:00
16	wholesome.monitoring.internet-measurement.com	1	00:00:00
17	resounding.monitoring.internet-measurement.com	1	00:00:00
18	empathetic.monitoring.internet-measurement.com	1	00:00:05
19	soulful.monitoring.internet-measurement.com	1	00:00:00
20	amicable.monitoring.internet-measurement.com	1	00:00:01
21	patient.monitoring.internet-measurement.com	1	00:00:00
22	creative.monitoring.internet-measurement.com	1	00:00:00
23	evocative.monitoring.internet-measurement.com	1	00:00:00
24	lstlambert-656-1-48-236.w92-154.abo.wanadoo.fr	1	00:00:10
25	172-105-246-139.ip.linodeusercontent.com	194	00:00:51
26	thrifty.monitoring.internet-measurement.com	1	00:00:00
27	spellbound.monitoring.internet-measurement.com	1	00:00:00
28	eloquent.monitoring.internet-measurement.com	1	00:00:00
TOTAL: 28		509	00:02:45

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.ip.linodeusercontent.com	194	00:00:51
2	*.w92-154.abo.wanadoo.fr	1	00:00:10
3	unresolved	3	00:00:01
4	*.monitoring.internet-measurement.com	23	00:00:15
5	*.gegeweb.eu	288	00:01:25
TOTAL: 5		509	00:02:45

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.510	4.508	1.936	00:01:25
172-105-246-139.ip.linodeusercontent.com	4.666	3.057	0.000	00:00:51
lstlambert-656-1-48-236.w92-154.abo.wanadoo.fr	0.026	0.026	0.000	00:00:10
famous.monitoring.internet-measurement.com	0.066	0.028	0.000	00:00:05
empathetic.monitoring.internet-measurement.com	0.085	0.011	0.000	00:00:05
amicable.monitoring.internet-measurement.com	0.035	0.017	0.000	00:00:01
175.178.191.129	0.064	0.046	0.000	00:00:01
wholesome.monitoring.internet-measurement.com	0.019	0.019	0.000	00:00:00
192.241.239.25	0.020	0.031	0.000	00:00:00
happy.monitoring.internet-measurement.com	0.059	0.030	0.000	00:00:00
prudent.monitoring.internet-measurement.com	0.030	0.010	0.000	00:00:00
evocative.monitoring.internet-measurement.com	0.049	0.039	0.000	00:00:00
eloquent.monitoring.internet-measurement.com	0.055	0.022	0.000	00:00:00
thrifty.monitoring.internet-measurement.com	0.017	0.025	0.000	00:00:00
encouraging.monitoring.internet-measurement.com	0.047	0.012	0.000	00:00:00
hopeful.monitoring.internet-measurement.com	0.043	0.026	0.000	00:00:00
commended.monitoring.internet-measurement.com	0.058	0.019	0.000	00:00:00
supportive.monitoring.internet-measurement.com	0.035	0.023	0.000	00:00:00
patient.monitoring.internet-measurement.com	0.039	0.000	0.000	00:00:00
sprightly.monitoring.internet-measurement.com	0.039	0.000	0.000	00:00:00
TOTAL: 28	10.142	8.099	1.936	00:02:45

NNRP unrecognized commands (by host):

System	Conn
175.178.191.129	9
192.241.239.25	1
TOTAL: 2	10

NNRP unrecognized commands (by command):

Command	Count
GET / HTTP/1.1	1
À#024	1
#026#003#001	1
MGLNDD_45.13.105.36_119	1
Connection: close	1
Accept-Encoding: gzip	1
Host: 45.13.105.36:119	1
User-Agent: Mozilla/5.0 (Windows NT 6.1;...	1
Accept-Charset: utf-8	1
#023#001#023#002#023#003#001	1
TOTAL: 10	10

Daily Usenet report for news.niel.me

Jan 20 04:15:02 -- Jan 21 04:15:01