Daily Usenet Report: Dec 26 00:01:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Dec 27 00:00:01 newsfeed nnrpd[3701991]: localhost auth: program exited with status 8

Log entries by program:

Program name	Lines	%Lines	Size	%Size
innd	9854	42.7%	1.4 MB	27.9%
inn	8254	35.7%	2.8 MB	55.0%
innfeed	4434	19.2%	806.3 KB	15.4%
cnfsstat	432	1.9%	69.2 KB	1.3%
nnrpd	75	0.3%	7.8 KB	0.1%
nocem	43	0.2%	7.7 KB	0.1%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 7	23093	100.0%	5.1 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	99179	64.2%
Negative hits	47011	30.4%
Do not exist	8154	5.3%
Cache misses	124	0.1%
TOTAL: 4	154468	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.192	0.0%	44	0.000	4.364	8.000
article cleanup	00:00:00.067	0.0%	8193	0.000	0.008	0.100
article logging	00:00:00.444	0.0%	8233	0.000	0.054	0.608
article parse	00:00:00.236	0.0%	18663	0.000	0.013	0.053
article write	00:00:02.101	0.0%	5346	0.000	0.393	6.808
artlog/artcncl	00:00:00.000	0.0%	8	0.000	0.000	0.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:00.759	0.0%	162423	0.000	0.005	0.066
hisgrep/artcncl	00:00:00.164	0.0%	47	0.000	3.489	5.917
hishave/artcncl	00:00:00.000	0.0%	8	0.000	0.000	0.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:19.172	0.2%	155226	0.136	0.897	7.209
history sync	00:00:00.069	0.0%	398	0.000	0.173	1.667
history write	00:01:52.301	0.1%	8188	3.342	13.715	100.786
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:39:42.050	99.0%	159987	96.847	532.431	2981.535
nntp read	00:00:04.100	0.0%	165478	0.003	0.025	0.813
overview write	00:08:23.750	0.6%	5346	0.765	94.229	40815.143
perl filter	00:00:24.188	0.0%	8188	1.281	2.954	12.970
python filter	00:00:00.918	0.0%	8188	0.000	0.112	0.859
site send	00:00:00.795	0.0%	10730	0.000	0.074	0.250
TOTAL: 23:53:31.862	23:52:51.306	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.014	0.0%	6684	0.000	0.002	0.062
article prepare	00:00:00.003	0.0%	32616	0.000	0.000	0.007
article read	00:00:00.515	0.0%	3635	0.000	0.142	0.630
backlog stats	00:00:00.284	0.0%	186920	0.000	0.002	0.009
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.519	0.0%	123918	0.000	0.012	0.032
data write	00:00:02.137	0.0%	120035	0.006	0.018	0.046
idle	23:58:20.968	100.0%	186920	209.514	461.700	2136.085
status file	00:00:00.549	0.0%	454	0.750	1.209	7.000
TOTAL: 23:58:52.065	23:58:25.989	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:26.895	3.9%	22	0.250	1222.500	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:03.444	0.5%	78787	0.000	0.044	0.250
TOTAL: 00:11:21.612	00:00:30.339	4.5%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	endofthelinebbs-out.news.weretis.net	4	10627	1561	8819	247	14%	45:02:24
2	glockenspiel.complete.org	2	6780	740	6011	29	10%	35:41:50
3	usenet.blueworldhosting.com	712	7163	720	5640	803	10%	23:34:52
4	nntp.comgw.net	1	7567	390	6274	903	5%	23:59:57
5	newsfeed.bofh.team	3	7812	286	7367	159	3%	24:00:22
6	i2pn.org	2	6568	276	6200	92	4%	23:59:46
7	news.corradoroberto.it	22	699	233	465	1	33%	20:51:23
8	usenet.goja.nl.eu.org	10	7478	230	7118	130	3%	23:56:04
9	194.87.241.33	39	270	176	94	0	65%	15:43:54
10	newsfeed.xs3.de	2	4938	165	4751	22	3%	23:59:18
11	endoftheline-out.news.chmurka.net	2	3016	90	2924	2	2%	23:59:47
12	usenet.network	1	4653	78	4572	3	1%	23:59:57
13	news.samoylyk.net	2	5167	77	5046	44	1%	20:06:54
14	news.netfront.net	1	6696	54	6198	444	0%	24:10:23
15	news.nntp4.net	2	5208	51	5155	2	0%	23:59:39
16	news.hispagatos.org	6	7205	48	7108	49	0%	24:26:20
17	endofthelinebbs.peers.news.panix.com	22	6265	24	6241	0	0%	23:56:35
18	news.bbs.nz	2	4837	23	4814	0	0%	23:59:28
19	news.furie.org.uk	1	2865	14	2851	0	0%	23:59:57
20	outgoing.news.lysator.liu.se	1	3249	1	3248	0	0%	23:59:57
21	eotl-out.news.tnetconsulting.net	1	0	0	0	0	0%	00:10:04
22	localhost	28	0	0	0	0	0%	00:00:00
23	news.nk.ca	1	0	0	0	0	0%	00:10:06
TOTAL: 23		867	109063	5237	100896	2930	4%	497:48:57

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	endofthelinebbs-out.news.weretis.net	5.4 MB	321.6 KB	393.2 KB	6.0 MB	88%	3.4 KB
2	glockenspiel.complete.org	2.5 MB	0.0 KB	43.1 KB	2.6 MB	98%	3.4 KB
3	usenet.blueworldhosting.com	1.8 MB	0.0 KB	1.6 MB	3.4 MB	53%	2.3 KB
4	news.corradoroberto.it	1.2 MB	0.0 KB	2.7 KB	1.2 MB	99%	5.4 KB
5	nntp.comgw.net	1.0 MB	321.5 KB	13.8 MB	15.2 MB	6%	12.0 KB
6	newsfeed.bofh.team	918.4 KB	0.0 KB	795.1 KB	1.7 MB	53%	3.9 KB
7	i2pn.org	786.3 KB	321.5 KB	109.4 KB	1.2 MB	64%	3.3 KB
8	usenet.goja.nl.eu.org	735.0 KB	0.0 KB	175.2 KB	910.2 KB	80%	2.5 KB
9	usenet.network	620.6 KB	0.0 KB	3.2 KB	623.8 KB	99%	7.7 KB
10	194.87.241.33	581.0 KB	0.0 KB	0.0 KB	581.0 KB	100%	3.3 KB
11	news.hispagatos.org	501.7 KB	0.0 KB	91.4 KB	593.1 KB	84%	6.1 KB
12	newsfeed.xs3.de	489.9 KB	321.6 KB	36.1 KB	847.6 KB	57%	4.5 KB
13	news.samoylyk.net	451.0 KB	321.6 KB	70.3 KB	842.9 KB	53%	7.0 KB
14	endoftheline-out.news.chmurka.net	300.8 KB	0.0 KB	1.3 KB	302.2 KB	99%	3.3 KB
15	news.nntp4.net	127.2 KB	0.0 KB	2.7 KB	130.0 KB	97%	2.5 KB
16	news.netfront.net	94.0 KB	0.0 KB	16.4 MB	16.4 MB	0%	33.8 KB
17	endofthelinebbs.peers.news.panix.com	91.6 KB	0.0 KB	0.0 KB	91.6 KB	100%	3.8 KB
18	news.furie.org.uk	71.2 KB	0.0 KB	0.0 KB	71.2 KB	100%	5.1 KB
19	news.bbs.nz	66.8 KB	0.0 KB	0.0 KB	66.8 KB	100%	2.9 KB
20	outgoing.news.lysator.liu.se	3.9 KB	0.0 KB	0.0 KB	3.9 KB	100%	3.9 KB
21	eotl-out.news.tnetconsulting.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
22	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
23	news.nk.ca	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 23		17.6 MB	1.6 MB	33.4 MB	52.6 MB	33%	6.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 26 00:01:01 - 00:59:59	61	1.1%	0.02	190.8 KB	1.0%	0.05
Dec 26 01:00:00 - 01:59:59	116	2.2%	0.03	398.2 KB	2.1%	0.11
Dec 26 02:00:00 - 02:59:59	181	3.4%	0.05	494.4 KB	2.6%	0.14
Dec 26 03:00:00 - 03:59:59	289	5.4%	0.08	900.3 KB	4.8%	0.25
Dec 26 04:00:00 - 04:59:59	271	5.1%	0.08	715.4 KB	3.8%	0.20
Dec 26 05:00:00 - 05:59:59	286	5.3%	0.08	713.2 KB	3.8%	0.20
Dec 26 06:00:00 - 06:59:59	237	4.4%	0.07	748.6 KB	4.0%	0.21
Dec 26 07:00:00 - 07:59:59	315	5.9%	0.09	930.9 KB	4.9%	0.26
Dec 26 08:00:00 - 08:59:59	252	4.7%	0.07	715.6 KB	3.8%	0.20
Dec 26 09:00:00 - 09:59:59	377	7.0%	0.10	1.3 MB	7.1%	0.37
Dec 26 10:00:00 - 10:59:59	277	5.2%	0.08	1.0 MB	5.5%	0.29
Dec 26 11:00:00 - 11:59:59	350	6.5%	0.10	1.1 MB	5.8%	0.30
Dec 26 12:00:00 - 12:59:59	284	5.3%	0.08	963.4 KB	5.1%	0.27
Dec 26 13:00:00 - 13:59:59	359	6.7%	0.10	1.3 MB	6.8%	0.36
Dec 26 14:00:00 - 14:59:59	239	4.5%	0.07	808.4 KB	4.3%	0.22
Dec 26 15:00:00 - 15:59:59	235	4.4%	0.07	866.3 KB	4.6%	0.24
Dec 26 16:00:00 - 16:59:59	225	4.2%	0.06	839.4 KB	4.4%	0.23
Dec 26 17:00:00 - 17:59:59	236	4.4%	0.07	1.7 MB	9.2%	0.48
Dec 26 18:00:00 - 18:59:59	167	3.1%	0.05	625.5 KB	3.3%	0.17
Dec 26 19:00:00 - 19:59:59	126	2.4%	0.04	500.8 KB	2.6%	0.14
Dec 26 20:00:00 - 20:59:59	116	2.2%	0.03	410.0 KB	2.2%	0.11
Dec 26 21:00:00 - 21:59:59	117	2.2%	0.03	669.3 KB	3.5%	0.19
Dec 26 22:00:00 - 22:59:59	128	2.4%	0.04	440.2 KB	2.3%	0.12
Dec 26 23:00:00 - 23:59:59	108	2.0%	0.03	478.6 KB	2.5%	0.13
Dec 27 00:00:00 - 00:01:02	2	0.0%	0.03	11.4 KB	0.1%	0.18
TOTAL: 24:00:01	5354	100.0%	0.06	18.5 MB	100.0%	0.22

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.35	53934.15
CYCTXT1	TEXT	5.0 GB	4.0 GB	79.8%	0	0.02	2533.49
TOTAL: 3	-	3077.0 GB	105.6 GB	3.4%	1	0.25	-

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	nntp.comgw.net	905	0	1	904
2	usenet.blueworldhosting.com	821	1	0	820
3	news.netfront.net	403	0	0	403
4	endofthelinebbs-out.news.weretis.net	241	0	1	240
5	newsfeed.bofh.team	162	4	0	158
6	usenet.goja.nl.eu.org	134	0	0	134
7	i2pn.org	94	0	1	93
8	news.hispagatos.org	52	30	0	22
9	news.samoylyk.net	44	0	1	43
10	newsfeed.xs3.de	23	0	1	22
11	glockenspiel.complete.org	5	0	0	5
12	usenet.network	3	0	0	3
13	endoftheline-out.news.chmurka.net	2	0	0	2
14	news.nntp4.net	2	0	0	2
15	news.corradoroberto.it	1	0	0	1
TOTAL: 15		2892	35	5	2852

