Daily Usenet Report: Jul 6 00:02:15

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Jul 6 13:11:33 newsfeed innd: message repeated 2 times: [ ctlinnd command s]
Jul 6 16:50:03 newsfeed controlchan[2124467]: Unknown "affects" control by robomod@news.nic.it

Log entries by program:

Program name	Lines	%Lines	Size	%Size
innfeed	43167	69.4%	5.7 MB	51.5%
inn	9990	16.1%	3.9 MB	35.1%
innd	8146	13.1%	1.3 MB	11.9%
cnfsstat	432	0.7%	80.4 KB	0.7%
nocem	230	0.4%	64.0 KB	0.6%
nnrpd	221	0.4%	20.1 KB	0.2%
controlchan	2	0.0%	0.3 KB	0.0%
TOTAL: 7	62188	100.0%	11.1 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	124661	61.1%
Negative hits	70338	34.4%
Do not exist	9078	4.4%
Cache misses	103	0.1%
TOTAL: 4	204180	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.783	0.0%	761	0.000	1.029	11.667
article cleanup	00:00:00.084	0.0%	9216	0.000	0.009	0.439
article logging	00:00:00.476	0.0%	9313	0.000	0.051	0.573
article parse	00:00:00.217	0.0%	13205	0.000	0.016	0.118
article write	00:00:02.236	0.0%	7854	0.000	0.285	2.131
artlog/artcncl	00:00:00.019	0.0%	701	0.000	0.027	0.625
data move	00:00:00.204	0.0%	206630	0.000	0.001	0.013
hisgrep/artcncl	00:00:00.334	0.0%	752	0.000	0.444	11.667
hishave/artcncl	00:00:00.057	0.0%	737	0.000	0.077	5.750
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:01:59.847	0.1%	205516	0.089	0.583	5.401
history sync	00:00:00.062	0.0%	394	0.000	0.157	1.667
history write	00:01:36.694	0.1%	9190	2.640	10.522	112.000
hiswrite/artcncl	00:00:00.038	0.0%	15	2.429	2.533	3.000
idle	23:48:05.309	99.1%	202318	79.543	423.518	2001.727
nntp read	00:00:02.792	0.0%	208199	0.002	0.013	0.074
overview write	00:08:32.224	0.6%	7854	0.867	65.218	6265.775
perl filter	00:00:17.972	0.0%	9190	0.953	1.956	8.482
python filter	00:00:00.666	0.0%	9190	0.000	0.072	1.916
site send	00:00:01.314	0.0%	15825	0.000	0.083	0.304
TOTAL: 24:01:21.160	24:00:41.328	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.049	0.0%	47201	0.000	0.001	0.022
article prepare	00:00:00.006	0.0%	48962	0.000	0.000	0.006
article read	00:00:02.868	0.0%	5679	0.000	0.505	9.156
backlog stats	00:00:00.452	0.0%	299412	0.000	0.002	0.009
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.698	0.0%	196143	0.003	0.014	0.056
data write	00:00:04.224	0.0%	189684	0.009	0.022	0.045
idle	23:55:55.232	99.9%	299412	29.709	287.748	994.887
status file	00:00:19.428	0.0%	16852	1.000	1.153	5.883
TOTAL: 23:56:43.620	23:56:24.957	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	12:13:55.549	100.0%	1183	25.000	37223.626	118902.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.047	0.0%	2488	0.000	0.019	0.143
readart	00:00:00.016	0.0%	27	0.412	0.593	0.900
TOTAL: 12:13:58.115	12:13:55.612	100.0%	-	-	-	-

Control commands to INND:

