Daily Usenet Report: Jul 29 00:01:02

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Jul 29 08:09:25 newsfeed innd: message repeated 2 times: [ ctlinnd command s]
Jul 29 21:36:24 newsfeed innfeed[805586]: ME tape invalid messageID in /news/spool/innfeed/news.netfront.net.input: <nRAVLQsHPJQXqqGZg@03024359434E47533200017A108B00000001@

Log entries by program:

Program name	Lines	%Lines	Size	%Size
innfeed	30056	58.0%	3.9 MB	41.1%
inn	11482	22.2%	4.0 MB	42.0%
innd	9563	18.5%	1.5 MB	15.6%
cnfsstat	432	0.8%	75.6 KB	0.8%
nocem	161	0.3%	41.9 KB	0.4%
nnrpd	98	0.2%	9.6 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 7	51793	100.0%	9.6 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	124567	56.9%
Negative hits	77508	35.4%
Do not exist	10853	5.0%
Cache misses	6013	2.7%
TOTAL: 4	218941	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.940	0.0%	584	0.000	1.610	17.875
article cleanup	00:00:00.103	0.0%	11066	0.000	0.009	0.196
article logging	00:00:00.532	0.0%	11167	0.000	0.048	0.184
article parse	00:00:00.281	0.0%	22354	0.000	0.013	0.087
article write	00:00:02.099	0.0%	7728	0.000	0.272	2.080
artlog/artcncl	00:00:00.015	0.0%	345	0.000	0.043	0.600
data move	00:00:01.247	0.0%	214393	0.000	0.006	0.348
hisgrep/artcncl	00:00:00.428	0.0%	585	0.000	0.732	8.875
hishave/artcncl	00:00:00.124	0.0%	555	0.000	0.223	9.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:02:43.630	0.2%	220871	0.089	0.741	4.732
history sync	00:00:00.053	0.0%	391	0.000	0.136	1.000
history write	00:02:06.792	0.1%	11064	2.929	11.460	124.817
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:47:06.541	99.0%	208920	104.135	409.853	1668.006
nntp read	00:00:05.925	0.0%	216397	0.001	0.027	0.423
overview write	00:08:02.919	0.6%	7728	0.500	62.490	16325.778
perl filter	00:00:37.030	0.0%	11064	1.177	3.347	20.520
python filter	00:00:01.476	0.0%	11064	0.000	0.133	7.815
site send	00:00:01.219	0.0%	15538	0.000	0.078	0.253
TOTAL: 24:01:31.847	24:00:51.354	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.243	0.0%	237846	0.000	0.001	0.024
article prepare	00:00:00.004	0.0%	66324	0.000	0.000	0.003
article read	00:00:11.823	0.0%	8922	0.000	1.325	56.673
backlog stats	00:00:00.521	0.0%	381886	0.000	0.001	0.006
callbacks	00:00:00.005	0.0%	21	0.238	0.238	0.238
data read	00:00:02.914	0.0%	259661	0.002	0.011	0.040
data write	00:00:04.469	0.0%	253693	0.007	0.018	0.035
idle	23:56:29.236	99.9%	381886	28.542	225.694	780.512
newart/cb	00:00:00.000	0.0%	2	0.000	0.000	0.000
prepart/cb	00:00:00.000	0.0%	80	0.000	0.000	0.000
readart/cb	00:00:00.004	0.0%	21	0.190	0.190	0.190
status file	00:00:34.426	0.0%	11236	1.000	3.064	279.460
TOTAL: 23:57:50.443	23:57:23.645	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:35.786	97.2%	13	24.500	2752.769	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.000	0.0%	75	0.000	0.000	0.000
TOTAL: 00:00:36.801	00:00:35.786	97.2%	-	-	-	-

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	endofthelinebbs-out.news.weretis.net	4	14461	1511	12647	303	10%	49:06:53
2	outgoing.news.lysator.liu.se	2	6636	1436	5104	96	21%	23:59:54
3	usenet.blueworldhosting.com	723	9655	1013	8113	529	10%	23:52:05
4	nntp.comgw.net	2	8081	748	7214	119	9%	23:59:41
5	news.hispagatos.org	5	7901	486	7395	20	6%	24:26:19
6	news.corradoroberto.it	4	1460	462	998	0	31%	24:28:31
7	usenet.network	2	6036	384	5650	2	6%	23:59:46
8	i2pn.org	2	7703	278	7407	18	3%	23:59:23
9	usenet.goja.nl.eu.org	10	7558	265	7255	38	3%	21:51:06
10	endoftheline-out.news.chmurka.net	1	3898	255	3642	1	6%	23:59:56
11	194.87.241.33	46	276	176	100	0	63%	16:23:43
12	news.samoylyk.net	1	7045	166	6877	2	2%	23:59:53
13	newsfeed.xs3.de	1	6490	155	6334	1	2%	23:59:53
14	endofthelinebbs.peers.news.panix.com	30	8998	126	8800	72	1%	24:43:46
15	newsfeed.bofh.team	1	8590	80	8499	11	0%	23:59:57
16	news.nntp4.net	2	6738	69	6668	1	1%	23:59:45
17	glockenspiel.complete.org	2	5589	49	5536	4	0%	23:57:54
18	news.bbs.nz	3	7868	39	7735	94	0%	05:23:14
19	news.furie.org.uk	1	4243	8	4233	2	0%	23:59:55
20	photonic.trudheim.com	2	4544	3	2472	2069	0%	29:41:37
21	news.netfront.net	3	5047	2	5006	39	0%	18:19:44
22	eotl-out.news.tnetconsulting.net	1	0	0	0	0	0%	00:10:04
23	localhost	6	0	0	0	0	0%	00:00:01
24	news.nk.ca	2	0	0	0	0	0%	00:20:14
TOTAL: 24		856	138817	7711	127685	3421	5%	502:43:14

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	endofthelinebbs-out.news.weretis.net	7.8 MB	2.2 KB	2.3 MB	10.1 MB	77%	5.7 KB
2	outgoing.news.lysator.liu.se	4.9 MB	0.0 KB	215.2 KB	5.2 MB	95%	3.4 KB
3	usenet.network	4.8 MB	0.0 KB	2.0 KB	4.8 MB	99%	12.7 KB
4	news.corradoroberto.it	3.8 MB	0.0 KB	0.0 KB	3.8 MB	100%	8.4 KB
5	usenet.blueworldhosting.com	2.5 MB	0.0 KB	1.4 MB	4.0 MB	63%	2.6 KB
6	nntp.comgw.net	2.1 MB	0.0 KB	420.3 KB	2.6 MB	83%	3.0 KB
7	news.samoylyk.net	2.0 MB	0.0 KB	4.9 KB	2.0 MB	99%	12.2 KB
8	news.hispagatos.org	1.7 MB	0.0 KB	71.2 KB	1.7 MB	96%	3.5 KB
9	endoftheline-out.news.chmurka.net	921.6 KB	0.0 KB	0.8 KB	922.4 KB	99%	3.6 KB
10	i2pn.org	916.5 KB	0.0 KB	44.9 KB	961.4 KB	95%	3.2 KB
11	usenet.goja.nl.eu.org	742.6 KB	0.0 KB	69.1 KB	811.7 KB	91%	2.7 KB
12	194.87.241.33	553.2 KB	0.0 KB	0.0 KB	553.2 KB	100%	3.1 KB
13	newsfeed.xs3.de	462.4 KB	0.0 KB	1.3 KB	463.7 KB	99%	3.0 KB
14	endofthelinebbs.peers.news.panix.com	303.9 KB	0.0 KB	282.7 KB	586.7 KB	51%	3.0 KB
15	newsfeed.bofh.team	273.8 KB	0.0 KB	40.4 KB	314.2 KB	87%	3.5 KB
16	news.nntp4.net	196.8 KB	0.0 KB	2.1 KB	198.9 KB	98%	2.8 KB
17	glockenspiel.complete.org	150.0 KB	1.4 KB	14.0 KB	165.4 KB	90%	3.1 KB
18	news.bbs.nz	108.3 KB	0.0 KB	103.5 KB	211.8 KB	51%	1.6 KB
19	news.furie.org.uk	55.9 KB	473.9 KB	4.7 KB	534.5 KB	10%	53.4 KB
20	photonic.trudheim.com	23.8 KB	0.0 KB	12.1 MB	12.1 MB	0%	6.0 KB
21	news.netfront.net	13.5 KB	1.4 KB	170.2 KB	185.1 KB	7%	4.5 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		34.3 MB	478.9 KB	17.2 MB	51.9 MB	65%	4.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jul 29 00:01:02 - 00:59:59	231	3.0%	0.07	889.3 KB	2.5%	0.25
Jul 29 01:00:00 - 01:59:59	342	4.4%	0.10	2.5 MB	7.2%	0.71
Jul 29 02:00:00 - 02:59:59	338	4.4%	0.09	1.1 MB	3.1%	0.31
Jul 29 03:00:00 - 03:59:59	357	4.6%	0.10	1.1 MB	3.1%	0.31
Jul 29 04:00:00 - 04:59:59	374	4.9%	0.10	1.2 MB	3.6%	0.36
Jul 29 05:00:00 - 05:59:59	354	4.6%	0.10	1.1 MB	3.2%	0.31
Jul 29 06:00:00 - 06:59:59	356	4.6%	0.10	999.8 KB	2.8%	0.28
Jul 29 07:00:00 - 07:59:59	401	5.2%	0.11	1.4 MB	3.9%	0.39
Jul 29 08:00:00 - 08:59:59	448	5.8%	0.12	1.7 MB	5.0%	0.50
Jul 29 09:00:00 - 09:59:59	399	5.2%	0.11	1.2 MB	3.6%	0.35
Jul 29 10:00:00 - 10:59:59	423	5.5%	0.12	1.4 MB	3.9%	0.39
Jul 29 11:00:00 - 11:59:59	463	6.0%	0.13	3.5 MB	10.0%	0.99
Jul 29 12:00:00 - 12:59:59	428	5.6%	0.12	5.4 MB	15.6%	1.54
Jul 29 13:00:00 - 13:59:59	368	4.8%	0.10	1.8 MB	5.2%	0.52
Jul 29 14:00:00 - 14:59:59	404	5.2%	0.11	1.4 MB	4.0%	0.40
Jul 29 15:00:00 - 15:59:59	422	5.5%	0.12	1.8 MB	5.1%	0.51
Jul 29 16:00:00 - 16:59:59	285	3.7%	0.08	1.2 MB	3.3%	0.33
Jul 29 17:00:00 - 17:59:59	282	3.7%	0.08	1.1 MB	3.3%	0.33
Jul 29 18:00:00 - 18:59:59	188	2.4%	0.05	745.2 KB	2.1%	0.21
Jul 29 19:00:00 - 19:59:59	167	2.2%	0.05	708.3 KB	2.0%	0.20
Jul 29 20:00:00 - 20:59:59	183	2.4%	0.05	760.5 KB	2.1%	0.21
Jul 29 21:00:00 - 21:59:59	167	2.2%	0.05	686.8 KB	1.9%	0.19
Jul 29 22:00:00 - 22:59:59	116	1.5%	0.03	454.7 KB	1.3%	0.13
Jul 29 23:00:00 - 23:59:59	209	2.7%	0.06	733.4 KB	2.1%	0.20
Jul 30 00:00:00 - 00:01:03	4	0.1%	0.06	36.0 KB	0.1%	0.57
TOTAL: 24:00:01	7709	100.0%	0.09	34.8 MB	100.0%	0.41

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.6 GB	6.2%	0	0.58	32134.60
CYCTXT1	TEXT	5.0 GB	3.6 GB	72.3%	0	0.06	1063.21
TOTAL: 3	-	3077.0 GB	99.2 GB	3.2%	1	0.42	-

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	photonic.trudheim.com	1998	938	0	1060
2	usenet.blueworldhosting.com	572	12	0	560
3	endofthelinebbs-out.news.weretis.net	337	1	0	336
4	nntp.comgw.net	129	0	0	129
5	outgoing.news.lysator.liu.se	97	5	0	92
6	news.bbs.nz	95	1	0	94
7	endofthelinebbs.peers.news.panix.com	73	59	0	14
8	usenet.goja.nl.eu.org	54	0	0	54
9	news.hispagatos.org	22	6	0	16
10	i2pn.org	18	0	0	18
11	news.netfront.net	11	0	0	11
12	newsfeed.bofh.team	11	0	0	11
13	news.samoylyk.net	5	0	0	5
14	newsfeed.xs3.de	4	0	0	4
15	news.furie.org.uk	2	0	1	1
16	usenet.network	2	0	0	2
17	endoftheline-out.news.chmurka.net	1	0	0	1
18	glockenspiel.complete.org	1	0	0	1
19	news.nntp4.net	1	0	0	1
TOTAL: 19		3433	1022	1	2410

