NetWorker: Analizowanie wydajności we/wy za pomocą ddboost_precert.log

Rejestrowanie Precert jest włączone jako krok rozwiązywania problemów, w którym problemy z kopią zapasową NetWorker Client Direct są uważane za związane z biblioteką Data Domain DD Boost klienta. To narzędzie może identyfikować problemy z wydajnością na podstawie zebranych dzienników precert.

Przygotowywanie ddboost_precert.log

Jako prosty przykład użycia: create ddboost_precert.ini w katalogu głównym systemu UNIX lub katalogu głównym C:\ dla systemu Windows. Plik powinien zawierać: 

precert_enabled=true
num_log_files=4
log_file_size=512
log_file_name=ddboost_precert.log
log_file_dir=/DDLog
ddcl_logs_include=true
ddcl_logs_sev=4

Zapoznaj się z artykułem Data Domain: Włącz rejestrowanie interfejsu API DD Boost za pomocą narzędzia precert (dzienniki precert), aby uzyskać pełne szczegóły proceduralne dotyczące zbierania dzienników precert. (wyświetlanie tego artykułu wymaga zalogowania się do pomocy technicznej firmy Dell)

Przygotowanie do użycia skryptu

Wymagania wstępne:  Python 3.x
Pobierz skrypt z: Narzędzia NetWorker (dell.com)

1. Zapisz skrypt w katalogu roboczym zawierającym dzienniki precert jako precert-io-perf.py.
2. W systemie UNIX upewnij się, że skrypt jest wykonywalny: chmod +x precert-io-perf.py
3. Uruchom skrypt: ./precert-io-perf.py

Monity wejściowe

• Po wyświetleniu monitu wprowadź pełną ścieżkę do pliku dziennika precert DD Boost.
• Wprowadź wartość Tak lub Nie po wyświetleniu monitu o uwzględnienie MB/s dla każdej operacji we/wy

Podsumowanie danych wyjściowych

Skrypt wyświetla podsumowanie operacji zapisu i odczytu, w tym:

• Łączna liczba operacji zapisu i odczytu
• Średni czas zapisu i odczytu
• Maksymalny i minimalny czas zapisu i odczytu wraz z ich przepustowością (MB/s)
• Łączny czas zapisu i odczytu
• Wartość procentowa całkowitego czasu poświęconego na zapis i odczyt
• Średnia przepustowość zapisu i odczytu (MB/s)
• Szczegółowe operacje we/wy

Skrypt rejestruje szczegółowe operacje we/wy w dwóch plikach CSV:

• io-write.log — zawiera szczegółowe informacje o każdej operacji zapisu
• io-read.log - zawiera szczegółowe informacje o każdej operacji odczytu

Przykładowe dane wyjściowe

# ./precert-io-perf.py
Please enter the full path to the log file: ./ddboost_precert.log
Do you want to include MB/s for each I/O operation? (yes/no): yes

    Write Durations Summary:

    Total number of write operations: 2646
    Average write duration: 0.005389 seconds
    Maximum write duration: 0.041000 seconds (24.39 MB/s)
    Minimum write duration: 0.000001 seconds (1000000.00 MB/s)
    Total write time: 14.259001 seconds
    Percentage of total time spent on writes: 22.99%
    Average write throughput: 185.566997 MB/s
    Note: High MB/s values for very short durations indicate efficient operations.


    Read Durations Summary:

    Total number of read operations: 2651
    Average read duration: 0.018018 seconds
    Maximum read duration: 31.838000 seconds (0.03 MB/s)
    Minimum read duration: 0.001000 seconds (1000.00 MB/s)
    Total read time: 47.766000 seconds
    Percentage of total time spent on reads: 77.01%
    Average read throughput: 55.499728 MB/s
    Note: High MB/s values for very short durations indicate efficient operations.


