Start a Conversation

Unsolved

D

1 Rookie

 • 

82 Posts

4162

July 24th, 2019 09:00

Error disabling storage migration for virtual machine (migration enabled:true)

Hi Everyone a few weeks ago i have issues to backup somes VM with the error Error disabling storage migration for virtual machine "VM-example" 
I try this solution      but every failed VM  have migration enabled: true 

We have networker  9.1.1.3

Here  is a log example.:

 

2019/07/24 02:29:51 NOTICE: [189] Logging to '/opt/emc/vproxy/runtime/logs/vbackupd/2a3fc39d-5ef3-439e-b8c0-4a02429a64c5.log' on host 'nwprx-paip01'
2019/07/24 02:29:51 NOTICE: [189] Release: '2.0.2-11_1', Build number: '1', Build date: '2017-03-30T18:46:12Z'
2019/07/24 02:29:51 TRACE:  [189] Using locale "en", 67 messages.
2019/07/24 02:29:51 NOTICE: [189] Starting backup of "Fomento7-New" (vm-155) logging at level "TRACE" ...
2019/07/24 02:29:51 NOTICE: [189] BackupVmSessions supplied by client:
2019/07/24 02:29:51 NOTICE: [189] {
2019/07/24 02:29:51 NOTICE: [189]     "Config": {
2019/07/24 02:29:51 NOTICE: [189]         "SessionId": "2a3fc39d-5ef3-439e-b8c0-4a02429a64c5",
2019/07/24 02:29:51 NOTICE: [189]         "LogTag": "189",
2019/07/24 02:29:51 NOTICE: [189]         "LogLevel": "TRACE",
2019/07/24 02:29:51 NOTICE: [189]         "IdleTimeout": 300,
2019/07/24 02:29:51 NOTICE: [189]         "AcceptedLanguage": "en",
2019/07/24 02:29:51 NOTICE: [189]         "TransportModeRequested": "hotadd",
2019/07/24 02:29:51 NOTICE: [189]         "Parallelism": 1,
2019/07/24 02:29:51 NOTICE: [189]         "UseCbt": true,
2019/07/24 02:29:51 NOTICE: [189]         "VimServerRef": {
2019/07/24 02:29:51 NOTICE: [189]             "HostName": "vcenter-paip.xxx.xx",
2019/07/24 02:29:51 NOTICE: [189]             "TcpPort": 0,
2019/07/24 02:29:51 NOTICE: [189]             "UserName": "backup@vsphere.local",
2019/07/24 02:29:51 NOTICE: [189]             "UserPassword": "********",
2019/07/24 02:29:51 NOTICE: [189]             "ThumbPrint": ""
2019/07/24 02:29:51 NOTICE: [189]         },
2019/07/24 02:29:51 NOTICE: [189]         "VmSpec": {
2019/07/24 02:29:51 NOTICE: [189]             "Name": "Fomento7-New",
2019/07/24 02:29:51 NOTICE: [189]             "VmMoref": "vm-155",
2019/07/24 02:29:51 NOTICE: [189]             "VirtualDisks": [
2019/07/24 02:29:51 NOTICE: [189]                 {
2019/07/24 02:29:51 NOTICE: [189]                     "Label": "Hard disk 1",
2019/07/24 02:29:51 NOTICE: [189]                     "Key": 2000
2019/07/24 02:29:51 NOTICE: [189]                 },
2019/07/24 02:29:51 NOTICE: [189]                 {
2019/07/24 02:29:51 NOTICE: [189]                     "Label": "Hard disk 2",
2019/07/24 02:29:51 NOTICE: [189]                     "Key": 2001
2019/07/24 02:29:51 NOTICE: [189]                 },
2019/07/24 02:29:51 NOTICE: [189]                 {
2019/07/24 02:29:51 NOTICE: [189]                     "Label": "Hard disk 3",
2019/07/24 02:29:51 NOTICE: [189]                     "Key": 2002
2019/07/24 02:29:51 NOTICE: [189]                 }
2019/07/24 02:29:51 NOTICE: [189]             ],
2019/07/24 02:29:51 NOTICE: [189]             "CustomFieldName": "Last EMC vProxy Backup",
2019/07/24 02:29:51 NOTICE: [189]             "CustomFieldValue": "Backup Server=paipoterex, Policy=WMWARE FHVL, Workflow=VM_FILESERVERS, Action=backup, JobId=847324"
2019/07/24 02:29:51 NOTICE: [189]         },
2019/07/24 02:29:51 NOTICE: [189]         "SnapshotSpec": {
2019/07/24 02:29:51 NOTICE: [189]             "Name": "NetWorker Backup Snapshot",
2019/07/24 02:29:51 NOTICE: [189]             "Description": "Snapshot is created as part of protecting this VM by EMC NetWorker VProxy.",
2019/07/24 02:29:51 NOTICE: [189]             "Quiesce": false,
2019/07/24 02:29:51 NOTICE: [189]             "DumpMemory": false,
2019/07/24 02:29:51 NOTICE: [189]             "RemoveAll": false,
2019/07/24 02:29:51 NOTICE: [189]             "Consolidate": false
2019/07/24 02:29:51 NOTICE: [189]         },
2019/07/24 02:29:51 NOTICE: [189]         "TargetSpec": {
2019/07/24 02:29:51 NOTICE: [189]             "DeviceType": "DataDomain",
2019/07/24 02:29:51 NOTICE: [189]             "HostName": "paipotedata.xxxxx.cxl",
2019/07/24 02:29:51 NOTICE: [189]             "UserName": "nwboost",
2019/07/24 02:29:51 NOTICE: [189]             "UserPassword": "********",
2019/07/24 02:29:51 NOTICE: [189]             "BackupMode": "VSS",
2019/07/24 02:29:51 NOTICE: [189]             "BackupPath": "paipoteres/VM-01//paipoteres/VM-01/46/16/5909ba16-00000006-0f37c2ae-5d37c2ae-4ff36618-881ca6da",
2019/07/24 02:29:51 NOTICE: [189]             "PreviousBackupPath": "/paipoteres/VM-01/67/68/2cb0faab-00000006-1a0d92ad-5d0d92ad-2fe86618-881ca6da",
2019/07/24 02:29:51 NOTICE: [189]             "CurrentBackupPath": "/paipoteres/VM-01/active/5909ba16-00000006-0f37c2ae-5d37c2ae-4ff36618-881ca6da",
2019/07/24 02:29:51 NOTICE: [189]             "VBABackup": {
2019/07/24 02:29:51 NOTICE: [189]                 "VBABackupPath": "",
2019/07/24 02:29:51 NOTICE: [189]                 "VBATempPath": ""
2019/07/24 02:29:51 NOTICE: [189]             }
2019/07/24 02:29:51 NOTICE: [189]         },
2019/07/24 02:29:51 NOTICE: [189]         "ZeroFillUnusedSectors": false,
2019/07/24 02:29:51 NOTICE: [189]         "AutoEnableCbt": true,
2019/07/24 02:29:51 NOTICE: [189]         "AutoRepairCbt": true,
2019/07/24 02:29:51 NOTICE: [189]         "FallbackCbtThreshold": 0,
2019/07/24 02:29:51 NOTICE: [189]         "FallbackTransportMode": "",
2019/07/24 02:29:51 NOTICE: [189]         "DeprecatedREST": false,
2019/07/24 02:29:51 NOTICE: [189]         "ReadBufferMB": 0,
2019/07/24 02:29:51 NOTICE: [189]         "WriteBufferKB": 0,
2019/07/24 02:29:51 NOTICE: [189]         "BufferCount": 0
2019/07/24 02:29:51 NOTICE: [189]     },
2019/07/24 02:29:51 NOTICE: [189]     "Actions": {
2019/07/24 02:29:51 NOTICE: [189]         "ChangeSession": "",
2019/07/24 02:29:51 NOTICE: [189]         "DeleteSession": "/api/v1/BackupVmSessions/2a3fc39d-5ef3-439e-b8c0-4a02429a64c5",
2019/07/24 02:29:51 NOTICE: [189]         "CancelActivity": "/api/v1/BackupVmSessions/2a3fc39d-5ef3-439e-b8c0-4a02429a64c5/activity",
2019/07/24 02:29:51 NOTICE: [189]         "GetSession": "/api/v1/BackupVmSessions/2a3fc39d-5ef3-439e-b8c0-4a02429a64c5",
2019/07/24 02:29:51 NOTICE: [189]         "GetSessionLog": "/api/v1/BackupVmSessions/2a3fc39d-5ef3-439e-b8c0-4a02429a64c5/log",
2019/07/24 02:29:51 NOTICE: [189]         "GetAllSessions": "/api/v1/BackupVmSessions"
2019/07/24 02:29:51 NOTICE: [189]     },
2019/07/24 02:29:51 NOTICE: [189]     "Status": {
2019/07/24 02:29:51 NOTICE: [189]         "State": "Queued",
2019/07/24 02:29:51 NOTICE: [189]         "Description": "",
2019/07/24 02:29:51 NOTICE: [189]         "Progress": 0,
2019/07/24 02:29:51 NOTICE: [189]         "Error": {
2019/07/24 02:29:51 NOTICE: [189]             "Text": "",
2019/07/24 02:29:51 NOTICE: [189]             "Code": 0
2019/07/24 02:29:51 NOTICE: [189]         },
2019/07/24 02:29:51 NOTICE: [189]         "StartTime": "",
2019/07/24 02:29:51 NOTICE: [189]         "EndTime": "",
2019/07/24 02:29:51 NOTICE: [189]         "BytesToMove": 0,
2019/07/24 02:29:51 NOTICE: [189]         "BytesMoved": 0,
2019/07/24 02:29:51 NOTICE: [189]         "TransportModeUsed": "",
2019/07/24 02:29:51 NOTICE: [189]         "BackupModeUsed": ""
2019/07/24 02:29:51 NOTICE: [189]     }
2019/07/24 02:29:51 NOTICE: [189] }
2019/07/24 02:29:51 TRACE:  [189] Set state to running.
2019/07/24 02:29:51 TRACE:  [189] Sent initial status to vProxy Engine.
2019/07/24 02:29:51 TRACE:  [189] Opening session to target device "paipotedata.xxxxx.cxl" ...
2019/07/24 02:29:51 NOTICE: [189] DD Model = "DD6300", DDOS Version = "Data Domain OS 6.0.1.10-561375", DD Boost Version = "3.3.0.4-550644".
2019/07/24 02:29:51 TRACE:  [189] Opened session to target device "paipotedata.xxxxx.cxl".
2019/07/24 02:29:51 INFO:   [189] DDOS version 6.0.1.10-561375 compatible.
2019/07/24 02:29:51 TRACE:  [189] Verifying that target directory "/paipoteres/VM-01/active/5909ba16-00000006-0f37c2ae-5d37c2ae-4ff36618-881ca6da" on "paipotedata.xxxxx.cxl" is empty.
2019/07/24 02:29:51 TRACE:  [189] Opening target directory "/paipoteres/VM-01/active/5909ba16-00000006-0f37c2ae-5d37c2ae-4ff36618-881ca6da" on DD "paipotedata.xxxxx.cxl".
2019/07/24 02:29:51 INFO:   [189] Opened target directory "/paipoteres/VM-01/active/5909ba16-00000006-0f37c2ae-5d37c2ae-4ff36618-881ca6da" on DD "paipotedata.xxxxx.cxl".
2019/07/24 02:29:51 TRACE:  [189] Closing target directory "/paipoteres/VM-01/active/5909ba16-00000006-0f37c2ae-5d37c2ae-4ff36618-881ca6da" on DD "paipotedata.xxxxx.cxl".
2019/07/24 02:29:51 INFO:   [189] Closed target directory "/paipoteres/VM-01/active/5909ba16-00000006-0f37c2ae-5d37c2ae-4ff36618-881ca6da" on DD "paipotedata.xxxxx.cxl".
2019/07/24 02:29:51 TRACE:  [189] Converting VBA backup from  '' ...
2019/07/24 02:29:51 TRACE:  [189] Getting previous backup descriptor from "/paipoteres/VM-01/67/68/2cb0faab-00000006-1a0d92ad-5d0d92ad-2fe86618-881ca6da" ...
2019/07/24 02:29:51 TRACE:  [189] Opening Backup Descriptor file "/paipoteres/VM-01/67/68/2cb0faab-00000006-1a0d92ad-5d0d92ad-2fe86618-881ca6da/BackupDescriptor.json" ...
2019/07/24 02:29:51 INFO:   [189] Opened Backup Descriptor file "/paipoteres/VM-01/67/68/2cb0faab-00000006-1a0d92ad-5d0d92ad-2fe86618-881ca6da/BackupDescriptor.json" ...
2019/07/24 02:29:51 TRACE:  [189] Starting go routine to listen for cancel from vProxy engine.
2019/07/24 02:29:51 TRACE:  [189] Starting go routine to periodically send status updates...
2019/07/24 02:29:51 INFO:   [189] Loaded Backup Descriptor file "/paipoteres/VM-01/67/68/2cb0faab-00000006-1a0d92ad-5d0d92ad-2fe86618-881ca6da/BackupDescriptor.json".
2019/07/24 02:29:51 TRACE:  [189] Closing Backup Descriptor file "/paipoteres/VM-01/67/68/2cb0faab-00000006-1a0d92ad-5d0d92ad-2fe86618-881ca6da/BackupDescriptor.json" ...
2019/07/24 02:29:51 INFO:   [189] Closed Backup Descriptor file "/paipoteres/VM-01/67/68/2cb0faab-00000006-1a0d92ad-5d0d92ad-2fe86618-881ca6da/BackupDescriptor.json" ...
2019/07/24 02:29:51 INFO:   [189] Connected to session on vCenter 'vcenter-paip.xxxxx.cxl' Version '6.5.0 build-8024368, API:6.5', Uuid:ef4a6db1-7c65-4909-9195-5314c2bc614a.
2019/07/24 02:29:51 TRACE:  [189] Locating virtual machine associated with IP address 192.168.58.51 ...
2019/07/24 02:29:51 INFO:   [189] The vProxy's virtual machine has MORef ID = "vm-1857".
2019/07/24 02:29:51 TRACE:  [189] Searching for virtual machine with MORef "vm-155" ...
2019/07/24 02:29:51 TRACE:  [189] Querying vCenter for definition of virtual machine with MORef of "vm-155" ...
2019/07/24 02:29:52 INFO:   [189] Found virtual machine "Fomento7-New" with MORef "vm-155".
2019/07/24 02:29:52 TRACE:  [189] Check host'nodo-paip-01.xxxxx.cxl' connectionState:'connected',inMaintenanceMode:'false', powerState:poweredOn
2019/07/24 02:29:52 INFO:   [189] Host 'nodo-paip-01.xxxxx.cxl' is running VMware ESXi 6.5.0 build-7967591.
2019/07/24 02:29:52 INFO:   [189] Locking VM.
2019/07/24 02:29:52 TRACE:  [189] Setting custom attribute 'EMC vProxy Session' value for object vm-155 to 'Operation=Backup, StartTime=2019-07-24T02:29:51Z, vProxy=nwprx-paip01, SessionId=2a3fc39d-5ef3-439e-b8c0-4a02429a64c5' ...
2019/07/24 02:29:52 INFO:   [189] Set custom attribute 'EMC vProxy Session' value for object vm-155 to 'Operation=Backup, StartTime=2019-07-24T02:29:51Z, vProxy=nwprx-paip01, SessionId=2a3fc39d-5ef3-439e-b8c0-4a02429a64c5'.
2019/07/24 02:29:53 TRACE:  [189] Checking for old snapshots to cleanup ...
2019/07/24 02:29:53 INFO:   [189] Disabling storage migration of virtual machine ...
2019/07/24 02:29:53 TRACE:  [189] Disabling storage migration of virtual machine "vm-155" ...
2019/07/24 02:29:54 WARN:   [189] Error disabling storage migration, retrying, error: VDDK Error: 20005: The operation has been disabled by the guest operating system.
2019/07/24 02:29:54 ERROR:  [189] Failed to disable storage migration for virtual machine "vm-155": VDDK Error: 20005: The operation has been disabled by the guest operating system.
2019/07/24 02:29:54 ERROR:  [189] Error disabling storage migration for virtual machine "Fomento7-New".
2019/07/24 02:29:54 TRACE:  [189] Unlocking VM ...
2019/07/24 02:29:54 TRACE:  [189] Attemp #1 to clear virtual machine's custom field lock "EMC vProxy Session" ...
2019/07/24 02:29:54 TRACE:  [189] Setting custom attribute 'EMC vProxy Session' value for object vm-155 to '' ...
2019/07/24 02:29:54 INFO:   [189] Set custom attribute 'EMC vProxy Session' value for object vm-155 to ''.
2019/07/24 02:29:54 INFO:   [189] Unlocked virtual machine.
2019/07/24 02:29:54 INFO:   [189] Disconnected from session on vCenter 'vcenter-paip.xxxxx.cxl'.
2019/07/24 02:29:54 TRACE:  [189] Closing session with target device "paipotedata.xxxxx.cxl" ...
2019/07/24 02:29:54 INFO:   [189] Closed session with target device "paipotedata.xxxxx.cxl".
2019/07/24 02:29:54 TRACE:  [189] Checking final status...
2019/07/24 02:29:54 TRACE:  [189] Set state to failed.
2019/07/24 02:29:54 ERROR:  [189] Backup has FAILED.
2019/07/24 02:29:54 TRACE:  [189] Sending final status to vProxy Engine ...
2019/07/24 02:29:54 INFO:   [189] Sent final status to vProxy Engine.
2019/07/24 02:29:54 INFO:   [189] Go routine sending status updates has completed.
2019/07/24 02:29:54 INFO:   [189] Go routine listening for cancel messages from vProxy engine has completed.
2019/07/24 02:29:54 NOTICE: [189] Backup session is exiting

 

Thanks in advance.

2.4K Posts

July 24th, 2019 10:00

1 Rookie

 • 

82 Posts

July 24th, 2019 11:00

Hi Bingo, but it's the same link that i have  already referenced  the workaround works when migration enabled is false

.migration enabled: truemigration enabled: true ,

 

 

2.4K Posts

July 24th, 2019 11:00

Sorry - I did not open your link.

There is another link that may be useful:

  https://community.emc.com/docs/DOC-74698

In this doc it reads

1 - The Migration Status flag being left set as false     
      See KB:   495114 : NVP-vProxy: Error disabling storage migration, retrying, error: VDDK Error: 20005: The operation has been disabled by the guest operating system.

Unfortunately, accessing the url via the link is impossible. You might need to get in touch with Dell to get it.

 

1 Rookie

 • 

82 Posts

July 24th, 2019 13:00

Hi i am going to check, thanks.

No Events found!

Top