NVP vProxy: Los respaldos fallan de forma intermitente "Error de VDDK: 18000: No se puede conectar al host"
Resumen: Los respaldos de vProxy fallan intermitentemente con un error de conexión del kit de desarrollo de discos virtuales (VDDK) y es posible que una ejecución manual o una ejecución programada posterior se realice correctamente. ...
Síntomas
El error de conexión del disco VDDK muestra lo siguiente en /opt/emc/vproxy/runtime/logs/vbackupd/vbackupd-engine.log:
MM/DD/YYYY HH:MM:SS INFO: [99] Data Mover: Hard disk 1: Preparing for data movement.
MM/DD/YYYY HH:MM:SS ERROR: [99] Data Mover: Hard disk 1: VDDK: Failed to open source VMDK "[DATASTORE_NAME] VM_NAME/VM_NAME.vmdk": VDDK Error: 18000: Cannot connect to the host.
MM/DD/YYYY HH:MM:SS ERROR: [99] Data Mover: Hard disk 1: Failed to initialize Block Reader.
/opt/emc/vproxy/runtime/logs/vbackupd/vbackupd-vddk.log muestra lo siguiente:
MM/DD/YYYY HH:MM:SS NOTICE: VDDK INFO VixDiskLib: VixDiskLib_OpenEx: Open a disk.
MM/DD/YYYY HH:MM:SS NOTICE: VDDK INFO VixDiskLibVim: VixDiskLibVim_GetNfcTicket: Get NFC ticket for [DATASTORE_NAME] VM_NAME/VM_NAME.vmdk.
MM/DD/YYYY HH:MM:SS NOTICE: VDDK INFO VixDiskLibVim: Error 18000 (listener error GVmomiFaultInvalidResponse).
La falla de migración de almacenamiento muestra lo siguiente:
MM/DD/YYYY HH:MM:SS INFO: [99] Disabling storage migration of virtual machine ...
MM/DD/YYYY HH:MM:SS WARN: [99] Error disabling storage migration: VDDK Error: 18000: Cannot connect to the host., retrying.
MM/DD/YYYY HH:MM:SS INFO: [99] There are 3 certificates available at VCENTER_NAME. First one will be used.
MM/DD/YYYY HH:MM:SS ERROR: [99] Failed to disable storage migration for virtual machine "vm-###": VDDK Error: 18000: Cannot connect to the host.
MM/DD/YYYY HH:MM:SS ERROR: [99] Error disabling storage migration for virtual machine "VM_NAME".
La vbackupd-vddk.log del vProxy muestra lo siguiente:
MM/DD/YYYY HH:MM:SS NOTICE: VDDK INFO VixDiskLib: VixDiskLib_PrepareForAccess: Prepare to access disk.
MM/DD/YYYY HH:MM:SS NOTICE: VDDK INFO VixDiskLib: VixDiskLib_Connect: Establish connection.
MM/DD/YYYY HH:MM:SS NOTICE: VDDK INFO VixDiskLib: Resolve host.
MM/DD/YYYY HH:MM:SS NOTICE: VDDK INFO VixDiskLibVim: VixDiskLibVim_AllowVMotion: Disable VMotion.
MM/DD/YYYY HH:MM:SS NOTICE: VDDK INFO VixDiskLibVim: Error 18000 (listener error GVmomiFaultInvalidResponse).
El aumento de la depuración de VDDK ("vixDiskLib.transport.LogLevel = 4") en el archivo /opt/emc/vproxy/conf/VixDiskLib.config proporciona más información sobre el vbackup-vddk.log.
NetWorker VMware Protection (NVP)-vProxy: Cómo habilitar el registro de depuración
La salida de depuración de VDDK muestra lo siguiente:
MM/DD/YYYY HH:MM:SS NOTICE: VDDK INFO VixDiskLib: VixDiskLib_OpenEx: Open a disk.
MM/DD/YYYY HH:MM:SS NOTICE: VDDK INFO VixDiskLibVim: VixDiskLibVim_GetNfcTicket: Get NFC ticket for [DATASTORE_NAME] VM_NAME/VM_NAME.vmdk.
MM/DD/YYYY HH:MM:SS NOTICE: VDDK INFO 2019-10-24T13:19:20.348Z info -[7FF30C87D700] [Originator@6876 sub=Libs] GVmomi: Instantiating VMOMI session at https://VCENTER_IP:443/sdk
MM/DD/YYYY HH:MM:SS NOTICE: VDDK INFO 2019-10-24T13:19:20.348Z info -[7FF30C87D700] [Originator@6876 sub=Libs] GVmomi: Verifying SSL certificate with thumbprint AB:AB:AB:AB:AB:AB:AB:AB:AB:AB:AB:AB:AB:AB:AB:AB:AB:AB:AB:AB
MM/DD/YYYY HH:MM:SS NOTICE: VDDK INFO 2019-10-24T13:19:20.348Z info -[7FF30C87D700] [Originator@6876 sub=Libs] GVmomi: Certificate accepted
MM/DD/YYYY HH:MM:SS NOTICE: VDDK INFO 2019-10-24T13:19:20.453Z info -[7FF30C87D700] [Originator@6876 sub=Libs] BasicHttpOnSent: xmlReadMemory (NULL == xmlDoc) errorCode 0 responseCode 503 message
MM/DD/YYYY HH:MM:SS NOTICE: VDDK INFO VixDiskLibVim: Error 18000 (listener error GVmomiFaultInvalidResponse).
La depuración de falla de migración de almacenamiento muestra lo siguiente:
MM/DD/YYYY HH:MM:SS NOTICE: VDDK INFO VixDiskLib: VixDiskLib_Connect: Establish connection.
MM/DD/YYYY HH:MM:SS NOTICE: VDDK INFO VixDiskLib: Resolve host.
MM/DD/YYYY HH:MM:SS NOTICE: VDDK INFO VixDiskLibVim: VixDiskLibVim_AllowVMotion: Enable VMotion.
MM/DD/YYYY HH:MM:SS NOTICE: VDDK INFO 2019-10-24T13:20:11.512Z info -[7FF2CE7AE700] [Originator@6876 sub=Libs] GVmomi: Instantiating VMOMI session at https://VCENTER_IP:443/sdk
MM/DD/YYYY HH:MM:SS NOTICE: VDDK INFO 2019-10-24T13:20:11.512Z info -[7FF2CE7AE700] [Originator@6876 sub=Libs] GVmomi: Verifying SSL certificate with thumbprint AB:AB:AB:AB:AB:AB:AB:AB:AB:AB:AB:AB:AB:AB:AB:AB:AB:AB:AB:AB
MM/DD/YYYY HH:MM:SS NOTICE: VDDK INFO 2019-10-24T13:20:11.512Z info -[7FF2CE7AE700] [Originator@6876 sub=Libs] GVmomi: Certificate accepted
MM/DD/YYYY HH:MM:SS NOTICE: VDDK INFO 2019-10-24T13:20:11.612Z info -[7FF2CE7AE700] [Originator@6876 sub=Libs] BasicHttpOnSent: xmlReadMemory (NULL == xmlDoc) errorCode 0 responseCode 503 message
MM/DD/YYYY HH:MM:SS NOTICE: VDDK INFO VixDiskLibVim: Error 18000 (listener error GVmomiFaultInvalidResponse).Causa
503 Service Unavailable The server cannot handle the request (because it is overloaded or down for maintenance). Generally, this is a temporary state.
La vpxd.log de vCenter muestra que vCenter alcanza constantemente el límite de sesiones HTTP para la configuración durante la ventana de respaldo.
YYYY-MM-DD HH:MM:SS error vpxd[7FBB590AC700] [Originator@6876 sub=HTTP session map] Out of HTTP sessions: Limited to 2000
El dispositivo de respaldo vProxy de NetWorker requiere la conectividad de la sesión HTTP de vCenter durante el respaldo para realizar las funciones de vCenter. Las sesiones HTTP se están agotando en vCenter Server e impiden que el respaldo del vProxy inicie las conexiones HTTP necesarias.