Daily Usenet Report: Jul 23 00:01:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jul 23 08:11:02 newsfeed innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
innfeed	43189	64.3%	5.7 MB	47.9%
inn	12930	19.3%	4.5 MB	37.5%
innd	10248	15.3%	1.6 MB	13.4%
cnfsstat	432	0.6%	75.1 KB	0.6%
nnrpd	193	0.3%	16.7 KB	0.1%
nocem	150	0.2%	39.8 KB	0.3%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 7	67143	100.0%	11.9 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	135080	56.0%
Negative hits	80653	33.4%
Cache misses	13137	5.4%
Do not exist	12437	5.2%
TOTAL: 4	241307	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:08.772	0.0%	1220	0.000	7.190	66.500
article cleanup	00:00:00.105	0.0%	12392	0.000	0.008	0.107
article logging	00:00:00.895	0.0%	12509	0.000	0.072	2.415
article parse	00:00:00.282	0.0%	21114	0.000	0.013	0.054
article write	00:00:02.586	0.0%	8566	0.000	0.302	5.191
artlog/artcncl	00:00:00.021	0.0%	410	0.000	0.051	0.250
data move	00:00:00.974	0.0%	221213	0.000	0.004	0.237
hisgrep/artcncl	00:00:05.974	0.0%	1186	0.000	5.037	15.438
hishave/artcncl	00:00:00.090	0.0%	524	0.000	0.172	2.043
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:02:57.726	0.2%	241183	0.091	0.737	5.269
history sync	00:00:00.070	0.0%	399	0.000	0.175	1.000
history write	00:02:19.617	0.2%	12384	2.952	11.274	118.875
hiswrite/artcncl	00:00:00.095	0.0%	37	2.500	2.568	2.619
idle	23:34:47.785	98.6%	216235	67.990	392.572	1459.562
nntp read	00:00:03.602	0.0%	223797	0.002	0.016	0.315
overview write	00:12:39.263	0.9%	8566	0.536	88.637	9294.206
perl filter	00:00:40.107	0.0%	12384	1.114	3.239	24.353
python filter	00:00:01.926	0.0%	12384	0.000	0.156	4.203
site send	00:00:01.409	0.0%	17210	0.000	0.082	0.260
TOTAL: 23:54:34.372	23:53:51.299	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.051	0.0%	32913	0.000	0.002	0.024
article prepare	00:00:00.005	0.0%	44808	0.000	0.000	0.003
article read	00:00:00.413	0.0%	2964	0.000	0.139	1.032
backlog stats	00:00:00.500	0.0%	298184	0.000	0.002	0.008
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.653	0.0%	200702	0.003	0.013	0.044
data write	00:00:03.642	0.0%	195316	0.009	0.019	0.057
idle	23:56:15.861	99.9%	298184	80.210	289.002	835.778
status file	00:00:45.724	0.1%	16855	1.016	2.713	202.893
TOTAL: 23:57:31.625	23:57:08.849	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	24:31:47.780	100.0%	1712	15.000	51581.647	51819.819
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.047	0.0%	3444	0.000	0.014	0.014
readart	00:00:00.009	0.0%	17	0.529	0.529	0.529
TOTAL: 24:31:48.739	24:31:47.836	100.0%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
mode	98
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	120

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	outgoing.news.lysator.liu.se	1	7374	1849	5417	108	25%	23:59:57
2	endofthelinebbs-out.news.weretis.net	4	15136	1735	13096	305	11%	44:24:50
3	usenet.blueworldhosting.com	724	10160	938	8535	687	9%	23:50:17
4	nntp.comgw.net	3	9173	792	8246	135	8%	24:08:50
5	news.hispagatos.org	6	8724	601	8081	42	6%	24:25:40
6	news.corradoroberto.it	6	1382	449	933	0	32%	26:20:53
7	usenet.goja.nl.eu.org	11	9165	393	8725	47	4%	25:27:12
8	usenet.network	2	5937	281	5653	3	4%	23:59:34
9	i2pn.org	2	8504	259	8231	14	3%	23:59:43
10	newsfeed.bofh.team	2	9470	245	9215	10	2%	23:59:46
11	endoftheline-out.news.chmurka.net	1	4254	202	4051	1	4%	23:59:56
12	194.87.241.33	44	351	187	164	0	53%	17:10:39
13	endofthelinebbs.peers.news.panix.com	29	9635	186	9365	84	1%	24:47:47
14	news.samoylyk.net	4	15956	170	15009	777	1%	03:22:38
15	newsfeed.xs3.de	2	7214	137	7077	0	1%	23:59:22
16	news.nntp4.net	1	6679	70	6608	1	1%	23:59:53
17	news.netfront.net	1	10670	51	10488	131	0%	25:50:57
18	news.bbs.nz	1	8143	26	8116	1	0%	23:59:29
19	glockenspiel.complete.org	2	7309	17	7292	0	0%	23:59:07
20	news.furie.org.uk	1	4325	16	4306	3	0%	23:59:37
21	photonic.trudheim.com	2	3669	8	2121	1540	0%	25:05:41
22	eotl-out.news.tnetconsulting.net	1	0	0	0	0	0%	00:10:07
23	localhost	9	0	0	0	0	0%	00:00:00
24	news.nk.ca	2	0	0	0	0	0%	00:20:18
TOTAL: 24		861	163230	8612	150729	3889	5%	505:22:13

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	outgoing.news.lysator.liu.se	5.7 MB	0.0 KB	229.1 KB	5.9 MB	96%	3.1 KB
2	endofthelinebbs-out.news.weretis.net	4.6 MB	0.0 KB	687.7 KB	5.3 MB	87%	2.7 KB
3	usenet.network	2.8 MB	0.0 KB	2.8 KB	2.8 MB	99%	10.2 KB
4	news.corradoroberto.it	2.6 MB	0.0 KB	0.0 KB	2.6 MB	100%	6.0 KB
5	usenet.blueworldhosting.com	2.1 MB	23.0 KB	1.9 MB	4.0 MB	52%	2.5 KB
6	news.hispagatos.org	1.8 MB	0.0 KB	150.7 KB	1.9 MB	92%	3.0 KB
7	nntp.comgw.net	1.7 MB	0.0 KB	669.0 KB	2.3 MB	72%	2.6 KB
8	usenet.goja.nl.eu.org	1.1 MB	0.0 KB	52.6 KB	1.2 MB	95%	2.7 KB
9	i2pn.org	1.0 MB	0.0 KB	18.1 KB	1.0 MB	98%	3.9 KB
10	news.samoylyk.net	1022.5 KB	0.0 KB	1.5 MB	2.5 MB	40%	2.7 KB
11	endoftheline-out.news.chmurka.net	644.8 KB	0.0 KB	0.8 KB	645.5 KB	99%	3.2 KB
12	194.87.241.33	457.5 KB	0.0 KB	0.0 KB	457.5 KB	100%	2.4 KB
13	endofthelinebbs.peers.news.panix.com	405.1 KB	0.0 KB	347.7 KB	752.8 KB	53%	2.8 KB
14	newsfeed.bofh.team	360.9 KB	0.0 KB	40.8 KB	401.7 KB	89%	1.6 KB
15	newsfeed.xs3.de	349.0 KB	0.0 KB	0.0 KB	349.0 KB	100%	2.5 KB
16	news.nntp4.net	221.7 KB	0.0 KB	0.8 KB	222.5 KB	99%	3.1 KB
17	glockenspiel.complete.org	71.7 KB	0.0 KB	0.0 KB	71.7 KB	100%	4.2 KB
18	news.netfront.net	68.6 KB	0.0 KB	374.7 KB	443.3 KB	15%	2.4 KB
19	news.bbs.nz	64.7 KB	0.0 KB	1.6 KB	66.3 KB	97%	2.5 KB
20	news.furie.org.uk	49.3 KB	0.0 KB	13.1 KB	62.4 KB	79%	3.3 KB
21	photonic.trudheim.com	29.4 KB	0.0 KB	8.5 MB	8.5 MB	0%	5.7 KB
22	eotl-out.news.tnetconsulting.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
23	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
24	news.nk.ca	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 24		27.1 MB	23.0 KB	14.4 MB	41.6 MB	65%	3.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jul 23 00:01:02 - 00:59:59	406	4.7%	0.11	878.8 KB	3.1%	0.25
Jul 23 01:00:00 - 01:59:59	391	4.6%	0.11	916.6 KB	3.3%	0.25
Jul 23 02:00:00 - 02:59:59	359	4.2%	0.10	1011.4 KB	3.6%	0.28
Jul 23 03:00:00 - 03:59:59	459	5.4%	0.13	1.5 MB	5.6%	0.44
Jul 23 04:00:00 - 04:59:59	592	6.9%	0.16	1.4 MB	5.1%	0.40
Jul 23 05:00:00 - 05:59:59	451	5.3%	0.13	1.3 MB	4.7%	0.36
Jul 23 06:00:00 - 06:59:59	455	5.3%	0.13	1.8 MB	6.5%	0.51
Jul 23 07:00:00 - 07:59:59	449	5.2%	0.12	1.1 MB	3.9%	0.30
Jul 23 08:00:00 - 08:59:59	436	5.1%	0.12	1.1 MB	4.1%	0.32
Jul 23 09:00:00 - 09:59:59	543	6.3%	0.15	1.7 MB	6.1%	0.48
Jul 23 10:00:00 - 10:59:59	427	5.0%	0.12	1.4 MB	5.0%	0.39
Jul 23 11:00:00 - 11:59:59	427	5.0%	0.12	1.3 MB	4.6%	0.36
Jul 23 12:00:00 - 12:59:59	414	4.8%	0.12	1.4 MB	5.0%	0.39
Jul 23 13:00:00 - 13:59:59	367	4.3%	0.10	1.1 MB	4.2%	0.32
Jul 23 14:00:00 - 14:59:59	377	4.4%	0.10	1.2 MB	4.3%	0.33
Jul 23 15:00:00 - 15:59:59	350	4.1%	0.10	1.2 MB	4.5%	0.35
Jul 23 16:00:00 - 16:59:59	277	3.2%	0.08	1.5 MB	5.3%	0.41
Jul 23 17:00:00 - 17:59:59	260	3.0%	0.07	1.1 MB	4.2%	0.32
Jul 23 18:00:00 - 18:59:59	354	4.1%	0.10	1.7 MB	6.0%	0.47
Jul 23 19:00:00 - 19:59:59	150	1.7%	0.04	595.6 KB	2.1%	0.17
Jul 23 20:00:00 - 20:59:59	118	1.4%	0.03	401.6 KB	1.4%	0.11
Jul 23 21:00:00 - 21:59:59	206	2.4%	0.06	945.8 KB	3.4%	0.26
Jul 23 22:00:00 - 22:59:59	143	1.7%	0.04	601.2 KB	2.1%	0.17
Jul 23 23:00:00 - 23:59:59	157	1.8%	0.04	506.8 KB	1.8%	0.14
Jul 24 00:00:00 - 00:01:01	5	0.1%	0.08	16.2 KB	0.1%	0.27
TOTAL: 23:59:59	8573	100.0%	0.10	27.4 MB	100.0%	0.32

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days
CYCNGS1	NGS	1536.0 GB	48.0 MB	0.0%	1	0.00	0.00
CYCNGS2	NGS	1536.0 GB	95.3 GB	6.2%	0	0.51	36755.63
CYCTXT1	TEXT	5.0 GB	3.6 GB	72.2%	0	0.09	686.53
TOTAL: 3	-	3077.0 GB	99.0 GB	3.2%	1	0.37	-

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	photonic.trudheim.com	1432	676	0	756
2	news.samoylyk.net	777	47	0	730
3	usenet.blueworldhosting.com	711	45	8	658
4	endofthelinebbs-out.news.weretis.net	393	0	0	393
5	news.netfront.net	161	0	0	161
6	nntp.comgw.net	141	0	0	141
7	outgoing.news.lysator.liu.se	109	10	0	99
8	endofthelinebbs.peers.news.panix.com	91	69	0	22
9	usenet.goja.nl.eu.org	53	0	0	53
10	news.hispagatos.org	46	7	0	39
11	i2pn.org	15	0	0	15
12	newsfeed.bofh.team	11	0	0	11
13	news.furie.org.uk	3	0	0	3
14	usenet.network	3	0	0	3
15	endoftheline-out.news.chmurka.net	1	0	0	1
16	news.bbs.nz	1	0	0	1
17	news.nntp4.net	1	0	0	1
TOTAL: 17		3949	854	8	3087

