Daily Usenet Report: Nov 20 00:01:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Nov 21 00:00:01 newsfeed nnrpd[998210]: localhost auth: program exited with status 8

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	13031	31.0%	4.1 MB	49.6%
nnrpd	12150	28.9%	1.6 MB	19.7%
innd	11961	28.4%	1.6 MB	19.6%
innfeed	4331	10.3%	824.4 KB	9.7%
cnfsstat	432	1.0%	66.0 KB	0.8%
nocem	178	0.4%	51.2 KB	0.6%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 7	42084	100.0%	8.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	123166	52.1%
Negative hits	60098	25.4%
Cache misses	40773	17.3%
Do not exist	12303	5.2%
TOTAL: 4	236340	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.198	0.0%	790	0.000	1.516	9.000
article cleanup	00:00:00.117	0.0%	12393	0.000	0.009	0.088
article logging	00:00:00.978	0.0%	12463	0.000	0.078	2.983
article parse	00:00:00.316	0.0%	22152	0.000	0.014	0.108
article write	00:00:02.393	0.0%	7534	0.000	0.318	4.146
artlog/artcncl	00:00:00.018	0.0%	573	0.000	0.031	0.167
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:02.267	0.0%	197677	0.000	0.011	0.675
hisgrep/artcncl	00:00:00.901	0.0%	787	0.000	1.145	7.545
hishave/artcncl	00:00:00.083	0.0%	763	0.000	0.109	3.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:03:44.846	0.3%	237955	0.039	0.945	5.568
history sync	00:00:00.074	0.0%	403	0.000	0.184	1.000
history write	00:02:07.477	0.1%	12393	3.101	10.286	98.333
hiswrite/artcncl	00:00:00.030	0.0%	7	4.286	4.286	4.286
hiswrite/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:46:02.210	99.0%	197233	50.779	433.813	2972.342
nntp read	00:00:03.344	0.0%	201052	0.000	0.017	0.219
overview write	00:07:15.119	0.5%	7534	0.579	57.754	2131.402
perl filter	00:00:45.792	0.1%	12393	1.333	3.695	34.500
python filter	00:00:01.327	0.0%	12393	0.000	0.107	1.183
site send	00:00:01.505	0.0%	15181	0.000	0.099	4.455
TOTAL: 24:01:08.891	24:00:09.995	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.017	0.0%	8313	0.000	0.002	0.034
article prepare	00:00:00.007	0.0%	61300	0.000	0.000	0.031
article read	00:00:00.797	0.0%	5099	0.000	0.156	2.038
backlog stats	00:00:00.436	0.0%	294369	0.000	0.001	0.010
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.676	0.0%	197553	0.002	0.014	0.039
data write	00:00:03.409	0.0%	194067	0.004	0.018	0.036
idle	23:56:31.247	100.0%	294369	132.832	292.800	1642.883
status file	00:00:00.430	0.0%	362	0.857	1.188	8.000
TOTAL: 23:56:54.006	23:56:39.019	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:19:03.675	61.4%	7241	1.000	157.944	10053.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:03.950	0.2%	93483	0.000	0.042	0.333
TOTAL: 00:31:04.172	00:19:07.625	61.6%	-	-	-	-

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	14624	2710	11599	315	18%	49:51:14
2	usenet.blueworldhosting.com	713	8984	914	7298	772	10%	23:54:44
3	glockenspiel.complete.org	2	5796	651	5135	10	11%	21:33:42
4	nntp.comgw.net	1	8514	400	7891	223	4%	23:59:54
5	i2pn.org	1	7968	383	7520	65	4%	23:59:54
6	news.corradoroberto.it	9	1243	366	877	0	29%	22:55:36
7	usenet.goja.nl.eu.org	11	8661	348	8213	100	4%	25:37:56
8	usenet.network	1	6223	298	5913	12	4%	23:59:58
9	newsfeed.bofh.team	2	9034	274	8685	75	3%	23:59:37
10	endoftheline-out.news.chmurka.net	2	4136	266	3869	1	6%	23:59:03
11	194.87.241.33	42	360	239	121	0	66%	16:59:07
12	newsfeed.xs3.de	1	6341	231	6087	23	3%	23:59:57
13	news.samoylyk.net	1	6897	176	6721	0	2%	23:59:48
14	news.nntp4.net	1	6767	138	6613	16	2%	23:59:55
15	endofthelinebbs.peers.news.panix.com	25	8747	106	8592	49	1%	24:06:57
16	photonic.trudheim.com	7	43903	74	40840	2989	0%	02:17:09
17	news.netfront.net	1	6952	41	6739	172	0%	22:34:57
18	news.hispagatos.org	10	8804	28	8735	41	0%	24:49:57
19	news.furie.org.uk	1	3854	14	3840	0	0%	23:59:57
20	news.bbs.nz	2	7656	9	7647	0	0%	23:59:37
21	outgoing.news.lysator.liu.se	1	4469	4	4464	1	0%	23:59:57
22	eotl-out.news.tnetconsulting.net	1	0	0	0	0	0%	00:10:07
23	localhost	28	0	0	0	0	0%	00:00:01
24	news.nk.ca	1	0	0	0	0	0%	00:10:06
TOTAL: 24		868	179933	7670	167399	4864	4%	498:59:10

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	endofthelinebbs-out.news.weretis.net	8.0 MB	589.3 KB	8.5 MB	93%	2.9 KB
2	usenet.network	2.9 MB	11.8 KB	2.9 MB	99%	9.5 KB
3	glockenspiel.complete.org	2.6 MB	17.7 KB	2.6 MB	99%	4.1 KB
4	usenet.blueworldhosting.com	2.4 MB	1.5 MB	3.9 MB	62%	2.4 KB
5	news.corradoroberto.it	2.2 MB	0.0 KB	2.2 MB	100%	6.3 KB
6	nntp.comgw.net	1.1 MB	1.3 MB	2.5 MB	46%	4.0 KB
7	endoftheline-out.news.chmurka.net	1.1 MB	0.6 KB	1.1 MB	99%	4.2 KB
8	i2pn.org	1013.4 KB	83.1 KB	1.1 MB	92%	2.4 KB
9	usenet.goja.nl.eu.org	954.2 KB	208.3 KB	1.1 MB	82%	2.6 KB
10	newsfeed.bofh.team	793.9 KB	227.5 KB	1021.3 KB	77%	2.9 KB
11	news.samoylyk.net	748.1 KB	0.0 KB	748.1 KB	100%	4.3 KB
12	newsfeed.xs3.de	730.8 KB	54.8 KB	785.7 KB	93%	3.1 KB
13	194.87.241.33	625.3 KB	0.0 KB	625.3 KB	100%	2.6 KB
14	endofthelinebbs.peers.news.panix.com	360.2 KB	125.5 KB	485.7 KB	74%	3.1 KB
15	news.nntp4.net	355.3 KB	37.6 KB	392.9 KB	90%	2.6 KB
16	photonic.trudheim.com	297.7 KB	13.6 MB	13.9 MB	2%	4.6 KB
17	news.hispagatos.org	118.2 KB	64.5 KB	182.7 KB	64%	2.6 KB
18	news.netfront.net	81.6 KB	3.5 MB	3.6 MB	2%	17.1 KB
19	news.furie.org.uk	74.3 KB	0.0 KB	74.3 KB	100%	5.3 KB
20	news.bbs.nz	18.2 KB	0.0 KB	18.2 KB	100%	2.0 KB
21	outgoing.news.lysator.liu.se	11.2 KB	1.3 KB	12.5 KB	89%	2.5 KB
22	eotl-out.news.tnetconsulting.net	0.0 KB	0.0 KB	0.0 KB	0%	0
23	localhost	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
TOTAL: 24		26.4 MB	21.3 MB	47.6 MB	55%	3.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 20 00:01:01 - 00:59:59	245	3.3%	0.07	942.5 KB	3.5%	0.27
Nov 20 01:00:00 - 01:59:59	219	2.9%	0.06	698.2 KB	2.6%	0.19
Nov 20 02:00:00 - 02:59:59	376	5.0%	0.10	1.0 MB	3.9%	0.30
Nov 20 03:00:00 - 03:59:59	458	6.1%	0.13	1.4 MB	5.2%	0.40
Nov 20 04:00:00 - 04:59:59	590	7.8%	0.16	1.8 MB	6.7%	0.51
Nov 20 05:00:00 - 05:59:59	366	4.9%	0.10	1.4 MB	5.3%	0.40
Nov 20 06:00:00 - 06:59:59	388	5.2%	0.11	1.4 MB	5.4%	0.41
Nov 20 07:00:00 - 07:59:59	405	5.4%	0.11	1.5 MB	5.5%	0.42
Nov 20 08:00:00 - 08:59:59	406	5.4%	0.11	1.3 MB	5.0%	0.38
Nov 20 09:00:00 - 09:59:59	418	5.6%	0.12	1.4 MB	5.3%	0.40
Nov 20 10:00:00 - 10:59:59	434	5.8%	0.12	1.4 MB	5.2%	0.40
Nov 20 11:00:00 - 11:59:59	361	4.8%	0.10	1.2 MB	4.4%	0.33
Nov 20 12:00:00 - 12:59:59	487	6.5%	0.14	1.5 MB	5.6%	0.42
Nov 20 13:00:00 - 13:59:59	366	4.9%	0.10	1.4 MB	5.5%	0.41
Nov 20 14:00:00 - 14:59:59	369	4.9%	0.10	1.1 MB	4.2%	0.32
Nov 20 15:00:00 - 15:59:59	376	5.0%	0.10	1.7 MB	6.3%	0.48
Nov 20 16:00:00 - 16:59:59	270	3.6%	0.07	923.4 KB	3.4%	0.26
Nov 20 17:00:00 - 17:59:59	254	3.4%	0.07	1.2 MB	4.5%	0.34
Nov 20 18:00:00 - 18:59:59	143	1.9%	0.04	543.7 KB	2.0%	0.15
Nov 20 19:00:00 - 19:59:59	103	1.4%	0.03	510.3 KB	1.9%	0.14
Nov 20 20:00:00 - 20:59:59	95	1.3%	0.03	343.1 KB	1.3%	0.10
Nov 20 21:00:00 - 21:59:59	156	2.1%	0.04	597.1 KB	2.2%	0.17
Nov 20 22:00:00 - 22:59:59	107	1.4%	0.03	379.1 KB	1.4%	0.11
Nov 20 23:00:00 - 23:59:59	137	1.8%	0.04	979.1 KB	3.6%	0.27
Nov 21 00:00:00 - 00:01:01	1	0.0%	0.02	0.7 KB	0.0%	0.01
TOTAL: 24:00:00	7530	100.0%	0.09	26.6 MB	100.0%	0.31

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	100.2 GB	6.5%	0	0.50	37275.47
CYCTXT1	TEXT	5.0 GB	3.9 GB	78.6%	0	0.03	2266.43
TOTAL: 3	-	3077.0 GB	104.1 GB	3.4%	1	0.36	-

