Daily Usenet Report: Nov 11 00:01:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Nov 12 00:00:02 newsfeed nnrpd[3724581]: localhost auth: program exited with status 8

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	13937	34.1%	1.9 MB	21.8%
inn	12913	31.6%	4.4 MB	51.2%
innd	8747	21.4%	1.3 MB	14.8%
innfeed	4322	10.6%	831.2 KB	9.4%
nocem	492	1.2%	182.5 KB	2.1%
cnfsstat	432	1.1%	65.9 KB	0.7%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 7	40844	100.0%	8.6 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	138703	65.9%
Negative hits	61675	29.3%
Do not exist	9938	4.7%
Cache misses	180	0.1%
TOTAL: 4	210496	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:02.068	0.0%	3341	0.000	0.619	13.000
article cleanup	00:00:00.091	0.0%	10011	0.000	0.009	0.045
article logging	00:00:00.604	0.0%	10095	0.000	0.060	2.145
article parse	00:00:00.210	0.0%	14538	0.000	0.014	0.056
article write	00:00:02.573	0.0%	8420	0.030	0.306	7.136
artlog/artcncl	00:00:00.084	0.0%	2814	0.000	0.030	0.500
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:00.372	0.0%	213187	0.000	0.002	0.030
hisgrep/artcncl	00:00:01.179	0.0%	3317	0.000	0.355	8.000
hishave/artcncl	00:00:00.338	0.0%	3332	0.000	0.101	3.643
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:03.308	0.2%	209444	0.106	0.875	5.876
history sync	00:00:00.080	0.0%	396	0.000	0.202	1.333
history write	00:02:27.593	0.2%	10011	3.000	14.743	117.472
hiswrite/artcncl	00:00:00.076	0.0%	24	2.500	3.167	4.125
hiswrite/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:46:47.709	99.0%	210357	61.729	406.964	1662.396
nntp read	00:00:04.196	0.0%	213965	0.001	0.020	0.460
overview write	00:07:06.004	0.5%	8420	0.538	50.594	6395.750
perl filter	00:00:29.914	0.0%	10011	1.522	2.988	21.583
python filter	00:00:00.940	0.0%	10011	0.000	0.094	1.116
site send	00:00:01.401	0.0%	17114	0.000	0.082	0.261
TOTAL: 24:01:03.124	24:00:08.740	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.023	0.0%	9379	0.000	0.002	0.033
article prepare	00:00:00.005	0.0%	53964	0.000	0.000	0.003
article read	00:00:00.669	0.0%	4893	0.000	0.137	0.324
backlog stats	00:00:00.512	0.0%	321397	0.000	0.002	0.008
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.808	0.0%	218357	0.000	0.013	0.042
data write	00:00:03.781	0.0%	212837	0.010	0.018	0.032
idle	23:58:54.126	100.0%	321397	120.376	268.621	1300.356
status file	00:00:00.411	0.0%	355	1.000	1.158	5.000
TOTAL: 23:59:13.193	23:59:02.335	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:22:08.908	64.6%	8335	0.500	159.437	10048.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:04.412	0.2%	95426	0.000	0.046	0.333
TOTAL: 00:34:18.625	00:22:13.320	64.8%	-	-	-	-

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	15803	2700	12868	235	17%	49:01:02
2	usenet.blueworldhosting.com	721	9784	1086	8059	639	11%	23:54:19
3	glockenspiel.complete.org	3	2942	708	2233	1	24%	13:50:43
4	nntp.comgw.net	2	9209	647	8431	131	7%	23:59:40
5	newsfeed.bofh.team	2	9725	580	9052	93	5%	23:59:27
6	i2pn.org	1	8219	431	7682	106	5%	23:59:53
7	usenet.goja.nl.eu.org	11	9305	368	8833	104	3%	25:36:53
8	usenet.network	2	6289	334	5942	13	5%	23:59:50
9	news.corradoroberto.it	4	1259	327	932	0	25%	23:53:45
10	newsfeed.xs3.de	2	7352	269	7041	42	3%	23:59:31
11	endofthelinebbs.peers.news.panix.com	25	9004	217	8734	53	2%	24:24:21
12	endoftheline-out.news.chmurka.net	1	4441	215	4225	1	4%	23:59:56
13	194.87.241.33	44	329	175	153	1	53%	14:48:48
14	news.nntp4.net	2	7513	108	7401	4	1%	23:59:41
15	news.furie.org.uk	3	3971	104	3865	2	2%	23:59:47
16	news.netfront.net	1	7612	102	7406	104	1%	25:02:29
17	news.samoylyk.net	3	7671	86	7583	2	1%	23:55:40
18	news.hispagatos.org	25	9235	21	9173	41	0%	25:14:12
19	news.bbs.nz	1	7072	10	7061	1	0%	23:59:42
20	outgoing.news.lysator.liu.se	2	7378	1	7376	1	0%	23:59:09
21	eotl-out.news.tnetconsulting.net	1	0	0	0	0	0%	00:10:05
22	localhost	27	0	0	0	0	0%	00:00:01
23	news.nk.ca	2	0	0	0	0	0%	00:20:13
TOTAL: 23		889	144113	8489	134050	1574	5%	490:09:07

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	endofthelinebbs-out.news.weretis.net	8.4 MB	333.5 KB	8.8 MB	96%	3.1 KB
2	usenet.network	4.2 MB	11.6 KB	4.2 MB	99%	12.5 KB
3	glockenspiel.complete.org	2.5 MB	0.9 KB	2.5 MB	99%	3.6 KB
4	usenet.blueworldhosting.com	2.2 MB	1.2 MB	3.4 MB	64%	2.0 KB
5	news.corradoroberto.it	2.0 MB	0.0 KB	2.0 MB	100%	6.4 KB
6	nntp.comgw.net	2.0 MB	193.4 KB	2.2 MB	91%	2.9 KB
7	i2pn.org	1.9 MB	137.3 KB	2.1 MB	93%	4.0 KB
8	newsfeed.bofh.team	1.5 MB	124.8 KB	1.7 MB	92%	2.5 KB
9	usenet.goja.nl.eu.org	1001.4 KB	158.2 KB	1.1 MB	86%	2.5 KB
10	endoftheline-out.news.chmurka.net	864.6 KB	0.8 KB	865.4 KB	99%	4.0 KB
11	news.samoylyk.net	749.2 KB	6.6 KB	755.8 KB	99%	8.6 KB
12	newsfeed.xs3.de	688.4 KB	68.5 KB	756.9 KB	90%	2.4 KB
13	194.87.241.33	516.6 KB	1.7 KB	518.3 KB	99%	2.9 KB
14	endofthelinebbs.peers.news.panix.com	436.6 KB	76.1 KB	512.7 KB	85%	1.9 KB
15	news.furie.org.uk	362.3 KB	1.5 KB	363.7 KB	99%	3.4 KB
16	news.nntp4.net	257.2 KB	8.8 KB	266.0 KB	96%	2.4 KB
17	news.netfront.net	198.0 KB	337.0 KB	535.0 KB	37%	2.6 KB
18	news.hispagatos.org	65.1 KB	59.0 KB	124.0 KB	52%	2.0 KB
19	news.bbs.nz	43.0 KB	0.8 KB	43.8 KB	98%	4.0 KB
20	outgoing.news.lysator.liu.se	3.2 KB	1.3 KB	4.5 KB	71%	2.2 KB
21	eotl-out.news.tnetconsulting.net	0.0 KB	0.0 KB	0.0 KB	0%	0
22	localhost	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
TOTAL: 23		30.0 MB	2.7 MB	32.7 MB	91%	3.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 11 00:01:01 - 00:59:59	244	2.9%	0.07	949.5 KB	3.1%	0.27
Nov 11 01:00:00 - 01:59:59	215	2.6%	0.06	571.1 KB	1.9%	0.16
Nov 11 02:00:00 - 02:59:59	355	4.2%	0.10	1.1 MB	3.9%	0.33
Nov 11 03:00:00 - 03:59:59	319	3.8%	0.09	886.3 KB	2.9%	0.25
Nov 11 04:00:00 - 04:59:59	476	5.6%	0.13	1.3 MB	4.4%	0.37
Nov 11 05:00:00 - 05:59:59	402	4.8%	0.11	1.3 MB	4.4%	0.37
Nov 11 06:00:00 - 06:59:59	447	5.3%	0.12	1.4 MB	4.6%	0.39
Nov 11 07:00:00 - 07:59:59	416	4.9%	0.12	1.8 MB	6.1%	0.51
Nov 11 08:00:00 - 08:59:59	510	6.1%	0.14	1.6 MB	5.5%	0.46
Nov 11 09:00:00 - 09:59:59	575	6.8%	0.16	1.8 MB	6.3%	0.53
Nov 11 10:00:00 - 10:59:59	582	6.9%	0.16	1.6 MB	5.3%	0.45
Nov 11 11:00:00 - 11:59:59	506	6.0%	0.14	3.1 MB	10.4%	0.87
Nov 11 12:00:00 - 12:59:59	571	6.8%	0.16	1.8 MB	6.0%	0.50
Nov 11 13:00:00 - 13:59:59	382	4.5%	0.11	1.3 MB	4.3%	0.36
Nov 11 14:00:00 - 14:59:59	394	4.7%	0.11	1.4 MB	4.7%	0.39
Nov 11 15:00:00 - 15:59:59	283	3.4%	0.08	1.1 MB	3.8%	0.32
Nov 11 16:00:00 - 16:59:59	346	4.1%	0.10	992.4 KB	3.3%	0.28
Nov 11 17:00:00 - 17:59:59	196	2.3%	0.05	1.5 MB	5.0%	0.42
Nov 11 18:00:00 - 18:59:59	283	3.4%	0.08	879.0 KB	2.9%	0.24
Nov 11 19:00:00 - 19:59:59	196	2.3%	0.05	779.4 KB	2.6%	0.22
Nov 11 20:00:00 - 20:59:59	181	2.1%	0.05	679.8 KB	2.3%	0.19
Nov 11 21:00:00 - 21:59:59	156	1.9%	0.04	604.5 KB	2.0%	0.17
Nov 11 22:00:00 - 22:59:59	233	2.8%	0.06	636.5 KB	2.1%	0.18
Nov 11 23:00:00 - 23:59:59	143	1.7%	0.04	585.4 KB	1.9%	0.16
Nov 12 00:00:00 - 00:01:01	15	0.2%	0.25	105.4 KB	0.3%	1.73
TOTAL: 24:00:00	8426	100.0%	0.10	29.5 MB	100.0%	0.35

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	99.8 GB	6.5%	0	0.55	33613.49
CYCTXT1	TEXT	5.0 GB	3.9 GB	78.5%	0	0.03	2419.86
TOTAL: 3	-	3077.0 GB	103.7 GB	3.4%	1	0.42	-

Sites sending bad articles:

Server		Total	Group	Other
1	usenet.blueworldhosting.com	651	63	588
2	endofthelinebbs-out.news.weretis.net	307	0	307
3	nntp.comgw.net	131	0	131
4	news.netfront.net	109	0	109
5	usenet.goja.nl.eu.org	108	0	108
6	i2pn.org	107	0	107
7	newsfeed.bofh.team	91	1	90
8	endofthelinebbs.peers.news.panix.com	56	37	19
9	news.hispagatos.org	43	38	5
10	newsfeed.xs3.de	43	0	43
11	usenet.network	13	0	13
12	news.nntp4.net	5	0	5
13	news.furie.org.uk	2	0	2
14	news.samoylyk.net	2	0	2
15	194.87.241.33	1	0	1
16	endoftheline-out.news.chmurka.net	1	0	1
17	glockenspiel.complete.org	1	0	1
18	news.bbs.nz	1	0	1
19	outgoing.news.lysator.liu.se	1	0	1
TOTAL: 19		1673	139	1534

Unwanted newsgroups [Top 20]:

Newsgroup	Count
de.sci.announce	98
hispagatos.hacking.ctf	15
hispagatos.mastodon.tag.hacking	14
hispagatos.hacking.news	5
hispagatos.hacking.exploits	2
hispagatos.mastodon.tag.hackers	2
comp.sys.mac.forsale	1
soc.culture.africa	1
soc.culture.russia	1
TOTAL: 9	139

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	815
EMP (phr path)	334
EMP (md5)	157
Too many newsgroups	84
User-issued cancel	31
EMP (fsl)	23
HTML Multipart	3
Too many newsgroups (meow)	3
TOTAL: 8	1450

