Daily Usenet report: Oct 27 06:01:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Oct 27 06:01:49 kennel innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	363053	96.7%	45.2 MB	96.2%
innd	10876	2.9%	1.6 MB	3.3%
innfeed	1371	0.4%	181.5 KB	0.4%
cnfsstat	144	0.0%	22.5 KB	0.0%
nnrpd	32	0.0%	3.5 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	375477	100.0%	46.9 MB	100.0%

History cache:

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.002	0.0%	26	0.000	0.077	1.000
article cleanup	00:00:03.790	0.0%	362139	0.005	0.010	0.018
article logging	00:00:14.683	0.0%	362251	0.021	0.041	0.054
article parse	00:00:21.719	0.0%	1038279	0.006	0.021	0.030
article write	00:00:21.764	0.0%	247720	0.037	0.088	0.117
artlog/artparse	00:00:00.052	0.0%	849	0.000	0.061	1.000
data move	00:00:04.907	0.0%	1123733	0.001	0.004	0.010
hisgrep/artcncl	00:00:00.000	0.0%	26	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:43.129	0.0%	1296711	0.002	0.033	0.191
history sync	00:00:00.018	0.0%	312	0.000	0.058	0.500
history write	00:00:21.830	0.0%	355167	0.036	0.061	0.082
idle	23:53:09.299	99.5%	904346	35.896	95.085	321.885
nntp read	00:00:36.740	0.0%	904296	0.017	0.041	0.057
overview write	00:00:01.303	0.0%	247720	0.000	0.005	0.011
perl filter	00:00:17.915	0.0%	354335	0.024	0.051	0.066
python filter	00:00:17.313	0.0%	354335	0.024	0.049	0.061
site send	00:00:09.440	0.0%	551336	0.011	0.017	0.188
TOTAL: 24:00:30.870	23:56:43.904	99.7%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.169	0.0%	55668	0.000	0.003	0.020
article prepare	00:00:00.000	0.0%	601	0.000	0.000	0.000
article read	00:00:00.033	0.0%	480	0.000	0.069	1.000
backlog stats	00:00:00.162	0.0%	183696	0.000	0.001	0.005
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.966	0.0%	119586	0.011	0.025	0.047
data write	00:00:02.901	0.0%	76710	0.018	0.038	0.072
idle	23:54:11.437	100.0%	183696	108.405	468.445	1239.647
status file	00:00:00.147	0.0%	240	0.000	0.613	2.000
TOTAL: 23:54:23.721	23:54:17.815	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:00.000	0.0%	0	0.000	0.000	0.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.001	0.2%	7	0.000	0.143	1.000
TOTAL: 00:00:00.539	00:00:00.001	0.2%	-	-	-	-

Control commands to INND:

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	hasname-out.feeder.erje.net	586	680645	238165	327282	115198	34%	49:58:40
2	hasname-out.news.weretis.net	5	19320	6615	12564	141	34%	50:43:27
3	usenet.blueworldhosting.com	1398	11132	1300	9675	157	11%	23:48:12
4	news.nntp4.net	2	8312	1299	6758	255	15%	23:59:12
5	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 5		1992	719409	247379	356279	115751	34%	148:29:31

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	hasname-out.feeder.erje.net	2.2 GB	84.3 MB	1.2 GB	3.5 GB	62%	10.4 KB
2	hasname-out.news.weretis.net	14.3 MB	101.1 KB	156.4 KB	14.6 MB	98%	2.2 KB
3	news.nntp4.net	6.2 MB	30.4 KB	2.2 MB	8.3 MB	73%	5.5 KB
4	usenet.blueworldhosting.com	3.1 MB	5.2 KB	920.7 KB	4.0 MB	77%	2.8 KB
5	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 5		2.2 GB	84.4 MB	1.2 GB	3.5 GB	62%	10.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 27 06:01:01 - 06:59:59	8264	3.3%	2.34	74.8 MB	3.3%	21.63
Oct 27 07:00:00 - 07:59:59	7935	3.2%	2.20	76.8 MB	3.4%	21.86
Oct 27 08:00:00 - 08:59:59	24449	9.9%	6.79	152.1 MB	6.7%	43.26
Oct 27 09:00:00 - 09:59:59	7992	3.2%	2.22	91.3 MB	4.0%	25.96
Oct 27 10:00:00 - 10:59:59	12013	4.9%	3.34	135.6 MB	6.0%	38.56
Oct 27 11:00:00 - 11:59:59	8609	3.5%	2.39	95.3 MB	4.2%	27.10
Oct 27 12:00:00 - 12:59:59	10559	4.3%	2.93	102.3 MB	4.5%	29.11
Oct 27 13:00:00 - 13:59:59	11903	4.8%	3.31	96.4 MB	4.3%	27.41
Oct 27 14:00:00 - 14:59:59	12027	4.9%	3.34	128.1 MB	5.7%	36.43
Oct 27 15:00:00 - 15:59:59	8138	3.3%	2.26	79.9 MB	3.5%	22.71
Oct 27 16:00:00 - 16:59:59	10969	4.4%	3.05	111.9 MB	5.0%	31.84
Oct 27 17:00:00 - 17:59:59	9235	3.7%	2.57	73.2 MB	3.2%	20.81
Oct 27 18:00:00 - 18:59:59	11286	4.6%	3.13	123.7 MB	5.5%	35.17
Oct 27 19:00:00 - 19:59:59	9945	4.0%	2.76	90.5 MB	4.0%	25.75
Oct 27 20:00:00 - 20:59:59	13555	5.5%	3.77	117.8 MB	5.2%	33.51
Oct 27 21:00:00 - 21:59:59	9955	4.0%	2.77	88.2 MB	3.9%	25.09
Oct 27 22:00:00 - 22:59:59	15036	6.1%	4.18	102.8 MB	4.6%	29.25
Oct 27 23:00:00 - 23:59:59	8221	3.3%	2.28	73.8 MB	3.3%	20.99
Oct 28 00:00:00 - 00:59:59	8593	3.5%	2.39	68.5 MB	3.0%	19.48
Oct 28 01:00:00 - 01:59:59	7785	3.1%	2.16	76.9 MB	3.4%	21.88
Oct 28 02:00:00 - 02:59:59	7682	3.1%	2.13	67.5 MB	3.0%	19.19
Oct 28 03:00:00 - 03:59:59	8108	3.3%	2.25	76.5 MB	3.4%	21.77
Oct 28 04:00:00 - 04:59:59	7021	2.8%	1.95	69.9 MB	3.1%	19.88
Oct 28 05:00:00 - 05:59:59	7833	3.2%	2.18	82.2 MB	3.6%	23.37
Oct 28 06:00:00 - 06:01:01	135	0.1%	2.21	1.5 MB	0.1%	24.49
TOTAL: 24:00:00	247248	100.0%	2.86	2.2 GB	100.0%	26.75

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days
C1	DEFAULT	10.0 GB	501.3 MB	4.9%	93	32.68	3.71
TOTAL: 1	-	10.0 GB	501.3 MB	4.9%	93	32.68	-

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	hasname-out.feeder.erje.net	115207	106455	7739	5	1008
2	news.nntp4.net	289	239	12	0	38
3	usenet.blueworldhosting.com	169	146	5	0	18
4	hasname-out.news.weretis.net	140	71	58	0	11
TOTAL: 4		115805	106911	7814	5	1075

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.binaries.friends	46629
alt.binaries.encrypted	3758
alt.binaries.amazing	2969
alt.binaries.u-4all	2607
alt.binaries.encryptnzb.alpha	1348
alt.binaries.encryptnzb.charlie	1341
alt.binaries.encryptnzb.juliet	1335
alt.binaries.encryptnzb.lima	1334
alt.binaries.encryptnzb.delta	1330
alt.binaries.encryptnzb.novemeber	1329
alt.binaries.encryptnzb.bravo	1327
alt.binaries.encryptnzb.kilo	1309
alt.binaries.encryptnzb.beta	1301
alt.binaries.encryptnzb.india	1296
alt.binaries.encryptnzb.foxtrot	1288
alt.binaries.encryptnzb.golf	1286
alt.binaries.encryptnzb.hotel	1262
alt.binaries.encryptnzb.mike	1245
alt.binaries.encryptnzb.echo	1203
alt.binaries.font	1183
TOTAL: 212	106911

Supposedly-moderated groups with unmoderated postings [Top 20]:

Groups	Count
alt.binaries.whitburn	4
alt.binaries.sounds.mp3.jazz.vocals	1
TOTAL: 2	5

INND no permission servers:

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	hasname-out.feeder.erje.net	20
	TOTAL: 1	20
Including strange strings
	hasname-out.feeder.erje.net	47
	news.nntp4.net	38
	usenet.blueworldhosting.com	12
	hasname-out.news.weretis.net	11
	TOTAL: 4	108
No colon-space in header field
	hasname-out.feeder.erje.net	961
	usenet.blueworldhosting.com	6
	TOTAL: 2	967
TOTAL: 3		1095

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	bbsgslincom	441	441	0	0	0	100%	20:59:27
2	blueworldhosting	54941	36	53787	1	15	0%	23:59:56
3	nntp4	9287	0	9282	0	11	0%	23:59:56
4	erje	8503	0	8498	1	26	0%	23:59:56
5	weretis	3355	0	3353	2	0	0%	23:55:23
TOTAL: 5		76527	477	74920	4	52	0%	116:54:38

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	bbsgslincom	1.4 MB	0.0 KB	1.4 MB	3.4 KB	20:59:27
2	blueworldhosting	233.4 KB	31.3 KB	264.7 KB	7.2 KB	23:59:56
3	erje	0.0 KB	39.8 KB	39.8 KB	39.8 KB	23:59:56
4	nntp4	0.0 KB	0.0 KB	0.0 KB	0	23:59:56
5	weretis	0.0 KB	79.5 KB	79.5 KB	39.7 KB	23:55:23
TOTAL: 5		1.7 MB	150.6 KB	1.8 MB	3.9 KB	116:54:38

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
o64.scanner.modat.io	0.000	0.004	00:00:00
194.165.16.162	0.000	0.003	00:00:00
azpdcgu07k7i.stretchoid.com	0.000	0.004	00:00:00
162.142.125.118	0.000	0.003	00:00:00
198.235.24.214	0.000	0.003	00:00:00
205.210.31.28	0.001	0.002	00:00:00
TOTAL: 6	0.001	0.019	00:00:00

NNRP no permission clients [Top 20]:

Daily Usenet report