Unwanted newsgroups [Top 20]:

Newsgroup	Count
org.kernel.vger.linux-kernel	228
org.xenproject.lists.xen-devel	97
org.kernel.vger.linux-doc	85
org.infradead.lists.linux-riscv	72
org.nongnu.qemu-devel	67
org.alsa-project.alsa-devel	49
org.kernel.vger.netdev	49
org.kernel.vger.kvm	46
org.kernel.vger.linux-btrfs	40
org.kernel.vger.linux-nfs	37
org.kvack.linux-mm	37
org.kernel.vger.linux-wireless	31
org.kernel.vger.linux-hardening	25
org.kernel.vger.linux-cxl	24
org.kernel.vger.linux-crypto	23
alt.russian.z1	19
org.kernel.vger.linux-spi	18
org.kernel.vger.linux-i2c	10
org.kernel.vger.linux-acpi	9
org.infradead.lists.linux-nvme	8
TOTAL: 34	1022

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	1630
EMP (phr path)	399
EMP (md5)	157
Too many newsgroups	101
HTML Multipart	10
User-issued cancel	8
EMP (phl)	3
Subject (LSDI)	1
TOTAL: 8	2309

NoCeM on Spool:

Issuer (type)	Notices	Bad PGP	Cancel	Skip	Total
i2pn2-nocem@i2pn2.org (spam)	80	0	546	0	546
TOTAL: 1	80	0	546	0	546

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	usenet.blueworldhosting.com	43
	endofthelinebbs-out.news.weretis.net	30
	usenet.goja.nl.eu.org	12
	nntp.comgw.net	9
	newsfeed.xs3.de	3
	endofthelinebbs.peers.news.panix.com	2
	news.bbs.nz	1
	outgoing.news.lysator.liu.se	1
	TOTAL: 8	101
