Status code 156 or 4258 for Hyper-V

[KirillKrotov]

Greetings!

I woukd like to backup Hyper pass-through disk. I configured appropriate policy, backup was not succesfully. If i perform off-host backup in Hyper-V tab of that policy i get 156 error code, in another case 4258 error code. 

It fail to create snapshot. Some entries from bpfis:

11:28:48.843 [11064.13212] <2> onlfi_vfms_logf: INF - vfm_fi_get_credentials: No disk array credentials found on server
11:28:48.843 [11064.13212] <2> onlfi_add_to_fim_list: INF - snapshot method=VSS
11:28:48.843 [11064.13212] <2> onlfi_add_to_fim_list: INF - snapshot method=VSS_OST
11:28:48.843 [11064.13212] <2> onlfi_add_to_fim_list: INF - snapshot method=OST_FIM
11:28:48.843 [11064.13212] <2> onlfi_vfms_logf: INF - FlashSnap_init: Veritas Volume Manager not installed.
11:28:48.843 [11064.13212] <2> onlfi_initialize_vfms: INF - Extracting snapshot client error = 0
11:28:48.843 [11064.13212] <8> onlfi_initialize_vfms: WRN - VfMS error 10; see following messages:
11:28:48.843 [11064.13212] <8> onlfi_initialize_vfms: WRN - Non-fatal method error was reported
11:28:48.843 [11064.13212] <8> onlfi_initialize_vfms: WRN -
11:28:48.843 [11064.13212] <8> onlfi_initialize_vfms: WRN - VfMS method error 0; see following message:
11:28:48.843 [11064.13212] <8> onlfi_initialize_vfms: WRN -
11:28:48.858 [11064.13212] <2> onlfi_vfms_logf: INF - HVLOG : HV_set_locale - FIAPI called: HV_set_locale [../hyperv.cpp:361]
11:28:48.858 [11064.13212] <2> onlfi_add_to_fim_list: INF - snapshot method=HV
11:28:48.858 [11064.13212] <2> onlfi_vfms_logf: INF - HVLOG : HV_set_logf - FIAPI called: HV_set_logf [../hyperv.cpp:47]
11:28:48.858 [11064.13212] <2> onlfi_vfms_logf: INF - HVLOG : HV_set_locale - FIAPI called: HV_set_locale [../hyperv.cpp:361]
11:28:48.858 [11064.13212] <2> onlfi_add_to_fim_list: INF - snapshot method=remote_vxfs
11:28:48.874 [11064.13212] <2> onlfi_vfms_logf: INF - vxvm_init: Veritas Volume Manager not installed.
11:28:48.874 [11064.13212] <2> onlfi_initialize_vfms: INF - Extracting snapshot client error = 0
11:28:48.874 [11064.13212] <8> onlfi_initialize_vfms: WRN - VfMS error 10; see following messages:
11:28:48.874 [11064.13212] <8> onlfi_initialize_vfms: WRN - Non-fatal method error was reported
11:28:48.874 [11064.13212] <8> onlfi_initialize_vfms: WRN -
11:28:48.874 [11064.13212] <8> onlfi_initialize_vfms: WRN - VfMS method error 0; see following message:

11:28:48.952 [11064.13212] <2> onlfi_fim_split: INF - before split...
11:28:48.952 [11064.13212] <2> log_fs_dev_rec: INF - f_type=0 (F_REG)
11:28:48.952 [11064.13212] <2> log_fs_dev_rec: INF - fs_name=ALL_LOCAL_DRIVES
11:28:48.952 [11064.13212] <2> log_fs_dev_rec: INF - fs_type=NTFS
11:28:48.952 [11064.13212] <2> log_fs_dev_rec: INF - mnt_device=ALL_LOCAL_DRIVES
11:28:48.952 [11064.13212] <2> log_fs_dev_rec: INF - raw_device=
11:28:48.952 [11064.13212] <2> log_fs_dev_rec: INF - volume_group=
11:28:48.952 [11064.13212] <2> log_fs_dev_rec: INF - fi_fs_name=C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_ALL_LOCAL_DRIVES_11064_1
11:28:48.952 [11064.13212] <2> log_fs_dev_rec: INF - fi_host=
11:28:48.952 [11064.13212] <2> log_fs_dev_rec: INF - fi_host_fs_name=
11:28:48.952 [11064.13212] <2> log_fs_dev_rec: INF - fi_mnt_device=
11:28:48.952 [11064.13212] <2> log_fs_dev_rec: INF - fi_raw_device=
11:28:48.952 [11064.13212] <2> log_fs_dev_rec: INF - fi_args= [size = 107] allow_offline_backup=1,prov_type=0,csv_timeout=180,nameuse=1,Virtual_machine_backup=2,snap_attr=0,nameuse=1
11:28:48.952 [11064.13212] <2> log_fs_dev_rec: INF - fi_handle=000000000363C290
11:28:48.952 [11064.13212] <2> log_fs_dev_rec: INF - mnt_flag=0
11:28:48.952 [11064.13212] <2> log_fs_dev_rec: INF - fi_flag=1
11:28:48.952 [11064.13212] <2> log_fs_dev_rec: INF - fm_flag=0
11:28:48.952 [11064.13212] <2> log_fs_dev_rec: INF - cs_flag=0
11:28:48.952 [11064.13212] <2> onlfi_vfms_logf: INF - vfm_freeze_commit: fim Hyper-V_v2 config=allow_offline_backup=1,prov_type=0,csv_timeout=180,nameuse=1,Virtual_machine_backup=2,snap_attr=0,nameuse=1,id=SBT-OSA-411_1528100941
11:28:48.952 [11064.13212] <2> onlfi_vfms_logf: INF - Got delayed_mount_supported as 0
11:28:48.952 [11064.13212] <2> onlfi_vfms_logf: INF - vfm_freeze_commit: Setting fim name in VxFI to Hyper-V_v2
11:28:49.014 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: emcclariionfi:Mon Jun 4 2018 11:28:49.014000 <Thread id - 13212> WARNING: No credentials found for EMC CLARIION.
11:28:49.014 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: emcclariionfi:Mon Jun 4 2018 11:28:49.014000 <Thread id - 13212> Unable to import any login credentials for any appliances.
11:28:49.014 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: fi_pgninit: Plugin emcclariionfi : corresponding supported PTP not found.
11:28:49.014 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: emcsymfi: CLI tool C:\Program Files\EMC\SYMCLI\bin\ installation path symcfg.exe is invalid.
11:28:49.030 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: fi_pgninit: Plugin emcsymfi : corresponding supported PTP not found.
11:28:49.046 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: hitachifi:Mon Jun 4 2018 11:28:49.046000 <Thread id - 13212> CHitachiCommandIntf::init() : Error in dlopen of C:\windows\system32\libsvrrm.dll : The specified module could not be found.
11:28:49.046 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: hitachifi:Mon Jun 4 2018 11:28:49.046000 <Thread id - 13212> CHitachiPlugin::init : Library RMLIB init failed
11:28:49.046 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: fi_pgninit: Plugin hitachifi : corresponding supported PTP not found.
11:28:49.061 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: hpevafi: CLI tool C:\Program Files\Hewlett-Packard\Sanworks\Element Manager for StorageWorks HSV\Bridge\ installation path sssu_win_ia64.exe is invalid.
11:28:49.061 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: hpevafi:Mon Jun 4 2018 11:28:49.061000 <Thread id - 13212> CHpEvaPlugin::init: CLI tool is not installed.
11:28:49.061 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: fi_pgninit: Plugin hpevafi : corresponding supported PTP not found.
11:28:49.077 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: hpmsafi:Mon Jun 4 2018 11:28:49.077000 <Thread id - 13212> No array management credentials are available in configuration file.
11:28:49.077 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: hpmsafi: CLI tool C:\Program Files\Compaq\Hpacucli\Bin\ installation path hpacucli.exe is invalid.
11:28:49.077 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: fi_pgninit: Plugin hpmsafi : corresponding supported PTP not found.
11:28:49.108 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: ibmtsfi:Mon Jun 4 2018 11:28:49.108000 <Thread id - 13212> DSCLI not found at path=[C:\Program Files\IBM\DSCLI\]
11:28:49.108 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: ibmtsfi: DSCLI tool C:\Program Files (x86)\IBM\DSCLI\ installation path dscli.exe is invalid.
11:28:49.108 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: fi_pgninit: Plugin ibmtsfi : corresponding supported PTP not found.
11:28:49.139 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: ostfi:Mon Jun 4 2018 11:28:49.139000 <Thread id - 13212> WARNING: No credentials found for STORAGESERVER .
11:28:49.139 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: fi_pgninit: Plugin ostfi : corresponding supported PTP not found.
11:28:49.186 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: vss:Mon Jun 4 2018 11:28:49.186000 <Thread id - 13212> check_service_status - STATUS=[4]
11:28:49.233 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: winfsys:Mon Jun 4 2018 11:28:49.233000 WinFsysFiCoordinator::claim,Object not claimed, VFI_CLAIM_NONE
11:28:49.249 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: wmifi:Mon Jun 4 2018 11:28:49.249000 <Thread id - 13212> CWmiLibrary::initializeCom: ConnectServer() failed with error 0x8004100E. message: IDispatch error #3598
11:28:49.249 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: wmifi:Mon Jun 4 2018 11:28:49.249000 <Thread id - 13212> CWmiHelper::init error from CWmiLibrary::getWmiConnection()
11:28:49.249 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: wmifi:Mon Jun 4 2018 11:28:49.249000 <Thread id - 13212> CWmiHelper::init error from CWmiLibrary::initCluster() apparently this is not cluster. Initializing normal way
11:28:49.624 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: winfsys:Mon Jun 4 2018 11:28:49.624000 WinFsysFiCoordinator::claim, GetVolumeInformationW,Name:['D:\'], fsname: [ReFS], Status: [1]
11:28:49.640 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: winfsys:Mon Jun 4 2018 11:28:49.640000 WinFsysFiCoordinator::claim,Object not claimed, VFI_CLAIM_NONE
11:28:49.640 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: winfivol:Mon Jun 4 2018 11:28:49.640000 DBG: getOffset: vol_name = \\?\Volume{6fe88f97-ec92-435b-8043-2aaef3cb4ee9}
11:28:49.640 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: winfivol:Mon Jun 4 2018 11:28:49.640000 getOffset: Number of disk extents is [1]
11:28:49.640 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: winfsys:Mon Jun 4 2018 11:28:49.640000 WinFsysFiCoordinator::claim,Object not claimed, VFI_CLAIM_NONE
11:28:49.655 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: winfsys:Mon Jun 4 2018 11:28:49.655000 WinFsysFiCoordinator::claim,Object not claimed, VFI_CLAIM_NONE
11:28:49.718 [11064.8792] <2> onlfi_vfms_logf: INF - snapshot services: vss:Mon Jun 4 2018 11:28:49.718000 <Thread id - 8792> VSS API ERROR:- API [IsVolumeSupported] return val = 80042308 [VSS_E_OBJECT_NOT_FOUND]
11:28:49.718 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: vxfi_analyze fitype=[Hyper-V]
11:28:49.734 [11064.13212] <2> onlfi_vfms_logf: INF - ;csv_timeout=180;Virtual_machine_backup=2;allow_offline_backup=Yes
11:28:49.734 [11064.13212] <2> onlfi_vfms_logf: INF - <SET_CONFIG_INFO_LIST> <SET_CONFIG_INFO key=Virtual_machine_backup value=2 /> <SET_CONFIG_INFO key=allow_offline_backup value=Yes /> <SET_CONFIG_INFO key=csv_timeout value=180 /> </SET_CONFIG_INFO_LIST>
11:28:49.749 [11064.13212] <2> onlfi_vfms_logf: INF - vfm_freeze_commit: Before calling vfi_set_import_options fi_nbu_catalog = [0]
11:29:08.751 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: vss:Mon Jun 4 2018 11:29:08.751000 <Thread id - 13212> CWmiLibrary::initializeCom: ConnectServer() failed with error 0x8004100E. message: IDispatch error #3598
11:29:08.751 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: vss:Mon Jun 4 2018 11:29:08.751000 <Thread id - 13212> CWmiHelper::init error from CWmiLibrary::getWmiConnection()
11:29:08.751 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: vss:Mon Jun 4 2018 11:29:08.751000 <Thread id - 13212> CWmiHelper::init error from CWmiLibrary::initCluster() apparently this is not cluster. Initializing normal way
11:29:09.001 [11064.2968] <2> ACELogCallback::log: ACE logging for thread 2968 had been hooked
11:29:09.001 [11064.2968] <2> ACEThreadHook::start: New thread 2968 starting (../NcfInit.cpp:200)
11:29:09.017 [11064.13212] <2> RuntimeLoader::loadInterface: Searching C:\Program Files\Veritas\NetBackup\bin for libnburi (../RuntimeLoader.cpp:166)
11:29:09.017 [11064.13212] <2> RuntimeLoader::loadInterface: Found libnburi in C:\Program Files\Veritas\NetBackup\bin\libnburi (../RuntimeLoader.cpp:180)
11:29:09.017 [11064.13212] <2> SymbolResolver::resolveSymbols: Symbol C:\Program Files\Veritas\NetBackup\bin\libnburi::GetVersionInfo resolved to 00007FFCAF561060 (../RuntimeLink.cpp:61)
11:29:09.017 [11064.13212] <4> RuntimeLoader::loadInterface: Module: C:\Program Files\Veritas\NetBackup\bin\libnburi, Release: 8.1 <?>, Build: 09/10/2017 17:35:00 CDT (0049)
11:29:09.017 [11064.13212] <2> SymbolResolver::resolveSymbols: Symbol C:\Program Files\Veritas\NetBackup\bin\libnburi::RegisterURIs resolved to 00007FFCAF561440 (../RuntimeLink.cpp:61)
11:29:09.017 [11064.13212] <2> UriSchemeMgr::UriSchemeMgr: Found default scheme library, will register schemes (../UriSchemeMgr.cpp:65)
11:29:09.017 [11064.13212] <2> UriSchemeMgr::UriSchemeMgr: Registration of uri schemes in default scheme library completed (../UriSchemeMgr.cpp:69)
11:29:09.017 [11064.13212] <2> UriSchemeMgr::getScheme: Loading uri scheme library libpihyperv (../UriSchemeMgr.cpp:155)
11:29:09.017 [11064.13212] <2> RuntimeLoader::loadInterface: Searching C:\Program Files\Veritas\NetBackup\bin for libpihyperv (../RuntimeLoader.cpp:166)
11:29:09.017 [11064.13212] <2> RuntimeLoader::loadInterface: Found libpihyperv in C:\Program Files\Veritas\NetBackup\bin\libpihyperv (../RuntimeLoader.cpp:180)
11:29:09.017 [11064.13212] <2> SymbolResolver::resolveSymbols: Symbol C:\Program Files\Veritas\NetBackup\bin\libpihyperv::GetVersionInfo resolved to 00007FFC92101000 (../RuntimeLink.cpp:61)
11:29:09.017 [11064.13212] <4> RuntimeLoader::loadInterface: Module: C:\Program Files\Veritas\NetBackup\bin\libpihyperv, Release: 8.1 <?>, Build: 09/10/2017 17:35:00 CDT (0049)
11:29:09.017 [11064.13212] <2> SymbolResolver::resolveSymbols: Symbol C:\Program Files\Veritas\NetBackup\bin\libpihyperv::RegisterURIs resolved to 00007FFC92101610 (../RuntimeLink.cpp:61)
11:29:09.017 [11064.13212] <2> UriSchemeMgr::getScheme: Beginning registration of uri schemes in libpihyperv (../UriSchemeMgr.cpp:182)
11:29:09.017 [11064.13212] <2> UriSchemeMgr::getScheme: Registration of uri schemes in libpihyperv completed (../UriSchemeMgr.cpp:187)
11:29:09.017 [11064.13212] <4> CHypervVmList:isSupportedPlatform: Error while connecting to Hyper-V server. Error: [10]
11:29:09.017 [11064.13212] <2> CHypervVmList:doConnect: Location of psObjSerDeser File ** C:\Program Files\Veritas\NetBackup\temp\psObjSerDeser_11064.TMP (../CHypervVm.cpp:879)
11:29:09.564 [11064.13212] <2> CHypervVmList:doConnect: Created initial server session (../CHypervVm.cpp:914)
11:29:09.564 [11064.13212] <2> CHypervVmList:doConnect: Details Successfully created session with the server (../CHypervVm.cpp:915)
11:29:09.564 [11064.13212] <2> CHypervVmList:doConnect: Get server details (../CHypervVm.cpp:916)
11:29:09.564 [11064.13212] <2> CHypervVmList::getHypervServerDetails: Get hyperv server configuration details (../CHypervVm.cpp:1404)
11:29:09.564 [11064.13212] <2> getHostDetails: powershell command = Get-NBHostDetails | Select-Object -Property Name, Fqdn, OsVersion, OsCaption, IsAbove2008R2, HasHypervModule, HasClusterModule, HasScvmmModule (../PowershellCommand.cpp:131)
11:29:09.798 [11064.13212] <2> CHypervVmList:doConnect: Successfully created server session. (../CHypervVm.cpp:934)
11:29:09.798 [11064.13212] <2> getVmUsingVmGuidPowershellCmd: powershell command = Hyper-V\Get-Vm -Id 019C06DC-6059-427E-9B88-77821CC39E4A | Select-Object -Property Name, Id, ComputerName, State, Notes, IsClustered, Version (../PowershellCommand.cpp:180)
11:29:10.064 [11064.13212] <2> CHypervVmList:getVMVersion: vmList count: 1 (../CHypervVm.cpp:1053)
11:29:10.064 [11064.13212] <2> CHypervVmList:getVMVersion: VM version found to be empty (../CHypervVm.cpp:1072)
11:29:13.423 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: vss:Mon Jun 4 2018 11:29:13.423000 <Thread id - 13212> VssNode::getSelectedWriterStatus: GetWriterStatus FAILED for Selected writer [Microsoft Hyper-V VSS Writer], writer is in state [8] [VSS_WS_FAILED_AT_PREPARE_SNAPSHOT]. hrWriterFailure [800423f3] [-2147212301]
11:29:13.423 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: vss:Mon Jun 4 2018 11:29:13.423000 <Thread id - 13212> VssNode::getSelectedWriterStatus: application error [(null)]
11:29:13.439 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: vss:Mon Jun 4 2018 11:29:13.439000 <Thread id - 13212> VssNode::make getSelectedWriterStatus FAILED
11:29:13.439 [11064.13212] <2> onlfi_vfms_logf: INF - snapshot services: vss:Mon Jun 4 2018 11:29:13.439000 <Thread id - 13212> VssNode::make deleting the inconsistent snapshot.
11:29:13.501 [11064.13212] <2> onlfi_vfms_logf: INF - vfm_freeze_commit: vfm_method_errno=[57]
11:29:13.501 [11064.13212] <2> onlfi_fim_split: INF - Extracting snapshot client error = 4258
11:29:13.501 [11064.13212] <32> onlfi_fim_split: FTL - VfMS error 11; see following messages:
11:29:13.501 [11064.13212] <32> onlfi_fim_split: FTL - Fatal method error was reported
11:29:13.501 [11064.13212] <32> onlfi_fim_split: FTL - vfm_freeze_commit: method: Hyper-V_v2, type: FIM, function: Hyper-V_v2_make
11:29:13.501 [11064.13212] <32> onlfi_fim_split: FTL - VfMS method error 57; see follow

[RiaanBadenhorst · Accepted solution]

Its not possible to backup a pass-through disk with HyperV policy. Install the client software in the guest and backup using windows policy.