NVP vProxy:对 NetWorker 备份期间的 VMware 快照问题进行故障处理。

Summary: 本知识库文章旨在作为 NetWorker 支持人员和管理员有关通过 NVP vProxy 一体机执行的虚拟机备份的参考。虚拟机备份失败,并显示与快照相关的错误。

This article applies to This article does not apply to This article is not tied to any specific product. Not all product versions are identified in this article.

Symptoms

  • VMware 虚拟机通过 NetWorker VMware Protection (NVP) vProxy 一体机进行保护。
  • 备份无法创建 VMware 快照。可能会出现一些快照错误的变化形式;几乎所有问题都可以通过遵循此知识库文章来解决。
  • 由于未在 VMware 环境中清理剩余快照,因此虚拟机备份失败。

日志:

NetWorker 服务器:

备份作日志不会提供有关虚拟机备份失败的任何全面详细信息,并且只会报告作失败。它将说明哪些虚拟机备份失败。检查 NetWorker 服务器上的策略日志,其中会有一个会话日志,其中包含虚拟机名称:
Linux:/nsr/logs/policy/POLICY-NAME/WORKFLOW-NAME/####-VM-NAME-DATE
.logWindows:C:Program FilesEMC NetWorker srpolicyPOLICY-NAMEWORKFLOW-NAME####-VM-NAME-DATE.log
 

提醒:这些会话日志与 vProxy 一体机 vbackupd 日志中的信息相同,请检查有关快照创建失败的任何消息。

vProxy Appliance:

通过 SSH 使用管理员帐户访问 vProxy 设备并执行了虚拟机备份。

虚拟机备份完成或失败后,会话日志将移至以下位置:

/opt/emc/vproxy/runtime/logs/recycle/vbackupd/DATE/

 

提醒:这些是可以在 NetWorker 服务器上找到的相同会话日志,如上所述。

备份会话日志中显示的快照消息传送示例:
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.

vProxy 还有一个 snapmngr 日志,可在以下位置找到:
/opt/emc/vproxy/runtime/logs/vbackupd/vbackupd-snapmgr.log

 

提醒:此日志包含有关发送到 VMware 的快照请求的消息:创建、删除和整合。

相应vbackupd-snapmgr.log的示例:
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 Web 用户界面访问此日志。日志文件包含在数据存储上的虚拟机文件夹中:

image.png

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).

Cause

虚拟机备份开始时,vProxy 一体机会向 vCenter Server 发送快照请求。vCenter Server 负责创建和管理快照;观察到的任何故障都在 VMware 中发生,并且仅通过 VMware API 报告回 NetWorker。

快照或整合错误的原因可能有所不同。有关某些已知原因的特定知识库文章,请参阅“其他备注”字段。

Resolution

提醒:必须联系 VMware 支持人员,以确定任何发现的快照错误或问题的根本原因。这可能是在快照创建过程中观察到的问题,也可能是在 snapmgr 日志中发现其他问题(指示在快照删除或整合期间出现问题)的原因。联系 NetWorker 支持人员(如果尚未联系),可以相应地协调 VMware 与 NetWorker 之间的任何协作。


下面是一些初始故障处理步骤:

日志:
检视上述 “症状 ”字段中提到的日志,了解快照或整合作失败原因的任何迹象。

手动快照测试:
如果在虚拟机备份作期间 VMware 快照失败,还应从 vSphere Web Client 检查 VMware 快照功能。
如果虚拟机备份是基于映像的标准备份,则不需要停顿快照。如果虚拟机是执行 MSVMAPPAGENT 应用程序一致性备份的 SQL 虚拟机,则必须执行停顿快照。

如果快照创建成功,请整合虚拟机并从 VMware vSphere 中删除虚拟机快照。如果在 NetWorker 之外执行的快照上观察到相同的快照错误,请联系 VMware 支持部门了解快照问题的根本原因。即使手动快照正在完成,也可能是其他因素促成的;例如:创建快照与执行备份时的 VMware vCenter 和数据存储/存储 I/O。 

image.png
虚拟机文件清理
还可以在虚拟机上执行 Storage vMotion 以清理虚拟机文件。

ProxyHC 清理
如果使用以下选项,ProxyHC 实用程序也可用于对潜在的快照或磁盘相关问题执行一些清理:./ProxyHC tasks disk cleanup
NVP-vProxy:如何在 vProxy 一体机上使用运行状况检查工具 ProxyHC

Additional Information

Affected Products

NetWorker

Products

NetWorker Family, NetWorker Series
Article Properties
Article Number: 000201426
Article Type: Solution
Last Modified: 10 Jan 2025
Version:  10
Find answers to your questions from other Dell users
Support Services
Check if your device is covered by Support Services.