Daily Usenet Report: Dec 24 00:01:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Dec 24 08:17:15 newsfeed innd: message repeated 2 times: [ ctlinnd command s]
Dec 25 00:00:01 newsfeed nnrpd[2554814]: localhost auth: program exited with status 8

Log entries by program:

Program name	Lines	%Lines	Size	%Size
innd	9140	41.1%	1.3 MB	25.0%
inn	8093	36.4%	3.0 MB	57.5%
innfeed	4457	20.0%	853.2 KB	16.0%
cnfsstat	432	1.9%	64.7 KB	1.2%
nnrpd	106	0.5%	11.0 KB	0.2%
nocem	33	0.1%	4.0 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 7	22262	100.0%	5.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	98465	64.8%
Negative hits	45370	29.9%
Do not exist	8012	5.3%
Cache misses	5	0.0%
TOTAL: 4	151852	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.102	0.0%	23	0.000	4.435	11.500
article cleanup	00:00:00.054	0.0%	8045	0.000	0.007	0.091
article logging	00:00:00.435	0.0%	8089	0.000	0.054	0.807
article parse	00:00:00.181	0.0%	10678	0.000	0.017	0.118
article write	00:00:02.335	0.0%	5855	0.000	0.399	15.609
artlog/artcncl	00:00:00.000	0.0%	7	0.000	0.000	0.000
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:00:00.743	0.0%	156996	0.000	0.005	0.664
hisgrep/artcncl	00:00:00.065	0.0%	25	0.000	2.600	7.000
hishave/artcncl	00:00:00.002	0.0%	7	0.000	0.286	1.000
hishave/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:02:27.647	0.2%	152486	0.115	0.968	5.919
history sync	00:00:00.070	0.0%	396	0.000	0.177	1.000
history write	00:01:56.337	0.1%	8045	3.397	14.461	109.141
hiswrite/artcncl	00:00:00.003	0.0%	1	3.000	3.000	3.000
hiswrite/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:47:08.415	99.0%	152624	84.377	561.042	2984.323
nntp read	00:00:04.140	0.0%	158622	0.000	0.026	1.992
overview write	00:08:12.290	0.6%	5855	0.375	84.080	14122.087
perl filter	00:00:25.746	0.0%	8044	1.250	3.201	25.900
python filter	00:00:01.030	0.0%	8044	0.000	0.128	2.432
site send	00:00:01.065	0.0%	11740	0.000	0.091	0.235
TOTAL: 24:01:00.608	24:00:20.660	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.014	0.0%	5896	0.000	0.002	0.037
article prepare	00:00:00.005	0.0%	43956	0.000	0.000	0.003
article read	00:00:00.899	0.0%	4407	0.000	0.204	12.615
backlog stats	00:00:00.330	0.0%	203233	0.000	0.002	0.006
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.985	0.0%	134923	0.000	0.015	0.055
data write	00:00:02.586	0.0%	130763	0.005	0.020	0.039
idle	23:50:11.382	100.0%	203233	220.469	422.232	1904.897
status file	00:00:00.533	0.0%	437	0.857	1.220	19.000
TOTAL: 23:50:27.167	23:50:17.734	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:47.978	5.7%	34	0.500	1411.118	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:04.029	0.5%	78860	0.000	0.051	0.500
TOTAL: 00:13:55.517	00:00:52.007	6.2%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	endofthelinebbs-out.news.weretis.net	3	12854	2364	9803	687	18%	49:28:48
2	usenet.blueworldhosting.com	713	7841	898	6130	813	11%	23:57:41
3	glockenspiel.complete.org	2	5024	643	4380	1	12%	24:49:53
4	usenet.goja.nl.eu.org	11	7562	325	7096	141	4%	25:36:20
5	i2pn.org	2	7315	316	6896	103	4%	23:59:38
6	nntp.comgw.net	1	7500	314	6923	263	4%	23:59:57
7	news.corradoroberto.it	20	660	274	386	0	41%	21:45:49
8	194.87.241.33	41	390	248	141	1	63%	18:08:04
9	newsfeed.bofh.team	1	7771	143	7601	27	1%	23:59:55
10	endoftheline-out.news.chmurka.net	1	3159	124	3032	3	3%	23:59:58
11	usenet.network	2	5050	96	4952	2	1%	23:58:42
12	news.nntp4.net	2	5911	91	5817	3	1%	23:59:20
13	newsfeed.xs3.de	2	5513	47	5458	8	0%	23:59:49
14	news.netfront.net	1	5692	46	5569	77	0%	22:07:57
15	endofthelinebbs.peers.news.panix.com	27	6653	37	6612	4	0%	23:54:01
16	news.furie.org.uk	2	2872	29	2843	0	1%	23:58:00
17	news.hispagatos.org	5	7465	15	7410	40	0%	24:26:21
18	outgoing.news.lysator.liu.se	4	2348	13	2335	0	0%	25:09:21
19	news.bbs.nz	2	6353	9	6344	0	0%	23:59:00
20	eotl-out.news.tnetconsulting.net	1	0	0	0	0	0%	00:10:06
21	localhost	28	0	0	0	0	0%	00:00:00
22	news.nk.ca	3	0	0	0	0	0%	00:30:20
TOTAL: 22		874	107933	6032	99728	2173	5%	475:59:00

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	endofthelinebbs-out.news.weretis.net	6.7 MB	0.0 KB	1.1 MB	7.8 MB	85%	2.6 KB
2	usenet.blueworldhosting.com	2.2 MB	0.0 KB	1.6 MB	3.8 MB	57%	2.3 KB
3	glockenspiel.complete.org	2.2 MB	0.0 KB	0.7 KB	2.2 MB	99%	3.5 KB
4	news.corradoroberto.it	1.4 MB	0.0 KB	0.0 KB	1.4 MB	100%	5.2 KB
5	usenet.network	1.2 MB	0.0 KB	2.2 KB	1.2 MB	99%	12.2 KB
6	usenet.goja.nl.eu.org	929.0 KB	0.0 KB	181.4 KB	1.1 MB	83%	2.4 KB
7	194.87.241.33	877.1 KB	0.0 KB	1.7 KB	878.8 KB	99%	3.5 KB
8	i2pn.org	874.2 KB	0.0 KB	142.6 KB	1016.8 KB	85%	2.4 KB
9	nntp.comgw.net	864.9 KB	0.0 KB	502.4 KB	1.3 MB	63%	2.4 KB
10	newsfeed.bofh.team	419.9 KB	0.0 KB	48.6 KB	468.5 KB	89%	2.8 KB
11	endoftheline-out.news.chmurka.net	335.1 KB	0.0 KB	2.1 KB	337.2 KB	99%	2.7 KB
12	news.nntp4.net	236.9 KB	0.0 KB	6.6 KB	243.5 KB	97%	2.6 KB
13	newsfeed.xs3.de	131.8 KB	0.0 KB	13.1 KB	144.9 KB	90%	2.6 KB
14	news.furie.org.uk	92.3 KB	0.0 KB	0.0 KB	92.3 KB	100%	3.2 KB
15	endofthelinebbs.peers.news.panix.com	85.7 KB	3.3 KB	2.7 KB	91.8 KB	93%	2.2 KB
16	news.netfront.net	80.9 KB	0.0 KB	276.4 KB	357.3 KB	22%	2.9 KB
17	outgoing.news.lysator.liu.se	37.9 KB	0.0 KB	0.0 KB	37.9 KB	100%	2.9 KB
18	news.bbs.nz	36.3 KB	0.0 KB	0.0 KB	36.3 KB	100%	4.0 KB
19	news.hispagatos.org	26.7 KB	0.0 KB	56.4 KB	83.1 KB	32%	1.5 KB
20	eotl-out.news.tnetconsulting.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
21	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
22	news.nk.ca	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 22		18.5 MB	3.3 KB	4.0 MB	22.4 MB	82%	2.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 24 00:01:01 - 00:59:59	130	2.2%	0.04	465.3 KB	2.6%	0.13
Dec 24 01:00:00 - 01:59:59	202	3.5%	0.06	570.8 KB	3.2%	0.16
Dec 24 02:00:00 - 02:59:59	285	4.9%	0.08	883.9 KB	4.9%	0.25
Dec 24 03:00:00 - 03:59:59	339	5.8%	0.09	926.0 KB	5.1%	0.26
Dec 24 04:00:00 - 04:59:59	366	6.3%	0.10	956.1 KB	5.3%	0.27
Dec 24 05:00:00 - 05:59:59	348	5.9%	0.10	905.2 KB	5.0%	0.25
Dec 24 06:00:00 - 06:59:59	320	5.5%	0.09	1.0 MB	5.7%	0.29
Dec 24 07:00:00 - 07:59:59	387	6.6%	0.11	1016.4 KB	5.6%	0.28
Dec 24 08:00:00 - 08:59:59	309	5.3%	0.09	990.2 KB	5.5%	0.28
Dec 24 09:00:00 - 09:59:59	330	5.6%	0.09	983.9 KB	5.5%	0.27
Dec 24 10:00:00 - 10:59:59	373	6.4%	0.10	1.3 MB	7.1%	0.36
Dec 24 11:00:00 - 11:59:59	308	5.3%	0.09	956.1 KB	5.3%	0.27
Dec 24 12:00:00 - 12:59:59	251	4.3%	0.07	810.0 KB	4.5%	0.22
Dec 24 13:00:00 - 13:59:59	261	4.5%	0.07	1.0 MB	5.9%	0.30
Dec 24 14:00:00 - 14:59:59	280	4.8%	0.08	850.7 KB	4.7%	0.24
Dec 24 15:00:00 - 15:59:59	298	5.1%	0.08	1.1 MB	6.2%	0.31
Dec 24 16:00:00 - 16:59:59	201	3.4%	0.06	657.0 KB	3.6%	0.18
Dec 24 17:00:00 - 17:59:59	165	2.8%	0.05	472.3 KB	2.6%	0.13
Dec 24 18:00:00 - 18:59:59	149	2.5%	0.04	437.0 KB	2.4%	0.12
Dec 24 19:00:00 - 19:59:59	154	2.6%	0.04	547.4 KB	3.0%	0.15
Dec 24 20:00:00 - 20:59:59	98	1.7%	0.03	272.9 KB	1.5%	0.08
Dec 24 21:00:00 - 21:59:59	83	1.4%	0.02	240.7 KB	1.3%	0.07
Dec 24 22:00:00 - 22:59:59	111	1.9%	0.03	327.5 KB	1.8%	0.09
Dec 24 23:00:00 - 23:59:59	97	1.7%	0.03	242.4 KB	1.3%	0.07
Dec 25 00:00:00 - 00:01:01	4	0.1%	0.07	14.7 KB	0.1%	0.24
TOTAL: 24:00:00	5849	100.0%	0.07	17.6 MB	100.0%	0.21

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	101.5 GB	6.6%	0	0.36	52482.80
CYCTXT1	TEXT	5.0 GB	4.0 GB	79.7%	0	0.02	2558.47
TOTAL: 3	-	3077.0 GB	105.5 GB	3.4%	1	0.26	-

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	usenet.blueworldhosting.com	839	1	0	838
2	endofthelinebbs-out.news.weretis.net	690	0	0	690
3	nntp.comgw.net	277	0	0	277
4	usenet.goja.nl.eu.org	138	0	0	138
5	i2pn.org	108	0	0	108
6	news.netfront.net	93	0	0	93
7	news.hispagatos.org	41	33	0	8
8	newsfeed.bofh.team	29	1	0	28
9	newsfeed.xs3.de	8	0	0	8
10	endofthelinebbs.peers.news.panix.com	4	0	1	3
11	endoftheline-out.news.chmurka.net	3	0	0	3
12	news.nntp4.net	3	0	0	3
13	usenet.network	2	0	0	2
14	194.87.241.33	1	0	0	1
15	glockenspiel.complete.org	1	0	0	1
TOTAL: 15		2237	35	1	2201

Unwanted newsgroups [Top 20]:

Newsgroup	Count
hispagatos.hacking.ctf	15
hispagatos.mastodon.tag.hacking	15
hispagatos.hacking.news	3
0.verizon.test	1
clips.films.etc.pt	1
TOTAL: 5	35

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	1172
EMP (phl)	310
EMP (phr path)	288
EMP (md5)	176
Too many newsgroups	141
Too many newsgroups (meow)	36
EMP (fsl)	18
User-issued cancel	10
HTML Multipart	3
Subject (LSDQtdGE0YDQtd)	1
Subject (lsdk/spc/sampirsp.c: PVS-Studio)	1
TOTAL: 11	2156

NoCeM on Spool:

Issuer (type)	Notices	Cancel	Skip	Total
i2pn2-nocem@i2pn2.org (spam)	1	2	0	2
robot@pasdenom.info (spam)	1	2	0	2
i2pn2-nocem@i2pn2.org (multipost)	12	0	13	13
robot@pasdenom.info (spam3)	8	0	13	13
i2pn2-nocem@i2pn2.org (rmp)	4	0	9	9
robot@pasdenom.info (spam2)	4	0	4	4
TOTAL: 6	30	4	39	43

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	usenet.blueworldhosting.com	26
	endofthelinebbs-out.news.weretis.net	15
	i2pn.org	3
	TOTAL: 3	44