NoCeM on Spool:

Issuer (type)	Notices	Cancel	Skip	Total
i2pn2-nocem@i2pn2.org (spam)	142	2496	0	2496
nocem@eternal-september.org (bot)	75	836	0	836
i2pn2-nocem@i2pn2.org (multipost)	32	0	40	40
robot@pasdenom.info (spam2)	14	0	17	17
robot@pasdenom.info (spam3)	7	0	15	15
i2pn2-nocem@i2pn2.org (rmp)	4	0	9	9
TOTAL: 6	274	3332	81	3413

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	endofthelinebbs-out.news.weretis.net	54
	usenet.blueworldhosting.com	12
	usenet.goja.nl.eu.org	5
	endofthelinebbs.peers.news.panix.com	4
	newsfeed.xs3.de	3
	i2pn.org	2
	nntp.comgw.net	2
	news.netfront.net	1
	news.nntp4.net	1
	TOTAL: 9	84
TOTAL: 1		84

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.netfront.net	13496	2288	6035	5	13	16%	23:59:03
2	nyheter.lysator.liu.se	8840	1101	6865	459	4	12%	23:59:53
3	photonic.trudheim.com	10060	833	5816	1775	5	8%	23:59:53
4	news.furie.org.uk	5104	676	2901	15	5	13%	23:57:35
5	endofthelinebbs.peers.news.panix.com	8749	516	7902	3	0	5%	23:59:15
6	usenet.goja.nl.eu.org	9501	405	7323	199	0	4%	23:59:53
7	news.nk.ca	11155	292	7283	646	32	2%	23:59:53
8	news.corradoroberto.it	1617	270	793	0	0	16%	23:46:33
9	news.bbs.nz	15330	256	7422	736	100	1%	23:59:51
10	newsfeed.bofh.team	9271	211	7633	0	0	2%	23:59:40
11	news.hispagatos.org	10008	167	8011	223	0	1%	23:59:49
12	i2pn.org	9301	149	7716	98	20	1%	23:59:43
13	usenet.network	10473	139	7561	67	1	1%	23:59:31
14	news.nntp4.net	9901	111	8152	39	10	1%	23:59:45
15	nntp.comgw.net	8884	96	7589	120	0	1%	23:59:28
16	news.tnetconsulting.net	9397	72	8119	229	9	0%	23:59:29
17	news.weretis.net	8741	62	8214	149	3	0%	23:59:35
18	news.quux.org	6867	47	5784	650	0	0%	23:59:44
19	newsfeed.xs3.de	10233	37	7886	258	0	0%	23:58:03
20	news.chmurka.net	5567	23	4132	0	0	0%	23:58:04
21	news.samoylyk.net	12209	22	8257	39	757	0%	23:59:53
22	ddt.demos.su	62	10	43	0	0	16%	05:45:39
23	usenet.blueworldhosting.com	7394	0	7024	0	0	0%	23:59:51
24	feed.opticnetworks.net	0	0	0	0	8426	0%	23:59:53
TOTAL: 24		202160	7783	148461	5710	9385	3%	557:19:56

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.netfront.net	10.6 MB	10.3 KB	10.6 MB	0.1 KB/s	4.7 KB	23:59:03
2	photonic.trudheim.com	4.6 MB	5.5 MB	10.1 MB	0.1 KB/s	4.0 KB	23:59:53
3	news.furie.org.uk	4.2 MB	64.0 KB	4.3 MB	0.1 KB/s	6.3 KB	23:57:35
4	nyheter.lysator.liu.se	4.0 MB	4.0 MB	7.9 MB	0.1 KB/s	5.2 KB	23:59:53
5	endofthelinebbs.peers.news.panix.com	3.1 MB	2.8 KB	3.1 MB	0.0 KB/s	6.1 KB	23:59:15
6	newsfeed.bofh.team	1.5 MB	0.0 KB	1.5 MB	0.0 KB/s	7.3 KB	23:59:40
7	newsfeed.xs3.de	922.2 KB	1.5 MB	2.4 MB	0.0 KB/s	8.3 KB	23:58:03
8	usenet.goja.nl.eu.org	815.2 KB	2.5 MB	3.3 MB	0.0 KB/s	5.5 KB	23:59:53
9	news.corradoroberto.it	781.4 KB	0.0 KB	781.4 KB	0.0 KB/s	2.9 KB	23:46:33
10	news.bbs.nz	704.7 KB	3.8 MB	4.5 MB	0.1 KB/s	4.6 KB	23:59:51
11	news.nk.ca	601.6 KB	4.0 MB	4.6 MB	0.1 KB/s	5.0 KB	23:59:53
12	i2pn.org	566.5 KB	423.6 KB	990.1 KB	0.0 KB/s	4.0 KB	23:59:43
13	news.hispagatos.org	537.3 KB	1.8 MB	2.3 MB	0.0 KB/s	6.0 KB	23:59:49
14	usenet.network	430.1 KB	86.8 KB	516.9 KB	0.0 KB/s	2.5 KB	23:59:31
15	news.tnetconsulting.net	328.5 KB	2.2 MB	2.5 MB	0.0 KB/s	8.5 KB	23:59:29
16	news.weretis.net	307.3 KB	1.4 MB	1.7 MB	0.0 KB/s	8.1 KB	23:59:35
17	news.nntp4.net	284.1 KB	953.8 KB	1.2 MB	0.0 KB/s	8.3 KB	23:59:45
18	news.quux.org	275.2 KB	4.1 MB	4.4 MB	0.1 KB/s	6.4 KB	23:59:44
19	nntp.comgw.net	244.9 KB	1.7 MB	1.9 MB	0.0 KB/s	9.2 KB	23:59:28
20	news.samoylyk.net	63.6 KB	877.3 KB	940.9 KB	0.0 KB/s	15.4 KB	23:59:53
21	ddt.demos.su	27.4 KB	0.0 KB	27.4 KB	0.0 KB/s	2.7 KB	05:45:39
22	news.chmurka.net	25.7 KB	0.0 KB	25.7 KB	0.0 KB/s	1.1 KB	23:58:04
23	feed.opticnetworks.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:53
24	usenet.blueworldhosting.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:51
TOTAL: 24		34.7 MB	34.7 MB	69.4 MB	0.0 KB/s	5.3 KB	557:19:56