Unwanted newsgroups [Top 20]:

Newsgroup	Count
hispagatos.mastodon.tag.hacking	15
hispagatos.hacking.ctf	8
hispagatos.mastodon.tag.hackers	4
soc.culture.russia	3
hispagatos.hacking.news	1
hispagatos.mastodon.tag.hackthebox	1
hispagatos.mastodon.tag.hispagatos	1
soc.culture.kazakh	1
soc.culture.mexico	1
TOTAL: 9	35

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	1254
Too many newsgroups	989
EMP (phr path)	317
EMP (md5)	199
EMP (fsl)	15
User-issued cancel	14
Too many newsgroups (meow)	12
EMP (phl)	6
HTML Multipart	4
EMP (phr nph)	2
TOTAL: 10	2812

NoCeM on Spool:

Issuer (type)	Notices	Cancel	Skip	Total
i2pn2-nocem@i2pn2.org (spam)	4	5	0	5
i2pn2-nocem@i2pn2.org (multipost)	16	0	16	16
robot@pasdenom.info (spam3)	5	0	14	14
i2pn2-nocem@i2pn2.org (rmp)	7	0	13	13
robot@pasdenom.info (spam2)	6	0	7	7
TOTAL: 5	38	5	50	55

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	usenet.blueworldhosting.com	19
	endofthelinebbs-out.news.weretis.net	10
	usenet.goja.nl.eu.org	5
	i2pn.org	3
	nntp.comgw.net	1
	glockenspiel.complete.org	1
	newsfeed.xs3.de	1
	TOTAL: 7	40