Sites sending bad articles:

Server		Total	Group	Other
1	photonic.trudheim.com	2989	0	2989
2	usenet.blueworldhosting.com	789	15	774
3	endofthelinebbs-out.news.weretis.net	353	0	353
4	nntp.comgw.net	224	0	224
5	news.netfront.net	186	0	186
6	usenet.goja.nl.eu.org	85	0	85
7	newsfeed.bofh.team	80	2	78
8	i2pn.org	66	0	66
9	endofthelinebbs.peers.news.panix.com	50	8	42
10	news.hispagatos.org	38	32	6
11	newsfeed.xs3.de	26	0	26
12	news.nntp4.net	17	0	17
13	usenet.network	13	0	13
14	glockenspiel.complete.org	10	0	10
15	endoftheline-out.news.chmurka.net	1	0	1
16	outgoing.news.lysator.liu.se	1	0	1
TOTAL: 16		4928	57	4871

Unwanted newsgroups [Top 20]:

Newsgroup	Count
de.sci.announce	20
hispagatos.hacking.ctf	17
hispagatos.mastodon.tag.hacking	7
hispagatos.hacking.news	6
soc.culture.russia	2
uunet.de.test	2
SerpentLord	1
hispagatos.mastodon.tag.hackers	1
hispagatos.mastodon.tag.hispagatos	1
TOTAL: 9	57