Command	Number
begin	1
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
mode	98
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 12	121

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	endofthelinebbs-out.news.weretis.net	3	13067	1588	11310	169	12%	44:43:56
2	usenet.blueworldhosting.com	719	8852	1492	7022	338	16%	23:54:13
3	outgoing.news.lysator.liu.se	3	7813	1352	6334	127	17%	23:59:25
4	news.hispagatos.org	6	7837	672	7131	34	8%	24:35:29
5	nntp.comgw.net	1	8171	645	7482	44	7%	23:59:57
6	i2pn.org	2	7636	342	7272	22	4%	23:59:28
7	usenet.goja.nl.eu.org	11	7666	238	7401	27	3%	22:22:31
8	usenet.network	1	5565	191	5369	5	3%	23:59:57
9	news.corradoroberto.it	6	1170	187	983	0	15%	21:06:26
10	news.samoylyk.net	2	6565	175	6381	9	2%	23:59:46
11	194.87.241.33	48	290	175	115	0	60%	16:48:09
12	endofthelinebbs.peers.news.panix.com	28	7916	174	7716	26	2%	24:43:26
13	newsfeed.xs3.de	2	6100	149	5950	1	2%	24:00:08
14	endoftheline-out.news.chmurka.net	2	3602	129	3471	2	3%	23:59:51
15	news.nntp4.net	2	6406	66	6340	0	1%	23:57:43
16	newsfeed.bofh.team	1	8500	54	8443	3	0%	23:59:56
17	news.netfront.net	1	8643	32	8548	63	0%	25:50:57
18	news.bbs.nz	1	4975	9	4966	0	0%	19:42:24
19	glockenspiel.complete.org	2	4596	5	4591	0	0%	20:21:11
20	news.furie.org.uk	1	3600	2	3592	6	0%	23:59:54
21	photonic.trudheim.com	6	2015	2	1516	497	0%	23:57:18
22	eotl-out.news.tnetconsulting.net	1	0	0	0	0	0%	00:10:02
23	localhost	3	0	0	0	0	0%	00:00:01
24	news.nk.ca	2	0	0	0	0	0%	00:20:18
TOTAL: 24		854	130985	7679	121933	1373	5%	508:32:26

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	endofthelinebbs-out.news.weretis.net	4.4 MB	0.0 KB	334.4 KB	4.7 MB	93%	2.8 KB
2	outgoing.news.lysator.liu.se	3.7 MB	0.0 KB	226.6 KB	3.9 MB	94%	2.7 KB
3	usenet.blueworldhosting.com	3.3 MB	0.0 KB	835.6 KB	4.1 MB	80%	2.3 KB
4	news.hispagatos.org	1.9 MB	0.0 KB	76.5 KB	2.0 MB	96%	2.9 KB
5	usenet.network	1.9 MB	0.0 KB	4.6 KB	1.9 MB	99%	9.8 KB
6	nntp.comgw.net	1.8 MB	11.3 KB	112.7 KB	1.9 MB	93%	2.8 KB
7	news.corradoroberto.it	1.4 MB	0.0 KB	0.0 KB	1.4 MB	100%	7.7 KB
8	i2pn.org	1.1 MB	0.0 KB	47.5 KB	1.2 MB	96%	3.4 KB
9	news.samoylyk.net	1.0 MB	11.2 KB	7.6 KB	1.1 MB	98%	5.9 KB
10	newsfeed.xs3.de	590.1 KB	0.0 KB	2.2 KB	592.3 KB	99%	3.9 KB
11	usenet.goja.nl.eu.org	573.8 KB	11.3 KB	19.5 KB	604.7 KB	94%	2.3 KB
12	endoftheline-out.news.chmurka.net	501.8 KB	0.0 KB	1.8 KB	503.6 KB	99%	3.8 KB
13	194.87.241.33	489.6 KB	0.0 KB	0.0 KB	489.6 KB	100%	2.8 KB
14	endofthelinebbs.peers.news.panix.com	405.9 KB	2.6 KB	91.7 KB	500.2 KB	81%	2.5 KB
15	news.nntp4.net	163.0 KB	0.0 KB	0.0 KB	163.0 KB	100%	2.5 KB
16	glockenspiel.complete.org	110.2 KB	0.0 KB	0.0 KB	110.2 KB	100%	22.0 KB
17	newsfeed.bofh.team	95.3 KB	0.0 KB	6.7 KB	101.9 KB	93%	1.8 KB
18	news.netfront.net	86.4 KB	12.0 KB	226.1 KB	324.4 KB	26%	3.4 KB
19	news.bbs.nz	20.5 KB	0.0 KB	0.0 KB	20.5 KB	100%	2.3 KB
20	news.furie.org.uk	3.6 KB	11.3 KB	0.8 KB	15.7 KB	22%	2.0 KB
21	photonic.trudheim.com	2.9 KB	0.0 KB	2.9 MB	2.9 MB	0%	6.0 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		23.6 MB	59.7 KB	4.9 MB	28.5 MB	82%	3.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jul 6 00:02:15 - 00:59:59	210	2.7%	0.06	805.5 KB	3.3%	0.23
Jul 6 01:00:00 - 01:59:59	306	3.9%	0.09	1.0 MB	4.2%	0.29
Jul 6 02:00:00 - 02:59:59	365	4.6%	0.10	1.2 MB	5.0%	0.34
Jul 6 03:00:00 - 03:59:59	378	4.8%	0.10	1.1 MB	4.6%	0.32
Jul 6 04:00:00 - 04:59:59	441	5.6%	0.12	1.2 MB	5.1%	0.35
Jul 6 05:00:00 - 05:59:59	423	5.4%	0.12	1.3 MB	5.3%	0.36
Jul 6 06:00:00 - 06:59:59	488	6.2%	0.14	1.2 MB	4.9%	0.34
Jul 6 07:00:00 - 07:59:59	495	6.3%	0.14	1.4 MB	5.8%	0.40
Jul 6 08:00:00 - 08:59:59	542	6.9%	0.15	1.5 MB	6.2%	0.43
Jul 6 09:00:00 - 09:59:59	391	5.0%	0.11	1.2 MB	5.0%	0.34
Jul 6 10:00:00 - 10:59:59	432	5.5%	0.12	1.4 MB	5.9%	0.40
Jul 6 11:00:00 - 11:59:59	378	4.8%	0.10	1.1 MB	4.7%	0.32
Jul 6 12:00:00 - 12:59:59	313	4.0%	0.09	1.1 MB	4.6%	0.31
Jul 6 13:00:00 - 13:59:59	324	4.1%	0.09	1.0 MB	4.3%	0.29
Jul 6 14:00:00 - 14:59:59	312	4.0%	0.09	1.1 MB	4.7%	0.32
Jul 6 15:00:00 - 15:59:59	324	4.1%	0.09	900.0 KB	3.7%	0.25
Jul 6 16:00:00 - 16:59:59	354	4.5%	0.10	1.1 MB	4.6%	0.32
Jul 6 17:00:00 - 17:59:59	238	3.0%	0.07	779.1 KB	3.2%	0.22
Jul 6 18:00:00 - 18:59:59	228	2.9%	0.06	817.7 KB	3.3%	0.23
Jul 6 19:00:00 - 19:59:59	164	2.1%	0.05	537.8 KB	2.2%	0.15
Jul 6 20:00:00 - 20:59:59	194	2.5%	0.05	601.2 KB	2.4%	0.17
Jul 6 21:00:00 - 21:59:59	222	2.8%	0.06	778.1 KB	3.2%	0.22
Jul 6 22:00:00 - 22:59:59	161	2.1%	0.04	484.7 KB	2.0%	0.13
Jul 6 23:00:00 - 23:59:59	163	2.1%	0.05	463.9 KB	1.9%	0.13
Jul 7 00:00:00 - 05:01:02	7	0.1%	0.00	14.3 KB	0.1%	0.00
TOTAL: 24:58:47	7853	100.0%	0.09	24.1 MB	100.0%	0.27

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	94.6 GB	6.2%	0	0.49	38193.78
CYCTXT1	TEXT	5.0 GB	3.5 GB	70.0%	0	0.03	2353.11
TOTAL: 3	-	3077.0 GB	98.2 GB	3.2%	1	0.38	-

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	photonic.trudheim.com	463	463	0	0
2	usenet.blueworldhosting.com	374	2	0	372
3	endofthelinebbs-out.news.weretis.net	212	1	0	211
4	outgoing.news.lysator.liu.se	128	1	0	127
5	news.netfront.net	63	0	5	58
6	nntp.comgw.net	46	0	5	41
7	usenet.goja.nl.eu.org	35	0	5	30
8	news.hispagatos.org	33	3	0	30
9	endofthelinebbs.peers.news.panix.com	32	12	1	19
10	i2pn.org	22	0	0	22
11	news.furie.org.uk	7	0	5	2
12	news.samoylyk.net	7	0	5	2
13	usenet.network	5	0	0	5
14	newsfeed.bofh.team	4	0	0	4
15	endoftheline-out.news.chmurka.net	2	0	0	2
16	glockenspiel.complete.org	2	0	0	2
17	newsfeed.xs3.de	1	1	0	0
TOTAL: 17		1436	483	26	927