TOTAL: 1		40

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	nyheter.lysator.liu.se	5657	2677	2522	154	0	47%	23:59:53
2	news.netfront.net	8438	1600	3707	1	3	18%	23:59:53
3	endofthelinebbs.peers.news.panix.com	5478	729	4620	0	0	13%	23:58:41
4	news.furie.org.uk	3374	628	1957	11	0	18%	23:59:39
5	usenet.goja.nl.eu.org	6203	238	4808	32	1	3%	23:59:49
6	news.corradoroberto.it	562	184	258	0	1	32%	20:48:29
7	news.hispagatos.org	6233	136	5095	63	6	2%	23:59:39
8	news.nntp4.net	6279	116	5136	14	4	1%	23:59:46
9	usenet.network	6462	114	4814	4	7	1%	23:58:28
10	newsfeed.bofh.team	5902	102	4959	1	0	1%	23:59:53
11	news.bbs.nz	9936	89	5041	216	39	0%	23:59:53
12	i2pn.org	5732	83	4955	26	11	1%	23:58:33
13	news.tnetconsulting.net	5987	80	5172	96	0	1%	23:58:43
14	news.weretis.net	5543	75	5229	49	0	1%	23:59:53
15	news.quux.org	4222	74	3698	225	0	1%	23:59:53
16	nntp.comgw.net	5465	73	4859	27	0	1%	23:59:53
17	newsfeed.xs3.de	6459	40	5026	105	5	0%	23:58:29
18	news.chmurka.net	3678	22	2737	1	4	0%	23:58:28
19	news.samoylyk.net	6632	12	5151	56	1124	0%	23:59:45
20	ddt.demos.su	26	2	23	0	0	7%	03:13:33
21	usenet.blueworldhosting.com	4922	1	4355	0	127	0%	23:59:53
22	feed.opticnetworks.net	0	0	0	0	5354	0%	23:59:53
23	news.nk.ca	0	0	0	0	5285	0%	23:59:53
24	photonic.trudheim.com	0	0	0	0	5343	0%	23:59:53
TOTAL: 24		113190	7075	84122	1081	17314	6%	551:50:45

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	nyheter.lysator.liu.se	8.3 MB	1.1 MB	9.4 MB	0.1 KB/s	3.4 KB	23:59:53
2	news.netfront.net	6.0 MB	1.8 KB	6.0 MB	0.1 KB/s	3.8 KB	23:59:53
3	news.furie.org.uk	2.8 MB	48.5 KB	2.9 MB	0.0 KB/s	4.6 KB	23:59:39
4	endofthelinebbs.peers.news.panix.com	2.1 MB	0.0 KB	2.1 MB	0.0 KB/s	3.0 KB	23:58:41
5	news.corradoroberto.it	549.1 KB	0.0 KB	549.1 KB	0.0 KB/s	3.0 KB	20:48:29
6	newsfeed.bofh.team	534.3 KB	1.8 KB	536.1 KB	0.0 KB/s	5.2 KB	23:59:53
7	news.hispagatos.org	528.1 KB	509.9 KB	1.0 MB	0.0 KB/s	5.2 KB	23:59:39
8	usenet.goja.nl.eu.org	474.1 KB	301.4 KB	775.4 KB	0.0 KB/s	2.9 KB	23:59:49
9	news.nntp4.net	454.7 KB	289.2 KB	743.9 KB	0.0 KB/s	5.7 KB	23:59:46
10	news.quux.org	434.8 KB	822.0 KB	1.2 MB	0.0 KB/s	4.2 KB	23:59:53
11	usenet.network	373.9 KB	20.9 KB	394.9 KB	0.0 KB/s	3.3 KB	23:58:28
12	news.tnetconsulting.net	343.4 KB	459.4 KB	802.8 KB	0.0 KB/s	4.6 KB	23:58:43
13	news.weretis.net	312.6 KB	341.9 KB	654.5 KB	0.0 KB/s	5.3 KB	23:59:53
14	news.bbs.nz	298.1 KB	1.1 MB	1.4 MB	0.0 KB/s	4.7 KB	23:59:53
15	i2pn.org	293.4 KB	98.6 KB	392.0 KB	0.0 KB/s	3.6 KB	23:58:33
16	nntp.comgw.net	192.6 KB	294.1 KB	486.7 KB	0.0 KB/s	4.9 KB	23:59:53
17	newsfeed.xs3.de	159.9 KB	437.4 KB	597.3 KB	0.0 KB/s	4.1 KB	23:58:29
18	news.chmurka.net	58.3 KB	1.8 KB	60.1 KB	0.0 KB/s	2.6 KB	23:58:28
19	news.samoylyk.net	46.6 KB	158.6 KB	205.1 KB	0.0 KB/s	3.0 KB	23:59:45
20	ddt.demos.su	5.9 KB	0.0 KB	5.9 KB	0.0 KB/s	3.0 KB	03:13:33
21	usenet.blueworldhosting.com	1.4 KB	0.0 KB	1.4 KB	0.0 KB/s	1.4 KB	23:59:53
22	feed.opticnetworks.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:53
23	news.nk.ca	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		24.2 MB	5.9 MB	30.1 MB	0.0 KB/s	3.8 KB	551:50:45

