Snapshop backup with error 156 (Vmware Backup)

Hi Everybody,

I have a problem with my vmware backup with error 156.

my environments :

- Netbackup Master 7.1.0.4 (solaris)

- Vcenter 5.1 (windows 2008)

- Esx 5.1

any advise for this case, please ?

Thanks.

 

this is bpfis log on client (Vcenter machine) :

05:20:30.339 [1424.9192] <2> logparams: D:\Program Files\Veritas\NetBackup\bin\bpfis.exe create -nbu -owner NBU -id WIRKERID_1367446825 -bpstart_to 3600 -bpend_to 3600 -backup_copy 0 -ru root -pt 29 -vm_type 2 -vm_client WIRKERID -clnt WIRKERID -st FULL -rg root -fim VMware:file_system_optimization=1,snapact=2,Virtual_machine_backup=2,vmmono=0,disable_quiesce=0,nameuse=0,trantype=6,nameuse=0 -class VMware_JTN_Policy -sched Full -fso -S masterbackup
05:20:30.339 [1424.9192] <2> bpfis main: received FIM as [126] VMware:file_system_optimization=1,snapact=2,Virtual_machine_backup=2,vmmono=0,disable_quiesce=0,nameuse=0,trantype=6,nameuse=0
05:20:30.342 [1424.9192] <4> bpfis: INF - BACKUP START 1424
05:20:30.344 [1424.9192] <2> bpfis main: receive filelist:<NEW_STREAM>
05:20:30.344 [1424.9192] <2> bpfis main: receive filelist:<ALL_LOCAL_DRIVES>
05:20:30.345 [1424.9192] <2> bpfis main: receive filelist:<CONTINUE>
05:20:30.354 [1424.9192] <2> read_vfm_conf: options=0x2
05:20:30.354 [1424.9192] <2> read_vfm_conf: Reading file: D:\Program Files\Veritas\NetBackup\vfm.conf
05:20:30.354 [1424.9192] <2> read_vfm_conf: Found FIM: auto
05:20:30.354 [1424.9192] <2> read_vfm_conf: Found library: D:\Program Files\Veritas\NetBackup\bin\libfi_auto.dll
05:20:30.354 [1424.9192] <2> read_vfm_conf: Found FIM: Hyper-V
05:20:30.354 [1424.9192] <2> read_vfm_conf: Found library: D:\Program Files\Veritas\NetBackup\bin\libvfms.dll
05:20:30.354 [1424.9192] <2> parse_ssm_parms: Found keyword nameuse
05:20:30.354 [1424.9192] <2> parse_ssm_parms: Found data type %dd
05:20:30.354 [1424.9192] <2> parse_ssm_parms: Found value specification hyperv_client_name_type_list
05:20:30.354 [1424.9192] <2> parse_value_specification: Value specification='hyperv_client_name_type_list'
05:20:30.354 [1424.9192] <2> parse_value_specification: Found default hyperv_client_name_type_list
05:20:30.354 [1424.9192] <2> parse_ssm_parms: Found prompt Client Name Selection
05:20:30.354 [1424.9192] <2> parse_ssm_parms: Found keyword Virtual_machine_backup
05:20:30.354 [1424.9192] <2> parse_ssm_parms: Found data type %dd
05:20:30.354 [1424.9192] <2> parse_ssm_parms: Found value specification hyperv_backup_type_list
05:20:30.354 [1424.9192] <2> parse_value_specification: Value specification='hyperv_backup_type_list'
05:20:30.354 [1424.9192] <2> parse_value_specification: Found default hyperv_backup_type_list
05:20:30.354 [1424.9192] <2> parse_ssm_parms: Found prompt Virtual Machine Backup
05:20:30.354 [1424.9192] <2> parse_ssm_parms: Found keyword prov_type
05:20:30.354 [1424.9192] <2> parse_ssm_parms: Found data type %dd
05:20:30.354 [1424.9192] <2> parse_ssm_parms: Found value specification vss_provider_type_list
05:20:30.354 [1424.9192] <2> parse_value_specification: Value specification='vss_provider_type_list'
05:20:30.354 [1424.9192] <2> parse_value_specification: Found default vss_provider_type_list
05:20:30.354 [1424.9192] <2> parse_ssm_parms: Found prompt Provider Type
05:20:30.354 [1424.9192] <2> parse_ssm_parms: Found keyword snap_attr
05:20:30.354 [1424.9192] <2> parse_ssm_parms: Found data type %dd
05:20:30.354 [1424.9192] <2> parse_ssm_parms: Found value specification snapshot_attribute_list
05:20:30.354 [1424.9192] <2> parse_value_specification: Value specification='snapshot_attribute_list'
05:20:30.354 [1424.9192] <2> parse_value_specification: Found default snapshot_attribute_list
05:20:30.354 [1424.9192] <2> parse_ssm_parms: Found prompt Snapshot Attribute
05:20:30.354 [1424.9192] <2> parse_ssm_parms: Found keyword allow_offline_backup
05:20:30.354 [1424.9192] <2> parse_ssm_parms: Found data type %b
05:20:30.354 [1424.9192] <2> parse_ssm_parms: Found value specification 1
05:20:30.354 [1424.9192] <2> parse_value_specification: Value specification='1'
05:20:30.354 [1424.9192] <2> parse_value_specification: Found default 1
05:20:30.354 [1424.9192] <2> parse_ssm_parms: Found prompt Allow Offline Backup of VM
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found keyword csv_timeout
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found data type %d
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found value specification 0-:0
05:20:30.355 [1424.9192] <2> parse_value_specification: Value specification='0-:0'
05:20:30.355 [1424.9192] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
05:20:30.355 [1424.9192] <2> parse_value_specification: Found default 0
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found prompt CSV Timeout in Minutes
05:20:30.355 [1424.9192] <2> map_integer_value: virtual_machine_supported=Hyper-V, converted value=2, status=1
05:20:30.355 [1424.9192] <2> read_vfm_conf: Found FIM: VSS
05:20:30.355 [1424.9192] <2> read_vfm_conf: Found library: D:\Program Files\Veritas\NetBackup\bin\libvfms.dll
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found keyword prov_type
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found data type %d
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found value specification 0-3:0
05:20:30.355 [1424.9192] <2> parse_value_specification: Value specification='0-3:0'
05:20:30.355 [1424.9192] <2> parse_value_specification: Found default 0
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found prompt Provider Type (0-auto 1-system 2-software 3-hardware)
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found keyword snap_attr
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found data type %d
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found value specification 0-2:0
05:20:30.355 [1424.9192] <2> parse_value_specification: Value specification='0-2:0'
05:20:30.355 [1424.9192] <2> parse_value_specification: Found default 0
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found prompt Snapshot Attribute(0-unspecified 1-differential 2-plex)
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found keyword max_snapshots
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found data type %d
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found value specification 1-:1
05:20:30.355 [1424.9192] <2> parse_value_specification: Value specification='1-:1'
05:20:30.355 [1424.9192] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
05:20:30.355 [1424.9192] <2> parse_value_specification: Found default 1
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
05:20:30.355 [1424.9192] <2> read_vfm_conf: Found FIM: FlashSnap
05:20:30.355 [1424.9192] <2> read_vfm_conf: Found library: D:\Program Files\Veritas\NetBackup\bin\libfi_FlashSnap.dll
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found keyword keep_fi
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found data type %b
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found value specification 0
05:20:30.355 [1424.9192] <2> parse_value_specification: Value specification='0'
05:20:30.355 [1424.9192] <2> parse_value_specification: Found default 0
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found prompt Keep snapshot after backup (not Instant Recovery)
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found keyword async_resync
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found data type %b
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found value specification 0
05:20:30.355 [1424.9192] <2> parse_value_specification: Value specification='0'
05:20:30.355 [1424.9192] <2> parse_value_specification: Found default 0
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found prompt Resynchronize mirror in background (not Instant Recovery)
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found keyword max_snapshots
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found data type %d
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found value specification 1-:1
05:20:30.355 [1424.9192] <2> parse_value_specification: Value specification='1-:1'
05:20:30.355 [1424.9192] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
05:20:30.355 [1424.9192] <2> parse_value_specification: Found default 1
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found keyword dg_split_retry_times
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found data type %d
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found value specification 1
05:20:30.355 [1424.9192] <2> parse_value_specification: Value specification='1'
05:20:30.355 [1424.9192] <2> parse_value_specification: Found default 1
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found prompt Number of times to retry disk group split
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found keyword dg_split_retry_wait_period
05:20:30.355 [1424.9192] <2> parse_ssm_parms: Found data type %d
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found value specification 60-:60
05:20:30.356 [1424.9192] <2> parse_value_specification: Value specification='60-:60'
05:20:30.356 [1424.9192] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
05:20:30.356 [1424.9192] <2> parse_value_specification: Found default 60
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found prompt Delay in seconds between disk group split retries
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found keyword num_sync_vols
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found data type %d
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found value specification 1-32:1
05:20:30.356 [1424.9192] <2> parse_value_specification: Value specification='1-32:1'
05:20:30.356 [1424.9192] <2> parse_value_specification: Found default 1
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found prompt Maximum number of volumes to resynchronize concurrently
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found keyword iosize
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found data type %d
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found value specification 1-128:1
05:20:30.356 [1424.9192] <2> parse_value_specification: Value specification='1-128:1'
05:20:30.356 [1424.9192] <2> parse_value_specification: Found default 1
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found prompt Sync region size in MB (UNIX only)
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found keyword slow
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found data type %d
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found value specification 0-:0
05:20:30.356 [1424.9192] <2> parse_value_specification: Value specification='0-:0'
05:20:30.356 [1424.9192] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
05:20:30.356 [1424.9192] <2> parse_value_specification: Found default 0
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found prompt Sync I/O delay in milliseconds (UNIX only)
05:20:30.356 [1424.9192] <2> read_vfm_conf: Found FIM: vxvm
05:20:30.356 [1424.9192] <2> read_vfm_conf: Found library: D:\Program Files\Veritas\NetBackup\bin\libfi_vxvm.dll
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found keyword async_resync
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found data type %b
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found value specification 0
05:20:30.356 [1424.9192] <2> parse_value_specification: Value specification='0'
05:20:30.356 [1424.9192] <2> parse_value_specification: Found default 0
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found prompt Resynchronize mirror in background (not Instant Recovery)
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found keyword max_snapshots
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found data type %d
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found value specification 1-:1
05:20:30.356 [1424.9192] <2> parse_value_specification: Value specification='1-:1'
05:20:30.356 [1424.9192] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
05:20:30.356 [1424.9192] <2> parse_value_specification: Found default 1
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found keyword sync_wait
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found data type %b
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found value specification 1
05:20:30.356 [1424.9192] <2> parse_value_specification: Value specification='1'
05:20:30.356 [1424.9192] <2> parse_value_specification: Found default 1
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found prompt Wait for mirror sync completion (Data Mover backups only)
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found keyword num_sync_vols
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found data type %d
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found value specification 1-32:1
05:20:30.356 [1424.9192] <2> parse_value_specification: Value specification='1-32:1'
05:20:30.356 [1424.9192] <2> parse_value_specification: Found default 1
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found prompt Maximum number of volumes to resynchronize concurrently
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found keyword iosize
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found data type %d
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found value specification 1-128:1
05:20:30.356 [1424.9192] <2> parse_value_specification: Value specification='1-128:1'
05:20:30.356 [1424.9192] <2> parse_value_specification: Found default 1
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found prompt Sync region size in MB (UNIX only)
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found keyword slow
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found data type %d
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found value specification 0-:0
05:20:30.356 [1424.9192] <2> parse_value_specification: Value specification='0-:0'
05:20:30.356 [1424.9192] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
05:20:30.356 [1424.9192] <2> parse_value_specification: Found default 0
05:20:30.356 [1424.9192] <2> parse_ssm_parms: Found prompt Sync I/O delay in milliseconds (UNIX only)
05:20:30.357 [1424.9192] <2> read_vfm_conf: Found FIM: VMware
05:20:30.357 [1424.9192] <2> read_vfm_conf: Found library: D:\Program Files\Veritas\NetBackup\bin\libfi_VMware.dll
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found keyword nameuse
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found data type %dd
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found value specification vmware_client_name_type_list
05:20:30.357 [1424.9192] <2> parse_value_specification: Value specification='vmware_client_name_type_list'
05:20:30.357 [1424.9192] <2> parse_value_specification: Found default vmware_client_name_type_list
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found prompt Client name selection
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found keyword Virtual_machine_backup
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found data type %dd
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found value specification vmware_backup_type_list
05:20:30.357 [1424.9192] <2> parse_value_specification: Value specification='vmware_backup_type_list'
05:20:30.357 [1424.9192] <2> parse_value_specification: Found default vmware_backup_type_list
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found prompt Virtual machine backup
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found keyword trantype
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found data type %dd
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found value specification VMware_transfer_list
05:20:30.357 [1424.9192] <2> parse_value_specification: Value specification='VMware_transfer_list'
05:20:30.357 [1424.9192] <2> parse_value_specification: Found default VMware_transfer_list
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found prompt Transfer type
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found keyword disable_quiesce
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found data type %dd
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found value specification enabled_disable_quiesce_list
05:20:30.357 [1424.9192] <2> parse_value_specification: Value specification='enabled_disable_quiesce_list'
05:20:30.357 [1424.9192] <2> parse_value_specification: Found default enabled_disable_quiesce_list
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found prompt Virtual machine quiesce
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found keyword file_system_optimization
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found data type %dd
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found value specification enabled_disabled_type_list
05:20:30.357 [1424.9192] <2> parse_value_specification: Value specification='enabled_disabled_type_list'
05:20:30.357 [1424.9192] <2> parse_value_specification: Found default enabled_disabled_type_list
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found prompt Exclude unused and deleted blocks
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found keyword snapact
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found data type %dd
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found value specification snapshot_handling_list
05:20:30.357 [1424.9192] <2> parse_value_specification: Value specification='snapshot_handling_list'
05:20:30.357 [1424.9192] <2> parse_value_specification: Found default snapshot_handling_list
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found prompt Existing snapshot handling
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found keyword vmmono
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found data type %dd
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found value specification disabled_enabled_type_list
05:20:30.357 [1424.9192] <2> parse_value_specification: Value specification='disabled_enabled_type_list'
05:20:30.357 [1424.9192] <2> parse_value_specification: Found default disabled_enabled_type_list
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found prompt Monolithic export (VCB only)
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found keyword mntpt
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found data type %s
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found prompt Snapshot mount point (VCB only)
05:20:30.357 [1424.9192] <2> map_integer_value: virtual_machine_supported=VMware, converted value=1, status=1
05:20:30.357 [1424.9192] <2> read_vfm_conf: Found FIM: NAS_Snapshot
05:20:30.357 [1424.9192] <2> read_vfm_conf: Found library: D:\Program Files\Veritas\NetBackup\bin\libfi_NAS_Snapshot.dll
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found keyword max_snapshots
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found data type %d
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found value specification 1-:1
05:20:30.357 [1424.9192] <2> parse_value_specification: Value specification='1-:1'
05:20:30.357 [1424.9192] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
05:20:30.357 [1424.9192] <2> parse_value_specification: Found default 1
05:20:30.357 [1424.9192] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
05:20:30.357 [1424.9192] <2> read_vfm_conf: Found FIM: VSS_Writer
05:20:30.357 [1424.9192] <2> read_vfm_conf: Found library: D:\Program Files\Veritas\NetBackup\bin\libfi_vss_writer.dll
05:20:30.365 [1424.9192] <2> vnet_pbxConnect: pbxConnectEx Succeeded
05:20:30.366 [1424.9192] <2> logconnections: BPRD CONNECT FROM 10.62.34.18.54864 TO 10.34.130.40.1556 fd = 552
05:20:30.517 [1424.9192] <8> bpfis: WRN - VfMS error 10; see following messages:
05:20:30.517 [1424.9192] <8> bpfis: WRN - Non-fatal method error was reported
05:20:30.517 [1424.9192] <8> bpfis: WRN - vfm_configure_fi_one: method: FlashSnap, type: FIM, function: FlashSnap_init
05:20:30.517 [1424.9192] <8> bpfis: WRN - VfMS method error 3; see following message:
05:20:30.517 [1424.9192] <8> bpfis: WRN - FlashSnap_init: Veritas Volume Manager not installed.
05:20:30.517 [1424.9192] <8> bpfis: WRN - VfMS error 10; see following messages:
05:20:30.518 [1424.9192] <8> bpfis: WRN - Non-fatal method error was reported
05:20:30.518 [1424.9192] <8> bpfis: WRN - vfm_configure_fi_one: method: vxvm, type: FIM, function: vxvm_init
05:20:30.518 [1424.9192] <8> bpfis: WRN - VfMS method error 3; see following message:
05:20:30.518 [1424.9192] <8> bpfis: WRN - vxvm_init: Veritas Volume Manager not installed.
05:20:30.526 [1424.9192] <4> bpfis: INF - FIS_ID=WIRKERID_1367446825
05:20:30.527 [1424.9192] <4> bpfis: INF - Freezing ALL_LOCAL_DRIVES using snapshot method VMware.
05:20:30.527 [1424.9192] <4> bpfis: INF - ACT=WIRKERID
05:20:30.527 [1424.9192] <4> bpfis: INF - Created mount point D:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_ALL_LOCAL_DRIVES_1424
05:20:30.534 [1424.9192] <2> vnet_pbxConnect: pbxConnectEx Succeeded
05:20:30.534 [1424.9192] <2> logconnections: BPRD CONNECT FROM 10.62.34.18.54865 TO 10.34.130.40.1556 fd = 620
05:20:48.925 [1424.9192] <4> bpfis: INF - Deleted mount point D:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_ALL_LOCAL_DRIVES_1424
05:20:48.925 [1424.9192] <32> bpfis: FTL - VfMS error 11; see following messages:
05:20:48.925 [1424.9192] <32> bpfis: FTL - Fatal method error was reported
05:20:48.925 [1424.9192] <32> bpfis: FTL - vfm_freeze: method: VMware, type: FIM, function: VMware_freeze
05:20:48.925 [1424.9192] <32> bpfis: FTL - VfMS method error 7; see following message:
05:20:48.925 [1424.9192] <32> bpfis: FTL - VMware_freeze: VIXAPI freeze failed with 36
05:20:48.925 [1424.9192] <32> bpfis: FTL - VfMS error 11; see following messages:
05:20:48.925 [1424.9192] <32> bpfis: FTL - Fatal method error was reported
05:20:48.925 [1424.9192] <32> bpfis: FTL - vfm_freeze: method: VMware, type: FIM, function: VMware_freeze
05:20:48.925 [1424.9192] <32> bpfis: FTL - VfMS method error 7; see following message:
05:20:48.925 [1424.9192] <32> bpfis: FTL - VMware_freeze: VIXAPI freeze failed with 36
05:20:48.925 [1424.9192] <16> bpfis: FTL - snapshot creation failed, status 156
05:20:48.926 [1424.9192] <4> bpfis: INF - Thawing ALL_LOCAL_DRIVES using snapshot method VMware.
05:20:48.926 [1424.9192] <8> bpfis: WRN - ALL_LOCAL_DRIVES is not frozen
05:20:48.926 [1424.9192] <8> bpfis: WRN - snapshot delete returned status 20
05:20:48.927 [1424.9192] <4> bpfis: INF - EXIT STATUS 156: snapshot error encountered
05:20:52.662 [308.4516] <2> logparams: D:\Program Files\Veritas\NetBackup\bin\bpfis.exe delete -nbu -id WIRKERID_1367446825 -bpstart_to 3600 -bpend_to 3600 -clnt WIRKERID -S masterbackup
05:20:52.678 [308.4516] <2> vnet_pbxConnect: pbxConnectEx Succeeded
05:20:52.678 [308.4516] <2> logconnections: BPRD CONNECT FROM 10.62.34.18.54901 TO 10.34.130.40.1556 fd = 516
05:20:53.303 [308.4516] <4> bpfis: INF - BACKUP START 308
05:20:53.303 [308.4516] <32> bpfis: FTL - cannot open D:\Program Files\Veritas\NetBackup\online_util\fi_cntl\bpfis.fim.WIRKERID_1367446825.0
05:20:53.303 [308.4516] <4> bpfis: INF - EXIT STATUS 0: the requested operation was successfully completed