Daily Usenet report for news.niel.me: Jan 6 04:15:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Jan 6 17:19:33 rpi-studio innd: filter: No Cancel-Key[sha1:vCul+fHY67PtH3MVFK/tNqlIugE=] matches Cancel-Lock[sha1:rLam+q2+i3rBso3BGcrvmxLpFY8=] target=<63b83e6f$0$25970$426a74cc@news.free.fr>
Jan 7 01:30:03 rpi-studio innd: filter: No Cancel-Key[sha1:bc7HrUcUqRLp7Cc9ET+oXILLDJs=] matches Cancel-Lock[sha1:cDIMtJ4yQqdcDsJtr6Zi31AWLlQ=] target=<de-gruppen-finden-31.12.2022@dnqmail.priggish.de>

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3990	40.8%	783.6 KB	46.5%
innd	2278	23.3%	416.6 KB	24.7%
nnrpd	1761	18.0%	190.3 KB	11.3%
innfeed	1736	17.8%	292.6 KB	17.4%
nocem	3	0.0%	0.3 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	9769	100.0%	1.6 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	26036	64.5%
Negative hits	10397	25.8%
Do not exist	3934	9.7%
Cache misses	3	0.0%
TOTAL: 4	40370	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.023	0.0%	16	0.667	1.438	7.000
article cancel	00:00:00.007	0.0%	20	0.000	0.350	4.000
article cleanup	00:00:00.065	0.0%	3936	0.000	0.017	0.143
article logging	00:00:00.311	0.0%	3953	0.000	0.079	0.308
article parse	00:00:00.764	0.0%	8842	0.000	0.086	0.333
article write	00:00:02.498	0.0%	3750	0.143	0.666	1.500
artlog/artcncl	00:00:00.001	0.0%	20	0.000	0.050	0.333
artlog/artcncl/perl	00:00:00.001	0.0%	16	0.000	0.062	1.000
data move	00:00:00.145	0.0%	44388	0.000	0.003	0.014
hisgrep/artcncl	00:00:00.001	0.0%	19	0.000	0.053	0.333
hisgrep/artcncl/perl	00:00:00.000	0.0%	16	0.000	0.000	0.000
hisgrep/perl	00:00:00.003	0.0%	21	0.000	0.143	1.000
hishave/artcncl	00:00:00.001	0.0%	20	0.000	0.050	1.000
hishave/artcncl/perl	00:00:00.000	0.0%	16	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.547	0.0%	40367	0.000	0.014	0.033
history sync	00:00:00.043	0.0%	413	0.000	0.104	0.667
history write	00:00:00.902	0.0%	3936	0.053	0.229	0.562
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
idle	24:00:36.655	100.0%	45051	753.567	1918.640	6319.537
nntp read	00:00:01.299	0.0%	44411	0.004	0.029	0.064
overview write	00:00:02.378	0.0%	3750	0.067	0.634	4.818
perl filter	00:00:16.388	0.0%	3936	2.627	4.164	10.778
python filter	00:00:00.009	0.0%	3936	0.000	0.002	0.077
site send	00:00:01.766	0.0%	7564	0.000	0.233	0.500
TOTAL: 24:01:15.825	24:01:03.807	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.027	0.0%	3900	0.000	0.007	0.133
article prepare	00:00:00.001	0.0%	332	0.000	0.003	0.125
article read	00:00:00.019	0.0%	66	0.000	0.288	8.000
backlog stats	00:00:00.145	0.0%	55195	0.000	0.003	0.017
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.799	0.0%	33611	0.000	0.024	0.073
data write	00:00:01.906	0.0%	30133	0.012	0.063	0.113
idle	23:57:06.569	100.0%	55195	620.520	1562.217	3784.132
status file	00:00:00.407	0.0%	177	2.000	2.299	7.000
TOTAL: 23:57:13.533	23:57:09.873	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:45.688	69.2%	1453	11.600	31.444	10040.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.102	0.2%	3198	0.000	0.032	0.364
TOTAL: 00:01:06.047	00:00:45.790	69.3%	-	-	-	-

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	3693	1588	2055	50	43%	22:57:19
2	i2pn.org	2	3939	1124	2726	89	28%	24:52:42
3	news.glou.org	1	3142	448	2673	21	14%	23:59:57
4	feed-out.gegeweb.org	3	2343	268	2075	0	11%	23:59:48
5	usenet.pasdenom.info	1	2354	156	2195	3	6%	23:59:54
6	nntp.terraraq.uk	2	3602	92	3506	4	2%	23:59:15
7	news.samoylyk.net	2	7473	53	7419	1	0%	46:55:11
8	gegeweb-out.news.tnetconsulting.net	1	3840	49	3781	10	1%	23:59:57
9	news.nntp4.net	2	3669	17	3631	21	0%	22:23:22
10	localhost	26	0	0	0	0	0%	00:00:00
TOTAL: 10		41	34055	3795	30061	199	11%	237:07:25

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news-out.aioe.org	6.2 MB	321.2 KB	6.5 MB	95%	4.1 KB
2	news.samoylyk.net	3.9 MB	1.8 KB	3.9 MB	99%	74.2 KB
3	i2pn.org	3.5 MB	279.5 KB	3.8 MB	92%	3.2 KB
4	news.glou.org	3.3 MB	146.6 KB	3.5 MB	95%	7.6 KB
5	feed-out.gegeweb.org	934.4 KB	0.0 KB	934.4 KB	100%	3.5 KB
6	usenet.pasdenom.info	382.9 KB	4.7 KB	387.6 KB	98%	2.4 KB
7	nntp.terraraq.uk	350.1 KB	11.3 KB	361.4 KB	96%	3.8 KB
8	gegeweb-out.news.tnetconsulting.net	306.8 KB	80.6 KB	387.4 KB	79%	6.6 KB
9	news.nntp4.net	104.7 KB	112.3 KB	217.1 KB	48%	5.7 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		19.0 MB	958.0 KB	20.0 MB	95%	5.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 6 04:15:01 - 04:59:59	59	1.6%	0.02	234.0 KB	1.4%	0.09
Jan 6 05:00:00 - 05:59:59	94	2.5%	0.03	268.6 KB	1.6%	0.07
Jan 6 06:00:00 - 06:59:59	151	4.0%	0.04	540.8 KB	3.1%	0.15
Jan 6 07:00:00 - 07:59:59	153	4.1%	0.04	494.0 KB	2.9%	0.14
Jan 6 08:00:00 - 08:59:59	96	2.6%	0.03	331.5 KB	1.9%	0.09
Jan 6 09:00:00 - 09:59:59	126	3.4%	0.04	445.5 KB	2.6%	0.12
Jan 6 10:00:00 - 10:59:59	130	3.5%	0.04	529.3 KB	3.1%	0.15
Jan 6 11:00:00 - 11:59:59	121	3.2%	0.03	514.0 KB	3.0%	0.14
Jan 6 12:00:00 - 12:59:59	157	4.2%	0.04	516.2 KB	3.0%	0.14
Jan 6 13:00:00 - 13:59:59	194	5.2%	0.05	717.9 KB	4.2%	0.20
Jan 6 14:00:00 - 14:59:59	154	4.1%	0.04	590.1 KB	3.4%	0.16
Jan 6 15:00:00 - 15:59:59	191	5.1%	0.05	1.0 MB	6.1%	0.29
Jan 6 16:00:00 - 16:59:59	149	4.0%	0.04	1.2 MB	7.2%	0.35
Jan 6 17:00:00 - 17:59:59	250	6.7%	0.07	820.9 KB	4.8%	0.23
Jan 6 18:00:00 - 18:59:59	218	5.8%	0.06	785.3 KB	4.6%	0.22
Jan 6 19:00:00 - 19:59:59	190	5.1%	0.05	757.7 KB	4.4%	0.21
Jan 6 20:00:00 - 20:59:59	180	4.8%	0.05	1.2 MB	7.4%	0.35
Jan 6 21:00:00 - 21:59:59	174	4.6%	0.05	1.6 MB	9.2%	0.44
Jan 6 22:00:00 - 22:59:59	244	6.5%	0.07	1.4 MB	8.4%	0.40
Jan 6 23:00:00 - 23:59:59	204	5.4%	0.06	788.8 KB	4.6%	0.22
Jan 7 00:00:00 - 00:59:59	157	4.2%	0.04	727.2 KB	4.2%	0.20
Jan 7 01:00:00 - 01:59:59	125	3.3%	0.03	396.8 KB	2.3%	0.11
Jan 7 02:00:00 - 02:59:59	130	3.5%	0.04	623.0 KB	3.6%	0.17
Jan 7 03:00:00 - 03:59:59	83	2.2%	0.02	428.6 KB	2.5%	0.12
Jan 7 04:00:00 - 04:15:02	21	0.6%	0.02	132.4 KB	0.8%	0.15
TOTAL: 24:00:01	3751	100.0%	0.04	16.9 MB	100.0%	0.20

