NetWorker: Cómo analizar el rendimiento de I/O mediante ddboost_precert.log

El registro de certificación previa se habilita como un paso de solución de problemas en el que se cree que los problemas de respaldo de NetWorker Client Direct están relacionados con la biblioteca de Data Domain Boost del cliente. Esta utilidad puede identificar problemas de rendimiento a partir de los registros de certificación previa recopilados.

Preparación ddboost_precert.log

Como ejemplo de uso simple, cree ddboost_precert.ini en la raíz de UNIX o en la raíz de C:\ para Windows. El archivo debe contener lo siguiente: 

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

Consulte el artículo Data Domain: Habilite el registro de la API de DD Boost con la herramienta de precertificación (registros de precertificación) a fin de obtener detalles completos del procedimiento para recopilar registros de precertificación. (es necesario iniciar sesión en el soporte de Dell para ver este artículo)

Preparación para usar el script

Requisitos previos:  Python 3.x
Descargue el script desde: Soluciones Herramientas de NetWorker (dell.com)

1. Guarde el script en un directorio de trabajo que contenga los registros de precertificados como precert-io-perf.py.
2. En los sistemas UNIX, asegúrese de que el script sea ejecutable: chmod +x precert-io-perf.py
3. Ejecute el script: ./precert-io-perf.py

Indicaciones de entrada

• Ingrese la ruta completa al archivo de registro de certificación previa de DD Boost cuando se le solicite.
• Ingrese Sí o No cuando se le pregunte si desea incluir MB/s para cada operación de I/O

Resumen de salida

El script muestra un resumen de las operaciones de escritura y lectura, incluido lo siguiente:

• Cantidad total de operaciones de escritura y lectura
• Duración promedio de escritura y lectura
• Duración máxima y mínima de escritura y lectura, junto con su respectivo rendimiento (MB/s)
• Tiempo total de escritura y lectura
• Porcentaje del tiempo total dedicado a la escritura y la lectura
• Rendimiento promedio de escritura y lectura (MB/s)
• Operaciones de I/O detalladas

El script registra las operaciones de I/O detalladas en dos archivos CSV:

• io-write.log: contiene información detallada sobre cada operación de escritura
• io-read.log: contiene información detallada sobre cada operación de lectura

Ejemplo de salida

# ./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%

En este ejemplo, se muestra cómo aparece el problema de rendimiento con la operación de lectura de los datos en lugar de las operaciones de escritura.