cancel
Showing results for 
Search instead for 
Did you mean: 

Vmware Restore from an imported image fails on san

Hamza_H
Moderator
Moderator
   VIP   

Hello All,

 

We are facing a problem when we try to restore an imported Vmware image which its backup succeded in SAN mode.

The restore job fails with error "Error opening the snapshot disks using given transport mode: san Status 23"

 

and the vxms logs are showing :

Transport mode san failed pre-flight check. Ignoring.

 

09:46:08.0373 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] VixDiskLib: VixDiskLib_ConnectEx: No transport modes available to access disks. Error 3 (One of the parameters was invalid) at 4433.

09:46:08.0373 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] VixDiskLib: VixDiskLib_Disconnect: Disconnect.

09:46:08.0373 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.373+02:00 info -[12000] [Originator@6876 sub=Default] Successfully released all resources.

 

The datastores are presented to the Media & Master servers.

The restore through nbd is successful.

 

we did another test by backuping the same VM throught the 2nd master via SAN and it completed succesfully.

This same backup was replicated to the 1st master and try to do the restore via SAN, also failed.

 

any ideas please?

 

thanks

1 ACCEPTED SOLUTION

Accepted Solutions

Hamza_H
Moderator
Moderator
   VIP   

Hello All,

We have found the problem and fixed it.

On restore panel, we changed the server used for restore from the master server to the media server (it is normal because the media server is the one who can access to the datastores and not the master).

On the master from where the VM was backed up, it is not necessary to change it, because the media server is already known as Vm backup host, but on the other side (replicated image) you must show to netbackup that the VMbackup host is the media server.

I am marking this one as solution hopefully that can help the others.

BR.

H.

View solution in original post

9 REPLIES 9

Michal_Mikulik1
Moderator
Moderator
Partner    VIP    Accredited Certified

Hello,

 

was it ever working? The fact that it is an imported image is not probably relevant. Find a cause on SAN/Disk Mgmt. My tip is that your disks are Offline in the Disk management, which is sufficient for backups but not for restores.

Regards

M.

Hamza_H
Moderator
Moderator
   VIP   

Hello Michal,

This is a new test, so never tested.

Please what do you mean by "The fact that it is an imported image is not probably relevant. "

The disks are Online in the Disk management, the restore works from the primary copy of both masters, it only fails using the imported image.

should we try to select the media server in the BAR GUI instead of the master to try?

Regards

H.

Michal_Mikulik1
Moderator
Moderator
Partner    VIP    Accredited Certified

Hello,

doublecheck that all datastores presented on source Master/Media Server are presented on target server, too.

For a while a had an idea if a different mapping could not be a problem, but I think that VMware API should cope with this (for example, when datastore X is presented as Disk 4 to server A and as Disk 5 to server B). Try to choose the Restore as Alternate instead of Original, keeping every parameter the same.

Regards

Michal

Hamza_H
Moderator
Moderator
   VIP   

Hello Michal,

 

Thanks for your reply,

 

I double checked, and all the datastores are presented.

- One question, should the DS be presented to the target master too? I only thought it should be only the VM backup host (media server) even if its not the original of the backup? because the target media server can backup the vm on SAN..so it confirms that the DS are already presented to the target media server.. but should they be presented to the larget master too?

 