Sites sending bad articles:

Server		Total	Group	Other
1	i2pn.org	85	0	85
2	news-out.aioe.org	57	1	56
3	news.nntp4.net	21	0	21
4	news.glou.org	21	0	21
5	nntp.terraraq.uk	8	0	8
6	news.samoylyk.net	7	0	7
7	usenet.pasdenom.info	4	0	4
TOTAL: 7		203	1	202

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)	69
EMP (md5)	63
EMP (phl)	23
EMP (phn nph)	13
Too many newsgroups	11
Cancels abusifs	2
HTML Multipart	1
No Cancel-Key matches Cancel-Lock. target=<63b83e6f$0$25970$426a74cc@news.free.fr>	1
Cancel of non-existing ID <k1rgakFs83pU1@mid.individual.net>	1
Cancel of non-existing ID <k1q010Fl17cU1@mid.individual.net>	1
TOTAL: 10	185

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.samoylyk.net	7
	news-out.aioe.org	7
	i2pn.org	2
	nntp.terraraq.uk	1
	TOTAL: 4	17
TOTAL: 1		17

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn.org	4620	14	2634	4	55	0%	23:57:46
2	news.tnetconsulting.net	5748	13	3725	2	59	0%	23:57:45
3	news.nntp4.net	4329	12	3710	0	5	0%	23:57:46
4	news.samoylyk.net	4392	3	3727	0	27	0%	23:57:46
5	news.gegeweb.org	3553	2	3455	16	2	0%	23:57:23
6	nntp.terraraq.uk	2857	1	2486	16	2	0%	23:57:32
7	news.pasdenom.info	3374	0	3047	0	2	0%	23:57:17
8	news.aioe.org	1831	0	1686	0	0	0%	23:59:57
TOTAL: 8		30704	45	24470	38	152	0%	191:43:12

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.nntp4.net	339.5 KB	0.0 KB	339.5 KB	28.3 KB	23:57:46
2	news.tnetconsulting.net	114.3 KB	20.9 KB	135.2 KB	9.0 KB	23:57:45
3	i2pn.org	76.8 KB	14.3 KB	91.1 KB	5.1 KB	23:57:46
4	news.samoylyk.net	35.8 KB	0.0 KB	35.8 KB	11.9 KB	23:57:46
5	news.gegeweb.org	7.6 KB	82.7 KB	90.3 KB	5.0 KB	23:57:23
6	nntp.terraraq.uk	2.7 KB	791.2 KB	793.9 KB	46.7 KB	23:57:32
7	news.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0	23:57:17
8	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	23:59:57
TOTAL: 8		576.6 KB	909.1 KB	1.5 MB	17.9 KB	191:43:12

