DBA工具——DMV——如何知道TSQL语句已运行了多久

DBA通常想知道正在运行的语句已经执行了多久了？可以使用Sqlserver profiler来捕获语句的开始时间，和现有时间比较，但是在生产环境下通常会对性能有负面影响，所以通常不建议在非必要的前提下在生产环境使用SQL Server Profiler。

此时，可以使用DMV来查询：

sys.dm_exec_requests中有一个重要字段：start_time，表示request的开始时间，一个批处理就是一个request，一个request对应一个task，如果批处理是并发，则对应多个tasks。下面脚本不考虑并发情况。在DMV中的sys.dm_os_workers里面有一个字段task_bound_ms_ticks表示线程（worker）拿到task的时间（单位是tick）。

由于sys.dm_exec_requests没有包含语句文本，所以需要借助sys.dm_exec_sql_text转换sql_handle而得到。然后从sys.dm_exec_query_plan得到执行计划。还输出正在执行的哪一句具体的stmt。这对于一个批处理包含多条语句时特别有用：

DECLARE @ms_per_tick DECIMAL(10, 6)
--millisecond per tick
SELECT  @ms_per_tick = 1.0 * DATEDIFF(millisecond, sqlserver_start_time,
GETDATE()) / ( ms_ticks
- sqlserver_start_time_ms_ticks )
FROM    sys.[dm_os_sys_info] ;

--select @ms_per_tick

SELECT  req.session_id ,
req.start_time request_start_time ,
( ( SELECT  ms_ticks
FROM    sys.dm_os_sys_info
) - workers.task_bound_ms_ticks ) * @ms_per_tick 'ms_since_task_bound' ,
DATEDIFF(ms, req.start_time, GETDATE()) 'ms_since_request_start' ,
tasks.task_state ,
workers.state worker_state ,
req.status request_state ,
st.text ,
SUBSTRING(st.text, ( req.statement_start_offset / 2 ) + 1,
( ( CASE req.statement_end_offset
WHEN -1 THEN DATALENGTH(st.text)
ELSE req.statement_end_offset
END - req.statement_start_offset ) / 2 ) + 1) AS stmt ,
qp.query_plan ,
req.*
FROM    sys.dm_exec_requests req
LEFT JOIN sys.dm_os_tasks tasks ON tasks.task_address = req.task_address
LEFT JOIN sys.dm_os_workers workers ON tasks.task_address = workers.task_address
CROSS APPLY sys.dm_exec_sql_text(req.sql_handle) st
CROSS APPLY sys.dm_exec_query_plan(req.plan_handle) qp
WHERE   ( req.session_id > 50
OR req.session_id IS NULL
)

go

上面的@ms_per_tick用来计算一个tick相当与多少ms（毫秒），一般一个tick基本就是一毫秒。输出如下：