Unwanted newsgroups [Top 20]:

Newsgroup	Count
org.kernel.vger.linux-kernel	330
alt.russian.z1	65
org.xenproject.lists.xen-devel	60
org.kernel.vger.kvm	42
org.kernel.vger.netdev	38
org.infradead.lists.linux-riscv	31
edu.columbia.cs.lists.kvmarm	30
org.kernel.vger.linux-btrfs	26
org.kernel.vger.linux-doc	25
org.kvack.linux-mm	24
org.kernel.vger.linux-pci	22
org.kernel.vger.io-uring	14
org.kernel.vger.linux-hardening	14
org.alsa-project.alsa-devel	13
org.infradead.lists.linux-nvme	13
org.kernel.vger.linux-acpi	13
org.kernel.vger.linux-cifs	13
org.kernel.vger.linux-nfs	11
org.kernel.vger.linux-cxl	8
org.kernel.vger.linux-wireless	7
TOTAL: 37	854

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	1434
EMP (phr path)	930
EMP (md5)	298
Too many newsgroups	200
User-issued cancel	49
EMP (fsl)	29
HTML Multipart	24
Subject (LSDQvdCw0Ygg0LrQvtGB0YzQutCwINCz0LvQsNCy0L3Ri9C5INC/0LjQtN)	3
MID-Bot	2
Cancel for rejected article	1
TOTAL: 10	2970