INND Perl filter [Top 20]:

Reason	Count
Too many newsgroups	3043
EMP (phn path)	857
EMP (md5)	341
EMP (phr path)	300
Too many newsgroups (meow)	136
User-issued cancel	71
HTML Multipart	28
EMP (phn nph)	12
EMP (phr nph)	9
hierarchy violation - crosspost outside sdnet	2
Subject (LSDCoCAi)	1
Subject (LSDguJ7guJo)	1
TOTAL: 12	4801

NoCeM on Spool:

Issuer (type)	Notices	Cancel	Skip	Total
i2pn2-nocem@i2pn2.org (spam)	43	576	0	576
nocem@eternal-september.org (bot)	21	183	0	183
i2pn2-nocem@i2pn2.org (multipost)	33	0	34	34
robot@pasdenom.info (spam3)	4	0	10	10
i2pn2-nocem@i2pn2.org (rmp)	5	0	9	9
robot@pasdenom.info (spam2)	7	0	8	8
TOTAL: 6	113	759	61	820

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	endofthelinebbs-out.news.weretis.net	32
	usenet.blueworldhosting.com	17
	nntp.comgw.net	5
	usenet.goja.nl.eu.org	4
	newsfeed.bofh.team	3
	newsfeed.xs3.de	3
	endofthelinebbs.peers.news.panix.com	3
	usenet.network	1
	news.nntp4.net	1
	news.netfront.net	1
	TOTAL: 10	70
