Daily Usenet Report: Oct 21 00:01:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Oct 22 00:00:01 newsfeed nnrpd[86132]: localhost auth: program exited with status 8

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	9350	40.9%	3.8 MB	63.5%
innd	8542	37.4%	1.3 MB	21.6%
innfeed	4399	19.3%	830.7 KB	13.6%
cnfsstat	432	1.9%	68.7 KB	1.1%
nnrpd	66	0.3%	7.8 KB	0.1%
nocem	44	0.2%	5.4 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 7	22834	100.0%	6.0 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	124327	60.2%
Negative hits	72882	35.3%
Do not exist	9258	4.5%
Cache misses	12	0.0%
TOTAL: 4	206479	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.511	0.0%	34	0.000	15.029	43.000
article cleanup	00:00:00.176	0.0%	9299	0.000	0.019	0.872
article logging	00:00:00.505	0.0%	9354	0.000	0.054	0.845
article parse	00:00:00.202	0.0%	13713	0.000	0.015	0.095
article write	00:00:02.209	0.0%	7840	0.023	0.282	2.215
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.251	0.0%	209682	0.000	0.006	0.206
hisgrep/artcncl	00:00:00.447	0.0%	39	0.000	11.462	42.444
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:47.637	0.2%	207269	0.101	0.809	4.924
history sync	00:00:00.065	0.0%	389	0.000	0.167	1.667
history write	00:02:19.733	0.2%	9291	3.224	15.040	107.055
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:48:10.540	99.1%	202383	70.067	423.408	1651.873
nntp read	00:00:03.721	0.0%	209875	0.002	0.018	0.429
overview write	00:06:21.452	0.4%	7840	0.926	48.655	5522.932
perl filter	00:00:30.778	0.0%	9291	1.203	3.313	28.016
python filter	00:00:01.889	0.0%	9291	0.000	0.203	4.730
site send	00:00:01.301	0.0%	15723	0.000	0.083	0.221
TOTAL: 24:01:05.846	24:00:22.417	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.020	0.0%	8180	0.000	0.002	0.038
article prepare	00:00:00.008	0.0%	53676	0.000	0.000	0.006
article read	00:00:00.949	0.0%	4175	0.000	0.227	6.750
backlog stats	00:00:00.435	0.0%	273059	0.000	0.002	0.007
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.510	0.0%	188854	0.000	0.013	0.040
data write	00:00:03.317	0.0%	184190	0.008	0.018	0.036
idle	23:58:01.641	100.0%	273059	175.968	315.982	1100.322
status file	00:00:06.691	0.0%	398	0.000	16.812	774.750
TOTAL: 23:58:26.286	23:58:15.571	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:10:30.951	47.7%	25	0.500	25238.040	302450.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:03.961	0.3%	78801	0.000	0.050	0.333
TOTAL: 00:22:04.039	00:10:34.912	48.0%	-	-	-	-

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	outgoing.news.lysator.liu.se	3	6296	1414	4874	8	22%	24:02:33
2	endofthelinebbs-out.news.weretis.net	3	13870	1152	12462	256	8%	47:28:18
3	nntp.comgw.net	1	8231	1140	6813	278	13%	23:59:55
4	usenet.blueworldhosting.com	721	9103	930	7605	568	10%	23:54:36
5	news.hispagatos.org	10	8784	709	8043	32	8%	28:34:52
6	usenet.network	2	6205	448	5748	9	7%	23:59:53
7	i2pn.org	2	8114	376	7610	128	4%	23:59:46
8	news.corradoroberto.it	7	1225	365	859	1	29%	23:40:33
9	194.87.241.33	37	489	322	167	0	65%	18:33:48
10	usenet.goja.nl.eu.org	11	8306	304	7928	74	3%	25:11:04
11	endoftheline-out.news.chmurka.net	1	3851	217	3633	1	5%	23:59:58
12	newsfeed.xs3.de	1	6204	198	5986	20	3%	23:59:54
13	endofthelinebbs.peers.news.panix.com	26	8249	121	8113	15	1%	23:56:40
14	news.nntp4.net	2	6649	74	6575	0	1%	23:59:47
15	news.furie.org.uk	1	4269	74	4193	2	1%	23:59:57
16	newsfeed.bofh.team	1	8951	68	8879	4	0%	23:59:55
17	news.samoylyk.net	3	6951	32	6917	2	0%	23:55:05
18	glockenspiel.complete.org	2	5810	16	5793	1	0%	23:56:06
19	news.bbs.nz	2	6607	10	6597	0	0%	23:59:24
20	eotl-out.news.tnetconsulting.net	1	0	0	0	0	0%	00:10:04
21	localhost	27	0	0	0	0	0%	00:00:01
22	news.nk.ca	2	0	0	0	0	0%	00:20:08
23	photonic.trudheim.com	1	0	0	0	0	0%	00:08:07
TOTAL: 23		867	128164	7970	118795	1399	6%	479:50:24

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	usenet.network	5.1 MB	0.0 KB	8.2 KB	5.1 MB	99%	11.4 KB
2	outgoing.news.lysator.liu.se	4.6 MB	1.4 KB	6.9 KB	4.6 MB	99%	3.3 KB
3	endofthelinebbs-out.news.weretis.net	4.0 MB	1.5 KB	383.0 KB	4.4 MB	91%	3.2 KB
4	nntp.comgw.net	3.0 MB	4.4 KB	416.8 KB	3.4 MB	87%	2.5 KB
5	usenet.blueworldhosting.com	2.4 MB	0.0 KB	1.3 MB	3.8 MB	64%	2.6 KB
6	news.hispagatos.org	2.4 MB	0.0 KB	43.9 KB	2.5 MB	98%	3.4 KB
7	news.corradoroberto.it	2.1 MB	11.2 KB	0.0 KB	2.1 MB	99%	5.9 KB
8	i2pn.org	1022.3 KB	3.7 KB	172.4 KB	1.2 MB	85%	2.4 KB
9	endoftheline-out.news.chmurka.net	984.3 KB	0.0 KB	0.8 KB	985.2 KB	99%	4.5 KB
10	usenet.goja.nl.eu.org	978.4 KB	0.0 KB	105.2 KB	1.1 MB	90%	2.9 KB
11	194.87.241.33	804.3 KB	0.0 KB	0.0 KB	804.3 KB	100%	2.5 KB
12	newsfeed.xs3.de	432.8 KB	0.0 KB	37.5 KB	470.4 KB	92%	2.2 KB
13	news.furie.org.uk	372.3 KB	5.4 KB	0.8 KB	378.5 KB	98%	5.0 KB
14	endofthelinebbs.peers.news.panix.com	354.5 KB	0.0 KB	50.2 KB	404.7 KB	87%	3.0 KB
15	newsfeed.bofh.team	182.5 KB	0.0 KB	8.3 KB	190.8 KB	95%	2.6 KB
16	news.nntp4.net	161.8 KB	0.0 KB	0.0 KB	161.8 KB	100%	2.2 KB
17	news.samoylyk.net	119.6 KB	0.0 KB	9.9 KB	129.5 KB	92%	3.8 KB
18	glockenspiel.complete.org	89.3 KB	3.1 KB	0.0 KB	92.4 KB	96%	5.4 KB
19	news.bbs.nz	21.0 KB	0.0 KB	0.0 KB	21.0 KB	100%	2.1 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
23	photonic.trudheim.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 23		29.0 MB	30.7 KB	2.6 MB	31.6 MB	91%	3.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 21 00:01:02 - 00:59:59	191	2.4%	0.05	541.9 KB	1.8%	0.15
Oct 21 01:00:00 - 01:59:59	266	3.4%	0.07	1.7 MB	6.0%	0.49
Oct 21 02:00:00 - 02:59:59	353	4.5%	0.10	1.0 MB	3.5%	0.29
Oct 21 03:00:00 - 03:59:59	351	4.5%	0.10	1.0 MB	3.5%	0.29
Oct 21 04:00:00 - 04:59:59	376	4.8%	0.10	1.3 MB	4.5%	0.37
Oct 21 05:00:00 - 05:59:59	412	5.3%	0.11	1.5 MB	5.3%	0.44
Oct 21 06:00:00 - 06:59:59	378	4.8%	0.10	1.3 MB	4.4%	0.37
Oct 21 07:00:00 - 07:59:59	472	6.0%	0.13	1.5 MB	5.2%	0.43
Oct 21 08:00:00 - 08:59:59	401	5.1%	0.11	1.7 MB	5.9%	0.48
Oct 21 09:00:00 - 09:59:59	466	6.0%	0.13	1.7 MB	5.7%	0.47
Oct 21 10:00:00 - 10:59:59	459	5.9%	0.13	1.7 MB	5.8%	0.48
Oct 21 11:00:00 - 11:59:59	413	5.3%	0.11	1.5 MB	5.0%	0.41
Oct 21 12:00:00 - 12:59:59	407	5.2%	0.11	1.4 MB	4.8%	0.40
Oct 21 13:00:00 - 13:59:59	362	4.6%	0.10	1.5 MB	5.1%	0.42
Oct 21 14:00:00 - 14:59:59	442	5.6%	0.12	1.7 MB	5.8%	0.48
Oct 21 15:00:00 - 15:59:59	393	5.0%	0.11	1.4 MB	4.9%	0.41
Oct 21 16:00:00 - 16:59:59	343	4.4%	0.10	1.2 MB	4.3%	0.35
Oct 21 17:00:00 - 17:59:59	256	3.3%	0.07	825.7 KB	2.8%	0.23
Oct 21 18:00:00 - 18:59:59	194	2.5%	0.05	815.5 KB	2.7%	0.23
Oct 21 19:00:00 - 19:59:59	193	2.5%	0.05	794.6 KB	2.7%	0.22
Oct 21 20:00:00 - 20:59:59	241	3.1%	0.07	992.8 KB	3.3%	0.28
Oct 21 21:00:00 - 21:59:59	136	1.7%	0.04	901.0 KB	3.0%	0.25
Oct 21 22:00:00 - 22:59:59	152	1.9%	0.04	622.0 KB	2.1%	0.17
Oct 21 23:00:00 - 23:59:59	168	2.1%	0.05	533.5 KB	1.8%	0.15
Oct 22 00:00:00 - 00:01:01	3	0.0%	0.05	13.1 KB	0.0%	0.22
TOTAL: 23:59:59	7828	100.0%	0.09	29.0 MB	100.0%	0.34

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	98.9 GB	6.4%	0	0.53	35443.81
CYCTXT1	TEXT	5.0 GB	3.9 GB	78.1%	0	0.03	2297.26
TOTAL: 3	-	3077.0 GB	102.8 GB	3.3%	1	0.36	-

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	usenet.blueworldhosting.com	593	0	0	593
2	endofthelinebbs-out.news.weretis.net	279	0	1	278
3	nntp.comgw.net	268	0	2	266
4	i2pn.org	130	0	1	129
5	usenet.goja.nl.eu.org	75	0	0	75
6	news.netfront.net	74	0	0	74
7	news.hispagatos.org	33	21	0	12
8	newsfeed.xs3.de	20	0	0	20
9	endofthelinebbs.peers.news.panix.com	16	1	0	15
10	usenet.network	9	0	0	9
11	outgoing.news.lysator.liu.se	8	0	1	7
12	newsfeed.bofh.team	4	0	0	4
13	news.furie.org.uk	2	0	1	1
14	news.samoylyk.net	2	0	0	2
15	endoftheline-out.news.chmurka.net	1	0	0	1
16	glockenspiel.complete.org	1	0	1	0
17	news.corradoroberto.it	1	0	1	0
TOTAL: 17		1516	22	8	1486

