NVP vProxy:故障診斷 NetWorker 備份期間的 VMware 快照問題。
Summary: 本 KB 旨在為 NetWorker 支援和系統管理員提供透過 NVP vProxy 裝置執行 VM 備份的相關參考。VM 備份失敗,並出現與快照相關的錯誤。
Symptoms
- VMware VM 可透過 NetWorker VMware Protection (NVP) vProxy 裝置獲得保護。
- 備份無法建立 VMware 快照。可能會出現一些快照錯誤變體;幾乎所有的問題都可以透過遵循此知識文章加以解決。
- VM 備份失敗,因為遺留快照未在 VMware 環境中清理。
記錄:
NetWorker 伺服器:
備份操作日誌不會提供有關 VM 備份失敗的任何全面詳細資訊,只會報告操作失敗。它會指出哪些 VM 備份失敗。檢查 NetWorker 伺服器上的原則記錄,將會有一個工作階段記錄,其中包含 VM 名稱:
Linux:/nsr/logs/policy/POLICY-NAME/WORKFLOW-NAME/####-VM-NAME-DATE
.logWindows:C:Program FilesEMC NetWorker srpolicyPOLICY-NAMEWORKFLOW-NAME####-VM-NAME-DATE.log
vProxy 裝置:
透過 SSH 使用管理員帳戶存取 vProxy 裝置以執行 VM 備份。
VM 備份完成或失敗後,工作階段記錄會移至下列位置:
備份工作階段記錄中顯示的快照訊息範例:
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:
VM 的vmware.log檔案將包含有關 VMware 處理 VM 快照建立、刪除和整合要求的訊息。可從 vSphere Web 使用者介面存取此記錄。記錄檔包含在資料存放區的虛擬機器資料夾中:

NetWorker VM 備份期間出現的記錄類型範例:
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
快照或整合錯誤的原因可能有所不同。如需特定已知原因的某些 KB,請參閱「其他備註」欄位。
Resolution
以下是一些初始故障診斷步驟:
日誌:
查看上述 “癥狀 ”字段中提到的日誌,以獲取有關快照或合併操作失敗原因的任何指標。
手動快照測試:
如果 VMware 快照在 VM 備份作業期間失敗,也應從 vSphere Web Client 檢查 VMware 快照功能。
如果 VM 備份是標準映像備份,則不需要靜止快照。如果 VM 是執行 MSVMAPPAGENT 應用程式一致備份的 SQL VM,則必須執行靜止快照。
如果快照建立成功,請整合 VM,然後從 VMware vSphere 刪除 VM 快照。如果在 NetWorker 之外執行的快照上發生相同的快照錯誤,請聯絡 VMware 支援,以瞭解快照問題的根本原因。即使手動快照正在完成,其他因素也可能導致這種情況;比如:拍攝快照與執行備份時的 VMware vCenter 和資料存放區/儲存 I/O。
亦可在 VM 上執行 Storage vMotion 以清理 VM 檔案。
ProxyHC 清理
如果使用下列選項,ProxyHC 公用程式也可用來清理潛在的快照或磁碟相關問題:./ProxyHC 工作磁碟清理
NVP-vProxy:如何在 vProxy 裝置上使用執行狀況檢查工具 ProxyHC
Additional Information
如需 VM 快照的概觀,請參閱 VMware KB:https://kb.vmware.com/s/article/1015180
快照錯誤特定 KB:
- NVP vProxy:VM 備份失敗,並顯示「快照已刪除或尚未完全建立」。
- NVP vProxy:VM 備份失敗,並顯示「無法取得建立快照工作的狀態:作業逾時」
- NVP-vProxy:虛擬機器無法備份,並顯示「無法建立虛擬機器的快照:無法建立快照。」
- NetWorker vProxy 備份失敗,並顯示「無法在重試嘗試後建立非靜止快照:偵測到無效的快照組態」
- NVP-vProxy:VM 在快照移除程序期間失去連線。
- NVP-vProxy 分級指南:NetWorker VMware Protection vProxy 分級和紀錄收集指南
VMware: