Daily Usenet Report: Feb 18 00:01:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Feb 19 00:00:01 newsfeed nnrpd[3419934]: localhost auth: program exited with status 8

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	9967	43.5%	3.7 MB	63.8%
innd	7970	34.8%	1.2 MB	20.2%
innfeed	4448	19.4%	862.6 KB	14.4%
cnfsstat	432	1.9%	78.8 KB	1.3%
nnrpd	44	0.2%	5.2 KB	0.1%
nocem	42	0.2%	5.1 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 7	22904	100.0%	5.8 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	137892	64.2%
Negative hits	66946	31.2%
Do not exist	9852	4.6%
Cache misses	74	0.0%
TOTAL: 4	214764	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.124	0.0%	36	0.000	3.444	12.000
article cleanup	00:00:00.117	0.0%	9915	0.000	0.012	0.250
article logging	00:00:00.436	0.0%	9957	0.000	0.044	0.333
article parse	00:00:00.235	0.0%	15855	0.000	0.015	0.104
article write	00:00:02.363	0.0%	7484	0.000	0.316	3.500
artlog/artcncl	00:00:00.000	0.0%	6	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:01.471	0.0%	207482	0.000	0.007	0.701
hisgrep/artcncl	00:00:00.089	0.0%	38	0.000	2.342	9.000
hishave/artcncl	00:00:00.000	0.0%	6	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:43.784	0.2%	216231	0.103	0.757	5.989
history sync	00:00:00.083	0.0%	398	0.000	0.209	1.667
history write	00:02:34.693	0.2%	9911	3.035	15.608	125.416
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:51:35.791	99.3%	198851	106.236	431.961	2679.205
nntp read	00:00:03.966	0.0%	208327	0.002	0.019	0.516
overview write	00:02:23.737	0.2%	7484	0.500	19.206	828.708
perl filter	00:00:38.781	0.0%	9911	1.261	3.913	52.628
python filter	00:00:03.244	0.0%	9911	0.000	0.327	7.384
site send	00:00:01.241	0.0%	15005	0.000	0.083	0.241
TOTAL: 24:01:00.441	24:00:10.155	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.021	0.0%	7671	0.000	0.003	0.042
article prepare	00:00:00.004	0.0%	44893	0.000	0.000	0.003
article read	00:00:00.663	0.0%	4129	0.000	0.161	2.667
backlog stats	00:00:00.409	0.0%	277129	0.000	0.001	0.006
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.543	0.0%	191785	0.000	0.013	0.042
data write	00:00:03.383	0.0%	184157	0.000	0.018	0.038
idle	23:57:43.707	100.0%	277129	161.479	311.276	1466.063
status file	00:00:00.499	0.0%	411	0.750	1.214	20.000
TOTAL: 23:58:00.936	23:57:51.229	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:35.794	4.7%	15	0.750	2386.267	10048.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:04.119	0.5%	78847	0.000	0.052	0.052
TOTAL: 00:12:48.385	00:00:39.913	5.2%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	glockenspiel.complete.org	2	6074	1787	4257	30	29%	21:21:13
2	endofthelinebbs-out.news.weretis.net	3	16214	1174	14704	336	7%	48:22:56
3	usenet.blueworldhosting.com	289	9691	909	7850	932	9%	23:48:32
4	newsfeed.bofh.team	2	9678	638	8801	239	6%	23:57:53
5	usenet.network	1	6682	502	6157	23	7%	23:59:58
6	newsfeed.xs3.de	2	7317	431	6749	137	5%	23:58:20
7	usenet.goja.nl.eu.org	11	9155	385	8642	128	4%	25:18:40
8	news.corradoroberto.it	12	1289	384	905	0	29%	24:03:48
9	news.samoylyk.net	3	7831	376	7396	59	4%	23:58:13
10	i2pn.org	1	8925	296	8579	50	3%	23:59:54
11	endoftheline-out.news.chmurka.net	1	3837	157	3679	1	4%	23:59:56
12	nntp.comgw.net	1	9062	145	8838	79	1%	23:59:58
13	194.87.241.33	43	737	129	413	195	17%	16:11:00
14	news.nntp4.net	5	7999	113	7842	44	1%	23:59:21
15	news.hispagatos.org	5	9240	32	9158	50	0%	24:26:20
16	endofthelinebbs.peers.news.panix.com	24	8328	27	8297	4	0%	23:53:08
17	news.netfront.net	1	7874	21	7714	139	0%	25:00:48
18	news.furie.org.uk	1	4042	15	4027	0	0%	23:59:57
19	outgoing.news.lysator.liu.se	1	6234	11	6220	3	0%	23:59:57
20	news.bbs.nz	2	7964	7	7943	14	0%	23:59:09
21	photonic.trudheim.com	3	1891	0	1889	2	0%	25:00:52
22	localhost	29	0	0	0	0	0%	00:00:00
23	news.nk.ca	2	0	0	0	0	0%	00:20:11
TOTAL: 23		444	150064	7539	140060	2465	5%	521:40:04

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	glockenspiel.complete.org	5.2 MB	0.0 KB	64.7 KB	5.3 MB	98%	3.0 KB
2	usenet.network	4.8 MB	0.0 KB	25.7 KB	4.8 MB	99%	9.4 KB
3	endofthelinebbs-out.news.weretis.net	3.2 MB	0.0 KB	711.9 KB	3.9 MB	82%	2.7 KB
4	news.corradoroberto.it	2.6 MB	0.0 KB	0.0 KB	2.6 MB	100%	6.9 KB
5	usenet.blueworldhosting.com	2.0 MB	0.0 KB	2.0 MB	4.0 MB	49%	2.2 KB
6	newsfeed.bofh.team	1.7 MB	271.4 KB	452.1 KB	2.4 MB	70%	2.8 KB
7	news.samoylyk.net	1.6 MB	271.4 KB	144.4 KB	2.0 MB	79%	4.8 KB
8	usenet.goja.nl.eu.org	1.4 MB	0.0 KB	200.9 KB	1.6 MB	87%	3.1 KB
9	newsfeed.xs3.de	1.3 MB	0.0 KB	428.6 KB	1.7 MB	75%	3.0 KB
10	i2pn.org	927.2 KB	0.0 KB	62.5 KB	989.7 KB	93%	2.9 KB
11	nntp.comgw.net	446.3 KB	271.4 KB	243.3 KB	961.0 KB	46%	4.3 KB
12	endoftheline-out.news.chmurka.net	438.9 KB	0.0 KB	0.6 KB	439.6 KB	99%	2.8 KB
13	194.87.241.33	332.1 KB	0.0 KB	508.2 KB	840.3 KB	39%	2.6 KB
14	news.nntp4.net	244.5 KB	0.0 KB	128.2 KB	372.7 KB	65%	2.4 KB
15	news.hispagatos.org	151.2 KB	0.0 KB	107.3 KB	258.5 KB	58%	3.2 KB
16	endofthelinebbs.peers.news.panix.com	74.2 KB	0.0 KB	4.9 KB	79.1 KB	93%	2.6 KB
17	news.furie.org.uk	71.9 KB	0.0 KB	0.0 KB	71.9 KB	100%	4.8 KB
18	news.netfront.net	62.5 KB	0.0 KB	659.6 KB	722.1 KB	8%	4.5 KB
19	outgoing.news.lysator.liu.se	45.9 KB	271.4 KB	2.5 KB	319.8 KB	14%	22.8 KB
20	news.bbs.nz	15.6 KB	0.0 KB	37.8 KB	53.3 KB	29%	2.5 KB
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
23	photonic.trudheim.com	0.0 KB	0.0 KB	7.9 KB	7.9 KB	0%	4.0 KB
TOTAL: 23		26.5 MB	1.1 MB	5.7 MB	33.3 MB	79%	3.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 18 00:01:01 - 00:59:59	167	2.2%	0.05	448.6 KB	1.7%	0.13
Feb 18 01:00:00 - 01:59:59	234	3.1%	0.07	712.6 KB	2.7%	0.20
Feb 18 02:00:00 - 02:59:59	334	4.5%	0.09	931.9 KB	3.5%	0.26
Feb 18 03:00:00 - 03:59:59	373	5.0%	0.10	1.2 MB	4.7%	0.35
Feb 18 04:00:00 - 04:59:59	403	5.4%	0.11	1.2 MB	4.6%	0.34
Feb 18 05:00:00 - 05:59:59	349	4.7%	0.10	1.3 MB	5.2%	0.38
Feb 18 06:00:00 - 06:59:59	401	5.4%	0.11	1.7 MB	6.7%	0.49
Feb 18 07:00:00 - 07:59:59	349	4.7%	0.10	1.3 MB	5.1%	0.37
Feb 18 08:00:00 - 08:59:59	426	5.7%	0.12	1.4 MB	5.3%	0.39
Feb 18 09:00:00 - 09:59:59	482	6.4%	0.13	1.3 MB	4.9%	0.36
Feb 18 10:00:00 - 10:59:59	468	6.3%	0.13	1.7 MB	6.4%	0.47
Feb 18 11:00:00 - 11:59:59	437	5.8%	0.12	1.4 MB	5.5%	0.41
Feb 18 12:00:00 - 12:59:59	377	5.0%	0.10	1.3 MB	4.9%	0.36
Feb 18 13:00:00 - 13:59:59	514	6.9%	0.14	2.4 MB	9.4%	0.69
Feb 18 14:00:00 - 14:59:59	370	4.9%	0.10	1.0 MB	4.0%	0.30
Feb 18 15:00:00 - 15:59:59	405	5.4%	0.11	1.6 MB	6.1%	0.45
Feb 18 16:00:00 - 16:59:59	320	4.3%	0.09	1.1 MB	4.1%	0.30
Feb 18 17:00:00 - 17:59:59	233	3.1%	0.06	929.7 KB	3.5%	0.26
Feb 18 18:00:00 - 18:59:59	149	2.0%	0.04	585.7 KB	2.2%	0.16
Feb 18 19:00:00 - 19:59:59	165	2.2%	0.05	605.7 KB	2.3%	0.17
Feb 18 20:00:00 - 20:59:59	139	1.9%	0.04	592.3 KB	2.2%	0.16
Feb 18 21:00:00 - 21:59:59	115	1.5%	0.03	439.7 KB	1.7%	0.12
Feb 18 22:00:00 - 22:59:59	121	1.6%	0.03	427.2 KB	1.6%	0.12
Feb 18 23:00:00 - 23:59:59	143	1.9%	0.04	376.4 KB	1.4%	0.10
Feb 19 00:00:00 - 00:01:01	11	0.1%	0.18	48.6 KB	0.2%	0.80
TOTAL: 24:00:00	7485	100.0%	0.09	25.9 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	103.7 GB	6.7%	0	0.48	38818.44
CYCTXT1	TEXT	5.0 GB	4.0 GB	81.0%	0	0.03	2214.49
TOTAL: 3	-	3077.0 GB	107.8 GB	3.5%	1	0.33	-

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	usenet.blueworldhosting.com	938	0	0	938
2	endofthelinebbs-out.news.weretis.net	344	0	0	344
3	newsfeed.bofh.team	237	0	1	236
4	194.87.241.33	177	0	0	177
5	newsfeed.xs3.de	152	0	0	152
6	news.netfront.net	137	0	0	137
7	usenet.goja.nl.eu.org	127	0	0	127
8	nntp.comgw.net	77	0	1	76
9	news.samoylyk.net	67	0	1	66
10	news.hispagatos.org	51	28	0	23
11	i2pn.org	50	0	0	50
12	news.nntp4.net	44	0	0	44
13	glockenspiel.complete.org	35	0	0	35
14	usenet.network	28	0	0	28
15	endofthelinebbs.peers.news.panix.com	6	1	0	5
16	outgoing.news.lysator.liu.se	3	0	1	2
17	photonic.trudheim.com	2	0	0	2
18	endoftheline-out.news.chmurka.net	1	0	0	1
TOTAL: 18		2476	29	4	2443

Unwanted newsgroups [Top 20]:

Newsgroup	Count
hispagatos.mastodon.tag.hacking	16
hispagatos.hacking.news	7
hispagatos.hacking.ctf	4
hispagatos.mastodon.tag.hackers	2
TOTAL: 4	29

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	1575
EMP (phr path)	289
EMP (md5)	200
Too many newsgroups	178
EMP (phn nph)	69
EMP (phl)	42
User-issued cancel	17
Too many newsgroups (meow)	12
Angle-bracket bot	9
HTML Multipart	7
Subject (LSDQu9C+0LrQsNC70YzQvd)	1
Too many newsgroups (low_xpost)	1
hierarchy violation - crosspost outside sdnet	1
TOTAL: 13	2401

NoCeM on Spool:

Issuer (type)	Notices	Cancel	Skip	Total
robot@pasdenom.info (spam)	4	4	0	4
robot@pasdenom.info (spam2)	14	0	16	16
i2pn2-nocem@i2pn2.org (multipost)	8	0	9	9
i2pn2-nocem@i2pn2.org (rmp)	5	0	8	8
robot@pasdenom.info (spam4)	4	0	5	5
robot@pasdenom.info (spam3)	2	0	3	3
TOTAL: 6	37	4	41	45

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	endofthelinebbs-out.news.weretis.net	13
	nntp.comgw.net	8
	usenet.network	7
	usenet.blueworldhosting.com	5
	newsfeed.xs3.de	4
	newsfeed.bofh.team	3
	glockenspiel.complete.org	2
	TOTAL: 7	42
