Daily Usenet Report: Feb 23 00:01:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Feb 24 00:00:03 newsfeed nnrpd[2072202]: localhost auth: program exited with status 8

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	9228	41.7%	3.4 MB	61.6%
innd	7892	35.7%	1.2 MB	21.4%
innfeed	4499	20.3%	867.3 KB	15.4%
cnfsstat	432	2.0%	75.6 KB	1.3%
nocem	52	0.2%	6.7 KB	0.1%
nnrpd	24	0.1%	2.7 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 7	22128	100.0%	5.5 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	133310	63.2%
Negative hits	68404	32.4%
Do not exist	9132	4.3%
Cache misses	43	0.0%
TOTAL: 4	210889	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.082	0.0%	17	0.000	4.824	13.667
article cleanup	00:00:00.113	0.0%	9174	0.000	0.012	0.108
article logging	00:00:00.483	0.0%	9220	0.000	0.052	0.524
article parse	00:00:00.224	0.0%	14405	0.000	0.016	0.128
article write	00:00:02.388	0.0%	6813	0.040	0.351	11.484
artlog/artcncl	00:00:00.000	0.0%	10	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.862	0.0%	205027	0.000	0.009	0.705
hisgrep/artcncl	00:00:00.057	0.0%	21	0.000	2.714	10.000
hishave/artcncl	00:00:00.002	0.0%	10	0.000	0.200	0.667
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:35.852	0.2%	211520	0.097	0.737	4.371
history sync	00:00:00.066	0.0%	409	0.000	0.161	1.000
history write	00:02:23.907	0.2%	9155	3.210	15.719	112.810
hiswrite/artcncl	00:00:00.003	0.0%	1	3.000	3.000	3.000
hiswrite/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:43:25.736	98.8%	196685	69.030	434.226	1550.320
nntp read	00:00:04.761	0.0%	206511	0.002	0.023	0.284
overview write	00:10:44.582	0.7%	6813	0.800	94.611	11179.000
perl filter	00:00:55.160	0.1%	9155	1.235	6.025	148.011
python filter	00:00:04.416	0.0%	9155	0.000	0.482	10.586
site send	00:00:00.984	0.0%	13675	0.000	0.072	0.256
TOTAL: 24:01:09.421	24:00:20.678	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.018	0.0%	7034	0.000	0.003	0.091
article prepare	00:00:00.002	0.0%	22709	0.000	0.000	0.025
article read	00:00:00.519	0.0%	2762	0.000	0.188	3.438
backlog stats	00:00:00.383	0.0%	235122	0.000	0.002	0.016
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.125	0.0%	164962	0.002	0.013	0.044
data write	00:00:02.831	0.0%	160093	0.006	0.018	0.041
idle	23:57:57.589	100.0%	235122	163.246	366.948	1208.368
status file	00:00:00.535	0.0%	436	0.667	1.227	17.000
TOTAL: 23:58:15.918	23:58:04.002	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:21.755	3.1%	9	0.500	2417.222	10048.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:04.273	0.6%	78757	0.000	0.054	0.250
TOTAL: 00:11:32.065	00:00:26.028	3.8%	-	-	-	-

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	5	6633	1764	4855	14	26%	26:56:56
2	usenet.blueworldhosting.com	289	9038	861	7201	976	9%	23:48:29
3	newsfeed.bofh.team	1	9016	785	7987	244	8%	23:59:56
4	endofthelinebbs-out.news.weretis.net	4	14799	621	14116	62	4%	48:23:30
5	usenet.goja.nl.eu.org	10	8656	535	7908	213	6%	24:20:12
6	news.corradoroberto.it	6	1099	393	704	2	35%	24:46:15
7	news.nntp4.net	2	7638	375	7123	140	4%	23:59:17
8	i2pn.org	2	8438	305	8055	78	3%	23:59:09
9	194.87.241.33	41	546	220	197	129	40%	17:23:49
10	news.samoylyk.net	1	6945	218	6697	30	3%	21:52:54
11	newsfeed.xs3.de	2	6315	194	6082	39	3%	23:59:48
12	usenet.network	2	6141	155	5970	16	2%	23:59:35
13	news.hispagatos.org	6	8734	140	8316	278	1%	24:26:14
14	news.furie.org.uk	1	4025	94	3927	4	2%	23:59:56
15	endofthelinebbs.peers.news.panix.com	33	8692	85	8563	44	0%	25:17:20
16	endoftheline-out.news.chmurka.net	2	3999	74	3922	3	1%	23:59:50
17	nntp.comgw.net	1	8683	70	8564	49	0%	23:59:58
18	news.bbs.nz	2	7026	17	7007	2	0%	23:59:25
19	news.netfront.net	1	7642	7	7603	32	0%	23:19:34
20	outgoing.news.lysator.liu.se	1	6461	6	6454	1	0%	23:59:57
21	photonic.trudheim.com	2	1736	0	1736	0	0%	23:53:29
22	localhost	28	0	0	0	0	0%	00:00:00
23	news.nk.ca	2	0	0	0	0	0%	00:20:17
TOTAL: 23		444	142262	6919	132987	2356	4%	524:45:50

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	glockenspiel.complete.org	5.5 MB	13.3 KB	19.4 KB	5.6 MB	99%	3.2 KB
2	news.corradoroberto.it	3.3 MB	0.0 KB	2.4 KB	3.3 MB	99%	8.6 KB
3	usenet.blueworldhosting.com	2.4 MB	0.0 KB	2.2 MB	4.6 MB	52%	2.6 KB
4	newsfeed.bofh.team	2.1 MB	13.3 KB	455.1 KB	2.5 MB	81%	2.5 KB
5	endofthelinebbs-out.news.weretis.net	2.1 MB	26.5 KB	183.2 KB	2.3 MB	90%	3.4 KB
6	usenet.goja.nl.eu.org	1.6 MB	13.3 KB	335.8 KB	1.9 MB	82%	2.6 KB
7	news.samoylyk.net	1.3 MB	13.2 KB	89.2 KB	1.4 MB	92%	5.8 KB
8	usenet.network	1.1 MB	0.0 KB	20.9 KB	1.1 MB	98%	6.4 KB
9	news.nntp4.net	995.3 KB	13.2 KB	289.5 KB	1.3 MB	76%	2.5 KB
10	i2pn.org	840.3 KB	15.6 KB	150.1 KB	1006.0 KB	83%	2.6 KB
11	newsfeed.xs3.de	751.7 KB	13.3 KB	79.5 KB	844.5 KB	89%	3.6 KB
12	194.87.241.33	737.6 KB	0.0 KB	321.7 KB	1.0 MB	69%	3.0 KB
13	news.hispagatos.org	436.2 KB	14.5 KB	753.6 KB	1.2 MB	36%	2.9 KB
14	news.furie.org.uk	317.7 KB	0.0 KB	8.4 KB	326.1 KB	97%	3.3 KB
15	nntp.comgw.net	284.7 KB	13.3 KB	231.3 KB	529.2 KB	53%	4.4 KB
16	endofthelinebbs.peers.news.panix.com	233.7 KB	13.2 KB	86.8 KB	333.7 KB	70%	2.6 KB
17	endoftheline-out.news.chmurka.net	187.5 KB	0.0 KB	6.9 KB	194.4 KB	96%	2.5 KB
18	news.netfront.net	90.6 KB	14.7 KB	294.6 KB	400.0 KB	22%	10.3 KB
19	news.bbs.nz	58.8 KB	13.2 KB	3.0 KB	75.0 KB	78%	3.9 KB
20	outgoing.news.lysator.liu.se	55.4 KB	13.2 KB	0.0 KB	68.6 KB	80%	9.8 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	0.0 KB	0.0 KB	0%	0
TOTAL: 23		24.2 MB	203.7 KB	5.5 MB	29.9 MB	81%	3.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 23 00:01:01 - 00:59:59	126	1.8%	0.04	352.8 KB	1.4%	0.10
Feb 23 01:00:00 - 01:59:59	221	3.2%	0.06	650.6 KB	2.6%	0.18
Feb 23 02:00:00 - 02:59:59	293	4.3%	0.08	815.4 KB	3.3%	0.23
Feb 23 03:00:00 - 03:59:59	246	3.6%	0.07	919.4 KB	3.7%	0.26
Feb 23 04:00:00 - 04:59:59	404	5.9%	0.11	1.4 MB	5.6%	0.39
Feb 23 05:00:00 - 05:59:59	304	4.5%	0.08	932.3 KB	3.8%	0.26
Feb 23 06:00:00 - 06:59:59	314	4.6%	0.09	817.3 KB	3.3%	0.23
Feb 23 07:00:00 - 07:59:59	385	5.7%	0.11	1.3 MB	5.4%	0.37
Feb 23 08:00:00 - 08:59:59	328	4.8%	0.09	922.2 KB	3.7%	0.26
Feb 23 09:00:00 - 09:59:59	331	4.9%	0.09	1.1 MB	4.5%	0.31
Feb 23 10:00:00 - 10:59:59	405	5.9%	0.11	1.6 MB	6.6%	0.46
Feb 23 11:00:00 - 11:59:59	384	5.6%	0.11	1.4 MB	5.8%	0.40
Feb 23 12:00:00 - 12:59:59	425	6.2%	0.12	1.5 MB	6.4%	0.44
Feb 23 13:00:00 - 13:59:59	434	6.4%	0.12	1.6 MB	6.5%	0.45
Feb 23 14:00:00 - 14:59:59	369	5.4%	0.10	1.1 MB	4.4%	0.30
Feb 23 15:00:00 - 15:59:59	430	6.3%	0.12	1.9 MB	8.1%	0.55
Feb 23 16:00:00 - 16:59:59	306	4.5%	0.09	1.2 MB	5.0%	0.34
Feb 23 17:00:00 - 17:59:59	260	3.8%	0.07	914.6 KB	3.7%	0.25
Feb 23 18:00:00 - 18:59:59	164	2.4%	0.05	736.7 KB	3.0%	0.20
Feb 23 19:00:00 - 19:59:59	118	1.7%	0.03	796.1 KB	3.2%	0.22
Feb 23 20:00:00 - 20:59:59	151	2.2%	0.04	602.8 KB	2.4%	0.17
Feb 23 21:00:00 - 21:59:59	97	1.4%	0.03	517.2 KB	2.1%	0.14
Feb 23 22:00:00 - 22:59:59	132	1.9%	0.04	645.3 KB	2.6%	0.18
Feb 23 23:00:00 - 23:59:59	178	2.6%	0.05	661.7 KB	2.7%	0.18
Feb 24 00:00:00 - 00:01:02	9	0.1%	0.15	21.6 KB	0.1%	0.35
TOTAL: 24:00:01	6814	100.0%	0.08	24.1 MB	100.0%	0.29

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	104.1 GB	6.8%	0	0.44	42206.01
CYCTXT1	TEXT	5.0 GB	4.1 GB	82.4%	0	0.02	2518.78
TOTAL: 3	-	3077.0 GB	108.3 GB	3.5%	1	0.31	-

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	usenet.blueworldhosting.com	988	1	0	987
2	news.hispagatos.org	280	15	2	263
3	newsfeed.bofh.team	251	0	1	250
4	usenet.goja.nl.eu.org	193	0	1	192
5	news.nntp4.net	161	0	1	160
6	194.87.241.33	121	0	0	121
7	i2pn.org	77	0	3	74
8	nntp.comgw.net	66	0	1	65
9	endofthelinebbs-out.news.weretis.net	63	0	2	61
10	endofthelinebbs.peers.news.panix.com	43	0	1	42
11	newsfeed.xs3.de	41	0	1	40
12	news.netfront.net	37	0	2	35
13	news.samoylyk.net	32	0	1	31
14	usenet.network	21	0	0	21
15	glockenspiel.complete.org	18	0	1	17
16	news.furie.org.uk	5	0	0	5
17	endoftheline-out.news.chmurka.net	2	0	0	2
18	news.bbs.nz	2	0	1	1
19	news.corradoroberto.it	2	0	0	2
20	outgoing.news.lysator.liu.se	1	0	1	0
TOTAL: 20		2404	16	19	2369

Unwanted newsgroups [Top 20]:

Newsgroup	Count
hispagatos.mastodon.tag.hacking	13
hispagatos.hacking.ctf	1
hispagatos.mastodon.tag.hackers	1
news.test_messages	1
TOTAL: 4	16

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	1198
EMP (phr path)	680
EMP (md5)	241
Too many newsgroups	146
User-issued cancel	19
EMP (fsl)	12
Angle-bracket bot	11
Too many newsgroups (meow)	6
EMP (phl)	5
HTML Multipart	5
TOTAL: 10	2323

NoCeM on Spool:

Issuer (type)	Notices	Cancel	Skip	Total
i2pn2-nocem@i2pn2.org (spam)	2	5	0	5
robot@pasdenom.info (spam2)	22	0	28	28
i2pn2-nocem@i2pn2.org (multipost)	14	0	22	22
robot@pasdenom.info (spam3)	3	0	16	16
i2pn2-nocem@i2pn2.org (rmp)	4	0	10	10
robot@pasdenom.info (spam4)	4	0	4	4
TOTAL: 6	49	5	80	85

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	usenet.blueworldhosting.com	12
	nntp.comgw.net	11
	usenet.goja.nl.eu.org	5
	glockenspiel.complete.org	4
	endofthelinebbs-out.news.weretis.net	3
	newsfeed.bofh.team	3
	usenet.network	2
	news.nntp4.net	2
	newsfeed.xs3.de	2
	news.furie.org.uk	1
	TOTAL: 11	46
