Daily Usenet report: Sep 10 15:00:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Sep 10 15:01:39 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	20285	68.6%	2.7 MB	69.9%
innd	6770	22.9%	825.7 KB	20.9%
innfeed	1329	4.5%	189.6 KB	4.8%
cnfsstat	1152	3.9%	171.9 KB	4.4%
nnrpd	16	0.1%	1.6 KB	0.0%
controlchan	2	0.0%	0.1 KB	0.0%
overchan	2	0.0%	0.4 KB	0.0%
TOTAL: 7	29556	100.0%	3.9 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	39950	41.6%
Positive hits	35973	37.5%
Do not exist	20027	20.9%
Cache misses	64	0.1%
TOTAL: 4	96014	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.289	0.0%	87	0.000	3.322	51.400
article cleanup	00:00:00.141	0.0%	20050	0.000	0.007	0.042
article logging	00:00:00.531	0.0%	20061	0.000	0.026	0.083
article parse	00:00:00.331	0.0%	35547	0.000	0.009	0.031
article write	00:00:00.660	0.0%	13039	0.000	0.051	0.111
artlog/artcncl	00:00:00.001	0.0%	83	0.000	0.012	0.250
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:00:00.067	0.0%	100378	0.000	0.001	0.006
hisgrep/artcncl	00:00:00.005	0.0%	87	0.000	0.057	1.000
hishave/artcncl	00:00:00.000	0.0%	87	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:02.450	0.0%	96125	0.000	0.025	0.462
history sync	00:00:00.013	0.0%	394	0.000	0.033	0.667
history write	00:00:01.567	0.0%	20050	0.000	0.078	2.575
idle	23:50:28.572	100.0%	103132	440.179	832.221	2807.402
nntp read	00:00:00.753	0.0%	102576	0.000	0.007	0.015
overview write	00:00:00.064	0.0%	13039	0.000	0.005	0.032
perl filter	00:00:19.422	0.0%	20049	0.609	0.969	1.526
python filter	00:00:00.452	0.0%	20049	0.000	0.023	0.098
site send	00:00:02.098	0.0%	39117	0.016	0.054	0.105
TOTAL: 23:51:07.799	23:50:57.416	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.027	0.0%	13282	0.000	0.002	0.040
article prepare	00:00:00.001	0.0%	13872	0.000	0.000	0.005
article read	00:00:00.601	0.0%	3564	0.000	0.169	1.579
backlog stats	00:00:00.051	0.0%	83795	0.000	0.001	0.006
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.357	0.0%	48783	0.000	0.007	0.027
data write	00:00:01.130	0.0%	35989	0.008	0.031	0.088
idle	23:47:55.774	100.0%	83795	389.325	1022.445	3158.347
status file	00:00:00.113	0.0%	205	0.000	0.551	4.000
TOTAL: 23:48:01.132	23:47:58.054	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:52.819	98.3%	55	960.345	960.345	960.345
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.002	0.0%	216	0.000	0.009	0.009
readart	00:00:00.335	0.6%	51	6.569	6.569	6.569
TOTAL: 00:00:53.727	00:00:53.156	98.9%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	hasname-out.news.weretis.net	5	23846	7833	15462	551	32%	46:42:17
2	usenet.blueworldhosting.com	310	19832	4176	9654	6002	21%	23:39:59
3	news.nntp4.net	2	11347	1076	9850	421	9%	23:33:19
4	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 4		318	55025	13085	34966	6974	23%	93:55:35

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	hasname-out.news.weretis.net	26.7 MB	3.9 KB	1.7 MB	28.5 MB	93%	3.5 KB
2	usenet.blueworldhosting.com	23.6 MB	0.0 KB	14.4 MB	38.0 MB	62%	3.8 KB
3	news.nntp4.net	3.0 MB	0.0 KB	2.5 MB	5.4 MB	54%	3.7 KB
4	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 4		53.3 MB	3.9 KB	18.6 MB	71.9 MB	74%	3.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 10 15:00:02 - 15:59:59	655	5.0%	0.18	2.1 MB	3.9%	0.59
Sep 10 16:00:00 - 16:59:59	686	5.2%	0.19	2.8 MB	5.2%	0.80
Sep 10 17:00:00 - 17:59:59	605	4.6%	0.17	2.6 MB	4.9%	0.74
Sep 10 18:00:00 - 18:59:59	573	4.4%	0.16	2.3 MB	4.3%	0.66
Sep 10 19:00:00 - 19:59:59	632	4.8%	0.18	2.3 MB	4.3%	0.65
Sep 10 20:00:00 - 20:59:59	572	4.3%	0.16	2.6 MB	4.9%	0.75
Sep 10 21:00:00 - 21:59:59	592	4.5%	0.16	2.1 MB	4.0%	0.61
Sep 10 22:00:00 - 22:59:59	489	3.7%	0.14	2.3 MB	4.2%	0.65
Sep 10 23:00:00 - 23:59:59	461	3.5%	0.13	2.0 MB	3.8%	0.58
Sep 11 00:00:00 - 00:59:59	330	2.5%	0.09	1.6 MB	2.9%	0.45
Sep 11 01:00:00 - 01:59:59	325	2.5%	0.09	1.5 MB	2.8%	0.43
Sep 11 02:00:00 - 02:59:59	299	2.3%	0.08	1.1 MB	2.0%	0.30
Sep 11 03:00:00 - 03:59:59	294	2.2%	0.08	1.5 MB	2.7%	0.41
Sep 11 04:00:00 - 04:59:59	337	2.6%	0.09	2.4 MB	4.4%	0.67
Sep 11 05:00:00 - 05:59:59	371	2.8%	0.10	1.8 MB	3.3%	0.51
Sep 11 06:00:00 - 06:59:59	598	4.5%	0.17	2.7 MB	5.1%	0.78
Sep 11 07:00:00 - 07:59:59	579	4.4%	0.16	2.1 MB	3.8%	0.58
Sep 11 08:00:00 - 08:59:59	657	5.0%	0.18	2.4 MB	4.5%	0.68
Sep 11 09:00:00 - 09:59:59	669	5.1%	0.19	2.8 MB	5.2%	0.80
Sep 11 10:00:00 - 10:59:59	555	4.2%	0.15	1.7 MB	3.2%	0.49
Sep 11 11:00:00 - 11:59:59	665	5.1%	0.18	3.1 MB	5.7%	0.87
Sep 11 12:00:00 - 12:59:59	800	6.1%	0.22	2.8 MB	5.3%	0.80
Sep 11 13:00:00 - 13:59:59	734	5.6%	0.20	2.8 MB	5.2%	0.79
Sep 11 14:00:00 - 15:00:01	681	5.2%	0.19	2.4 MB	4.4%	0.68
TOTAL: 23:59:59	13159	100.0%	0.15	53.7 MB	100.0%	0.64

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days
EIGHT	BIG	4.0 GB	2.9 GB	72.6%	1	0.00	0.00
FIVE	BIG	4.0 GB	2.9 GB	72.6%	1	0.00	0.00
FOUR	DEFAULT	1024.0 MB	207.0 MB	20.2%	23	0.24	50.39
ONE	DEFAULT	1024.0 MB	365.0 MB	35.6%	25	0.23	52.23
SEVEN	BIG	4.0 GB	2.9 GB	72.6%	1	0.00	0.00
SIX	BIG	4.0 GB	2.9 GB	72.8%	1	0.00	0.00
THREE	DEFAULT	1024.0 MB	214.5 MB	21.0%	23	0.23	51.94
TWO	DEFAULT	1024.0 MB	200.6 MB	19.6%	23	0.24	50.90
TOTAL: 8	-	20.0 GB	12.6 GB	62.9%	98	0.24	-

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	usenet.blueworldhosting.com	6012	3066	0	2946
2	hasname-out.news.weretis.net	562	1	1	560
3	news.nntp4.net	469	0	0	469
TOTAL: 3		7043	3067	1	3975

