Windows Server: Analysera en Storport-spårning med Excel och Xperf

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

Då skapas en kommaavgränsad fil (CSV) med namnet storport.csv. Den här filen kan nu öppnas i Microsoft Office Excel. Men om spårningen kördes under ett längre antal minuter, vilket resulterade i en stor ETL-fil och en kommaavgränsad fil med över en miljon rader, visas följande meddelande när du försöker öppna den i Excel:
 

I det här fallet är det praktiskt att använda PowerShell för att extrahera endast relevanta rader från den kommaavgränsade filen och med dessa skapa en ny kommaavgränsad fil innan du öppnar den i Excel.

• Gå tillbaka till PowerShell och ange kommandot:

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

(Ersätt "D:\Path" med enhetsbokstaven och katalogsökvägen som innehåller käll-CSV-filen som skapades i steg 2.)
 

Analysera resultaten i Microsoft Office Excel:

• Den resulterande filtrerade CSV-filen kan sorteras och filtreras efter kolumnerna "Timestamp", "RequestDuration_100ns" och "Target".
• Använd average-funktioner för att beräkna genomsnittlig svarstid.
• Tidsstämpel är en klocka eller timer som används för att beräkna hur lång tid det tar för I/O-begäran att slutföras.
• ”RequestDuration_100ns" är antalet hundradels nanosekunder som I/O-begäran tog att slutföra.
• "Mål" ser disknumret (disk 0, disk 1, disk 2 osv.)

Att markera "RequestDuration_100ns" kan du få en uppfattning om den genomsnittliga latensen:

 

Att använda vanliga Excel-filter och diagram kan hjälpa till att visualisera data enklare. Diagrammet nedan visar till exempel det utspridda diagrammet för de olika I/O-begäranden som samlats in under storport Spår för disk #1. Detta åstadkoms genom att skapa ett spridd diagram med kolumnerna "Tidsstämpel" och "RequestDuration_100ns" och sedan filtrera rådatatabellen i kolumnen "Target" med "1":

 

Observera att även om de flesta I/O-begäranden tar under 100 ms att slutföra, tar ett betydande antal över 100 ms. Vissa mer över 200 ms och det finns några som tar över 300 ms.
Om problemet som undersöks i det här exemplet är en flaskhals i diskprestanda är detta en viktig aspekt att tänka på för att avgöra om det finns diskkonkurrens.

På samma sätt visar diagrammet nedan de olika I/O-begärandena under storport trace men den här gången för disk #2 (filtrering av rådatatabellen i kolumnen "Target" med "2"):

 

I det här andra diagrammet ackumuleras den betydande majoriteten av I/O-begäranden till disk #2 långt under 15 ms (genomsnittet är 0,06 ms). Det skulle vara korrekt att säga att den här disken #2 inte visar några tecken på strid under detta storport spåra.