TOTAL: 1		70

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	nyheter.lysator.liu.se	7867	3469	3659	398	11	44%	23:59:50
2	news.netfront.net	11968	2117	5370	1	50	17%	23:58:40
3	photonic.trudheim.com	9058	857	4813	1785	183	9%	23:59:49
4	news.furie.org.uk	4930	747	2875	40	1	15%	23:59:50
5	endofthelinebbs.peers.news.panix.com	8345	496	7022	8	11	5%	23:59:23
6	usenet.goja.nl.eu.org	9050	361	6589	204	0	3%	23:58:00
7	news.bbs.nz	13611	273	6687	561	221	2%	23:59:49
8	news.corradoroberto.it	1100	212	560	0	0	19%	23:11:13
9	newsfeed.bofh.team	8478	209	6963	0	0	2%	23:58:16
10	usenet.network	9491	200	6750	47	4	2%	23:59:50
11	news.nk.ca	9806	189	6682	526	52	1%	23:59:28
12	news.hispagatos.org	9416	175	7141	186	17	1%	23:59:50
13	news.nntp4.net	8669	135	7140	100	0	1%	23:59:44
14	nntp.comgw.net	8138	120	6905	106	0	1%	23:58:28
15	news.weretis.net	7865	112	7252	163	5	1%	23:58:10
16	news.tnetconsulting.net	8513	101	7185	239	39	1%	23:59:44
17	i2pn.org	8450	91	6983	54	155	1%	23:58:49
18	news.quux.org	6081	79	5087	515	15	1%	23:59:50
19	newsfeed.xs3.de	9033	67	6989	224	0	0%	23:59:50
20	news.samoylyk.net	9707	35	7221	70	15	0%	23:59:42
21	news.chmurka.net	4906	32	3547	0	0	0%	23:59:20
22	ddt.demos.su	73	18	45	1	0	24%	07:01:16
23	usenet.blueworldhosting.com	6593	4	6297	5	8	0%	23:59:50
24	feed.opticnetworks.net	0	0	0	0	7530	0%	23:59:50
TOTAL: 24		181148	10099	129762	5233	8317	5%	557:58:31

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	nyheter.lysator.liu.se	12.0 MB	3.1 MB	15.1 MB	0.2 KB/s	4.0 KB	23:59:50
2	news.netfront.net	9.1 MB	4.7 KB	9.1 MB	0.1 KB/s	4.4 KB	23:58:40
3	news.furie.org.uk	4.7 MB	212.3 KB	4.9 MB	0.1 KB/s	6.3 KB	23:59:50
4	photonic.trudheim.com	4.2 MB	5.7 MB	9.9 MB	0.1 KB/s	3.9 KB	23:59:49
5	endofthelinebbs.peers.news.panix.com	2.2 MB	28.9 KB	2.2 MB	0.0 KB/s	4.5 KB	23:59:23
6	newsfeed.bofh.team	1.4 MB	0.0 KB	1.4 MB	0.0 KB/s	7.1 KB	23:58:16
7	news.quux.org	1.1 MB	2.6 MB	3.7 MB	0.0 KB/s	6.4 KB	23:59:50
8	news.nk.ca	991.5 KB	2.8 MB	3.8 MB	0.0 KB/s	5.5 KB	23:59:28
9	nntp.comgw.net	885.1 KB	1.1 MB	2.0 MB	0.0 KB/s	9.0 KB	23:58:28
10	usenet.goja.nl.eu.org	870.9 KB	1.7 MB	2.6 MB	0.0 KB/s	4.6 KB	23:58:00
11	news.samoylyk.net	863.5 KB	279.1 KB	1.1 MB	0.0 KB/s	10.9 KB	23:59:42
12	news.bbs.nz	857.8 KB	3.4 MB	4.3 MB	0.1 KB/s	5.2 KB	23:59:49
13	usenet.network	822.9 KB	95.2 KB	918.0 KB	0.0 KB/s	3.7 KB	23:59:50
14	news.nntp4.net	689.4 KB	1016.5 KB	1.7 MB	0.0 KB/s	7.3 KB	23:59:44
15	news.hispagatos.org	622.3 KB	1.5 MB	2.1 MB	0.0 KB/s	6.1 KB	23:59:50
16	news.corradoroberto.it	525.7 KB	0.0 KB	525.7 KB	0.0 KB/s	2.5 KB	23:11:13
17	news.weretis.net	514.4 KB	2.0 MB	2.5 MB	0.0 KB/s	9.4 KB	23:58:10
18	news.tnetconsulting.net	489.3 KB	1.5 MB	1.9 MB	0.0 KB/s	5.8 KB	23:59:44
19	newsfeed.xs3.de	346.8 KB	1.5 MB	1.8 MB	0.0 KB/s	6.4 KB	23:59:50
20	ddt.demos.su	306.6 KB	1.8 KB	308.4 KB	0.0 KB/s	16.2 KB	07:01:16
21	i2pn.org	287.4 KB	140.0 KB	427.4 KB	0.0 KB/s	2.9 KB	23:58:49
22	news.chmurka.net	112.7 KB	0.0 KB	112.7 KB	0.0 KB/s	3.5 KB	23:59:20
23	usenet.blueworldhosting.com	11.1 KB	37.9 KB	49.0 KB	0.0 KB/s	5.4 KB	23:59:50
24	feed.opticnetworks.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:50
TOTAL: 24		43.7 MB	28.9 MB	72.5 MB	0.0 KB/s	4.8 KB	557:58:31