No colon-space in header field
	usenet.blueworldhosting.com	1
	TOTAL: 1	1
TOTAL: 2		45

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	nyheter.lysator.liu.se	6045	3730	1955	151	0	61%	23:59:50
2	news.netfront.net	9346	1762	4038	0	0	18%	23:58:45
3	endofthelinebbs.peers.news.panix.com	6000	817	5029	2	0	13%	23:59:53
4	news.furie.org.uk	3417	676	1879	7	0	19%	23:59:53
5	usenet.goja.nl.eu.org	6560	315	5040	68	3	4%	23:57:31
6	usenet.network	7699	219	5276	12	0	2%	23:59:53
7	news.hispagatos.org	6968	213	5485	134	3	3%	23:59:53
8	newsfeed.bofh.team	6641	212	5482	0	3	3%	23:59:53
9	news.bbs.nz	10904	195	5405	245	25	1%	23:59:53
10	news.nntp4.net	6762	190	5549	8	3	2%	23:59:53
11	news.corradoroberto.it	662	189	276	0	0	28%	21:02:27
12	news.tnetconsulting.net	6567	160	5543	144	0	2%	23:59:53
13	news.weretis.net	6042	151	5595	102	0	2%	23:58:09
14	nntp.comgw.net	6139	147	5325	53	3	2%	23:59:53
15	news.quux.org	4760	147	4133	268	0	3%	23:58:51
16	newsfeed.xs3.de	7106	114	5547	132	4	1%	23:59:53
17	i2pn.org	6149	111	5372	41	10	1%	23:58:46
18	news.nk.ca	4081	72	2660	184	2890	1%	23:59:53
19	news.chmurka.net	3805	35	2721	0	0	0%	23:59:53
20	ddt.demos.su	68	17	50	0	0	25%	07:01:09
21	usenet.blueworldhosting.com	4958	3	4614	0	0	0%	23:59:31
22	feed.opticnetworks.net	0	0	0	0	5849	0%	23:59:53
23	news.samoylyk.net	0	0	0	0	5849	0%	23:59:53
24	photonic.trudheim.com	0	0	0	0	5848	0%	23:59:53
TOTAL: 24		120679	9475	86974	1551	20490	7%	555:53:14

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	nyheter.lysator.liu.se	11.7 MB	1.0 MB	12.7 MB	0.2 KB/s	3.4 KB	23:59:50
2	news.netfront.net	5.6 MB	0.0 KB	5.6 MB	0.1 KB/s	3.3 KB	23:58:45
3	news.furie.org.uk	3.3 MB	26.2 KB	3.3 MB	0.0 KB/s	4.9 KB	23:59:53
4	endofthelinebbs.peers.news.panix.com	2.7 MB	3.7 KB	2.7 MB	0.0 KB/s	3.4 KB	23:59:53
5	newsfeed.bofh.team	1002.8 KB	0.0 KB	1002.8 KB	0.0 KB/s	4.7 KB	23:59:53
6	news.quux.org	954.2 KB	969.5 KB	1.9 MB	0.0 KB/s	4.6 KB	23:58:51
7	news.hispagatos.org	939.8 KB	869.6 KB	1.8 MB	0.0 KB/s	5.2 KB	23:59:53
8	usenet.network	850.8 KB	26.5 KB	877.3 KB	0.0 KB/s	3.8 KB	23:59:53
9	usenet.goja.nl.eu.org	775.0 KB	586.9 KB	1.3 MB	0.0 KB/s	3.6 KB	23:57:31
10	news.bbs.nz	768.5 KB	943.4 KB	1.7 MB	0.0 KB/s	3.9 KB	23:59:53
11	news.tnetconsulting.net	752.3 KB	775.8 KB	1.5 MB	0.0 KB/s	5.0 KB	23:59:53
12	news.weretis.net	729.9 KB	848.7 KB	1.5 MB	0.0 KB/s	6.2 KB	23:58:09
13	news.nntp4.net	651.1 KB	118.0 KB	769.2 KB	0.0 KB/s	3.9 KB	23:59:53
14	nntp.comgw.net	501.0 KB	681.9 KB	1.2 MB	0.0 KB/s	5.9 KB	23:59:53
15	news.corradoroberto.it	478.0 KB	0.0 KB	478.0 KB	0.0 KB/s	2.5 KB	21:02:27
16	newsfeed.xs3.de	468.2 KB	870.5 KB	1.3 MB	0.0 KB/s	5.4 KB	23:59:53
17	i2pn.org	425.0 KB	166.2 KB	591.2 KB	0.0 KB/s	3.9 KB	23:58:46
18	news.nk.ca	134.3 KB	762.9 KB	897.2 KB	0.0 KB/s	3.5 KB	23:59:53
19	news.chmurka.net	81.1 KB	0.0 KB	81.1 KB	0.0 KB/s	2.3 KB	23:59:53
20	ddt.demos.su	51.4 KB	0.0 KB	51.4 KB	0.0 KB/s	3.0 KB	07:01:09
21	usenet.blueworldhosting.com	6.3 KB	0.0 KB	6.3 KB	0.0 KB/s	2.1 KB	23:59:31
22	feed.opticnetworks.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:53
23	news.samoylyk.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:53
24	photonic.trudheim.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:53
TOTAL: 24		32.6 MB	8.5 MB	41.2 MB	0.0 KB/s	3.8 KB	555:53:14