TOTAL: 1		42

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	nyheter.lysator.liu.se	8429	2349	4705	420	0	27%	23:58:18
2	news.netfront.net	12291	2050	5411	2	6	16%	23:59:54
3	endofthelinebbs.peers.news.panix.com	7759	937	6528	16	6	12%	23:59:54
4	news.furie.org.uk	5232	473	3175	8	0	9%	23:58:19
5	photonic.trudheim.com	9473	469	6009	1004	11	4%	23:59:42
6	news.nntp4.net	7971	323	7044	2	1	4%	23:59:54
7	usenet.goja.nl.eu.org	7616	297	6393	199	0	3%	23:59:54
8	newsfeed.bofh.team	7762	134	6707	1	0	1%	23:59:54
9	news.corradoroberto.it	1030	125	566	0	0	12%	22:16:18
10	news.nk.ca	9310	123	6712	545	27	1%	23:59:54
11	news.bbs.nz	13982	78	7020	382	85	0%	23:59:54
12	news.hispagatos.org	8565	57	7215	175	0	0%	23:59:54
13	nntp.comgw.net	8065	50	7226	73	0	0%	23:59:54
14	news.weretis.net	8071	48	7278	158	0	0%	23:59:47
15	i2pn.org	8067	46	7098	24	37	0%	23:59:54
16	usenet.network	7504	31	6611	12	0	0%	23:59:54
17	news.quux.org	6007	27	5074	353	0	0%	23:59:44
18	news.tnetconsulting.net	8866	20	7252	210	9	0%	23:59:54
19	news.samoylyk.net	8356	18	6992	6	1	0%	23:58:33
20	news.chmurka.net	4377	16	3384	2	0	0%	23:59:38
21	newsfeed.xs3.de	8243	15	6847	189	0	0%	23:57:17
22	ddt.demos.su	101	12	73	0	0	11%	08:37:49
23	usenet.blueworldhosting.com	6948	2	6498	0	0	0%	23:58:37
24	feed.opticnetworks.net	0	0	0	0	7485	0%	23:59:54
TOTAL: 24		174025	7700	131818	3781	7668	4%	558:42:44

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.netfront.net	9.4 MB	7.9 KB	9.4 MB	0.1 KB/s	4.7 KB	23:59:54
2	nyheter.lysator.liu.se	6.7 MB	4.1 MB	10.8 MB	0.1 KB/s	4.0 KB	23:58:18
3	endofthelinebbs.peers.news.panix.com	4.4 MB	16.5 KB	4.4 MB	0.1 KB/s	4.7 KB	23:59:54
4	news.furie.org.uk	3.4 MB	24.3 KB	3.4 MB	0.0 KB/s	7.3 KB	23:58:19
5	photonic.trudheim.com	2.7 MB	2.8 MB	5.5 MB	0.1 KB/s	3.9 KB	23:59:42
6	newsfeed.bofh.team	987.9 KB	1.8 KB	989.6 KB	0.0 KB/s	7.3 KB	23:59:54
7	news.nntp4.net	641.2 KB	14.3 KB	655.5 KB	0.0 KB/s	2.0 KB	23:59:54
8	usenet.goja.nl.eu.org	576.7 KB	1.9 MB	2.5 MB	0.0 KB/s	5.1 KB	23:59:54
9	news.corradoroberto.it	307.7 KB	0.0 KB	307.7 KB	0.0 KB/s	2.5 KB	22:16:18
10	news.weretis.net	304.5 KB	1.9 MB	2.2 MB	0.0 KB/s	11.1 KB	23:59:47
11	news.bbs.nz	295.0 KB	2.9 MB	3.2 MB	0.0 KB/s	7.1 KB	23:59:54
12	news.nk.ca	280.5 KB	3.3 MB	3.6 MB	0.0 KB/s	5.5 KB	23:59:54
13	news.quux.org	207.1 KB	2.6 MB	2.8 MB	0.0 KB/s	7.7 KB	23:59:44
14	news.tnetconsulting.net	174.9 KB	1.7 MB	1.9 MB	0.0 KB/s	8.5 KB	23:59:54
15	news.hispagatos.org	151.9 KB	1.5 MB	1.7 MB	0.0 KB/s	7.4 KB	23:59:54
16	i2pn.org	145.9 KB	184.6 KB	330.4 KB	0.0 KB/s	4.7 KB	23:59:54
17	nntp.comgw.net	140.1 KB	778.2 KB	918.2 KB	0.0 KB/s	7.5 KB	23:59:54
18	usenet.network	117.4 KB	33.4 KB	150.8 KB	0.0 KB/s	3.5 KB	23:59:54
19	news.samoylyk.net	70.6 KB	7.4 KB	78.1 KB	0.0 KB/s	3.3 KB	23:58:33
20	news.chmurka.net	57.1 KB	3.2 KB	60.3 KB	0.0 KB/s	3.4 KB	23:59:38
21	newsfeed.xs3.de	42.1 KB	1.6 MB	1.6 MB	0.0 KB/s	8.1 KB	23:57:17
22	ddt.demos.su	29.4 KB	0.0 KB	29.4 KB	0.0 KB/s	2.5 KB	08:37:49
23	usenet.blueworldhosting.com	5.3 KB	0.0 KB	5.3 KB	0.0 KB/s	2.7 KB	23:58:37
24	feed.opticnetworks.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:54
TOTAL: 24		31.0 MB	25.5 MB	56.6 MB	0.0 KB/s	5.0 KB	558:42:44