TOTAL: 1		101

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	news.netfront.net	220618	5794	213360	394	52	8201	2%	23:59:47
2	nyheter.lysator.liu.se	6497	1432	4317	522	0	16	22%	23:59:47
3	photonic.trudheim.com	8042	694	5840	1166	0	0	8%	23:59:47
4	news.furie.org.uk	4831	494	3508	15	0	3	10%	23:59:47
5	news.hispagatos.org	8607	368	6585	241	0	1	4%	23:59:47
6	usenet.network	8071	309	6440	52	0	1	3%	23:59:47
7	usenet.goja.nl.eu.org	8740	285	6793	295	0	0	3%	23:59:47
8	news.nk.ca	10676	254	6713	641	0	56	2%	23:59:47
9	newsfeed.bofh.team	9009	250	7270	2	0	1	2%	23:58:34
10	news.bbs.nz	19830	245	13218	563	0	668	1%	23:59:47
11	news.nntp4.net	8783	245	7308	52	0	0	2%	23:59:36
12	i2pn.org	8573	147	7151	84	0	94	1%	23:59:47
13	news.weretis.net	8030	109	7393	206	0	1	1%	23:58:31
14	nntp.comgw.net	8228	90	6715	179	0	2	1%	23:59:47
15	news.tnetconsulting.net	8583	73	7313	295	0	29	0%	23:59:47
16	news.corradoroberto.it	818	67	651	12	0	0	8%	23:21:11
17	news.quux.org	8234	59	7057	579	0	0	0%	23:59:47
18	news.chmurka.net	4274	47	3480	0	0	0	1%	23:59:47
19	newsfeed.xs3.de	9180	45	7286	207	0	1	0%	23:58:55
20	news.samoylyk.net	8957	37	7413	30	0	0	0%	23:59:33
21	usenet.blueworldhosting.com	6760	1	6335	5	0	6	0%	23:59:12
22	ddt.demos.su	2803	0	0	0	0	2832	0%	23:59:47
23	endofthelinebbs.peers.news.panix.com	0	0	0	0	0	7682	0%	23:59:47
24	feed.opticnetworks.net	0	0	0	0	0	7709	0%	23:59:47
TOTAL: 24		388144	11045	342146	5540	52	27303	2%	575:11:51

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.netfront.net	81.2 MB	15.4 MB	96.6 MB	1.1 KB/s	16.0 KB	23:59:47
2	nyheter.lysator.liu.se	7.6 MB	5.3 MB	12.8 MB	0.2 KB/s	6.7 KB	23:59:47
3	photonic.trudheim.com	4.5 MB	5.9 MB	10.5 MB	0.1 KB/s	5.8 KB	23:59:47
4	news.furie.org.uk	3.6 MB	742.7 KB	4.3 MB	0.1 KB/s	8.6 KB	23:59:47
5	news.hispagatos.org	2.1 MB	2.5 MB	4.6 MB	0.1 KB/s	7.7 KB	23:59:47
6	newsfeed.bofh.team	1.8 MB	3.1 KB	1.8 MB	0.0 KB/s	7.2 KB	23:58:34
7	news.quux.org	1.1 MB	3.6 MB	4.7 MB	0.1 KB/s	7.6 KB	23:59:47
8	usenet.network	1003.7 KB	142.2 KB	1.1 MB	0.0 KB/s	3.2 KB	23:59:47
9	news.samoylyk.net	900.6 KB	219.2 KB	1.1 MB	0.0 KB/s	16.7 KB	23:59:33
10	news.bbs.nz	658.2 KB	4.3 MB	4.9 MB	0.1 KB/s	6.2 KB	23:59:47
11	news.nk.ca	572.3 KB	4.8 MB	5.4 MB	0.1 KB/s	6.1 KB	23:59:47
12	i2pn.org	568.3 KB	485.2 KB	1.0 MB	0.0 KB/s	4.6 KB	23:59:47
13	news.nntp4.net	537.2 KB	623.4 KB	1.1 MB	0.0 KB/s	3.9 KB	23:59:36
14	usenet.goja.nl.eu.org	529.0 KB	2.8 MB	3.3 MB	0.0 KB/s	5.8 KB	23:59:47
15	news.weretis.net	482.1 KB	3.6 MB	4.1 MB	0.0 KB/s	13.3 KB	23:58:31
16	news.tnetconsulting.net	363.3 KB	2.1 MB	2.5 MB	0.0 KB/s	6.9 KB	23:59:47
17	nntp.comgw.net	285.5 KB	2.5 MB	2.7 MB	0.0 KB/s	10.4 KB	23:59:47
18	news.corradoroberto.it	270.2 KB	37.9 KB	308.1 KB	0.0 KB/s	3.9 KB	23:21:11
19	newsfeed.xs3.de	158.0 KB	1.9 MB	2.0 MB	0.0 KB/s	8.3 KB	23:58:55
20	news.chmurka.net	149.6 KB	0.0 KB	149.6 KB	0.0 KB/s	3.2 KB	23:59:47
21	usenet.blueworldhosting.com	1.2 KB	7.7 KB	8.9 KB	0.0 KB/s	1.5 KB	23:59:12
22	ddt.demos.su	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:47
23	endofthelinebbs.peers.news.panix.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:47
24	feed.opticnetworks.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:47
TOTAL: 24		108.2 MB	56.8 MB	165.0 MB	0.1 KB/s	10.2 KB	575:11:51