NNRP readership statistics:

System		Conn	Elapsed
1	185.91.127.81	3	00:00:00
2	185.147.124.102	2	00:00:00
3	147.185.132.16	1	00:00:10
4	185.147.124.57	1	00:00:00
5	198.235.24.184	1	00:00:05
6	198.235.24.66	1	00:00:00
7	91.238.181.31	1	00:00:00
8	localhost	1	00:10:52
9	newsfeed.bofh.team	1	00:00:11
TOTAL: 9		12	00:11:21

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	unresolved	10	00:00:17
2	*.bofh.team	1	00:00:11
3	?	1	00:10:52
TOTAL: 3		12	00:11:21

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	180.737	365.039	0.074	00:10:52
newsfeed.bofh.team	0.000	0.017	0.000	00:00:11
147.185.132.16	0.000	0.017	0.000	00:00:10
198.235.24.184	0.010	0.033	0.000	00:00:05
185.91.127.81	0.011	0.040	0.000	00:00:00
185.147.124.102	0.005	0.045	0.000	00:00:00
198.235.24.66	0.000	0.016	0.000	00:00:00
185.147.124.57	0.009	0.018	0.000	00:00:00
91.238.181.31	0.004	0.022	0.000	00:00:00
TOTAL: 9	180.776	365.247	0.074	00:11:21

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

System	Conn
185.91.127.81	4
185.147.124.102	2
185.147.124.57	1
91.238.181.31	1
TOTAL: 4	8

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

Command	Count
#003	4
CONNECT api.ip.pn:443 HTTP/1.1	1
Connection: close	1
Host: api.ip.pn	1
User-Agent: Mozilla/5.0	1
TOTAL: 5	8

NNRP client timeouts [Top 20]:

System	Conn	Peer
185.147.124.102	2	2
185.147.124.57	1	1
91.238.181.31	1	1
TOTAL: 3	4	8

Daily Usenet Report

Dec 26 00:01:01 -- Dec 27 00:01:02