for the mapping thing, we had already tried the alternate restore (to another datastore) and it also fails :(

 

Regards,

 

H.

Michal_Mikulik1
Moderator
Moderator
Partner    VIP    Accredited Certified

Hello,

DS's presentation to the Backup Host is enough. No need to present them on the Master.

Regards

M.

Hamza_H
Moderator
Moderator
   VIP   

Hello @Michal_Mikulik1 ,

Thanks for the confirmation,

So any other ideas please?

Regards,

H.

Marianne
Moderator
Moderator
Partner    VIP    Accredited Certified

Please see if anything in this TN helps (https://www.veritas.com/content/support/en_US/article.100030882.html :(

Best practices around SAN:

  • For using SAN, make sure that datastore LUNs are accessible to the VMware Backup Host.
  • SAN transport is usually the best choice for backups when running on a physical VMware Backup Host. However, it is disabled inside virtual machines, so use HotAdd instead on a virtual VMware Backup Host.
  • SAN transport is not always the best choice for restores. It offers the best performance on thick disks, but the worst performance on thin disks, because of the way vStorage APIs work. For thin disk restore, LAN(NBD) is faster.
  • For SAN restores, disk size should be a multiple of the underlying VMFS block size, otherwise the write to the last fraction of a disk will fail. For example, if virtual disk has a 1MB block size and the datastore is 16.3MB large, the last 0.3MB will not get written. The workaround in this case would be to use NBD for restores of such Virtual Machines.
  • When using SAN transport or hot-add mode on a Windows Server 2008/2008 R2 VMware Backup Host, make sure to set:
    •  SAN policy to onlineAll
    •  SAN disk as read-only, except during restores

..................

ERR - Error opening the snapshot disks using given transport mode: Status 23  indicates that there was some problem in accessing the vmdk using given transport mode.

Here are some tips on handling this kind of error:

file write failed  indicates that there might be some problem in writing to the VMDK using the given transport mode.

  • If using SAN for restores, please make sure datastore LUNs are accessible to the VMware Backup Host and in an online state.
  • If using HotAdd for restore, please make sure that SAN policy on the Backup Host is set to OnlineAll.
  • If using SAN for restore, make sure that the size of VMDK is multiple of datastore block size.  Otherwise, the write of the last block will fail.  In this case, a workaround would be to use NBD for restore.
  • Please make sure that the you assign necessary privileges to the user configured in NetBackup or Backup Exec to log on to vSphere.

Hamza_H
Moderator
Moderator
   VIP   

Hello @Marianne,

Thank you for your reply,

I have been through these recommendations and I confirm you this :

- The datastores luns are accessible to the vmware backup host (otherwise the backup/restore from the original backup master wouldn't work.

- About the disk size, I don't think this would be the problem, as the restore doesn't even start writing and as mentionned, the restore from the image's first backup succeeds over SAN, the problem is just with the imported images.

- The Vm backup host is on W2016 standard.

- The user has the necessary privileges.

 

on the vxms logs, i have several messages to this kind :

09:46:08.0154 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.154+02:00 info -[12000] [Originator@6876 sub=Libs] FILE: FileCreateDirectoryRetry: Non-retriable error encountered (C:\ProgramData\VMware): Cannot create a file when that file already exists (183)

09:46:08.0154 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.154+02:00 info -[12000] [Originator@6876 sub=Libs] FILE: FileCreateDirectoryRetry: Non-retriable error encountered (C:\ProgramData\VMware\VMware Workstation): Cannot create a file when that file already exists (183)

09:46:08.0154 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.154+02:00 info -[12000] [Originator@6876 sub=Libs] DictionaryLoad: Cannot open file "C:\ProgramData\VMware\VMware Workstation\config.ini": The system cannot find the file specified.

09:46:08.0154 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.154+02:00 info -[12000] [Originator@6876 sub=Libs] [msg.dictionary.load.openFailed] Cannot open file "C:\ProgramData\VMware\VMware Workstation\config.ini": The system cannot find the file specified.

09:46:08.0154 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.154+02:00 info -[12000] [Originator@6876 sub=Libs] PREF Optional preferences file not found at C:\ProgramData\VMware\VMware Workstation\config.ini. Using default values.

09:46:08.0154 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.154+02:00 info -[12000] [Originator@6876 sub=Libs] FILE: FileCreateDirectoryRetry: Non-retriable error encountered (C:\ProgramData\VMware): Cannot create a file when that file already exists (183)

09:46:08.0154 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.154+02:00 info -[12000] [Originator@6876 sub=Libs] FILE: FileCreateDirectoryRetry: Non-retriable error encountered (C:\ProgramData\VMware\VMware Workstation): Cannot create a file when that file already exists (183)

09:46:08.0154 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.154+02:00 info -[12000] [Originator@6876 sub=Libs] FILE: FileCreateDirectoryRetry: Non-retriable error encountered (C:\ProgramData\VMware): Cannot create a file when that file already exists (183)

09:46:08.0154 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.154+02:00 info -[12000] [Originator@6876 sub=Libs] FILE: FileCreateDirectoryRetry: Non-retriable error encountered (C:\ProgramData\VMware\VMware Workstation): Cannot create a file when that file already exists (183)

09:46:08.0154 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.154+02:00 info -[12000] [Originator@6876 sub=Libs] DictionaryLoad: Cannot open file "C:\ProgramData\VMware\VMware Workstation\settings.ini": The system cannot find the file specified.

09:46:08.0154 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.154+02:00 info -[12000] [Originator@6876 sub=Libs] [msg.dictionary.load.openFailed] Cannot open file "C:\ProgramData\VMware\VMware Workstation\settings.ini": The system cannot find the file specified.

09:46:08.0154 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.154+02:00 info -[12000] [Originator@6876 sub=Libs] PREF Optional preferences file not found at C:\ProgramData\VMware\VMware Workstation\settings.ini. Using default values.

09:46:08.0154 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.154+02:00 info -[12000] [Originator@6876 sub=Libs] DictionaryLoad: Cannot open file "C:\ProgramData\VMware\VMware Workstation\config.ini": The system cannot find the file specified.

09:46:08.0154 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.154+02:00 info -[12000] [Originator@6876 sub=Libs] [msg.dictionary.load.openFailed] Cannot open file "C:\ProgramData\VMware\VMware Workstation\config.ini": The system cannot find the file specified.

09:46:08.0154 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.154+02:00 info -[12000] [Originator@6876 sub=Libs] PREF Optional preferences file not found at C:\ProgramData\VMware\VMware Workstation\config.ini. Using default values.

09:46:08.0154 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.154+02:00 info -[12000] [Originator@6876 sub=Libs] DictionaryLoad: Cannot open file "C:\Users\netbackup\AppData\Roaming\VMware\config.ini": The system cannot find the file specified.

09:46:08.0154 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.154+02:00 info -[12000] [Originator@6876 sub=Libs] [msg.dictionary.load.openFailed] Cannot open file "C:\Users\netbackup\AppData\Roaming\VMware\config.ini": The system cannot find the file specified.

09:46:08.0154 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.154+02:00 info -[12000] [Originator@6876 sub=Libs] PREF Optional preferences file not found at C:\Users\netbackup\AppData\Roaming\VMware\config.ini. Using default values.

09:46:08.0154 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.154+02:00 info -[12000] [Originator@6876 sub=Libs] UUID: SMBIOS UUID is reported as '42 3c 15 74 87 7f bd ed-28 77 60 79 3d 33 c8 f2'.

09:46:08.0154 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.154+02:00 info -[12000] [Originator@6876 sub=Libs] FILE: FileLockDynaLink: Further process validation tools are: available

09:46:08.0170 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.170+02:00 info -[12000] [Originator@6876 sub=Libs] DictionaryLoad: Cannot open file "C:\Users\netbackup\AppData\Roaming\VMware\preferences.ini": The system cannot find the file specified.

09:46:08.0170 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.170+02:00 info -[12000] [Originator@6876 sub=Libs] [msg.dictionary.load.openFailed] Cannot open file "C:\Users\netbackup\AppData\Roaming\VMware\preferences.ini": The system cannot find the file specified.

09:46:08.0170 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.170+02:00 info -[12000] [Originator@6876 sub=Libs] PREF Optional preferences file not found at C:\Users\netbackup\AppData\Roaming\VMware\preferences.ini. Using default values.

09:46:08.0170 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.170+02:00 info -[12000] [Originator@6876 sub=Libs] lib/ssl: OpenSSL using FIPS_drbg for RAND

09:46:08.0170 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.170+02:00 info -[12000] [Originator@6876 sub=Libs] lib/ssl: protocol list tls1.2

09:46:08.0170 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.170+02:00 info -[12000] [Originator@6876 sub=Libs] lib/ssl: protocol list tls1.2 (openssl flags 0x17000000)

09:46:08.0170 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.170+02:00 info -[12000] [Originator@6876 sub=Libs] lib/ssl: cipher list !aNULL:kECDH+AESGCM:ECDH+AESGCM:RSA+AESGCM:kECDH+AES:ECDH+AES:RSA+AES

09:46:08.0170 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.170+02:00 info -[12000] [Originator@6876 sub=Libs] FILE: FileCreateDirectoryRetry: Non-retriable error encountered (C:\ProgramData\VMware): Cannot create a file when that file already exists (183)

09:46:08.0170 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.170+02:00 info -[12000] [Originator@6876 sub=Libs] FILE: FileCreateDirectoryRetry: Non-retriable error encountered (C:\ProgramData\VMware): Cannot create a file when that file already exists (183)

09:46:08.0170 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.170+02:00 info -[12000] [Originator@6876 sub=Libs] FILE: FileCreateDirectoryRetry: Non-retriable error encountered (C:\ProgramData\VMware): Cannot create a file when that file already exists (183)

09:46:08.0170 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.170+02:00 info -[12000] [Originator@6876 sub=Libs] FILE: FileCreateDirectoryRetry: Non-retriable error encountered (C:\ProgramData\VMware): Cannot create a file when that file already exists (183)

09:46:08.0170 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.170+02:00 info -[12000] [Originator@6876 sub=Libs] FILE: FileCreateDirectoryRetry: Non-retriable error encountered (C:\ProgramData\VMware): Cannot create a file when that file already exists (183)

09:46:08.0170 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] 2019-09-26T09:46:08.170+02:00 info -[12000] [Originator@6876 sub=Default] Vmacore::InitSSL: handshakeTimeoutUs = 20000000

09:46:08.0170 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] FILE: FileCreateDirectoryRetry: Non-retriable error encountered (C:\ProgramData\VMware): Cannot create a file when that file already exists (183)

09:46:08.0170 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] FILE: FileCreateDirectoryRetry: Non-retriable error encountered (C:\ProgramData\VMware\VMware Virtual Disk Development Kit): Cannot create a file when that file already exists (183)