NNRP readership statistics (by domain):

System		Conn	Groups	Elapsed
1	unresolved	6	1	00:00:24
2	*.stretchoid.com	2	0	00:00:10
3	*.monitoring.internet-measurement.com	1	0	00:00:01
TOTAL: 3		9	1	00:00:36

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
147.185.132.51	0.006	0.011	00:00:10
198.235.24.181	0.000	0.016	00:00:10
azpdes70.stretchoid.com	0.000	0.019	00:00:09
199.45.154.142	0.020	0.046	00:00:04
distinguished.monitoring.internet-measurement.com	0.000	0.024	00:00:01
azpdwg32.stretchoid.com	0.000	0.024	00:00:00
91.238.181.71	0.000	0.017	00:00:00
TOTAL: 7	0.026	0.157	00:00:36

Curious NNRP server explorers [Top 20]:

System	Conn
199.45.154.142	3
147.185.132.51	1
198.235.24.181	1
91.238.181.71	1
azpdes70.stretchoid.com	1
azpdwg32.stretchoid.com	1
distinguished.monitoring.internet-measurement.com	1
TOTAL: 7	9

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

System	Conn
199.45.154.142	1
91.238.181.71	1
azpdwg32.stretchoid.com	1
TOTAL: 3	3

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

Command	Count
#003	1
EHLO www.censys.io	1
MGLNDD_144.172.126.95_119	1
TOTAL: 3	3

NNRP client timeouts [Top 20]:

System	Conn	Peer
199.45.154.142	1	2
91.238.181.71	1	1
TOTAL: 2	2	3

Newsgroup request counts (by hierarchy):

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

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

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

Daily Usenet Report

Jul 29 00:01:02 -- Jul 30 00:01:03