NNRP readership statistics:

System		Conn	Elapsed
1	162.142.125.126	4	00:00:06
2	185.91.127.81	3	00:00:00
3	147.185.132.228	1	00:00:10
4	167.94.138.181	1	00:00:03
5	167.94.138.186	1	00:00:04
6	198.235.24.116	1	00:00:10
7	198.235.24.166	1	00:00:00
8	206.168.34.86	1	00:00:15
9	2607:ff10:c8:594::6	1	00:00:01
10	71.6.134.235	1	00:00:00
11	80.66.76.134	1	00:00:00
12	azpdcg30.stretchoid.com	1	00:00:00
13	azpdssb43.stretchoid.com	1	00:00:09
14	equitable.monitoring.internet-measurement.com	1	00:00:01
15	localhost	1	00:12:51
TOTAL: 15		20	00:13:55

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	unresolved	15	00:00:51
2	*.stretchoid.com	2	00:00:10
3	?	2	00:12:52
4	*.monitoring.internet-measurement.com	1	00:00:01
TOTAL: 4		20	00:13:55

NNRP auth users [Top 20]:

User	Conn
getlist	1
TOTAL: 1	1

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
localhost	183.858	368.900	0.074	00:12:51
206.168.34.86	0.020	0.008	0.000	00:00:15
147.185.132.228	0.000	0.034	0.000	00:00:10
198.235.24.116	0.000	0.016	0.000	00:00:10
azpdssb43.stretchoid.com	0.004	0.012	0.000	00:00:09
162.142.125.126	0.015	0.057	0.000	00:00:06
167.94.138.186	0.010	0.020	0.000	00:00:04
167.94.138.181	0.015	0.027	0.000	00:00:03
equitable.monitoring.internet-measurement.com	0.008	0.008	0.000	00:00:01
2607:ff10:c8:594::6	0.004	0.012	0.000	00:00:01
185.91.127.81	0.000	0.053	0.000	00:00:00
71.6.134.235	0.000	0.017	0.000	00:00:00
198.235.24.166	0.003	0.023	0.000	00:00:00
80.66.76.134	0.000	0.018	0.000	00:00:00
azpdcg30.stretchoid.com	0.000	0.024	0.000	00:00:00
TOTAL: 15	183.937	369.229	0.074	00:13:55

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

System	Conn
185.91.127.81	4
167.94.138.181	1
167.94.138.186	1
206.168.34.86	1
80.66.76.134	1
azpdcg30.stretchoid.com	1
TOTAL: 6	9

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

Command	Count
EHLO www.censys.io	3
#003	1
CONNECT api.ip.pn:443 HTTP/1.1	1
Connection: close	1
Host: api.ip.pn	1
MGLNDD_144.172.126.95_119	1
User-Agent: Mozilla/5.0	1
TOTAL: 7	9

NNRP client timeouts [Top 20]:

System	Conn	Peer
162.142.125.126	1	4
80.66.76.134	1	1
TOTAL: 2	2	8

Daily Usenet Report

Dec 24 00:01:01 -- Dec 25 00:01:01