Unwanted newsgroups [Top 20]:

Newsgroup	Count
org.kernel.vger.linux-kernel	341
org.kernel.vger.linux-wireless	39
org.infradead.lists.linux-riscv	19
org.kernel.vger.linux-nfs	18
org.kernel.vger.linux-block	14
org.kernel.vger.linux-cxl	14
org.xenproject.lists.xen-devel	8
alt.russian.z1	6
com.openwall.lists.kernel-hardening	5
org.infradead.lists.linux-nvme	5
org.kernel.vger.linux-pci	4
org.kvack.linux-mm	4
org.kernel.linux.tools	2
org.kernel.vger.linux-cifs	2
org.kernel.vger.netdev	1
soc.culture.africa	1
TOTAL: 16	483

INND Perl filter [Top 20]:

Reason	Count
EMP (phr path)	363
EMP (md5)	139
EMP (fsl)	122
EMP (phn path)	91
Too many newsgroups	90
User-issued cancel	18
Too many newsgroups (meow)	6
HTML Multipart	1
TOTAL: 8	830

NoCeM on Spool:

Issuer (type)	Notices	Cancel	Skip	Total
i2pn2-nocem@i2pn2.org (spam)	113	731	0	731
robot@pasdenom.info (spam2)	2	0	2	2
robot@pasdenom.info (spam3)	1	0	1	1
TOTAL: 3	116	731	3	734

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	endofthelinebbs-out.news.weretis.net	43
	usenet.blueworldhosting.com	37
	endofthelinebbs.peers.news.panix.com	6
	usenet.goja.nl.eu.org	5
	glockenspiel.complete.org	2
	outgoing.news.lysator.liu.se	1
	nntp.comgw.net	1
	news.furie.org.uk	1
	newsfeed.bofh.team	1
	TOTAL: 9	97