NNRP readership statistics:

System		Conn	Elapsed
1	2001:470:28:a8:3ad5:47ff:fe02:c2fd	2775	00:22:35
2	ec2-13-58-97-162.us-east-2.compute.amazonaws.com	4	00:00:00
3	147.185.132.126	1	00:00:10
4	147.45.112.8	1	00:00:00
5	198.235.24.72	1	00:00:10
6	205.210.31.36	1	00:00:00
7	azpdcs10.stretchoid.com	1	00:00:09
8	intelligent.monitoring.internet-measurement.com	1	00:00:01
9	localhost	1	00:11:06
10	server-0-3.survey.inspici.com	1	00:00:03
TOTAL: 10		2787	00:34:17

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	?	2776	00:33:41
2	*.us-east-2.compute.amazonaws.com	4	00:00:00
3	unresolved	4	00:00:20
4	*.monitoring.internet-measurement.com	1	00:00:01
5	*.stretchoid.com	1	00:00:09
6	*.survey.inspici.com	1	00:00:03
TOTAL: 6		2787	00:34:17

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	10.147	37.058	0.000	00:22:35
localhost	184.721	369.753	0.074	00:11:06
147.185.132.126	0.000	0.018	0.000	00:00:10
198.235.24.72	0.000	0.016	0.000	00:00:10
azpdcs10.stretchoid.com	0.007	0.010	0.000	00:00:09
server-0-3.survey.inspici.com	0.000	0.017	0.000	00:00:03
intelligent.monitoring.internet-measurement.com	0.003	0.014	0.000	00:00:01
ec2-13-58-97-162.us-east-2.compute.amazonaws.com	0.012	0.059	0.000	00:00:00
147.45.112.8	0.007	0.015	0.000	00:00:00
205.210.31.36	0.003	0.013	0.000	00:00:00
TOTAL: 10	194.900	406.973	0.074	00:34:17

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

System	Conn
ec2-13-58-97-162.us-east-2.compute.amazonaws.com	9
147.45.112.8	1
TOTAL: 2	10

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

Command	Count
#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: 8	10

NNRP client timeouts [Top 20]:

System	Conn	Peer
147.45.112.8	1	1
TOTAL: 1	1	2

Daily Usenet Report

Nov 11 00:01:01 -- Nov 12 00:01:01