NNRP readership statistics:

System		Conn	Elapsed
1	199.45.154.157	3	00:00:04
2	198.235.24.239	1	00:00:00
3	205.210.31.239	1	00:00:10
4	205.210.31.83	1	00:00:10
5	fetching.monitoring.internet-measurement.com	1	00:00:01
6	localhost	1	00:12:11
7	zl-laxc-us-gp1-wk125c.internet-census.org	1	00:00:10
TOTAL: 7		9	00:12:48

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	unresolved	6	00:00:24
2	*.internet-census.org	1	00:00:10
3	*.monitoring.internet-measurement.com	1	00:00:01
4	?	1	00:12:11
TOTAL: 4		9	00:12:48

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	181.164	371.709	0.075	00:12:11
zl-laxc-us-gp1-wk125c.internet-census.org	0.000	0.017	0.000	00:00:10
205.210.31.239	0.006	0.045	0.000	00:00:10
205.210.31.83	0.004	0.012	0.000	00:00:10
199.45.154.157	0.017	0.065	0.000	00:00:04
fetching.monitoring.internet-measurement.com	0.000	0.025	0.000	00:00:01
198.235.24.239	0.004	0.012	0.000	00:00:00
TOTAL: 7	181.195	371.885	0.075	00:12:48

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

System	Conn
199.45.154.157	1
TOTAL: 1	1

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

Command	Count
EHLO www.censys.io	1
TOTAL: 1	1

NNRP client timeouts [Top 20]:

System	Conn	Peer
199.45.154.157	1	2
TOTAL: 1	1	3

Daily Usenet Report

Feb 18 00:01:01 -- Feb 19 00:01:01