NVP-vProxy. Поиск и устранение неполадок с моментальными снимками VMware во время резервного копирования NetWorker.

• Защита виртуальных машин VMware осуществляется с помощью устройства NetWorker VMware Protection (NVP) vProxy.
• Резервному копированию не удается создать моментальный снимок VMware. Существует несколько разновидностей ошибок моментальных снимков. почти все они могут быть решены с помощью этой статьи базы знаний.
• Резервное копирование виртуальных машин завершается сбоем из-за оставшихся моментальных снимков, которые не были очищены в среде VMware.

Журналы.

Сервер NetWorker:

Журнал действий резервного копирования не предоставляет полных сведений о сбоях резервного копирования виртуальных машин и сообщает только о сбое действия. В нем будет указано, какие резервные копии виртуальных машин завершились сбоем. Проверьте журналы политик на сервере NetWorker. Там есть журналы сеансов, содержащие имя виртуальной машины:
Linux: /nsr/logs/policy/POLICY-NAME/WORKFLOW-NAME/####-VM-NAME-DATE.log
Windows: C:\Program Files\EMC NetWorker\nsr\policy\POLICY-NAME\WORKFLOW-NAME\####-VM-NAME-DATE.log
 

Устройство vProxy:

Получите доступ к устройству vProxy, выполнившему резервное копирование виртуальной машины, с помощью учетной записи администратора по протоколу SSH.

После завершения или сбоя резервного копирования виртуальной машины журнал сеанса перемещается в следующее расположение:

YYYY-MM-DDTHH:mm:SS INFO:   [@(#) Build number: 39] Creating snapshot of virtual machine ...
YYYY-MM-DDTHH:mm:SS INFO:   [@(#) Build number: 39] Create snapshot request succeeded.
YYYY-MM-DDTHH:mm:SS INFO:   [@(#) Build number: 39] Found snapshot "snapshot-4301".
YYYY-MM-DDTHH:mm:SS INFO:   [@(#) Build number: 39] Set custom attribute 'Dell EMC vProxy Cleanup Descriptor' value for object vm-1011 to '{"DataMover":"","SessionType":"BackupVmSessions","SessionUuid":"e282db86-a1b3-4599-ba97-89b5625df0e0","SessionStartTime":"2024-02-29T03:59:59Z","VmMORef":"vm-1011","VmName":"win-client02","VProxyMORef":"vm-4214","SnapshotMORef":"snapshot-4301","VmdkBaseFileNames":["","[esx02-datastore] win-client02/win-client02.vmdk"]}'.
YYYY-MM-DDTHH:mm:SS INFO:   [@(#) Build number: 39] Remove snapshot request accepted by Snapshot Manager.
YYYY-MM-DDTHH:mm:SS INFO:   [@(#) Build number: 39] Sent snapshot removal.

YYYY-MM-DDTHH:mm:SS NOTICE: Created snapshot 'NetWorker Backup Snapshot' (snapshot-4301) on 'vcsa.amer.lan' for virtual machine 'win-client02' (vm-1011) in 1.125928806s.
YYYY-MM-DDTHH:mm:SS NOTICE: Removed snapshot 'snapshot-4301' from VM 'win-client02' on vCenter 'vcsa.amer.lan' in 2.266872212s.
YYYY-MM-DDTHH:mm:SS INFO:   Found virtual machine 'win-client02' with MORef 'vm-1011'.
YYYY-MM-DDTHH:mm:SS NOTICE: Consolidated disks of VM 'snapshot-4301 (win-client02)' on vCenter 'vcsa.amer.lan' in 6.983942ms.
YYYY-MM-DDTHH:mm:SS NOTICE: Snapshot 'snapshot-4301' of virtual machine 'win-client02' (vm-1011) was removed.

VMware

Файл vmware.log виртуальной машины содержит сообщения о том, как VMware обрабатывает запросы на создание, удаление и консолидацию моментальных снимков виртуальной машины. Доступ к этому журналу можно получить из пользовательского веб-интерфейса vSphere. Файл журнала содержится в папке виртуальной машины в хранилище данных:

Пример типа ведения журнала, который наблюдается во время резервного копирования виртуальной машины NetWorker:

YYYY-MM-DDTHH:mm:SS In(05) vmx - VigorTransportProcessClientPayload: opID=6c61ca63-a-ab35 seq=1177113: Receiving Snapshot.Take request.
YYYY-MM-DDTHH:mm:SS In(05) vmx 6c61ca63-a-ab35 SnapshotVMX_TakeSnapshot start: 'NetWorker Backup Snapshot', deviceState=0, lazy=0, quiesced=0, forceNative=0, tryNative=1, saveAllocMaps=0
YYYY-MM-DDTHH:mm:SS In(05) vmx 6c61ca63-a-ab35 VVolObjNotifySnapshotPrepare: Changing state to VEC_SNAP_PREPARE_IN_PROG.
YYYY-MM-DDTHH:mm:SS In(05) vmx 6c61ca63-a-ab35 SNAPSHOT: SnapshotPrepareTakeDoneCB: Prepare phase complete (The operation completed successfully).
YYYY-MM-DDTHH:mm:SS In(05) vcpu-0 6c61ca63-a-ab35 SnapshotVMXTakeSnapshotWork: Transition to mode 0.
YYYY-MM-DDTHH:mm:SS In(05) vcpu-0 6c61ca63-a-ab35 SNAPSHOT: SnapshotConfigInfoOpenVmsd: Creating new snapshot dictionary, '/vmfs/volumes/64a73f34-81454bf4-704e-00505606578d/win-client02/win-client02.vmsd.usd'.
YYYY-MM-DDTHH:mm:SS In(05) vcpu-0 6c61ca63-a-ab35 SNAPSHOT: SnapshotDumperOpenFromInfo: Creating checkpoint file /vmfs/volumes/64a73f34-81454bf4-704e-00505606578d/win-client02/win-client02-Snapshot31.vmsn
YYYY-MM-DDTHH:mm:SS In(05) vcpu-0 6c61ca63-a-ab35 VVolObjNotifySnapshot: isEnabled: 1, state: 1 
YYYY-MM-DDTHH:mm:SS In(05) vcpu-0 6c61ca63-a-ab35 VVolObjNotifySnapshot: State changed to VEC_SNAP_SNAPSHOT_IN_PROG.
YYYY-MM-DDTHH:mm:SS In(05) vcpu-0 6c61ca63-a-ab35 SnapshotVMXTakeSnapshotWork: Transition to mode 1.
YYYY-MM-DDTHH:mm:SS In(05) vcpu-0 6c61ca63-a-ab35 SnapshotVMXTakeSnapshotComplete: Done with snapshot 'NetWorker Backup Snapshot': 31
YYYY-MM-DDTHH:mm:SS In(05) vcpu-0 6c61ca63-a-ab35 VVolObjNotifySnapshotDone: isEnabled: 1
YYYY-MM-DDTHH:mm:SS In(05) vcpu-0 6c61ca63-a-ab35 VigorTransport_ServerSendResponse opID=6c61ca63-a-ab35 seq=1177113: Completed Snapshot request.
YYYY-MM-DDTHH:mm:SS In(05) vmx - VigorTransportProcessClientPayload: opID=2d4be388-e6-ad11 seq=1177390: Receiving Snapshot.Delete request.
YYYY-MM-DDTHH:mm:SS In(05) vmx 2d4be388-e6-ad11 SNAPSHOT: SnapshotDeleteWork '/vmfs/volumes/64a73f34-81454bf4-704e-00505606578d/win-client02/win-client02.vmx' : 31
YYYY-MM-DDTHH:mm:SS In(05) vmx 2d4be388-e6-ad11 VigorTransport_ServerSendResponse opID=2d4be388-e6-ad11 seq=1177390: Completed Snapshot request.
YYYY-MM-DDTHH:mm:SS In(05) vmx - VigorTransportProcessClientPayload: opID=2d4be388-e6-ad11 seq=1177391: Receiving Snapshot.Consolidate request.
YYYY-MM-DDTHH:mm:SS In(05) vmx 2d4be388-e6-ad11 SnapshotVMX_Consolidate: Starting online snapshot consolidate operation.
YYYY-MM-DDTHH:mm:SS In(05) vmx 2d4be388-e6-ad11 Turning on snapshot info cache. VM=win-client02.vmx.
YYYY-MM-DDTHH:mm:SS In(05) vmx 2d4be388-e6-ad11 SNAPSHOT: Turning on snapshot disk cache.
YYYY-MM-DDTHH:mm:SS In(05) vmx 2d4be388-e6-ad11 SnapshotESXCombineProgressTotal: Snapshot consolidation progress: 0
YYYY-MM-DDTHH:mm:SS In(05) vmx - SnapshotESXCombineProgressTotal: Snapshot consolidation progress: 0
YYYY-MM-DDTHH:mm:SS In(05) vmx - SnapshotESXCombineProgressTotal: Snapshot consolidation progress: 0
YYYY-MM-DDTHH:mm:SS In(05) vmx - SnapshotESXCombineProgressTotal: Snapshot consolidation progress: 7
YYYY-MM-DDTHH:mm:SS In(05) vmx - SnapshotESXCombineProgressTotal: Snapshot consolidation progress: 7
YYYY-MM-DDTHH:mm:SS In(05) vmx - SnapshotESXCombineProgressTotal: Snapshot consolidation progress: 9
YYYY-MM-DDTHH:mm:SS In(05) vmx - SnapshotESXCombineProgressTotal: Snapshot consolidation progress: 10
YYYY-MM-DDTHH:mm:SS In(05) vmx - SnapshotESXCombineProgressTotal: Snapshot consolidation progress: 10
YYYY-MM-DDTHH:mm:SS In(05) vcpu-0 - VigorTransport_ServerSendResponse opID=2d4be388-e6-ad11 seq=1177391: Completed Snapshot request.
YYYY-MM-DDTHH:mm:SS In(05) vcpu-0 - Turning off snapshot info cache.
YYYY-MM-DDTHH:mm:SS In(05) vcpu-0 - Turning off snapshot disk cache.
YYYY-MM-DDTHH:mm:SS In(05) vcpu-0 - ConsolidateEnd: Snapshot consolidate complete: The operation completed successfully (0).

Вот несколько начальных шагов по поиску и устранению неисправностей.

Журналы.

Просмотрите журналы, указанные в поле «Признаки » выше, на наличие признаков сбоя создания моментального снимка или операции консолидации.

Тестирование моментальных снимков вручную:

Если во время резервного копирования виртуальной машины происходит сбой создания моментальных снимков VMware, необходимо также проверить работу моментальных снимков VMware в веб-клиенте vSphere. 
Если в качестве резервной копии виртуальной машины используется стандартное резервное копирование на основе образа, замороженный моментальный снимок не требуется. Если это виртуальная машина SQL, выполняющая согласованное с приложениями MSVMAPPAGENT резервное копирование, необходимо выполнить замороженный моментальный снимок.

Если моментальный снимок создан успешно, консолидируйте виртуальную машину и удалите моментальный снимок виртуальной машины из VMware vSphere. Если такая же ошибка наблюдается при создании моментальных снимков, выполненных вне NetWorker, обратитесь в службу поддержки VMware, чтобы выяснить основную причину проблемы с моментальными снимками. Даже если моментальные снимки, созданные вручную, завершаются, этому могут способствовать другие факторы. Например: Операции ввода-вывода VMware vCenter и хранилища данных/хранилища во время создания моментального снимка и во время выполнения резервного копирования. 

Очистка файла виртуальной машины

На виртуальной машине также можно выполнить Storage vMotion для очистки файлов виртуальной машины.

Очистка ProxyHC

Общие сведения о моментальных снимках виртуальных машин см. в статье базы знаний VMware: Обзор моментальных снимков виртуальных машин в vSphere 

Статьи базы знаний, связанные с ошибками моментальных снимков:

• NVP-vProxy. Сбой резервного копирования виртуальной машины с сообщением «моментальный снимок уже удален или создан не полностью»
• NVP-vProxy. Сбой резервного копирования виртуальной машины с сообщением «Не удалось получить состояние задачи создания моментального снимка: Время ожидания операции истекло»
• NVP-vProxy. Виртуальной машине не удастся выполнить резервное копирование с сообщением «Не удается создать моментальный снимок виртуальной машины: Не удалось создать моментальный снимок».
• Сбой резервного копирования NetWorker vProxy с сообщением «Не удается создать незамороженный моментальный снимок после повторной попытки: Обнаружена недопустимая конфигурация моментального снимка»
• NVP-vProxy. Виртуальная машина теряет подключение во время процесса удаления моментального снимка.
• Руководство по сортировке NVP-vProxy. Обзор рассмотрения и ведения журналов NetWorker VMware Protection vProxy

VMware

• Удаление моментального снимка останавливает виртуальную машину на длительное время (1002836)  
• Оценка времени, необходимого для консолидации снимков виртуальной машины (2053758)