TOTAL: 1		46

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	nyheter.lysator.liu.se	8230	1567	5078	163	0	19%	23:59:42
2	news.netfront.net	11527	1164	5636	2	16	10%	23:59:53
3	news.furie.org.uk	4682	375	2958	14	0	8%	23:59:53
4	endofthelinebbs.peers.news.panix.com	7057	177	6620	13	35	2%	23:59:53
5	photonic.trudheim.com	8184	170	5930	707	5	2%	23:59:36
6	usenet.goja.nl.eu.org	6551	158	5820	15	0	2%	23:59:53
7	news.nntp4.net	6821	93	6212	0	1	1%	23:59:53
8	news.nk.ca	8145	69	6385	279	10	0%	23:59:53
9	news.corradoroberto.it	745	69	424	0	0	9%	22:27:00
10	i2pn.org	7352	43	6430	24	30	0%	23:59:53
11	news.bbs.nz	12840	42	6611	143	72	0%	23:59:53
12	newsfeed.bofh.team	6536	35	5983	0	0	0%	23:59:53
13	usenet.network	7318	32	6129	8	0	0%	23:59:53
14	news.hispagatos.org	7353	30	6615	23	2	0%	23:59:53
15	news.weretis.net	7014	28	6742	37	0	0%	23:59:53
16	nntp.comgw.net	6920	20	6698	11	0	0%	23:59:53
17	news.tnetconsulting.net	7801	16	6734	59	11	0%	23:59:53
18	news.quux.org	5270	16	4770	80	47	0%	23:59:53
19	newsfeed.xs3.de	7416	6	6557	40	0	0%	23:59:29
20	news.chmurka.net	3985	4	3458	0	0	0%	23:59:49
21	news.samoylyk.net	7348	3	6488	15	1	0%	23:59:39
22	usenet.blueworldhosting.com	6229	1	5840	0	0	0%	23:59:41
23	ddt.demos.su	83	1	76	0	0	1%	08:53:06
24	feed.opticnetworks.net	0	0	0	0	6814	0%	23:59:53
TOTAL: 24		155407	4119	124194	1633	7044	2%	559:16:10

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.netfront.net	5.5 MB	4.9 KB	5.5 MB	0.1 KB/s	4.8 KB	23:59:53
2	nyheter.lysator.liu.se	4.8 MB	1.3 MB	6.1 MB	0.1 KB/s	3.6 KB	23:59:42
3	news.furie.org.uk	2.1 MB	182.5 KB	2.3 MB	0.0 KB/s	6.0 KB	23:59:53
4	endofthelinebbs.peers.news.panix.com	1.2 MB	74.5 KB	1.3 MB	0.0 KB/s	7.0 KB	23:59:53
5	photonic.trudheim.com	843.2 KB	2.1 MB	2.9 MB	0.0 KB/s	3.4 KB	23:59:36
6	usenet.goja.nl.eu.org	318.1 KB	128.8 KB	446.9 KB	0.0 KB/s	2.6 KB	23:59:53
7	usenet.network	275.2 KB	69.4 KB	344.6 KB	0.0 KB/s	8.6 KB	23:59:53
8	news.nntp4.net	255.2 KB	0.0 KB	255.2 KB	0.0 KB/s	2.7 KB	23:59:53
9	news.bbs.nz	244.7 KB	715.2 KB	960.0 KB	0.0 KB/s	5.2 KB	23:59:53
10	news.corradoroberto.it	198.9 KB	0.0 KB	198.9 KB	0.0 KB/s	2.9 KB	22:27:00
11	newsfeed.bofh.team	175.2 KB	0.0 KB	175.2 KB	0.0 KB/s	5.0 KB	23:59:53
12	i2pn.org	151.6 KB	200.5 KB	352.2 KB	0.0 KB/s	5.3 KB	23:59:53
13	news.nk.ca	143.1 KB	780.7 KB	923.8 KB	0.0 KB/s	2.7 KB	23:59:53
14	news.hispagatos.org	137.7 KB	154.8 KB	292.5 KB	0.0 KB/s	5.5 KB	23:59:53
15	news.weretis.net	137.0 KB	785.7 KB	922.7 KB	0.0 KB/s	14.2 KB	23:59:53
16	news.tnetconsulting.net	74.9 KB	462.5 KB	537.4 KB	0.0 KB/s	7.2 KB	23:59:53
17	news.quux.org	57.0 KB	494.7 KB	551.7 KB	0.0 KB/s	5.7 KB	23:59:53
18	news.samoylyk.net	44.5 KB	76.7 KB	121.2 KB	0.0 KB/s	6.7 KB	23:59:39
19	nntp.comgw.net	40.2 KB	122.4 KB	162.6 KB	0.0 KB/s	5.2 KB	23:59:53
20	newsfeed.xs3.de	27.2 KB	187.3 KB	214.6 KB	0.0 KB/s	4.7 KB	23:59:29
21	news.chmurka.net	7.6 KB	0.0 KB	7.6 KB	0.0 KB/s	1.9 KB	23:59:49
22	ddt.demos.su	3.2 KB	0.0 KB	3.2 KB	0.0 KB/s	3.2 KB	08:53:06
23	usenet.blueworldhosting.com	1.3 KB	0.0 KB	1.3 KB	0.0 KB/s	1.3 KB	23:59:41
24	feed.opticnetworks.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:53
TOTAL: 24		16.7 MB	7.8 MB	24.5 MB	0.0 KB/s	4.4 KB	559:16:10

NNRP readership statistics:

System		Conn	Elapsed
1	198.235.24.123	1	00:00:10
2	198.235.24.140	1	00:00:10
3	2a06:4882:b000::b9	1	00:00:02
4	azpdegb2.stretchoid.com	1	00:00:00
5	localhost	1	00:11:08
TOTAL: 5		5	00:11:32

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	?	2	00:11:11
2	unresolved	2	00:00:20
3	*.stretchoid.com	1	00:00:00
TOTAL: 3		5	00:11:32

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.304	373.125	0.077	00:11:08
198.235.24.123	0.017	0.025	0.000	00:00:10
198.235.24.140	0.003	0.013	0.000	00:00:10
2a06:4882:b000::b9	0.010	0.024	0.000	00:00:02
azpdegb2.stretchoid.com	0.004	0.023	0.000	00:00:00
TOTAL: 5	180.338	373.210	0.077	00:11:32

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

System	Conn
azpdegb2.stretchoid.com	1
TOTAL: 1	1

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

Command	Count
MGLNDD_144.172.126.95_119	1
TOTAL: 1	1

Daily Usenet Report

Feb 23 00:01:01 -- Feb 24 00:01:02