09:46:08.0170 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] DictionaryLoad: Cannot open file "C:\ProgramData\VMware\VMware Virtual Disk Development Kit\config.ini": The system cannot find the file specified.

09:46:08.0170 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] [msg.dictionary.load.openFailed] Cannot open file "C:\ProgramData\VMware\VMware Virtual Disk Development Kit\config.ini": The system cannot find the file specified.

09:46:08.0170 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] PREF Optional preferences file not found at C:\ProgramData\VMware\VMware Virtual Disk Development Kit\config.ini. Using default values.

09:46:08.0170 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] FILE: FileCreateDirectoryRetry: Non-retriable error encountered (C:\ProgramData\VMware): Cannot create a file when that file already exists (183)

09:46:08.0170 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] FILE: FileCreateDirectoryRetry: Non-retriable error encountered (C:\ProgramData\VMware\VMware Virtual Disk Development Kit): Cannot create a file when that file already exists (183)

09:46:08.0170 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] FILE: FileCreateDirectoryRetry: Non-retriable error encountered (C:\ProgramData\VMware): Cannot create a file when that file already exists (183)

09:46:08.0170 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] FILE: FileCreateDirectoryRetry: Non-retriable error encountered (C:\ProgramData\VMware\VMware Virtual Disk Development Kit): Cannot create a file when that file already exists (183)

09:46:08.0170 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] DictionaryLoad: Cannot open file "C:\ProgramData\VMware\VMware Virtual Disk Development Kit\settings.ini": The system cannot find the file specified.

09:46:08.0170 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] [msg.dictionary.load.openFailed] Cannot open file "C:\ProgramData\VMware\VMware Virtual Disk Development Kit\settings.ini": The system cannot find the file specified.

09:46:08.0170 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] PREF Optional preferences file not found at C:\ProgramData\VMware\VMware Virtual Disk Development Kit\settings.ini. Using default values.

09:46:08.0170 : g_vixInterfaceLogger:libvix.cpp:1805 <DEBUG> : [VFM_ESINFO] DictionaryLoad: Cannot open file "C:\ProgramData\VMware\VMware Virtual Disk Development Kit\config.ini": The system cannot find the file specified.

 

 

Hamza_H
Moderator
Moderator
   VIP   

Hello All,

We have found the problem and fixed it.

On restore panel, we changed the server used for restore from the master server to the media server (it is normal because the media server is the one who can access to the datastores and not the master).

On the master from where the VM was backed up, it is not necessary to change it, because the media server is already known as Vm backup host, but on the other side (replicated image) you must show to netbackup that the VMbackup host is the media server.

I am marking this one as solution hopefully that can help the others.

BR.

H.