TOTAL: 1		97

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	nyheter.lysator.liu.se	34540	1386	31013	2086	3	5293	4%	23:57:46
2	photonic.trudheim.com	8340	583	5745	1521	0	18	6%	23:59:45
3	news.nk.ca	11341	486	6557	705	0	11	4%	23:59:54
4	usenet.goja.nl.eu.org	9196	460	7007	132	0	84	5%	23:59:53
5	news.nntp4.net	9019	456	7286	32	0	18	5%	23:59:54
6	news.hispagatos.org	8804	448	6477	146	0	7	5%	23:59:36
7	news.bbs.nz	14183	405	6832	608	0	48	2%	23:59:53
8	usenet.network	8801	396	6726	39	0	5	4%	23:59:53
9	newsfeed.bofh.team	9122	220	7481	0	0	7	2%	23:58:52
10	i2pn.org	8490	155	7275	66	0	7	1%	23:58:48
11	nntp.comgw.net	8491	136	6972	102	0	5	1%	23:59:22
12	news.weretis.net	8097	82	7623	147	0	16	1%	23:59:53
13	news.corradoroberto.it	926	82	716	1	0	149	8%	23:54:48
14	news.tnetconsulting.net	8808	56	7525	268	0	0	0%	23:59:54
15	news.quux.org	8280	56	7127	653	0	0	0%	23:58:36
16	news.samoylyk.net	9546	44	7535	56	0	75	0%	23:59:24
17	newsfeed.xs3.de	9564	34	7500	163	0	86	0%	23:59:45
18	news.chmurka.net	4120	32	3301	0	0	6	0%	23:59:53
19	usenet.blueworldhosting.com	6180	1	5938	0	0	0	0%	23:59:40
20	ddt.demos.su	2799	0	0	0	0	2842	0%	23:59:53
21	news.netfront.net	2739	0	0	0	0	10560	0%	23:59:53
22	endofthelinebbs.peers.news.panix.com	0	0	0	0	0	7850	0%	23:59:54
23	feed.opticnetworks.net	0	0	0	0	0	7853	0%	23:59:53
24	news.furie.org.uk	0	0	0	0	0	3385	0%	23:57:48
TOTAL: 24		191386	5518	146636	6725	3	38325	2%	575:42:50

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	nyheter.lysator.liu.se	4.5 MB	16.1 MB	20.6 MB	0.2 KB/s	6.1 KB	23:57:46
2	photonic.trudheim.com	2.2 MB	4.1 MB	6.3 MB	0.1 KB/s	3.1 KB	23:59:45
3	news.hispagatos.org	1.2 MB	1.1 MB	2.3 MB	0.0 KB/s	3.9 KB	23:59:36
4	news.nntp4.net	1.2 MB	250.8 KB	1.5 MB	0.0 KB/s	3.0 KB	23:59:54
5	newsfeed.bofh.team	1.1 MB	0.0 KB	1.1 MB	0.0 KB/s	5.3 KB	23:58:52
6	usenet.network	1.1 MB	75.3 KB	1.1 MB	0.0 KB/s	2.7 KB	23:59:53
7	news.nk.ca	1.0 MB	2.7 MB	3.7 MB	0.0 KB/s	3.2 KB	23:59:54
8	news.bbs.nz	958.2 KB	2.7 MB	3.7 MB	0.0 KB/s	3.7 KB	23:59:53
9	news.quux.org	902.0 KB	1.8 MB	2.6 MB	0.0 KB/s	3.8 KB	23:58:36
10	usenet.goja.nl.eu.org	807.6 KB	1.0 MB	1.8 MB	0.0 KB/s	3.1 KB	23:59:53
11	news.samoylyk.net	788.6 KB	85.7 KB	874.3 KB	0.0 KB/s	8.7 KB	23:59:24
12	i2pn.org	363.1 KB	180.0 KB	543.1 KB	0.0 KB/s	2.5 KB	23:58:48
13	news.corradoroberto.it	357.0 KB	1.4 KB	358.5 KB	0.0 KB/s	4.3 KB	23:54:48
14	news.weretis.net	299.6 KB	1.3 MB	1.6 MB	0.0 KB/s	7.0 KB	23:59:53
15	nntp.comgw.net	261.6 KB	1.2 MB	1.5 MB	0.0 KB/s	6.4 KB	23:59:22
16	news.tnetconsulting.net	217.4 KB	1.2 MB	1.4 MB	0.0 KB/s	4.4 KB	23:59:54
17	newsfeed.xs3.de	120.3 KB	1.4 MB	1.5 MB	0.0 KB/s	7.6 KB	23:59:45
18	news.chmurka.net	84.5 KB	0.0 KB	84.5 KB	0.0 KB/s	2.6 KB	23:59:53
19	usenet.blueworldhosting.com	4.7 KB	0.0 KB	4.7 KB	0.0 KB/s	4.7 KB	23:59:40
20	ddt.demos.su	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:53
21	endofthelinebbs.peers.news.panix.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:54
22	feed.opticnetworks.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:53
23	news.furie.org.uk	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:48
24	news.netfront.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:53
TOTAL: 24		17.4 MB	35.1 MB	52.5 MB	0.0 KB/s	4.4 KB	575:42:50

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	47.186.0.68	2	6	44.7 KB	1	1	0	12:07:30
TOTAL: 1		2	6	44.7 KB	1	1	0	12:13:58

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	unresolved	8	6	44.7 KB	1	1	12:08:01
2	*.1274-static.plfdilaa.metronetinc.net	1	0	0.0 KB	0	0	00:05:56
3	*.stretchoid.com	1	0	0.0 KB	0	0	00:00:00
TOTAL: 3		10	6	44.7 KB	1	1	12:13:58