Unwanted newsgroups [Top 20]:

Newsgroup	Count
hispagatos.hacking.ctf	17
hispagatos.hacking.news	4
hispagatos.hacking.exploits	1
TOTAL: 3	22

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	823
EMP (phr path)	344
EMP (md5)	133
Too many newsgroups	91
User-issued cancel	25
EMP (fsl)	9
Too many newsgroups (meow)	3
HTML Multipart	1
TOTAL: 8	1429

NoCeM on Spool:

Issuer (type)	Notices	Cancel	Skip	Total
nocem@usenet.ovh (faqfr)	1	1	0	1
i2pn2-nocem@i2pn2.org (multipost)	32	0	41	41
i2pn2-nocem@i2pn2.org (rmp)	4	0	8	8
robot@pasdenom.info (spam3)	5	0	7	7
TOTAL: 4	42	1	56	57

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	usenet.blueworldhosting.com	25
	endofthelinebbs-out.news.weretis.net	22
	nntp.comgw.net	4
	usenet.goja.nl.eu.org	3
	news.hispagatos.org	1
	endofthelinebbs.peers.news.panix.com	1
	newsfeed.xs3.de	1
	TOTAL: 7	57
TOTAL: 1		57

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.netfront.net	12141	2640	5144	1	5	21%	23:59:24
2	nyheter.lysator.liu.se	6649	1674	4132	606	0	25%	23:59:52
3	news.furie.org.uk	4929	747	3199	22	0	15%	23:57:20
4	endofthelinebbs.peers.news.panix.com	8306	564	7255	6	0	6%	23:59:47
5	usenet.goja.nl.eu.org	8407	417	6705	304	0	4%	23:59:33
6	news.hispagatos.org	8660	364	6636	270	29	4%	23:59:52
7	usenet.network	7952	313	6575	29	0	3%	23:59:50
8	news.bbs.nz	14062	304	6788	718	68	2%	23:59:52
9	newsfeed.bofh.team	8810	291	7340	1	0	3%	23:59:52
10	news.nk.ca	10815	210	6788	754	32	1%	23:59:52
11	nntp.comgw.net	7892	168	6381	151	0	2%	23:59:45
12	news.tnetconsulting.net	8738	163	7374	283	0	1%	23:59:52
13	news.nntp4.net	8745	161	7476	89	1	1%	23:59:41
14	news.corradoroberto.it	1082	137	684	0	0	12%	23:06:25
15	news.quux.org	8233	135	6942	724	0	1%	23:59:51
16	news.weretis.net	8140	133	7489	201	0	1%	23:59:52
17	i2pn.org	8839	116	7215	103	53	1%	23:59:52
18	newsfeed.xs3.de	9059	80	7254	294	0	0%	23:59:36
19	news.samoylyk.net	9898	46	7563	180	170	0%	23:59:52
20	news.chmurka.net	4194	38	3471	2	0	0%	23:59:52
21	ddt.demos.su	73	3	70	0	0	4%	07:05:52
22	usenet.blueworldhosting.com	6982	1	6667	0	0	0%	23:59:42
23	feed.opticnetworks.net	0	0	0	0	7828	0%	23:59:52
24	photonic.trudheim.com	0	0	0	0	7826	0%	23:59:52
TOTAL: 24		172606	8705	129148	4738	16012	5%	558:05:10

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.netfront.net	12.0 MB	4.9 KB	12.0 MB	0.1 KB/s	4.7 KB	23:59:24
2	nyheter.lysator.liu.se	5.9 MB	5.4 MB	11.4 MB	0.1 KB/s	5.1 KB	23:59:52
3	news.furie.org.uk	5.2 MB	107.3 KB	5.3 MB	0.1 KB/s	7.1 KB	23:57:20
4	endofthelinebbs.peers.news.panix.com	2.9 MB	9.5 KB	2.9 MB	0.0 KB/s	5.2 KB	23:59:47
5	newsfeed.bofh.team	2.2 MB	2.1 KB	2.2 MB	0.0 KB/s	7.7 KB	23:59:52
6	news.hispagatos.org	1.3 MB	2.4 MB	3.7 MB	0.0 KB/s	5.9 KB	23:59:52
7	news.quux.org	1.3 MB	4.7 MB	6.0 MB	0.1 KB/s	7.1 KB	23:59:51
8	news.bbs.nz	1.2 MB	5.5 MB	6.6 MB	0.1 KB/s	6.6 KB	23:59:52
9	usenet.goja.nl.eu.org	1.1 MB	3.0 MB	4.1 MB	0.0 KB/s	5.9 KB	23:59:33
10	usenet.network	1.1 MB	57.3 KB	1.2 MB	0.0 KB/s	3.5 KB	23:59:50
11	news.nntp4.net	1007.5 KB	1.1 MB	2.1 MB	0.0 KB/s	8.5 KB	23:59:41
12	news.samoylyk.net	716.4 KB	1.3 MB	2.0 MB	0.0 KB/s	8.9 KB	23:59:52
13	news.tnetconsulting.net	711.6 KB	2.2 MB	2.9 MB	0.0 KB/s	6.7 KB	23:59:52
14	nntp.comgw.net	633.6 KB	2.4 MB	3.0 MB	0.0 KB/s	9.6 KB	23:59:45
15	news.weretis.net	625.5 KB	2.6 MB	3.2 MB	0.0 KB/s	9.8 KB	23:59:52
16	news.nk.ca	612.9 KB	5.6 MB	6.2 MB	0.1 KB/s	6.6 KB	23:59:52
17	ddt.demos.su	578.6 KB	0.0 KB	578.6 KB	0.0 KB/s	192.9 KB	07:05:52
18	newsfeed.xs3.de	439.1 KB	2.8 MB	3.2 MB	0.0 KB/s	8.8 KB	23:59:36
19	news.corradoroberto.it	388.8 KB	0.0 KB	388.8 KB	0.0 KB/s	2.8 KB	23:06:25
20	i2pn.org	357.7 KB	404.2 KB	762.0 KB	0.0 KB/s	3.5 KB	23:59:52
21	news.chmurka.net	116.7 KB	7.6 KB	124.3 KB	0.0 KB/s	3.1 KB	23:59:52
22	usenet.blueworldhosting.com	10.3 KB	0.0 KB	10.3 KB	0.0 KB/s	10.3 KB	23:59:42
23	feed.opticnetworks.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:52
24	photonic.trudheim.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:52
TOTAL: 24		40.3 MB	39.5 MB	79.7 MB	0.0 KB/s	6.1 KB	558:05:10

NNRP readership statistics:

System		Conn	Elapsed
1	ec2-13-58-97-162.us-east-2.compute.amazonaws.com	4	00:00:01
2	147.185.132.105	1	00:00:00
3	147.185.132.40	1	00:00:11
4	198.235.24.66	1	00:00:10
5	45-79-163-53.ip.linodeusercontent.com	1	00:00:00
6	71.6.134.231	1	00:00:00
7	91.238.181.33	1	00:00:00
8	dublin.scan.bufferover.run	1	00:00:00
9	freeq.furie.org.uk	1	00:10:06
10	localhost	1	00:11:30
11	server-0-3.survey.inspici.com	1	00:00:03
TOTAL: 11		14	00:22:04

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	unresolved	5	00:00:21
2	*.us-east-2.compute.amazonaws.com	4	00:00:01
3	*.furie.org.uk	1	00:10:06
4	*.ip.linodeusercontent.com	1	00:00:00
5	*.scan.bufferover.run	1	00:00:00
6	*.survey.inspici.com	1	00:00:03
7	?	1	00:11:30
TOTAL: 7		14	00:22:04

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	178.883	366.168	0.073	00:11:30
freeq.furie.org.uk	0.006	0.013	0.000	00:10:06
147.185.132.40	0.005	0.019	0.000	00:00:11
198.235.24.66	0.000	0.016	0.000	00:00:10
server-0-3.survey.inspici.com	0.009	0.009	0.000	00:00:03
ec2-13-58-97-162.us-east-2.compute.amazonaws.com	0.008	0.061	0.000	00:00:01
45-79-163-53.ip.linodeusercontent.com	0.003	0.016	0.000	00:00:00
91.238.181.33	0.006	0.010	0.000	00:00:00
147.185.132.105	0.007	0.010	0.000	00:00:00
dublin.scan.bufferover.run	0.008	0.020	0.000	00:00:00
71.6.134.231	0.005	0.011	0.000	00:00:00
TOTAL: 11	178.940	366.353	0.073	00:22:04

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

System	Conn
ec2-13-58-97-162.us-east-2.compute.amazonaws.com	4
dublin.scan.bufferover.run	3
91.238.181.33	1
TOTAL: 3	8

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

Command	Count
#026#003#001	3
#001	2
#003	1
#023#001#023#002#023#003#001	1
À#024	1
TOTAL: 5	8

NNRP client timeouts [Top 20]:

System	Conn	Peer
91.238.181.33	1	1
TOTAL: 1	1	3

Daily Usenet Report

Oct 21 00:01:02 -- Oct 22 00:01:01