NNRP readership statistics:

System		Conn	Elapsed
1	2001:470:28:a8:3ad5:47ff:fe02:c2fd	2403	00:19:08
2	ec2-13-58-97-162.us-east-2.compute.amazonaws.com	4	00:00:00
3	167.94.138.121	3	00:00:03
4	167.94.138.33	3	00:00:03
5	167.94.145.104	3	00:00:03
6	199.45.154.145	3	00:00:05
7	206.168.34.39	3	00:00:03
8	194.165.16.72	1	00:00:00
9	205.210.31.241	1	00:00:10
10	205.210.31.90	1	00:00:10
11	localhost	1	00:11:08
12	server-0-3.survey.inspici.com	1	00:00:03
TOTAL: 12		2427	00:31:03

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	?	2404	00:30:17
2	unresolved	18	00:00:41
3	*.us-east-2.compute.amazonaws.com	4	00:00:00
4	*.survey.inspici.com	1	00:00:03
TOTAL: 4		2427	00:31:03

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
2001:470:28:a8:3ad5:47ff:fe02:c2fd	8.495	32.524	0.000	00:19:08
localhost	181.033	370.387	0.076	00:11:08
205.210.31.241	0.000	0.020	0.000	00:00:10
205.210.31.90	0.000	0.016	0.000	00:00:10
199.45.154.145	0.020	0.041	0.000	00:00:05
206.168.34.39	0.012	0.056	0.000	00:00:03
167.94.145.104	0.029	0.042	0.000	00:00:03
167.94.138.33	0.024	0.043	0.000	00:00:03
167.94.138.121	0.033	0.031	0.000	00:00:03
server-0-3.survey.inspici.com	0.012	0.012	0.000	00:00:03
194.165.16.72	0.004	0.012	0.000	00:00:00
ec2-13-58-97-162.us-east-2.compute.amazonaws.com	0.017	0.057	0.000	00:00:00
TOTAL: 12	189.679	403.241	0.076	00:31:03

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

System	Conn
ec2-13-58-97-162.us-east-2.compute.amazonaws.com	9
167.94.138.121	1
167.94.138.33	1
167.94.145.104	1
194.165.16.72	1
199.45.154.145	1
206.168.34.39	1
TOTAL: 7	15

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

Command	Count
EHLO www.censys.io	5
#001	2
#026#003#001	2
#003	1
Accept-Encoding: gzip	1
Accept: /	1
GET / HTTP/1.1	1
Host: 144.172.126.95:119	1
User-Agent: Mozilla/5.0 (Macintosh; Inte...	1
TOTAL: 9	15

NNRP client timeouts [Top 20]:

System	Conn	Peer
167.94.138.121	1	2
167.94.138.33	1	2
167.94.145.104	1	2
194.165.16.72	1	1
199.45.154.145	1	2
206.168.34.39	1	2
TOTAL: 6	6	11

Daily Usenet Report

Nov 20 00:01:01 -- Nov 21 00:01:01