Unwanted newsgroups [Top 20]:

Newsgroup	Count
own.health	457
alt.entertainment	410
sci.technology	365
alive.sports	343
misc.business	334
sci.science	309
general	238
linux.kernel.netdev	85
kraft.politics	81
fido7.pravda.news	72
fido7.pushkin.local	69
kraft.competent	35
fido7.ukrnews	33
fido7.fidonet.online	31
kraft.talks	31
eternal-september.nocems	22
linux.kernel.git	19
odessa.news	19
kraft.vehicles	18
perl.cpan	16
TOTAL: 46	3067

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	2343
EMP (md5)	1392
EMP (phl)	63
Too many newsgroups	57
Too many newsgroups (meow)	50
Binary: misplaced binary	21
Scoring filter	20
HTML Multipart	12
EMP (phn nph)	5
TOTAL: 9	3963

INND no permission servers:

System	Conn
194.165.16.78	1
167.94.138.125	1
TOTAL: 2	2

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	hasname-out.news.weretis.net	8
	usenet.blueworldhosting.com	3
	TOTAL: 2	11
No colon-space in header
	usenet.blueworldhosting.com	1
	TOTAL: 1	1
TOTAL: 2		12

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	nntp4	12890	3208	8805	65	0	24%	23:59:54
2	bbsgslincom	268	265	0	0	3870	98%	23:59:54
3	weretis	9019	112	5073	73	0	1%	23:59:54
4	aioe	0	0	0	0	13030	0%	23:59:51
5	blueworldhosting	10423	0	8554	0	0	0%	23:59:54
TOTAL: 5		32600	3585	22432	138	16900	10%	119:59:27

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	nntp4	18.7 MB	323.8 KB	19.0 MB	0.2 KB/s	5.9 KB	23:59:54
2	bbsgslincom	1.7 MB	0.0 KB	1.7 MB	0.0 KB/s	6.6 KB	23:59:54
3	weretis	640.4 KB	502.6 KB	1.1 MB	0.0 KB/s	6.2 KB	23:59:54
4	aioe	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:51
5	blueworldhosting	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:54
TOTAL: 5		21.0 MB	826.3 KB	21.8 MB	0.1 KB/s	6.0 KB	119:59:27

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	220-134-66-225.hinet-ip.hinet.net	1	51	99.4 KB	1	0	0	00:00:53
TOTAL: 1		1	51	99.4 KB	1	0	0	00:00:53

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.hinet-ip.hinet.net	1	51	99.4 KB	1	0	0	00:00:53
TOTAL: 1		1	51	99.4 KB	1	0	0	00:00:53

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
220-134-66-225.hinet-ip.hinet.net	0.004	0.010	00:00:53
192.241.206.11	0.001	0.001	00:00:00
171.67.71.80	0.001	0.002	00:00:00
TOTAL: 3	0.006	0.013	00:00:53

NNRP no permission clients:

System	Conn
171.67.71.80	1
192.241.206.11	1
TOTAL: 2	2

Newsgroup request counts (by category):

Category		Count	Pct
1	news	51	100.0%
TOTAL: 1		51	100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

Newsgroup		Count
1	news.admin.peering	51
TOTAL: 1		51

Daily Usenet report

Sep 10 15:00:02 -- Sep 11 15:00:01