SQL Server 2012新performance counter:非常实用的Batch Resp Statistics

 

SQL Server 2012引入了一个新的performance counter, Batch Resp Statistics。这个counter的目的是“to track SQL Batch Response times”。这个counter下面有好几档如下:

 

具体就是:

Batches >=000000ms & <000001ms                                                                                                 

Batches >=000001ms & <000002ms                                                                                                 

Batches >=000002ms & <000005ms                                                                                                 

Batches >=000005ms & <000010ms                                                                                                 

Batches >=000010ms & <000020ms                                                                                                 

Batches >=000020ms & <000050ms                                                                                                 

Batches >=000050ms & <000100ms                                                                                                 

Batches >=000100ms & <000200ms                                                                                                 

Batches >=000200ms & <000500ms                                                                                                 

Batches >=000500ms & <001000ms                                                                                                 

Batches >=001000ms & <002000ms                                                                                                 

Batches >=002000ms & <005000ms                                                                                                 

Batches >=005000ms & <010000ms                                                                                                 

Batches >=010000ms & <020000ms                                                                                                 

Batches >=020000ms & <050000ms                                                                                                 

Batches >=050000ms & <100000ms                                                                                                 

Batches >=100000ms                                                                                                             

 

这些档的含义是怎样的呢?假定对于Batches >=010000ms & <020000ms,它的含义是这样的:

1) 如果batch (也就是一个request)的执行时间是10000ms 到20000ms之间的则计数

2) CPU time 和Elapsed time 的含义和sys.dm_exec_requests 里面的含义一致。 CPU time 就是 “请求所使用的 CPU 时间”, Elapsed time 就是“请求到达后经过的总时间”。 简单说,CPU time就是batch request的CPU指令真正执行的时间,而Elapsed time 是指CPU时间加上等待的时间。比如当batch等待磁盘I/O,等待锁(就是被阻塞了)的时候,Elapsed time就一般比CPU time 长。这里注意的是因为并发执行的关系,Elapsed time 有时候并不会就恒等于CPU time 加上等待时间,而是应该有些出入。

3) CPU time:Requests 指CPU time 在这个范围内的batch request的总数。CPU time:total(ms)指CPU time 在这个范围内的时间总和。Elapsed time:request 和 Elapsed time:requests 的含义类似。

4)  这些counter的值是累计的。也就是说,会一直增加,直到SQL server 重启。

 

 

为了测试这个counter,我使用ostress.exe测试工具。这个工具可以产生指定数目的连接,反复执行指定的脚本。我的测试脚本如下:

1. 首先建立测试的表

 

USE[Test_good]

GO

 

/****** Object: Table [dbo].[test] Script Date: 2012/12/26 14:57:56 ******/

DROPTABLE[dbo].[test]

GO

 

/****** Object: Table [dbo].[test] Script Date: 2012/12/26 14:57:56 ******/

SETANSI_NULLSON

GO

 

SETQUOTED_IDENTIFIERON

GO

 

SETANSI_PADDINGON

GO

 

CREATETABLE[dbo].[test](

    [colid][int]IDENTITY(1,1)NOTNULL,

    [col2][varchar](400)NULL

)ON[PRIMARY]

 

GO

 

SETANSI_PADDINGOFF

GO

 

2. 然后插入上千万的记录。

  

3. 然后使用如下的脚本测试。为了让测试更有趣,我在语句里面使用了rand()函数,以及动态判断是否需要人为的delay (见waitfor delay 语句)2秒钟:

 

usetest_good

go

declare@col1int=rand()*10000

declare@col2int=rand()*100000

declare@tint

if (@col1>@col2)

begin

set@t=@col1

set@col1=@col2

set@col2=@t

end

begintran

updatetestsetcol2=getdate()wherecolid=(@col1+@col2)/2

declare@iint=rand()*100

if (@i>50)waitfordelay'00:00:02'

committran

select@col1,@col2

select*fromtestwherecolidbetween@col1and@col2

go

select 1

declare@iint=rand()*100

if (@i<30)waitfordelay'00:00:02'

go

select 2

go

declare@iint=rand()*100

if (@i>30)waitfordelay'00:00:02'

go

 

测试的结果如下:

 

 

 

从这个可以看出:

系统的语句主要分为几类(按照Elapsed time):

Batches >=000000ms & <000001ms 672次

Batches >=002000ms & <005000ms 309次

 

如果觉得上面的图形看起来不够直观,那么还可以使用下面的语句来得到更方便阅读的结果:

(注:语句来自Neil Hambly)

sELECT[counter_name],"CPU Time:Total(ms)","CPU Time:Requests","Elapsed Time:Total(ms)","Elapsed Time:Requests"

FROM (SELECT[counter_name],[instance_name],[cntr_value]FROMsys.dm_os_performance_countersWHEREOBJECT_NAMELIKE'%Batch Resp Statistics%')os_pc

PIVOT(AVG([cntr_value])FOR[instance_name]

IN("CPU Time:Total(ms)","CPU Time:Requests","Elapsed Time:Total(ms)","Elapsed Time:Requests"))ASPvt;

 

结果如下:

 

这个结果一目了然:

1) 你可以看到系统所有语句的响应时间的分布情况,真正体现了这个counter 的 resp statistics 的字面含义,也即系统batch request的响应时间统计信息。

2) 你很容易知道系统的大部分的语句的响应时间和语句的总数

3) 通过比较CPU time 和Elapsed time的差异,你很容易知道batch request 是否经常因为等待(如等待I/O,阻塞等)而导致长的执行总时间。