NVP vProxy:故障診斷 NetWorker 備份期間的 VMware 快照問題。

Summary: 本 KB 旨在為 NetWorker 支援和系統管理員提供透過 NVP vProxy 裝置執行 VM 備份的相關參考。VM 備份失敗,並出現與快照相關的錯誤。

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 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 裝置備份記錄中找到的資訊相同,請檢查是否有任何與快照建立失敗相關的訊息。

vProxy 裝置:

透過 SSH 使用管理員帳戶存取 vProxy 裝置以執行 VM 備份。

VM 備份完成或失敗後,工作階段記錄會移至下列位置:

/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:

VM 的vmware.log檔案將包含有關 VMware 處理 VM 快照建立、刪除和整合要求的訊息。可從 vSphere Web 使用者介面存取此記錄。記錄檔包含在資料存放區的虛擬機器資料夾中:

image.png

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

在 VM 備份開始時,vProxy 裝置會將快照要求傳送至 vCenter 伺服器。vCenter 伺服器負責建立和管理快照;任何觀察到的故障都會發生在 VMware 內部,且只會由 VMware API 回報給 NetWorker。

快照或整合錯誤的原因可能有所不同。如需特定已知原因的某些 KB,請參閱「其他備註」欄位。

Resolution

注意:必須聯絡 VMware 支援人員,以找出找出快照錯誤或問題的根本原因。這可能是在創建快照期間觀察到問題,還是在 snapmgr 日誌中發現其他問題(指示在快照刪除或整合期間出現問題)時。聯絡 NetWorker 支援 (如果尚未完成),VMware 和 NetWorker 之間的任何協同合作都可以據此進行協調。


以下是一些初始故障診斷步驟:

日誌:
查看上述 “癥狀 ”字段中提到的日誌,以獲取有關快照或合併操作失敗原因的任何指標。

手動快照測試:
如果 VMware 快照在 VM 備份作業期間失敗,也應從 vSphere Web Client 檢查 VMware 快照功能。
如果 VM 備份是標準映像備份,則不需要靜止快照。如果 VM 是執行 MSVMAPPAGENT 應用程式一致備份的 SQL VM,則必須執行靜止快照。

如果快照建立成功,請整合 VM,然後從 VMware vSphere 刪除 VM 快照。如果在 NetWorker 之外執行的快照上發生相同的快照錯誤,請聯絡 VMware 支援,以瞭解快照問題的根本原因。即使手動快照正在完成,其他因素也可能導致這種情況;比如:拍攝快照與執行備份時的 VMware vCenter 和資料存放區/儲存 I/O。 

image.png
VM 檔案清理
亦可在 VM 上執行 Storage vMotion 以清理 VM 檔案。

ProxyHC 清理
如果使用下列選項,ProxyHC 公用程式也可用來清理潛在的快照或磁碟相關問題:./ProxyHC 工作磁碟清理
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.