Video Screencast Help
Give us your opinion and win with Symantec! Please help us by taking this survey to tell us about your experience with Symantec Connect, so that we can continue to grow and improve.  Take the survey.

VM backup is failing continously with 156 error within start

Created: 12 Jan 2013 | 2 comments
rajkumarbaniwal's picture

VM backup is failing continously with 156 error within start

PFB bpfis logs:

17:51:00.342 [11788.8532] <2> logparams: C:\Program Files\Veritas\NetBackup\bin\bpfis.exe create -nbu -owner NBU -id gnnmis41-bkp_1357993258 -bpstart_to 30000 -bpend_to 3000 -backup_copy 0 -ru root -pt 29 -vm_type 2 -vm_client gnnmis41-bkp -clnt gnnbkp04 -st FULL -rg other -fim VMware:nameuse=0,Virtual_machine_backup=2,trantype=6,disable_quiesce=0,file_system_optimization=1,snapact=0,vmmono=0,nameuse=0 -class VM_Windows -sched Full -fso -S gnnbkp01
17:51:00.342 [11788.8532] <2> bpfis main: received FIM as [126] VMware:nameuse=0,Virtual_machine_backup=2,trantype=6,disable_quiesce=0,file_system_optimization=1,snapact=0,vmmono=0,nameuse=0
17:51:00.342 [11788.8532] <4> bpfis: INF - BACKUP START 11788
17:51:00.342 [11788.8532] <2> bpfis main: receive filelist:<NEW_STREAM>
17:51:00.342 [11788.8532] <2> bpfis main: receive filelist:<ALL_LOCAL_DRIVES>
17:51:00.342 [11788.8532] <2> bpfis main: receive filelist:<CONTINUE>
17:51:00.373 [11788.8532] <2> read_vfm_conf: options=0x2
17:51:00.373 [11788.8532] <2> read_vfm_conf: Reading file: C:\Program Files\Veritas\NetBackup\vfm.conf
17:51:00.373 [11788.8532] <2> read_vfm_conf: Found FIM: auto
17:51:00.373 [11788.8532] <2> read_vfm_conf: Found library: C:\Program Files\Veritas\NetBackup\bin\libfi_auto.dll
17:51:00.373 [11788.8532] <2> read_vfm_conf: Found FIM: Hyper-V
17:51:00.373 [11788.8532] <2> read_vfm_conf: Found library: C:\Program Files\Veritas\NetBackup\bin\libvfms.dll
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found keyword nameuse
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found data type %dd
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found value specification hyperv_client_name_type_list
17:51:00.373 [11788.8532] <2> parse_value_specification: Value specification='hyperv_client_name_type_list'
17:51:00.373 [11788.8532] <2> parse_value_specification: Found default hyperv_client_name_type_list
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found prompt Client Name Selection
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found keyword Virtual_machine_backup
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found data type %dd
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found value specification hyperv_backup_type_list
17:51:00.373 [11788.8532] <2> parse_value_specification: Value specification='hyperv_backup_type_list'
17:51:00.373 [11788.8532] <2> parse_value_specification: Found default hyperv_backup_type_list
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found prompt Virtual Machine Backup
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found keyword prov_type
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found data type %dd
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found value specification vss_provider_type_list
17:51:00.373 [11788.8532] <2> parse_value_specification: Value specification='vss_provider_type_list'
17:51:00.373 [11788.8532] <2> parse_value_specification: Found default vss_provider_type_list
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found prompt Provider Type
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found keyword snap_attr
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found data type %dd
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found value specification snapshot_attribute_list
17:51:00.373 [11788.8532] <2> parse_value_specification: Value specification='snapshot_attribute_list'
17:51:00.373 [11788.8532] <2> parse_value_specification: Found default snapshot_attribute_list
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found prompt Snapshot Attribute
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found keyword allow_offline_backup
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found data type %b
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found value specification 1
17:51:00.373 [11788.8532] <2> parse_value_specification: Value specification='1'
17:51:00.373 [11788.8532] <2> parse_value_specification: Found default 1
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found prompt Allow Offline Backup of VM
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found keyword csv_timeout
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found data type %d
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found value specification 0-:0
17:51:00.373 [11788.8532] <2> parse_value_specification: Value specification='0-:0'
17:51:00.373 [11788.8532] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
17:51:00.373 [11788.8532] <2> parse_value_specification: Found default 0
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found prompt CSV Timeout in Minutes
17:51:00.373 [11788.8532] <2> map_integer_value: virtual_machine_supported=Hyper-V, converted value=2, status=1
17:51:00.373 [11788.8532] <2> read_vfm_conf: Found FIM: VSS
17:51:00.373 [11788.8532] <2> read_vfm_conf: Found library: C:\Program Files\Veritas\NetBackup\bin\libvfms.dll
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found keyword prov_type
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found data type %d
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found value specification 0-3:0
17:51:00.373 [11788.8532] <2> parse_value_specification: Value specification='0-3:0'
17:51:00.373 [11788.8532] <2> parse_value_specification: Found default 0
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found prompt Provider Type (0-auto 1-system 2-software 3-hardware)
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found keyword snap_attr
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found data type %d
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found value specification 0-2:0
17:51:00.373 [11788.8532] <2> parse_value_specification: Value specification='0-2:0'
17:51:00.373 [11788.8532] <2> parse_value_specification: Found default 0
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found prompt Snapshot Attribute(0-unspecified 1-differential 2-plex)
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found keyword max_snapshots
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found data type %d
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found value specification 1-:1
17:51:00.373 [11788.8532] <2> parse_value_specification: Value specification='1-:1'
17:51:00.373 [11788.8532] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
17:51:00.373 [11788.8532] <2> parse_value_specification: Found default 1
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
17:51:00.373 [11788.8532] <2> read_vfm_conf: Found FIM: FlashSnap
17:51:00.373 [11788.8532] <2> read_vfm_conf: Found library: C:\Program Files\Veritas\NetBackup\bin\libfi_FlashSnap.dll
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found keyword keep_fi
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found data type %b
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found value specification 0
17:51:00.373 [11788.8532] <2> parse_value_specification: Value specification='0'
17:51:00.373 [11788.8532] <2> parse_value_specification: Found default 0
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found prompt Keep snapshot after backup (not Instant Recovery)
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found keyword async_resync
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found data type %b
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found value specification 0
17:51:00.373 [11788.8532] <2> parse_value_specification: Value specification='0'
17:51:00.373 [11788.8532] <2> parse_value_specification: Found default 0
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found prompt Resynchronize mirror in background (not Instant Recovery)
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found keyword max_snapshots
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found data type %d
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found value specification 1-:1
17:51:00.373 [11788.8532] <2> parse_value_specification: Value specification='1-:1'
17:51:00.373 [11788.8532] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
17:51:00.373 [11788.8532] <2> parse_value_specification: Found default 1
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found keyword dg_split_retry_times
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found data type %d
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found value specification 1
17:51:00.373 [11788.8532] <2> parse_value_specification: Value specification='1'
17:51:00.373 [11788.8532] <2> parse_value_specification: Found default 1
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found prompt Number of times to retry disk group split
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found keyword dg_split_retry_wait_period
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found data type %d
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found value specification 60-:60
17:51:00.373 [11788.8532] <2> parse_value_specification: Value specification='60-:60'
17:51:00.373 [11788.8532] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
17:51:00.373 [11788.8532] <2> parse_value_specification: Found default 60
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found prompt Delay in seconds between disk group split retries
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found keyword num_sync_vols
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found data type %d
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found value specification 1-32:1
17:51:00.373 [11788.8532] <2> parse_value_specification: Value specification='1-32:1'
17:51:00.373 [11788.8532] <2> parse_value_specification: Found default 1
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found prompt Maximum number of volumes to resynchronize concurrently
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found keyword iosize
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found data type %d
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found value specification 1-128:1
17:51:00.373 [11788.8532] <2> parse_value_specification: Value specification='1-128:1'
17:51:00.373 [11788.8532] <2> parse_value_specification: Found default 1
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found prompt Sync region size in MB (UNIX only)
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found keyword slow
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found data type %d
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found value specification 0-:0
17:51:00.373 [11788.8532] <2> parse_value_specification: Value specification='0-:0'
17:51:00.373 [11788.8532] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
17:51:00.373 [11788.8532] <2> parse_value_specification: Found default 0
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found prompt Sync I/O delay in milliseconds (UNIX only)
17:51:00.373 [11788.8532] <2> read_vfm_conf: Found FIM: vxvm
17:51:00.373 [11788.8532] <2> read_vfm_conf: Found library: C:\Program Files\Veritas\NetBackup\bin\libfi_vxvm.dll
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found keyword async_resync
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found data type %b
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found value specification 0
17:51:00.373 [11788.8532] <2> parse_value_specification: Value specification='0'
17:51:00.373 [11788.8532] <2> parse_value_specification: Found default 0
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found prompt Resynchronize mirror in background (not Instant Recovery)
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found keyword max_snapshots
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found data type %d
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found value specification 1-:1
17:51:00.373 [11788.8532] <2> parse_value_specification: Value specification='1-:1'
17:51:00.373 [11788.8532] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
17:51:00.373 [11788.8532] <2> parse_value_specification: Found default 1
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found keyword sync_wait
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found data type %b
17:51:00.373 [11788.8532] <2> parse_ssm_parms: Found value specification 1
17:51:00.373 [11788.8532] <2> parse_value_specification: Value specification='1'
17:51:00.373 [11788.8532] <2> parse_value_specification: Found default 1
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found prompt Wait for mirror sync completion (Data Mover backups only)
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found keyword num_sync_vols
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found data type %d
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found value specification 1-32:1
17:51:00.389 [11788.8532] <2> parse_value_specification: Value specification='1-32:1'
17:51:00.389 [11788.8532] <2> parse_value_specification: Found default 1
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found prompt Maximum number of volumes to resynchronize concurrently
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found keyword iosize
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found data type %d
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found value specification 1-128:1
17:51:00.389 [11788.8532] <2> parse_value_specification: Value specification='1-128:1'
17:51:00.389 [11788.8532] <2> parse_value_specification: Found default 1
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found prompt Sync region size in MB (UNIX only)
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found keyword slow
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found data type %d
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found value specification 0-:0
17:51:00.389 [11788.8532] <2> parse_value_specification: Value specification='0-:0'
17:51:00.389 [11788.8532] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
17:51:00.389 [11788.8532] <2> parse_value_specification: Found default 0
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found prompt Sync I/O delay in milliseconds (UNIX only)
17:51:00.389 [11788.8532] <2> read_vfm_conf: Found FIM: VMware
17:51:00.389 [11788.8532] <2> read_vfm_conf: Found library: C:\Program Files\Veritas\NetBackup\bin\libfi_VMware.dll
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found keyword nameuse
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found data type %dd
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found value specification vmware_client_name_type_list
17:51:00.389 [11788.8532] <2> parse_value_specification: Value specification='vmware_client_name_type_list'
17:51:00.389 [11788.8532] <2> parse_value_specification: Found default vmware_client_name_type_list
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found prompt Client name selection
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found keyword Virtual_machine_backup
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found data type %dd
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found value specification vmware_backup_type_list
17:51:00.389 [11788.8532] <2> parse_value_specification: Value specification='vmware_backup_type_list'
17:51:00.389 [11788.8532] <2> parse_value_specification: Found default vmware_backup_type_list
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found prompt Virtual machine backup
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found keyword trantype
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found data type %dd
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found value specification VMware_transfer_list
17:51:00.389 [11788.8532] <2> parse_value_specification: Value specification='VMware_transfer_list'
17:51:00.389 [11788.8532] <2> parse_value_specification: Found default VMware_transfer_list
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found prompt Transfer type
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found keyword disable_quiesce
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found data type %dd
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found value specification enabled_disable_quiesce_list
17:51:00.389 [11788.8532] <2> parse_value_specification: Value specification='enabled_disable_quiesce_list'
17:51:00.389 [11788.8532] <2> parse_value_specification: Found default enabled_disable_quiesce_list
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found prompt Virtual machine quiesce
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found keyword file_system_optimization
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found data type %dd
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found value specification enabled_disabled_type_list
17:51:00.389 [11788.8532] <2> parse_value_specification: Value specification='enabled_disabled_type_list'
17:51:00.389 [11788.8532] <2> parse_value_specification: Found default enabled_disabled_type_list
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found prompt Exclude unused and deleted blocks
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found keyword snapact
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found data type %dd
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found value specification snapshot_handling_list
17:51:00.389 [11788.8532] <2> parse_value_specification: Value specification='snapshot_handling_list'
17:51:00.389 [11788.8532] <2> parse_value_specification: Found default snapshot_handling_list
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found prompt Existing snapshot handling
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found keyword vmmono
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found data type %dd
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found value specification disabled_enabled_type_list
17:51:00.389 [11788.8532] <2> parse_value_specification: Value specification='disabled_enabled_type_list'
17:51:00.389 [11788.8532] <2> parse_value_specification: Found default disabled_enabled_type_list
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found prompt Monolithic export (VCB only)
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found keyword mntpt
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found data type %s
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found prompt Snapshot mount point (VCB only)
17:51:00.389 [11788.8532] <2> map_integer_value: virtual_machine_supported=VMware, converted value=1, status=1
17:51:00.389 [11788.8532] <2> read_vfm_conf: Found FIM: NAS_Snapshot
17:51:00.389 [11788.8532] <2> read_vfm_conf: Found library: C:\Program Files\Veritas\NetBackup\bin\libfi_NAS_Snapshot.dll
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found keyword max_snapshots
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found data type %d
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found value specification 1-:1
17:51:00.389 [11788.8532] <2> parse_value_specification: Value specification='1-:1'
17:51:00.389 [11788.8532] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
17:51:00.389 [11788.8532] <2> parse_value_specification: Found default 1
17:51:00.389 [11788.8532] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
17:51:00.389 [11788.8532] <2> read_vfm_conf: Found FIM: VSS_Writer
17:51:00.389 [11788.8532] <2> read_vfm_conf: Found library: C:\Program Files\Veritas\NetBackup\bin\libfi_vss_writer.dll
17:51:00.405 [11788.8532] <2> vnet_pbxConnect: pbxConnectEx Succeeded
17:51:00.405 [11788.8532] <2> logconnections: BPRD CONNECT FROM 172.30.27.4.1335 TO 172.30.27.1.1556 fd = 544
17:51:00.498 [11788.8532] <8> bpfis: WRN - VfMS error 10; see following messages:
17:51:00.498 [11788.8532] <8> bpfis: WRN - Non-fatal method error was reported
17:51:00.498 [11788.8532] <8> bpfis: WRN - vfm_configure_fi_one: method: FlashSnap, type: FIM, function: FlashSnap_init
17:51:00.498 [11788.8532] <8> bpfis: WRN - VfMS method error 3; see following message:
17:51:00.498 [11788.8532] <8> bpfis: WRN - FlashSnap_init: Veritas Volume Manager not installed.
17:51:00.498 [11788.8532] <8> bpfis: WRN - VfMS error 10; see following messages:
17:51:00.498 [11788.8532] <8> bpfis: WRN - Non-fatal method error was reported
17:51:00.498 [11788.8532] <8> bpfis: WRN - vfm_configure_fi_one: method: vxvm, type: FIM, function: vxvm_init
17:51:00.498 [11788.8532] <8> bpfis: WRN - VfMS method error 3; see following message:
17:51:00.498 [11788.8532] <8> bpfis: WRN - vxvm_init: Veritas Volume Manager not installed.
17:51:00.514 [11788.8532] <4> bpfis: INF - FIS_ID=gnnmis41-bkp_1357993258
17:51:00.514 [11788.8532] <4> bpfis: INF - Freezing ALL_LOCAL_DRIVES using snapshot method VMware.
17:51:00.514 [11788.8532] <4> bpfis: INF - ACT=gnnmis41-bkp
17:51:00.514 [11788.8532] <4> bpfis: INF - Created mount point C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_ALL_LOCAL_DRIVES_11788
17:51:00.530 [11788.8532] <2> vnet_pbxConnect: pbxConnectEx Succeeded
17:51:00.530 [11788.8532] <2> logconnections: BPRD CONNECT FROM 172.30.27.4.1338 TO 172.30.27.1.1556 fd = 336
17:51:04.311 [11788.8532] <4> bpfis: INF - Deleted mount point C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_ALL_LOCAL_DRIVES_11788
17:51:04.311 [11788.8532] <32> bpfis: FTL - VfMS error 11; see following messages:
17:51:04.311 [11788.8532] <32> bpfis: FTL - Fatal method error was reported
17:51:04.311 [11788.8532] <32> bpfis: FTL - vfm_freeze: method: VMware, type: FIM, function: VMware_freeze
17:51:04.311 [11788.8532] <32> bpfis: FTL - VfMS method error 7; see following message:
17:51:04.311 [11788.8532] <32> bpfis: FTL - VMware_freeze: VIXAPI freeze failed unknown client gnnmis41-bkp
17:51:04.311 [11788.8532] <32> bpfis: FTL - VfMS error 11; see following messages:
17:51:04.311 [11788.8532] <32> bpfis: FTL - Fatal method error was reported
17:51:04.311 [11788.8532] <32> bpfis: FTL - vfm_freeze: method: VMware, type: FIM, function: VMware_freeze
17:51:04.311 [11788.8532] <32> bpfis: FTL - VfMS method error 7; see following message:
17:51:04.311 [11788.8532] <32> bpfis: FTL - VMware_freeze: VIXAPI freeze failed unknown client gnnmis41-bkp
17:51:04.311 [11788.8532] <16> bpfis: FTL - snapshot creation failed, status 156
17:51:04.311 [11788.8532] <4> bpfis: INF - Thawing ALL_LOCAL_DRIVES using snapshot method VMware.
17:51:04.311 [11788.8532] <8> bpfis: WRN - ALL_LOCAL_DRIVES is not frozen
17:51:04.311 [11788.8532] <8> bpfis: WRN - snapshot delete returned status 20
17:51:04.311 [11788.8532] <4> bpfis: INF - EXIT STATUS 156: snapshot error encountered
17:51:05.623 [5080.9172] <2> logparams: C:\Program Files\Veritas\NetBackup\bin\bpfis.exe delete -nbu -id gnnmis41-bkp_1357993258 -bpstart_to 30000 -bpend_to 3000 -clnt gnnbkp04 -S gnnbkp01
17:51:05.655 [5080.9172] <2> vnet_pbxConnect: pbxConnectEx Succeeded
17:51:05.655 [5080.9172] <2> logconnections: BPRD CONNECT FROM 172.30.27.4.1377 TO 172.30.27.1.1556 fd = 604
17:51:06.233 [5080.9172] <4> bpfis: INF - BACKUP START 5080
17:51:06.233 [5080.9172] <32> bpfis: FTL - cannot open C:\Program Files\Veritas\NetBackup\online_util\fi_cntl\bpfis.fim.gnnmis41-bkp_1357993258.0
17:51:06.233 [5080.9172] <4> bpfis: INF - EXIT STATUS 0: the requested operation was successfully completed
 

Please provide solution

Comments 2 CommentsJump to latest comment

RamNagalla's picture

17:51:04.311 [11788.8532] <32> bpfis: FTL - VfMS error 11; see following messages:

17:51:04.311 [11788.8532] <32> bpfis: FTL - Fatal method error was reported

17:51:04.311 [11788.8532] <32> bpfis: FTL - vfm_freeze: method: VMware, type: FIM, function: VMware_freeze

17:51:04.311 [11788.8532] <32> bpfis: FTL - VfMS method error 7; see following message:

17:51:04.311 [11788.8532] <32> bpfis: FTL - VMware_freeze: VIXAPI freeze failed unknown client gnnmis41-bkp

its saying that the gnnmis41-bkp is unknow client.

check below tech notes

http://www.symantec.com/business/support/index?pag...

http://www.symantec.com/business/support/index?pag...

https://www-secure.symantec.com/connect/forums/net...

What is your current version of Netbackup?

Dan@NB's picture

1. Try deleting gnnmis41-bkp client from configurd policy. Re-add the client from the list of VM's.

2. Run a test backup.

3. if it still fails, try to create a manual snapshot for the VM.

4. ensure enough disk space exist in diskstore for the VM.

That should resolve the issue.

+ Dan