NNRP auth users [Top 20]:

User	Conn
nelgin	2
TOTAL: 1	2

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
47.186.0.68	0.016	0.197	0.040	12:07:30
1512264-v118.1274-static.plfdilaa.metronetinc.net	0.007	0.007	0.000	00:05:56
118.123.105.86	0.003	0.018	0.000	00:00:24
167.94.145.97	0.025	0.030	0.000	00:00:04
206.168.34.212	0.018	0.009	0.000	00:00:00
91.238.181.21	0.003	0.010	0.000	00:00:00
azpdwgc2.stretchoid.com	0.006	0.013	0.000	00:00:00
TOTAL: 7	0.078	0.284	0.040	12:13:58

Curious NNRP server explorers [Top 20]:

System	Conn
167.94.145.97	3
118.123.105.86	1
1512264-v118.1274-static.plfdilaa.metronetinc.net	1
206.168.34.212	1
91.238.181.21	1
azpdwgc2.stretchoid.com	1
TOTAL: 6	8

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

System	Conn
167.94.145.97	1
206.168.34.212	1
91.238.181.21	1
azpdwgc2.stretchoid.com	1
TOTAL: 4	4

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

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

NNRP client timeouts [Top 20]:

System	Conn	Peer
167.94.145.97	1	2
47.186.0.68	1	0
91.238.181.21	1	1
TOTAL: 3	3	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.announce	1
TOTAL: 1		1

Daily Usenet Report

Jul 6 00:02:15 -- Jul 7 05:01:02