Windows Server: Analisando um rastreamento Storport com Excel e Xperf

xperf -i D:\Path\storport.etl -o D:\Path\storport.csv 

Isso cria um arquivo delimitado por vírgulas (CSV) chamado storport.csv. Agora, esse arquivo pode ser aberto no Microsoft Office Excel. No entanto, se o rastreamento foi executado por um longo número de minutos, resultando em um grande arquivo ETL e um arquivo delimitado por vírgulas com mais de um milhão de linhas, a seguinte mensagem será exibida ao tentar abri-lo no Excel:
 

Nesse caso, é conveniente usar o PowerShell para extrair apenas as linhas relevantes do arquivo delimitado por vírgulas e, com isso, criar um novo arquivo delimitado por vírgulas antes de abri-lo no Excel.

• De volta ao PowerShell, digite o comando:

 Get-Content D:\Path\storport.csv | Where-Object {$_ -like "Microsoft-Windows-Storport/Port/win:Info*"} | Set-Content D:\Path\filtered_storport.csv 

(Substitua "D:\Path" com a letra da unidade e o caminho do diretório que contêm o arquivo CSV de origem criado na etapa 2.)
 

Analise os resultados no Microsoft Office Excel:

• O arquivo CSV filtrado resultante pode ser classificado e filtrado pelas colunas "Timestamp", "RequestDuration_100ns" e "Target".
• Use funções médias para calcular a latência média.
• "Timestamp" é um relógio ou temporizador usado para calcular quanto tempo a solicitação de E/S leva para ser concluída.
• "RequestDuration_100ns" é o número de centenas de nanossegundos que a solicitação de E/S levou para ser concluída.
• "Destino" vê o número do disco (disco 0, disco 1, disco 2 etc.)

Destaque para o "RequestDuration_100ns", você pode ter uma ideia da latência média:

 

O uso de filtros e gráficos comuns do Excel pode ajudar a visualizar os dados com mais facilidade. Por exemplo, o gráfico abaixo mostra o gráfico disperso das várias solicitações de E/S capturadas durante o storport Rastreamento do disco #1. Isso é feito criando um gráfico disperso com as colunas "Timestamp" e "RequestDuration_100ns" e, em seguida, filtrando a tabela de dados brutos na coluna "Destino" por "1":

 

Observe que, embora a maioria das solicitações de E/S esteja levando menos de 100 ms para ser concluída, um número significativo leva mais de 100 ms; alguns com mais de 200 ms e alguns com mais de 300 ms.
Se o problema que está sendo investigado neste exemplo for um gargalo de desempenho do disco, esse seria um aspecto essencial a considerar para determinar se há conflito de acesso de disco.

Da mesma forma, o gráfico abaixo mostra as várias solicitações de E/S durante o storport trace, mas desta vez para o disco #2 (realizada a filtragem da tabela de dados brutos na coluna "Target" por "2"):

 

Neste segundo gráfico, a maioria significativa das solicitações de E/S para o disco #2 se acumula bem abaixo de 15 ms (a média é de 0,06 ms). Seria correto dizer que este disco #2 não está mostrando sinais de discórdia durante este storport traço.