NoCeM on Spool:

Issuer (type)	Notices	Cancel	Skip	Total
i2pn2-nocem@i2pn2.org (spam)	70	528	0	528
robot@pasdenom.info (spam3)	6	0	10	10
robot@pasdenom.info (spam2)	3	0	3	3
TOTAL: 3	79	528	13	541

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	endofthelinebbs-out.news.weretis.net	73
	usenet.blueworldhosting.com	24
	usenet.goja.nl.eu.org	6
	endofthelinebbs.peers.news.panix.com	6
	nntp.comgw.net	5
	outgoing.news.lysator.liu.se	1
	i2pn.org	1
	news.hispagatos.org	1
	TOTAL: 8	117
TOTAL: 1		117

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	nyheter.lysator.liu.se	6954	1637	4692	395	10	23%	23:59:15
2	photonic.trudheim.com	9166	612	6760	1185	35	6%	23:59:43
3	news.furie.org.uk	4812	485	3594	18	6	10%	23:59:49
4	news.hispagatos.org	9456	481	7310	209	9	5%	23:58:54
5	usenet.network	8951	469	7095	49	13	5%	23:59:27
6	news.corradoroberto.it	1502	355	720	0	22	23%	22:49:26
7	usenet.goja.nl.eu.org	9192	339	7401	265	13	3%	23:59:49
8	news.bbs.nz	15513	324	7783	444	502	2%	23:59:12
9	news.nntp4.net	9428	324	8020	64	23	3%	23:59:41
10	newsfeed.bofh.team	8834	321	7314	0	0	3%	23:59:49
11	news.nk.ca	11741	214	7642	626	276	1%	23:59:49
12	news.tnetconsulting.net	9564	200	8097	272	210	2%	23:59:38
13	news.weretis.net	8899	187	8216	167	0	2%	23:59:13
14	nntp.comgw.net	8850	156	7471	156	13	1%	23:59:49
15	news.quux.org	8953	144	7849	561	0	1%	23:59:35
16	i2pn.org	9519	131	8077	88	16	1%	23:59:21
17	newsfeed.xs3.de	9879	98	8144	188	15	0%	23:59:43
18	news.chmurka.net	4617	53	3906	0	0	1%	23:59:49
19	news.samoylyk.net	18496	3	18364	2	7640	0%	23:59:49
20	usenet.blueworldhosting.com	7440	1	7212	2	0	0%	23:59:35
21	ddt.demos.su	2811	0	0	0	2890	0%	23:59:49
22	news.netfront.net	2746	0	0	0	11268	0%	23:59:49
23	endofthelinebbs.peers.news.panix.com	0	0	0	0	8570	0%	23:59:49
24	feed.opticnetworks.net	0	0	0	0	8573	0%	23:59:49
TOTAL: 24		187323	6534	145667	4691	40104	3%	574:40:42

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	nyheter.lysator.liu.se	5.3 MB	3.3 MB	8.6 MB	0.1 KB/s	4.4 KB	23:59:15
2	photonic.trudheim.com	3.6 MB	3.5 MB	7.2 MB	0.1 KB/s	4.1 KB	23:59:43
3	news.furie.org.uk	3.6 MB	93.7 KB	3.7 MB	0.0 KB/s	7.5 KB	23:59:49
4	newsfeed.bofh.team	2.1 MB	0.0 KB	2.1 MB	0.0 KB/s	6.5 KB	23:59:49
5	news.hispagatos.org	1.8 MB	1.5 MB	3.3 MB	0.0 KB/s	4.9 KB	23:58:54
6	usenet.network	1.5 MB	134.0 KB	1.6 MB	0.0 KB/s	3.2 KB	23:59:27
7	news.tnetconsulting.net	1.1 MB	1.6 MB	2.6 MB	0.0 KB/s	5.7 KB	23:59:38
8	news.bbs.nz	1.1 MB	2.9 MB	4.0 MB	0.0 KB/s	5.4 KB	23:59:12
9	news.nntp4.net	1.1 MB	418.6 KB	1.5 MB	0.0 KB/s	3.9 KB	23:59:41
10	usenet.goja.nl.eu.org	1.0 MB	2.4 MB	3.4 MB	0.0 KB/s	5.8 KB	23:59:49
11	news.weretis.net	911.4 KB	1.7 MB	2.6 MB	0.0 KB/s	7.4 KB	23:59:13
12	news.corradoroberto.it	863.8 KB	0.0 KB	863.8 KB	0.0 KB/s	2.4 KB	22:49:26
13	news.quux.org	846.0 KB	3.2 MB	4.0 MB	0.0 KB/s	5.8 KB	23:59:35
14	nntp.comgw.net	642.9 KB	1.2 MB	1.8 MB	0.0 KB/s	6.0 KB	23:59:49
15	newsfeed.xs3.de	628.0 KB	1.2 MB	1.8 MB	0.0 KB/s	6.6 KB	23:59:43
16	i2pn.org	439.3 KB	375.0 KB	814.3 KB	0.0 KB/s	3.7 KB	23:59:21
17	news.nk.ca	400.1 KB	3.4 MB	3.8 MB	0.0 KB/s	4.6 KB	23:59:49
18	news.chmurka.net	207.0 KB	0.0 KB	207.0 KB	0.0 KB/s	3.9 KB	23:59:49
19	news.samoylyk.net	11.1 KB	2.8 KB	13.8 KB	0.0 KB/s	2.8 KB	23:59:49
20	usenet.blueworldhosting.com	1.9 KB	2.9 KB	4.8 KB	0.0 KB/s	1.6 KB	23:59:35
21	ddt.demos.su	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:49
22	endofthelinebbs.peers.news.panix.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:49
23	feed.opticnetworks.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:49
24	news.netfront.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:49
TOTAL: 24		27.1 MB	26.9 MB	53.9 MB	0.0 KB/s	4.9 KB	574:40:42

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	3	2	4.1 KB	1	24:31:46
2	*.monitoring.internet-measurement.com	1	0	0.0 KB	0	00:00:01
3	*.stretchoid.com	1	0	0.0 KB	0	00:00:00
TOTAL: 3		5	2	4.1 KB	1	24:31:48

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
47.186.0.68	0.077	0.224	0.097	24:31:41
147.185.132.174	0.004	0.013	0.000	00:00:04
cozy.monitoring.internet-measurement.com	0.004	0.020	0.000	00:00:01
80.66.76.121	0.009	0.009	0.000	00:00:00
91.238.181.22	0.008	0.012	0.000	00:00:00
azpdsgb31.stretchoid.com	0.004	0.013	0.000	00:00:00
TOTAL: 6	0.106	0.291	0.097	24:31:48

Curious NNRP server explorers [Top 20]:

System	Conn
147.185.132.174	1
80.66.76.121	1
91.238.181.22	1
azpdsgb31.stretchoid.com	1
cozy.monitoring.internet-measurement.com	1
TOTAL: 5	5

NNRP unrecognized commands (by host) [Top 20]:

System	Conn
80.66.76.121	1
91.238.181.22	1
azpdsgb31.stretchoid.com	1
TOTAL: 3	3

NNRP unrecognized commands (by command) [Top 20]:

Command	Count
#003	2
MGLNDD_144.172.126.95_119	1
TOTAL: 2	3

NNRP client timeouts [Top 20]:

System	Conn	Peer
80.66.76.121	1	1
91.238.181.22	1	1
TOTAL: 2	2	3

Newsgroup request counts (by hierarchy):

Hierarchy		Count	Pct
1	comp	2	100.0%
TOTAL: 1		2	100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

Newsgroup		Count
1	comp.sys.acorn.apps	2
TOTAL: 1		2

Daily Usenet Report

Jul 23 00:01:02 -- Jul 24 00:01:01