Top 20 Slowest Write I/O Operations:
1. I/O Number: 608, Duration: 0.041000 seconds, MB/s: 24.39
2. I/O Number: 2276, Duration: 0.038000 seconds, MB/s: 26.32
3. I/O Number: 1548, Duration: 0.025000 seconds, MB/s: 40.00
4. I/O Number: 2076, Duration: 0.025000 seconds, MB/s: 40.00
5. I/O Number: 636, Duration: 0.024000 seconds, MB/s: 41.67
6. I/O Number: 195, Duration: 0.023000 seconds, MB/s: 43.48
7. I/O Number: 892, Duration: 0.023000 seconds, MB/s: 43.48
8. I/O Number: 1451, Duration: 0.023000 seconds, MB/s: 43.48
9. I/O Number: 1539, Duration: 0.023000 seconds, MB/s: 43.48
10. I/O Number: 1987, Duration: 0.023000 seconds, MB/s: 43.48
11. I/O Number: 604, Duration: 0.022000 seconds, MB/s: 45.45
12. I/O Number: 896, Duration: 0.022000 seconds, MB/s: 45.45
13. I/O Number: 1283, Duration: 0.022000 seconds, MB/s: 45.45
14. I/O Number: 1532, Duration: 0.022000 seconds, MB/s: 45.45
15. I/O Number: 1544, Duration: 0.022000 seconds, MB/s: 45.45
16. I/O Number: 595, Duration: 0.021000 seconds, MB/s: 47.62
17. I/O Number: 616, Duration: 0.021000 seconds, MB/s: 47.62
18. I/O Number: 652, Duration: 0.021000 seconds, MB/s: 47.62
19. I/O Number: 1512, Duration: 0.021000 seconds, MB/s: 47.62
20. I/O Number: 1552, Duration: 0.021000 seconds, MB/s: 47.62

Top 20 Slowest Read I/O Operations:
1. I/O Number: 5900, Duration: 31.838000 seconds, MB/s: 0.03
2. I/O Number: 1614, Duration: 0.041000 seconds, MB/s: 24.39
3. I/O Number: 4950, Duration: 0.039000 seconds, MB/s: 25.64
4. I/O Number: 4550, Duration: 0.026000 seconds, MB/s: 38.46
5. I/O Number: 1670, Duration: 0.025000 seconds, MB/s: 40.00
6. I/O Number: 3494, Duration: 0.025000 seconds, MB/s: 40.00
7. I/O Number: 788, Duration: 0.023000 seconds, MB/s: 43.48
8. I/O Number: 1606, Duration: 0.023000 seconds, MB/s: 43.48
9. I/O Number: 2182, Duration: 0.023000 seconds, MB/s: 43.48
10. I/O Number: 3300, Duration: 0.023000 seconds, MB/s: 43.48
11. I/O Number: 3476, Duration: 0.023000 seconds, MB/s: 43.48
12. I/O Number: 3486, Duration: 0.023000 seconds, MB/s: 43.48
13. I/O Number: 4372, Duration: 0.023000 seconds, MB/s: 43.48
14. I/O Number: 2190, Duration: 0.022000 seconds, MB/s: 45.45
15. I/O Number: 2964, Duration: 0.022000 seconds, MB/s: 45.45
16. I/O Number: 3422, Duration: 0.022000 seconds, MB/s: 45.45
17. I/O Number: 3462, Duration: 0.022000 seconds, MB/s: 45.45
18. I/O Number: 4628, Duration: 0.022000 seconds, MB/s: 45.45
19. I/O Number: 5548, Duration: 0.022000 seconds, MB/s: 45.45
20. I/O Number: 1588, Duration: 0.021000 seconds, MB/s: 47.62
Detailed I/O operations have been logged to io-write.log and io-read.log


example of above analysis:

Percentage of total time spent on writes: 22.99%
Percentage of total time spent on reads: 77.01%

W tym przykładzie pokazano, jak wygląda problem z wydajnością w przypadku operacji odczytu danych w przeciwieństwie do operacji zapisu.