NVP vProxy: Problemen met VMware snapshots oplossen tijdens NetWorker-back-ups.
Summary: Dit KB-artikel is bedoeld als referentie voor NetWorker-support en -beheerders met betrekking tot VM-back-ups die worden uitgevoerd via de NVP vProxy-appliance. VM-back-ups mislukken met een snapshot-gerelateerde fout. ...
Symptoms
- VMware VM's worden beschermd via de NetWorker VMware Protection (NVP) vProxy appliance.
- Back-ups kunnen geen VMware-snapshot maken. Er zijn een paar variaties van snapshotfouten die kunnen optreden; bijna alle kunnen worden aangepakt door deze KB te volgen.
- VM-back-ups mislukken als gevolg van overgebleven snapshots die niet zijn opgeschoond in de VMware-omgeving.
Logs:
NetWorker-server:
Het back-upactielogboek bevat geen uitgebreide details over de VM-back-upfouten en meldt alleen dat de actie is mislukt. Hierin staat welke VM-back-ups zijn mislukt. Controleer de beleidslogboeken op de NetWorker-server, er zal een sessielogboek zijn met de VM-naam:
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:
Toegang tot het vProxy-apparaat heeft de VM-back-up uitgevoerd met behulp van het admin-account via SSH.
Nadat de VM-back-up is voltooid of mislukt, wordt het sessielogboek verplaatst naar de volgende locatie:
Een voorbeeld van de snapshotberichten in het back-upsessielog:
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.
De vProxy heeft ook een snapmngr-logboek dat u kunt vinden onder:
Een voorbeeld van de bijbehorende 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:
Het vmware.log-bestand van de VM bevat berichten over de verwerking door VMware van de VM-snapshot voor het maken, verwijderen en consolideren van aanvragen. Dit logboek kan worden geopend via de webinterface van vSphere. Het logbestand bevindt zich in de map van de VM in de datastore:

Een voorbeeld van het type logboekregistratie dat wordt waargenomen tijdens NetWorker VM-back-ups:
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
De oorzaak van een snapshot- of consolidatiefout kan variëren. Zie het veld Aanvullende opmerkingen voor enkele KB's die specifiek zijn voor enkele bekende oorzaken.
Resolution
Hier volgen enkele eerste stappen voor probleemoplossing:
Logboeken:
controleer de logboeken in het bovenstaande veld Symptomen op indicatoren waarom de snapshot- of consolidatiebewerking is mislukt.
Handmatig testen van snapshots:
Als VMware-snapshots mislukken tijdens een VM-back-upbewerking, moet de functionaliteit van VMware-snapshots ook worden gecontroleerd vanuit de vSphere-webclient.
Als de VM-back-up een standaardback-up op basis van een image is, is een stille snapshot niet nodig. Als de VM een SQL-VM is die consistente back-ups van MSVMAPPAGENT-app uitvoert, moet een stille snapshot worden uitgevoerd.
Als de snapshot is gemaakt, consolideert u de VM en verwijdert u de VM-snapshot uit VMware vSphere. Als dezelfde snapshotfout wordt waargenomen op snapshots die buiten NetWorker worden uitgevoerd, neem dan contact op met VMware-support voor een hoofdoorzaak van het snapshotprobleem. Zelfs als de handmatige snapshots worden voltooid, kunnen andere factoren hieraan bijdragen; Bijvoorbeeld: VMware vCenter en Datastore/storage I/O wanneer de snapshot werd gemaakt versus wanneer de back-up werd uitgevoerd.
Er kan ook een Storage vMotion worden uitgevoerd op de VM om de VM-bestanden op te schonen.
ProxyHC opschonen
Het hulpprogramma ProxyHC kan ook worden gebruikt om mogelijke snapshot- of schijfgerelateerde problemen op te ruimen als de volgende opties worden gebruikt: ./ProxyHC tasks disk cleanup
NVP-vProxy: De healthcheck-tool ProxyHC gebruiken op een vProxy-apparaat
Additional Information
Zie VMware KB voor een overzicht van VM-snapshots: https://kb.vmware.com/s/article/1015180
Snapshot Error specifieke KB's:
- NVP vProxy: VM-back-up mislukt met "snapshot has already been deleted or has not been completely created".
- NVP vProxy: VM-back-up mislukt met 'Kan status van snapshottaak maken' niet ophalen: Operation timed out"
- NVP-vProxy: Virtuele machine kan geen back-up maken met "Kan geen snapshot van virtuele machine maken: Kan geen snapshot maken."
- NetWorker vProxy back-up mislukt met "Unable to create nonquiesced snapshot after a retry attempt: Detected an invalid snapshot configuration"
- NVP-vProxy: VM verliest verbinding tijdens het verwijderingsproces van de snapshot.
- NVP-vProxy Triage Guide: NetWorker VMware Protection vProxy Triage and Log Collection Guide
VMware: