IO_STALL вопрос и понимание

9

Я собираю IO_STALLS из sys.dm_io_virtual_file_stats каждые 5 минут, а затем делаю дельту, чтобы увидеть, какие файлы больше всего подвержены IO.

За один 5-минутный период я ​​получаю дельту 5826331 мс, что составляет 97 минут.

Меня это немного смущает, говорит ли это, что операция, начатая 97 минут назад, только что завершилась в тот момент и, следовательно, записала это время ожидания?

Спасибо

Добавлен код по запросу:

/*

USE [SysDBA]
GO
*/
/****** Object:  Table [dbo].[DISKIOPS]    Script Date: 04/07/2013 11:40:15 ******/
/*
DROP TABLE [dbo].[DISKIOPS]
GO
*/
--Create the table
/****** Object:  Table [dbo].[DISKIOPS]    Script Date: 04/07/2013 11:40:15 ******/
/*
SET ANSI_NULLS ON
GO

SET QUOTED_IDENTIFIER ON
GO

SET ANSI_PADDING ON
GO

CREATE TABLE [dbo].[DISKIOPS](
    [IO_STALL] [bigint] NULL,
    [IO_STALL_READ_MS] [bigint] NULL,
    [IO_STALL_WRITE_MS] [bigint] NULL,
    [NUM_OF_READS] [bigint] NULL,
    [NUM_OF_WRITES] [bigint] NULL,
    [SIZE_ON_DISK_MB] [bigint] NULL,
    [DBNAME] [varchar](max) NULL,
    [NAME] [varchar](max) NULL,
    [FILE_ID] [int] NULL,
    [DB_FILE_TYPE] [varchar](max) NULL,
    [DISK] [varchar](max) NULL,
    [FILE_LOCATION] [varchar](max) NULL,
    [TIMESTAMP] [datetime] NULL
) ON [PRIMARY] TEXTIMAGE_ON [PRIMARY]

GO

SET ANSI_PADDING OFF
GO

*/

--Capture IO information from DMV and query to find deltas over time.
/*
USE [SysDBA]
GO

INSERT INTO [dbo].[DISKIOPS]
           ([IO_STALL]
           ,[IO_STALL_READ_MS]
           ,[IO_STALL_WRITE_MS]
           ,[NUM_OF_READS]
           ,[NUM_OF_WRITES]
           ,[SIZE_ON_DISK_MB]
           ,[DBNAME]
           ,[NAME]
           ,[FILE_ID]
           ,[DB_FILE_TYPE]
           ,[DISK]
           ,[FILE_LOCATION]
           ,[TIMESTAMP])
SELECT a.io_stall, a.io_stall_read_ms, a.io_stall_write_ms, a.num_of_reads, 
a.num_of_writes, 
--a.sample_ms, a.num_of_bytes_read, a.num_of_bytes_written,
( ( a.size_on_disk_bytes / 1024 ) / 1024.0 ) AS size_on_disk_mb, 
db_name(a.database_id) AS dbname, 
b.name, a.file_id, 
db_file_type = CASE 
                   WHEN a.file_id = 2 THEN 'Log' 
                   ELSE 'Data' 
                   END, 
UPPER(SUBSTRING(b.physical_name, 1, 2)) AS disk_location,
b.physical_name AS File_location,
GETDATE() AS Timestamp
FROM sys.dm_io_virtual_file_stats (NULL, NULL) a 
JOIN sys.master_files b ON a.file_id = b.file_id 
AND a.database_id = b.database_id
GO
*/
DECLARE @File_Name VARCHAR(8000),
        @Disk VARCHAR(5)
SET @File_Name = 'DBTEST'
SET @Disk = 'I:'
--Code to pull out deltas between collected IO stats.
;WITH IOPS   ([IO_STALL]
           ,[IO_STALL_READ_MS]
           ,[IO_STALL_WRITE_MS]
           ,[NUM_OF_READS]
           ,[NUM_OF_WRITES]
           ,[SIZE_ON_DISK_MB]
           ,[DBNAME]
           ,[NAME]
           ,[FILE_ID]
           ,[DB_FILE_TYPE]
           ,[DISK]
           ,[FILE_LOCATION]
           ,[TIMESTAMP]
           ,[ROW])
AS
(
SELECT *, ROW_NUMBER() OVER (PARTITION BY FILE_LOCATION ORDER BY TIMESTAMP DESC) AS [ROW]
FROM dbo.DISKIOPS 
)

SELECT MAX([IO2].[IO_STALL] - [IO1].[IO_STALL])
FROM IOPS IO1 JOIN IOPS IO2 ON IO1.ROW = (IO2.ROW+1)
WHERE IO1.NAME = IO2.NAME
AND IO1.Disk = @Disk
Том
источник
1
io_stallсамо по себе не значит слишком много. Если за 10 секунд у вас было 1000 операций срывом на 1 секунду каждая, у вас будет 1000 секунд срывов. Это было бы 16+ минут киосков за 10 секунд. Вы должны соотнести это с операциями ввода-вывода. Можете ли вы разместить свой фактический запрос в вашем вопросе?
Томас Стрингер
Привет! Я добавил код, у меня возникли проблемы с его форматированием, поэтому я надеюсь, что все в порядке.
Том

Ответы:

10

Комментарий вопроса вставлен ниже:

io_stallсамо по себе не значит слишком много. Если за 10 секунд у вас было 1000 операций срывом на 1 секунду каждая, у вас будет 1000 секунд срывов. Это было бы 16+ минут киосков за 10 секунд. Вы должны соотнести это с операциями ввода-вывода ...

Выше приведен довольно хороший пример того, как вы можете увидеть монументальные и, казалось бы, преувеличенные цифры. Само по себе io_stallничего не значит. Вам необходимо знать масштаб операций ввода-вывода для этого накопительного срыва.

Вместо этого:

SELECT MAX([IO2].[IO_STALL] - [IO1].[IO_STALL])
FROM IOPS IO1 JOIN IOPS IO2 ON IO1.ROW = (IO2.ROW+1)
...

Вам нужно разделить задержку на операции ввода / вывода, чтобы получить среднее значение задержки на ввод / вывод (или на чтение, или на запись, или на какую бы гранулярность вы не искали). Другими словами, я рекомендую изменить ваш запрос так, чтобы он выглядел примерно так:

SELECT
    MAX(([IO2].[IO_STALL] - [IO1].[IO_STALL]) / (IO2.NUM_OF_READS + IO2.NUM_OF_WRITES - IO1.NUM_OF_READS - IO1.NUM_OF_WRITES))
FROM IOPS IO1 JOIN IOPS IO2 ON IO1.ROW = (IO2.ROW+1)

И тогда вам нужно иметь дополнительное предикатное предложение, чтобы убедиться, что вы не делите на ноль:

...
WHERE IO1.NAME = IO2.NAME
and (IO2.NUM_OF_READS + IO2.NUM_OF_WRITES - IO1.NUM_OF_READS - IO1.NUM_OF_WRITES) > 0
AND IO1.Disk = @Disk

В основном это вычисляет среднее значение для io_stallкаждой операции ввода-вывода . Само по себе высокое значение io_stallможет просто означать более высокую нагрузку и необязательно признак проблемы.

Томас Стрингер
источник
2
Ах, правильно, я понимаю, большое спасибо, надеюсь, моя ошибка окажется полезной для других.
Том
2
Это распространенная ошибка не только для статистики виртуальных файлов, но и для статистики ожидания. Рад, что это помогло!
Томас Стрингер