NNRP readership statistics:

System		Conn	Elapsed
1	mail.gegeweb.eu	288	00:00:36
2	88.165.5.23	2	00:00:01
3	198.199.111.117	1	00:00:01
4	remarkable.monitoring.internet-measurement.com	1	00:00:02
5	104.152.52.201	1	00:00:00
6	104.152.52.232	1	00:00:10
7	sage.monitoring.internet-measurement.com	1	00:00:01
8	192.241.195.5	1	00:00:09
TOTAL: 8		296	00:01:05

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.monitoring.internet-measurement.com	2	00:00:04
2	*.gegeweb.eu	288	00:00:36
3	unresolved	6	00:00:23
TOTAL: 3		296	00:01:05

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.777	7.564	2.395	00:00:36
104.152.52.232	0.020	0.030	0.000	00:00:10
192.241.195.5	0.024	0.024	0.000	00:00:09
remarkable.monitoring.internet-measurement.com	0.031	0.010	0.000	00:00:02
sage.monitoring.internet-measurement.com	0.042	0.011	0.000	00:00:01
88.165.5.23	0.065	0.048	0.000	00:00:01
198.199.111.117	0.042	0.010	0.000	00:00:01
104.152.52.201	0.008	0.017	0.000	00:00:00
TOTAL: 8	8.009	7.714	2.395	00:01:05

NNRP unrecognized commands (by host):

System	Conn
198.199.111.117	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

Jan 6 04:15:01 -- Jan 7 04:15:02