NVP vProxy:对 NetWorker 备份期间的 VMware 快照问题进行故障处理。
Summary: 本知识库文章旨在作为 NetWorker 支持人员和管理员有关通过 NVP vProxy 一体机执行的虚拟机备份的参考。虚拟机备份失败,并显示与快照相关的错误。
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 Appliance:
通过 SSH 使用管理员帐户访问 vProxy 设备并执行了虚拟机备份。
虚拟机备份完成或失败后,会话日志将移至以下位置:
备份会话日志中显示的快照消息传送示例:
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 日志,可在以下位置找到:
相应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 用户界面访问此日志。日志文件包含在数据存储上的虚拟机文件夹中:

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
快照或整合错误的原因可能有所不同。有关某些已知原因的特定知识库文章,请参阅“其他备注”字段。
Resolution
下面是一些初始故障处理步骤:
日志:
检视上述 “症状 ”字段中提到的日志,了解快照或整合作失败原因的任何迹象。
手动快照测试:
如果在虚拟机备份作期间 VMware 快照失败,还应从 vSphere Web Client 检查 VMware 快照功能。
如果虚拟机备份是基于映像的标准备份,则不需要停顿快照。如果虚拟机是执行 MSVMAPPAGENT 应用程序一致性备份的 SQL 虚拟机,则必须执行停顿快照。
如果快照创建成功,请整合虚拟机并从 VMware vSphere 中删除虚拟机快照。如果在 NetWorker 之外执行的快照上观察到相同的快照错误,请联系 VMware 支持部门了解快照问题的根本原因。即使手动快照正在完成,也可能是其他因素促成的;例如:创建快照与执行备份时的 VMware vCenter 和数据存储/存储 I/O。
还可以在虚拟机上执行 Storage vMotion 以清理虚拟机文件。
ProxyHC 清理
如果使用以下选项,ProxyHC 实用程序也可用于对潜在的快照或磁盘相关问题执行一些清理:./ProxyHC tasks disk cleanup
NVP-vProxy:如何在 vProxy 一体机上使用运行状况检查工具 ProxyHC
Additional Information
有关虚拟机快照的概述,请参阅 VMware 知识库文章:https://kb.vmware.com/s/article/1015180
快照错误特定的知识库文章:
- NVP vProxy:虚拟机备份失败,并显示“快照已被删除或尚未完全创建”。
- NVP vProxy:虚拟机备份失败,并显示“无法获取创建快照任务的状态:作超时”
- NVP-vProxy:虚拟机备份失败,并显示“无法创建虚拟机的快照:未能创建快照。
- NetWorker vProxy 备份失败,并显示“Unable to create nonquiesced snapshot after a retry attempt:检测到无效的快照配置”
- NVP-vProxy:虚拟机在快照删除过程中失去连接。
- NVP-vProxy 分流指南:NetWorker VMware Protection vProxy 分流和日志收集指南
VMware: