15:41:33.341 [704] <2> logparams: bpfis create -nbu -owner NBU -id teocallib_1327876889 -bpstart_to 300 -bpend_to 300 -backup_copy 0 -ru root -pt 20 -clnt teocallib -rg root -fim VxFS_Snapshot:cache=/dev/vg00/rcachevol -class TEST-Flashbkup-UNIX -sched full -fso -S oxfordc 
15:41:33.341 [704] <2> bpfis main: received FIM as [39] VxFS_Snapshot:cache=/dev/vg00/rcachevol
15:41:33.349 [704] <4> bpfis main: INF - BACKUP START 704
15:41:33.350 [704] <2> bpfis main: receive filelist:<NEW_STREAM> 
15:41:33.373 [704] <2> onlfi_get_fl_opts: INF - GET_FLIST_OPTS=<NEW_STREAM>
15:41:33.380 [704] <2> bpfis main: receive filelist:</dev/vg00/rlvol9> 
15:41:33.381 [704] <2> onlfi_get_fl_opts: INF - GET_FLIST_OPTS=</dev/vg00/rlvol9>
15:41:33.381 [704] <2> bpfis main: receive filelist:<CONTINUE> 
15:41:33.389 [704] <2> ol_initialize: INF - stream_in_control = TEST-Flashbkup-UNIX+704+1, stream_name = TEST-Flashbkup-UNIX+704+1, streams = 1
15:41:33.487 [704] <2> onlfi_vfms_logf: INF - FlashSnap FIM $Revision: 1.199.20.2 $
15:41:33.488 [704] <2> onlfi_vfms_logf: INF - pVfMS FIM config string parser $Revision: 1.9 $
15:41:33.491 [704] <2> onlfi_add_to_fim_list: INF - snapshot method=FlashSnap
15:41:33.509 [704] <2> onlfi_vfms_logf: INF - SHADOWIMAGE FIM $Revision: 1.58 $
15:41:33.509 [704] <2> onlfi_add_to_fim_list: INF - snapshot method=ShadowImage
15:41:33.527 [704] <2> onlfi_vfms_logf: INF - TimeFinder FIM $Revision: 1.62 $
15:41:33.527 [704] <2> onlfi_add_to_fim_list: INF - snapshot method=TimeFinder
15:41:33.600 [704] <2> onlfi_vfms_logf: INF - @(#) $Source: src/vfms/fim/nas_snapshot/nas_snapshot.c,v $ $Revision: 1.100.20.1 $ 
15:41:33.600 [704] <2> onlfi_add_to_fim_list: INF - snapshot method=NAS_Snapshot
15:41:33.604 [704] <2> onlfi_vfms_logf: INF - VVR FIM $Revision: 1.199.20.2 $
15:41:33.605 [704] <2> onlfi_add_to_fim_list: INF - snapshot method=VVR
15:41:33.621 [704] <2> onlfi_vfms_logf: INF - Automatic Snapshot Method $Revision: 1.8 $
15:41:33.621 [704] <2> onlfi_add_to_fim_list: INF - snapshot method=auto
15:41:33.621 [704] <2> onlfi_vfms_logf: INF - vfm_configure_fi_one: starting VxFI
15:41:33.729 [704] <2> read_vfm_conf: options=0x2
15:41:33.730 [704] <2> read_vfm_conf: Found FIM: FlashSnap
15:41:33.730 [704] <2> read_vfm_conf: Found library: /usr/openv/lib/libfi_FlashSnap.sl
15:41:33.730 [704] <2> parse_ssm_parms: Found keyword keep_fi
15:41:33.730 [704] <2> parse_ssm_parms: Found data type %b
15:41:33.730 [704] <2> parse_ssm_parms: Found value specification 0
15:41:33.730 [704] <2> parse_value_specification: Value specification='0'
15:41:33.730 [704] <2> parse_value_specification: Found default 0
15:41:33.730 [704] <2> parse_ssm_parms: Found prompt Keep snapshot after backup (not Instant Recovery)
15:41:33.730 [704] <2> parse_ssm_parms: Found keyword async_resync
15:41:33.730 [704] <2> parse_ssm_parms: Found data type %b
15:41:33.730 [704] <2> parse_ssm_parms: Found value specification 0
15:41:33.730 [704] <2> parse_value_specification: Value specification='0'
15:41:33.730 [704] <2> parse_value_specification: Found default 0
15:41:33.730 [704] <2> parse_ssm_parms: Found prompt Resynchronize mirror in background (not Instant Recovery)
15:41:33.730 [704] <2> parse_ssm_parms: Found keyword max_snapshots
15:41:33.730 [704] <2> parse_ssm_parms: Found data type %d
15:41:33.730 [704] <2> parse_ssm_parms: Found value specification 1-:1
15:41:33.730 [704] <2> parse_value_specification: Value specification='1-:1'
15:41:33.730 [704] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
15:41:33.730 [704] <2> parse_value_specification: Found default 1
15:41:33.730 [704] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
15:41:33.730 [704] <2> parse_ssm_parms: Found keyword dg_split_retry_times
15:41:33.730 [704] <2> parse_ssm_parms: Found data type %d
15:41:33.730 [704] <2> parse_ssm_parms: Found value specification 1
15:41:33.730 [704] <2> parse_value_specification: Value specification='1'
15:41:33.730 [704] <2> parse_value_specification: Found default 1
15:41:33.730 [704] <2> parse_ssm_parms: Found prompt Number of times to retry disk group split
15:41:33.730 [704] <2> parse_ssm_parms: Found keyword dg_split_retry_wait_period
15:41:33.730 [704] <2> parse_ssm_parms: Found data type %d
15:41:33.730 [704] <2> parse_ssm_parms: Found value specification 60-:60
15:41:33.730 [704] <2> parse_value_specification: Value specification='60-:60'
15:41:33.730 [704] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
15:41:33.730 [704] <2> parse_value_specification: Found default 60
15:41:33.730 [704] <2> parse_ssm_parms: Found prompt Delay in seconds between disk group split retries
15:41:33.730 [704] <2> parse_ssm_parms: Found keyword num_sync_vols
15:41:33.730 [704] <2> parse_ssm_parms: Found data type %d
15:41:33.730 [704] <2> parse_ssm_parms: Found value specification 1-32:1
15:41:33.730 [704] <2> parse_value_specification: Value specification='1-32:1'
15:41:33.730 [704] <2> parse_value_specification: Found default 1
15:41:33.730 [704] <2> parse_ssm_parms: Found prompt Maximum number of volumes to resynchronize concurrently
15:41:33.730 [704] <2> parse_ssm_parms: Found keyword iosize
15:41:33.730 [704] <2> parse_ssm_parms: Found data type %d
15:41:33.730 [704] <2> parse_ssm_parms: Found value specification 1-128:1
15:41:33.731 [704] <2> parse_value_specification: Value specification='1-128:1'
15:41:33.731 [704] <2> parse_value_specification: Found default 1
15:41:33.731 [704] <2> parse_ssm_parms: Found prompt Sync region size in MB (UNIX only)
15:41:33.731 [704] <2> parse_ssm_parms: Found keyword slow
15:41:33.731 [704] <2> parse_ssm_parms: Found data type %d
15:41:33.731 [704] <2> parse_ssm_parms: Found value specification 0-:0
15:41:33.731 [704] <2> parse_value_specification: Value specification='0-:0'
15:41:33.731 [704] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
15:41:33.731 [704] <2> parse_value_specification: Found default 0
15:41:33.731 [704] <2> parse_ssm_parms: Found prompt Sync I/O delay in milliseconds (UNIX only)
15:41:33.731 [704] <2> read_vfm_conf: Found FIM: ShadowImage
15:41:33.731 [704] <2> read_vfm_conf: Found library: /usr/openv/lib/libfi_ShadowImage.sl
15:41:33.731 [704] <2> parse_ssm_parms: Found keyword keep_fi
15:41:33.731 [704] <2> parse_ssm_parms: Found data type %b
15:41:33.731 [704] <2> parse_ssm_parms: Found value specification 0
15:41:33.731 [704] <2> parse_value_specification: Value specification='0'
15:41:33.731 [704] <2> parse_value_specification: Found default 0
15:41:33.731 [704] <2> parse_ssm_parms: Found prompt Keep snapshot after backup
15:41:33.731 [704] <2> parse_ssm_parms: Found keyword sync_at_start
15:41:33.731 [704] <2> parse_ssm_parms: Found data type %b
15:41:33.731 [704] <2> parse_ssm_parms: Found value specification 0
15:41:33.731 [704] <2> parse_value_specification: Value specification='0'
15:41:33.731 [704] <2> parse_value_specification: Found default 0
15:41:33.731 [704] <2> parse_ssm_parms: Found prompt Synchronize mirror before backup
15:41:33.731 [704] <2> parse_ssm_parms: Found keyword async_resync
15:41:33.731 [704] <2> parse_ssm_parms: Found data type %b
15:41:33.731 [704] <2> parse_ssm_parms: Found value specification 0
15:41:33.731 [704] <2> parse_value_specification: Value specification='0'
15:41:33.731 [704] <2> parse_value_specification: Found default 0
15:41:33.731 [704] <2> parse_ssm_parms: Found prompt Resynchronize mirror in background
15:41:33.731 [704] <2> parse_ssm_parms: Found keyword timeout
15:41:33.731 [704] <2> parse_ssm_parms: Found data type %d
15:41:33.731 [704] <2> parse_ssm_parms: Found value specification 3-3600:240
15:41:33.731 [704] <2> parse_value_specification: Value specification='3-3600:240'
15:41:33.731 [704] <2> parse_value_specification: Found default 240
15:41:33.731 [704] <2> parse_ssm_parms: Found prompt FS Freeze Timeout default 4 minutes
15:41:33.731 [704] <2> read_vfm_conf: Found FIM: TimeFinder
15:41:33.731 [704] <2> read_vfm_conf: Found library: /usr/openv/lib/libfi_TimeFinder.sl
15:41:33.731 [704] <2> parse_ssm_parms: Found keyword keep_fi
15:41:33.731 [704] <2> parse_ssm_parms: Found data type %b
15:41:33.731 [704] <2> parse_ssm_parms: Found value specification 0
15:41:33.731 [704] <2> parse_value_specification: Value specification='0'
15:41:33.731 [704] <2> parse_value_specification: Found default 0
15:41:33.731 [704] <2> parse_ssm_parms: Found prompt Keep snapshot after backup
15:41:33.731 [704] <2> read_vfm_conf: Found FIM: NAS_Snapshot
15:41:33.732 [704] <2> read_vfm_conf: Found library: /usr/openv/lib/libfi_NAS_Snapshot.sl
15:41:33.732 [704] <2> parse_ssm_parms: Found keyword max_snapshots
15:41:33.732 [704] <2> parse_ssm_parms: Found data type %d
15:41:33.732 [704] <2> parse_ssm_parms: Found value specification 1-:1
15:41:33.732 [704] <2> parse_value_specification: Value specification='1-:1'
15:41:33.732 [704] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
15:41:33.732 [704] <2> parse_value_specification: Found default 1
15:41:33.732 [704] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
15:41:33.732 [704] <2> read_vfm_conf: Found FIM: VVR
15:41:33.732 [704] <2> read_vfm_conf: Found library: /usr/openv/lib/libfi_VVR.sl
15:41:33.732 [704] <2> parse_ssm_parms: Found keyword keep_fi
15:41:33.732 [704] <2> parse_ssm_parms: Found data type %b
15:41:33.732 [704] <2> parse_ssm_parms: Found value specification 0
15:41:33.732 [704] <2> parse_value_specification: Value specification='0'
15:41:33.732 [704] <2> parse_value_specification: Found default 0
15:41:33.732 [704] <2> parse_ssm_parms: Found prompt Keep snapshot after backup
15:41:33.732 [704] <2> parse_ssm_parms: Found keyword send_timeout
15:41:33.732 [704] <2> parse_ssm_parms: Found data type %d
15:41:33.732 [704] <2> parse_ssm_parms: Found value specification 1-3600:60
15:41:33.732 [704] <2> parse_value_specification: Value specification='1-3600:60'
15:41:33.732 [704] <2> parse_value_specification: Found default 60
15:41:33.732 [704] <2> parse_ssm_parms: Found prompt IBC send timeout (seconds)
15:41:33.732 [704] <2> parse_ssm_parms: Found keyword receive_timeout
15:41:33.732 [704] <2> parse_ssm_parms: Found data type %d
15:41:33.732 [704] <2> parse_ssm_parms: Found value specification 1-3600:600
15:41:33.732 [704] <2> parse_value_specification: Value specification='1-3600:600'
15:41:33.732 [704] <2> parse_value_specification: Found default 600
15:41:33.732 [704] <2> parse_ssm_parms: Found prompt IBC receive timeout (seconds)
15:41:33.732 [704] <2> parse_ssm_parms: Found keyword async_resync
15:41:33.732 [704] <2> parse_ssm_parms: Found data type %b
15:41:33.732 [704] <2> parse_ssm_parms: Found value specification 0
15:41:33.732 [704] <2> parse_value_specification: Value specification='0'
15:41:33.732 [704] <2> parse_value_specification: Found default 0
15:41:33.732 [704] <2> parse_ssm_parms: Found prompt Resynchronize mirror in background
15:41:33.732 [704] <2> parse_ssm_parms: Found keyword max_snapshots
15:41:33.732 [704] <2> parse_ssm_parms: Found data type %d
15:41:33.732 [704] <2> parse_ssm_parms: Found value specification 1-:1
15:41:33.732 [704] <2> parse_value_specification: Value specification='1-:1'
15:41:33.732 [704] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
15:41:33.732 [704] <2> parse_value_specification: Found default 1
15:41:33.732 [704] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
15:41:33.732 [704] <2> read_vfm_conf: Found FIM: auto
15:41:33.732 [704] <2> read_vfm_conf: Found library: /usr/openv/lib/libfi_auto.sl
15:41:33.732 [704] <2> read_vfm_conf: Found FIM: IBM_DiskStorage_FlashCopy
15:41:33.732 [704] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:33.732 [704] <2> parse_ssm_parms: Found keyword snapshot_resource_spec
15:41:33.732 [704] <2> parse_ssm_parms: Found data type %s
15:41:33.733 [704] <2> parse_ssm_parms: Found prompt Snapshot Resource Specification
15:41:33.733 [704] <2> parse_ssm_parms: Found keyword flashcopy_wait
15:41:33.733 [704] <2> parse_ssm_parms: Found data type %b
15:41:33.733 [704] <2> parse_ssm_parms: Found value specification 0
15:41:33.733 [704] <2> parse_value_specification: Value specification='0'
15:41:33.733 [704] <2> parse_value_specification: Found default 0
15:41:33.733 [704] <2> parse_ssm_parms: Found prompt Wait for Flashcopy operation to complete.(Default is no wait)
15:41:33.733 [704] <2> read_vfm_conf: Found FIM: VxFS_Checkpoint
15:41:33.733 [704] <2> read_vfm_conf: Found library: /usr/openv/lib/libfi_vxfs_ckpt.sl
15:41:33.733 [704] <2> parse_ssm_parms: Found keyword max_snapshots
15:41:33.733 [704] <2> parse_ssm_parms: Found data type %d
15:41:33.733 [704] <2> parse_ssm_parms: Found value specification 1-:1
15:41:33.733 [704] <2> parse_value_specification: Value specification='1-:1'
15:41:33.733 [704] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
15:41:33.733 [704] <2> parse_value_specification: Found default 1
15:41:33.733 [704] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
15:41:33.733 [704] <2> read_vfm_conf: Found FIM: VxFS_Snapshot
15:41:33.733 [704] <2> read_vfm_conf: Found library: /usr/openv/lib/libfi_vxfs.sl
15:41:33.733 [704] <2> parse_ssm_parms: Found keyword cache
15:41:33.733 [704] <2> parse_ssm_parms: Found data type %c
15:41:33.733 [704] <2> parse_ssm_parms: Found prompt Cache device path
15:41:33.733 [704] <2> read_vfm_conf: Found FIM: vxvm
15:41:33.733 [704] <2> read_vfm_conf: Found library: /usr/openv/lib/libfi_vxvm.sl
15:41:33.733 [704] <2> parse_ssm_parms: Found keyword async_resync
15:41:33.733 [704] <2> parse_ssm_parms: Found data type %b
15:41:33.733 [704] <2> parse_ssm_parms: Found value specification 0
15:41:33.733 [704] <2> parse_value_specification: Value specification='0'
15:41:33.733 [704] <2> parse_value_specification: Found default 0
15:41:33.733 [704] <2> parse_ssm_parms: Found prompt Resynchronize mirror in background (not Instant Recovery)
15:41:33.733 [704] <2> parse_ssm_parms: Found keyword max_snapshots
15:41:33.733 [704] <2> parse_ssm_parms: Found data type %d
15:41:33.733 [704] <2> parse_ssm_parms: Found value specification 1-:1
15:41:33.733 [704] <2> parse_value_specification: Value specification='1-:1'
15:41:33.733 [704] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
15:41:33.733 [704] <2> parse_value_specification: Found default 1
15:41:33.733 [704] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
15:41:33.733 [704] <2> parse_ssm_parms: Found keyword sync_wait
15:41:33.733 [704] <2> parse_ssm_parms: Found data type %b
15:41:33.733 [704] <2> parse_ssm_parms: Found value specification 1
15:41:33.733 [704] <2> parse_value_specification: Value specification='1'
15:41:33.733 [704] <2> parse_value_specification: Found default 1
15:41:33.733 [704] <2> parse_ssm_parms: Found prompt Wait for mirror sync completion (Data Mover backups only)
15:41:33.733 [704] <2> parse_ssm_parms: Found keyword num_sync_vols
15:41:33.733 [704] <2> parse_ssm_parms: Found data type %d
15:41:33.733 [704] <2> parse_ssm_parms: Found value specification 1-32:1
15:41:33.733 [704] <2> parse_value_specification: Value specification='1-32:1'
15:41:33.734 [704] <2> parse_value_specification: Found default 1
15:41:33.734 [704] <2> parse_ssm_parms: Found prompt Maximum number of volumes to resynchronize concurrently
15:41:33.734 [704] <2> parse_ssm_parms: Found keyword iosize
15:41:33.734 [704] <2> parse_ssm_parms: Found data type %d
15:41:33.734 [704] <2> parse_ssm_parms: Found value specification 1-128:1
15:41:33.734 [704] <2> parse_value_specification: Value specification='1-128:1'
15:41:33.734 [704] <2> parse_value_specification: Found default 1
15:41:33.734 [704] <2> parse_ssm_parms: Found prompt Sync region size in MB (UNIX only)
15:41:33.734 [704] <2> parse_ssm_parms: Found keyword slow
15:41:33.734 [704] <2> parse_ssm_parms: Found data type %d
15:41:33.734 [704] <2> parse_ssm_parms: Found value specification 0-:0
15:41:33.734 [704] <2> parse_value_specification: Value specification='0-:0'
15:41:33.734 [704] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
15:41:33.734 [704] <2> parse_value_specification: Found default 0
15:41:33.734 [704] <2> parse_ssm_parms: Found prompt Sync I/O delay in milliseconds (UNIX only)
15:41:33.734 [704] <2> read_vfm_conf: Found FIM: BusinessCopy
15:41:33.734 [704] <2> read_vfm_conf: Found library: /usr/openv/lib/libfi_BusinessCopy.sl
15:41:33.734 [704] <2> parse_ssm_parms: Found keyword keep_fi
15:41:33.734 [704] <2> parse_ssm_parms: Found data type %b
15:41:33.734 [704] <2> parse_ssm_parms: Found value specification 0
15:41:33.734 [704] <2> parse_value_specification: Value specification='0'
15:41:33.734 [704] <2> parse_value_specification: Found default 0
15:41:33.734 [704] <2> parse_ssm_parms: Found prompt Keep snapshot after backup
15:41:33.734 [704] <2> parse_ssm_parms: Found keyword sync_at_start
15:41:33.734 [704] <2> parse_ssm_parms: Found data type %b
15:41:33.734 [704] <2> parse_ssm_parms: Found value specification 0
15:41:33.734 [704] <2> parse_value_specification: Value specification='0'
15:41:33.734 [704] <2> parse_value_specification: Found default 0
15:41:33.734 [704] <2> parse_ssm_parms: Found prompt Synchronize mirror before backup
15:41:33.734 [704] <2> parse_ssm_parms: Found keyword async_resync
15:41:33.734 [704] <2> parse_ssm_parms: Found data type %b
15:41:33.734 [704] <2> parse_ssm_parms: Found value specification 0
15:41:33.734 [704] <2> parse_value_specification: Value specification='0'
15:41:33.734 [704] <2> parse_value_specification: Found default 0
15:41:33.734 [704] <2> parse_ssm_parms: Found prompt Resynchronize mirror in background
15:41:33.734 [704] <2> read_vfm_conf: Found FIM: EMC_CLARiiON_Snapview_Clone
15:41:33.734 [704] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:33.734 [704] <2> parse_ssm_parms: Found keyword snapshot_resource_spec
15:41:33.734 [704] <2> parse_ssm_parms: Found data type %s
15:41:33.734 [704] <2> parse_ssm_parms: Found prompt Snapshot Resource Specification
15:41:33.734 [704] <2> read_vfm_conf: Found FIM: EMC_CLARiiON_Snapview_Snapshot
15:41:33.734 [704] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:33.734 [704] <2> parse_ssm_parms: Found keyword max_snapshots
15:41:33.735 [704] <2> parse_ssm_parms: Found data type %d
15:41:33.735 [704] <2> parse_ssm_parms: Found value specification 1-8:1
15:41:33.735 [704] <2> parse_value_specification: Value specification='1-8:1'
15:41:33.735 [704] <2> parse_value_specification: Found default 1
15:41:33.735 [704] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
15:41:33.735 [704] <2> read_vfm_conf: Found FIM: EMC_TimeFinder_Clone
15:41:33.735 [704] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:33.735 [704] <2> parse_ssm_parms: Found keyword snapshot_resource_spec
15:41:33.735 [704] <2> parse_ssm_parms: Found data type %s
15:41:33.735 [704] <2> parse_ssm_parms: Found prompt Snapshot Resource Specification
15:41:33.735 [704] <2> read_vfm_conf: Found FIM: EMC_TimeFinder_Mirror
15:41:33.735 [704] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:33.735 [704] <2> parse_ssm_parms: Found keyword snapshot_resource_spec
15:41:33.735 [704] <2> parse_ssm_parms: Found data type %s
15:41:33.735 [704] <2> parse_ssm_parms: Found prompt Snapshot Resource Specification
15:41:33.735 [704] <2> read_vfm_conf: Found FIM: EMC_TimeFinder_Snap
15:41:33.735 [704] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:33.735 [704] <2> parse_ssm_parms: Found keyword snapshot_resource_spec
15:41:33.735 [704] <2> parse_ssm_parms: Found data type %s
15:41:33.735 [704] <2> parse_ssm_parms: Found prompt Snapshot Resource Specification
15:41:33.735 [704] <2> parse_ssm_parms: Found keyword savedev_pool
15:41:33.735 [704] <2> parse_ssm_parms: Found data type %s
15:41:33.735 [704] <2> parse_ssm_parms: Found value specification Use_Default_Pool
15:41:33.735 [704] <2> parse_value_specification: Value specification='Use_Default_Pool'
15:41:33.735 [704] <2> parse_value_specification: Found default Use_Default_Pool
15:41:33.735 [704] <2> parse_ssm_parms: Found prompt SAVE Device Pool
15:41:33.735 [704] <2> read_vfm_conf: Found FIM: Hitachi_ShadowImage
15:41:33.735 [704] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:33.735 [704] <2> parse_ssm_parms: Found keyword snapshot_resource_spec
15:41:33.735 [704] <2> parse_ssm_parms: Found data type %s
15:41:33.735 [704] <2> parse_ssm_parms: Found prompt Snapshot Resource Specification
15:41:33.735 [704] <2> read_vfm_conf: Found FIM: Hitachi_CopyOnWrite
15:41:33.735 [704] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:33.735 [704] <2> parse_ssm_parms: Found keyword snapshot_resource_spec
15:41:33.735 [704] <2> parse_ssm_parms: Found data type %s
15:41:33.735 [704] <2> parse_ssm_parms: Found prompt Snapshot Resource Specification
15:41:33.735 [704] <2> read_vfm_conf: Found FIM: HP_EVA_Vsnap
15:41:33.735 [704] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:33.735 [704] <2> parse_ssm_parms: Found keyword max_snapshots
15:41:33.735 [704] <2> parse_ssm_parms: Found data type %d
15:41:33.735 [704] <2> parse_ssm_parms: Found value specification 1-:1
15:41:33.735 [704] <2> parse_value_specification: Value specification='1-:1'
15:41:33.736 [704] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
15:41:33.736 [704] <2> parse_value_specification: Found default 1
15:41:33.736 [704] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
15:41:33.736 [704] <2> read_vfm_conf: Found FIM: HP_EVA_Snapshot
15:41:33.736 [704] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:33.736 [704] <2> parse_ssm_parms: Found keyword max_snapshots
15:41:33.736 [704] <2> parse_ssm_parms: Found data type %d
15:41:33.736 [704] <2> parse_ssm_parms: Found value specification 1-:1
15:41:33.736 [704] <2> parse_value_specification: Value specification='1-:1'
15:41:33.736 [704] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
15:41:33.736 [704] <2> parse_value_specification: Found default 1
15:41:33.736 [704] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
15:41:33.736 [704] <2> read_vfm_conf: Found FIM: HP_EVA_Snapclone
15:41:33.736 [704] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:33.736 [704] <2> parse_ssm_parms: Found keyword max_snapshots
15:41:33.736 [704] <2> parse_ssm_parms: Found data type %d
15:41:33.736 [704] <2> parse_ssm_parms: Found value specification 1-:1
15:41:33.736 [704] <2> parse_value_specification: Value specification='1-:1'
15:41:33.736 [704] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
15:41:33.736 [704] <2> parse_value_specification: Found default 1
15:41:33.736 [704] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
15:41:33.736 [704] <2> read_vfm_conf: Found FIM: HP_XP_BusinessCopy
15:41:33.736 [704] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:33.736 [704] <2> parse_ssm_parms: Found keyword snapshot_resource_spec
15:41:33.736 [704] <2> parse_ssm_parms: Found data type %s
15:41:33.736 [704] <2> parse_ssm_parms: Found prompt Snapshot Resource Specification
15:41:33.736 [704] <2> read_vfm_conf: Found FIM: HP_XP_Snapshot
15:41:33.736 [704] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:33.736 [704] <2> parse_ssm_parms: Found keyword snapshot_resource_spec
15:41:33.736 [704] <2> parse_ssm_parms: Found data type %s
15:41:33.736 [704] <2> parse_ssm_parms: Found prompt Snapshot Resource Specification
15:41:33.736 [704] <2> read_vfm_conf: Found FIM: IBM_StorageManager_FlashCopy
15:41:33.736 [704] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:33.736 [704] <2> parse_ssm_parms: Found keyword max_snapshots
15:41:33.736 [704] <2> parse_ssm_parms: Found data type %d
15:41:33.736 [704] <2> parse_ssm_parms: Found value specification 1-4:1
15:41:33.736 [704] <2> parse_value_specification: Value specification='1-4:1'
15:41:33.736 [704] <2> parse_value_specification: Found default 1
15:41:33.736 [704] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
15:41:33.736 [704] <2> parse_ssm_parms: Found keyword repository_drive_capacity
15:41:33.736 [704] <2> parse_ssm_parms: Found data type %d
15:41:33.737 [704] <2> parse_ssm_parms: Found value specification 0-100:0
15:41:33.737 [704] <2> parse_value_specification: Value specification='0-100:0'
15:41:33.737 [704] <2> parse_value_specification: Found default 0
15:41:33.737 [704] <2> parse_ssm_parms: Found prompt Repository % of Base (100 for Instant Recovery)
15:41:33.737 [704] <2> read_vfm_conf: Found FIM: RealTime
15:41:33.737 [704] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:33.737 [704] <2> parse_ssm_parms: Found keyword max_snapshots
15:41:33.737 [704] <2> parse_ssm_parms: Found data type %d
15:41:33.737 [704] <2> parse_ssm_parms: Found value specification 1-:1
15:41:33.737 [704] <2> parse_value_specification: Value specification='1-:1'
15:41:33.737 [704] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
15:41:33.737 [704] <2> parse_value_specification: Found default 1
15:41:33.737 [704] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
15:41:33.737 [704] <2> onlfi_vfms_logf: INF - vfm_configure_fi_one: configuring VxFI credentials
15:41:33.738 [704] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6669: 0: fopen() failed: 2 0x00000002
15:41:33.738 [704] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6670: 0: fopen() failed: /usr/openv/var/host_cache/049/efd34649+veritas_pbx,1,40,2,1,0+oxfordc.txt
15:41:33.759 [704] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6669: 0: fopen() failed: 2 0x00000002
15:41:33.759 [704] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6670: 0: fopen() failed: /usr/openv/var/host_cache/186/cf370d86+0,1,a,0,1,0+169.143.74.127.txt
15:41:33.779 [704] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6669: 0: fopen() failed: 2 0x00000002
15:41:33.779 [704] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6670: 0: fopen() failed: /usr/openv/var/host_cache/0cc/b94466cc+0,1,a,2,1,0+teocallib.txt
15:41:33.807 [704] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6669: 0: fopen() failed: 2 0x00000002
15:41:33.807 [704] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6670: 0: fopen() failed: /usr/openv/var/host_cache/0cc/b94466cc+0,1,40,2,1,0+teocallib.txt
15:41:33.827 [704] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6669: 0: fopen() failed: 2 0x00000002
15:41:33.827 [704] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6670: 0: fopen() failed: /usr/openv/var/host_cache/049/efd34649+vnetd,1,40,2,1,0+oxfordc.txt
15:41:33.844 [704] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6669: 0: fopen() failed: 2 0x00000002
15:41:33.844 [704] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6670: 0: fopen() failed: /usr/openv/var/host_cache/049/efd34649+bprd,1,40,2,1,0+oxfordc.txt
15:41:33.875 [704] <2> vnet_pbxConnect: pbxConnectEx Succeeded
15:41:33.875 [704] <2> logconnections: BPRD CONNECT FROM 169.143.74.248.53938 TO 169.143.74.127.1556 fd = 7
15:41:34.693 [704] <2> bprd_read_text_file: Received status 131
15:41:34.694 [704] <2> onlfi_vfms_logf: INF - vfm_configure_fi_one: read credentials file failed
15:41:34.694 [704] <2> onlfi_add_to_fim_list: INF - snapshot method=IBM_DiskStorage_FlashCopy
15:41:34.705 [704] <2> onlfi_vfms_logf: INF - VxFS_Checkpoint FIM $Revision: 1.44 $
15:41:34.705 [704] <2> onlfi_add_to_fim_list: INF - snapshot method=VxFS_Checkpoint
15:41:34.740 [704] <2> onlfi_vfms_logf: INF - VxFS_Snapshot FIM $Revision: 1.30 $
15:41:34.740 [704] <2> onlfi_add_to_fim_list: INF - snapshot method=VxFS_Snapshot
15:41:34.753 [704] <2> onlfi_vfms_logf: INF - VxVM FIM $Revision: 1.199.20.2 $
15:41:34.753 [704] <2> onlfi_add_to_fim_list: INF - snapshot method=vxvm
15:41:34.777 [704] <2> onlfi_vfms_logf: INF - BusinessCopy FIM $Revision: 1.58 $
15:41:34.777 [704] <2> onlfi_add_to_fim_list: INF - snapshot method=BusinessCopy
15:41:34.777 [704] <2> onlfi_add_to_fim_list: INF - snapshot method=EMC_CLARiiON_Snapview_Clone
15:41:34.777 [704] <2> onlfi_add_to_fim_list: INF - snapshot method=EMC_CLARiiON_Snapview_Snapshot
15:41:34.777 [704] <2> onlfi_add_to_fim_list: INF - snapshot method=EMC_TimeFinder_Clone
15:41:34.777 [704] <2> onlfi_add_to_fim_list: INF - snapshot method=EMC_TimeFinder_Mirror
15:41:34.777 [704] <2> onlfi_add_to_fim_list: INF - snapshot method=EMC_TimeFinder_Snap
15:41:34.777 [704] <2> onlfi_add_to_fim_list: INF - snapshot method=Hitachi_ShadowImage
15:41:34.777 [704] <2> onlfi_add_to_fim_list: INF - snapshot method=Hitachi_CopyOnWrite
15:41:34.777 [704] <2> onlfi_add_to_fim_list: INF - snapshot method=HP_EVA_Vsnap
15:41:34.777 [704] <2> onlfi_add_to_fim_list: INF - snapshot method=HP_EVA_Snapshot
15:41:34.777 [704] <2> onlfi_add_to_fim_list: INF - snapshot method=HP_EVA_Snapclone
15:41:34.777 [704] <2> onlfi_add_to_fim_list: INF - snapshot method=HP_XP_BusinessCopy
15:41:34.777 [704] <2> onlfi_add_to_fim_list: INF - snapshot method=HP_XP_Snapshot
15:41:34.777 [704] <2> onlfi_add_to_fim_list: INF - snapshot method=IBM_StorageManager_FlashCopy
15:41:34.777 [704] <2> onlfi_add_to_fim_list: INF - snapshot method=RealTime
15:41:34.777 [704] <2> ActMonCallback: Activity Monitor Log : [1] Act Monitor Init  
15:41:34.777 [704] <4> bpfis main: INF - FIS_ID=teocallib_1327876889
15:41:34.785 [704] <2> onlfi_process_fs_list: INF - processing file=/tmp/TEST-Flashbkup-UNIX+704+1.std_filelist
15:41:34.824 [704] <2> onlfi_freeze_prepare: INF - snapshot method=FlashSnap
15:41:34.824 [704] <2> onlfi_freeze_prepare: INF - snapshot method=ShadowImage
15:41:34.824 [704] <2> onlfi_freeze_prepare: INF - snapshot method=TimeFinder
15:41:34.824 [704] <2> onlfi_freeze_prepare: INF - snapshot method=NAS_Snapshot
15:41:34.824 [704] <2> onlfi_freeze_prepare: INF - snapshot method=VVR
15:41:34.824 [704] <2> onlfi_freeze_prepare: INF - snapshot method=auto
15:41:34.824 [704] <2> onlfi_freeze_prepare: INF - snapshot method=IBM_DiskStorage_FlashCopy
15:41:34.824 [704] <2> onlfi_freeze_prepare: INF - snapshot method=VxFS_Checkpoint
15:41:34.825 [704] <2> onlfi_freeze_prepare: INF - snapshot method=VxFS_Snapshot
15:41:34.825 [704] <2> onlfi_freeze_prepare: INF - snapshot method=vxvm
15:41:34.825 [704] <2> onlfi_freeze_prepare: INF - snapshot method=BusinessCopy
15:41:34.825 [704] <2> onlfi_freeze_prepare: INF - snapshot method=EMC_CLARiiON_Snapview_Clone
15:41:34.825 [704] <2> onlfi_freeze_prepare: INF - snapshot method=EMC_CLARiiON_Snapview_Snapshot
15:41:34.825 [704] <2> onlfi_freeze_prepare: INF - snapshot method=EMC_TimeFinder_Clone
15:41:34.825 [704] <2> onlfi_freeze_prepare: INF - snapshot method=EMC_TimeFinder_Mirror
15:41:34.825 [704] <2> onlfi_freeze_prepare: INF - snapshot method=EMC_TimeFinder_Snap
15:41:34.825 [704] <2> onlfi_freeze_prepare: INF - snapshot method=Hitachi_ShadowImage
15:41:34.825 [704] <2> onlfi_freeze_prepare: INF - snapshot method=Hitachi_CopyOnWrite
15:41:34.825 [704] <2> onlfi_freeze_prepare: INF - snapshot method=HP_EVA_Vsnap
15:41:34.825 [704] <2> onlfi_freeze_prepare: INF - snapshot method=HP_EVA_Snapshot
15:41:34.826 [704] <2> onlfi_freeze_prepare: INF - snapshot method=HP_EVA_Snapclone
15:41:34.826 [704] <2> onlfi_freeze_prepare: INF - snapshot method=HP_XP_BusinessCopy
15:41:34.826 [704] <2> onlfi_freeze_prepare: INF - snapshot method=HP_XP_Snapshot
15:41:34.826 [704] <2> onlfi_freeze_prepare: INF - snapshot method=IBM_StorageManager_FlashCopy
15:41:34.826 [704] <2> onlfi_freeze_prepare: INF - snapshot method=RealTime
15:41:34.826 [704] <2> onlfi_freeze: INF - snapshot method=FlashSnap
15:41:34.826 [704] <2> onlfi_freeze: INF - snapshot method=ShadowImage
15:41:34.826 [704] <2> onlfi_freeze: INF - snapshot method=TimeFinder
15:41:34.826 [704] <2> onlfi_freeze: INF - snapshot method=NAS_Snapshot
15:41:34.826 [704] <2> onlfi_freeze: INF - snapshot method=VVR
15:41:34.826 [704] <2> onlfi_freeze: INF - snapshot method=auto
15:41:34.826 [704] <2> onlfi_freeze: INF - snapshot method=IBM_DiskStorage_FlashCopy
15:41:34.826 [704] <2> onlfi_freeze: INF - snapshot method=VxFS_Checkpoint
15:41:34.826 [704] <2> onlfi_freeze: INF - snapshot method=VxFS_Snapshot
15:41:34.826 [704] <4> onlfi_freeze_fim: INF - Freezing /dev/vg00/rlvol9 using snapshot method VxFS_Snapshot.
15:41:34.826 [704] <2> ActMonCallback: Activity Monitor Log : [69] teocallib VxFS_Snapshot
15:41:34.826 [704] <4> ActMonCallback: INF - ACT=teocallib
15:41:34.829 [704] <2> onlfi_vfms_logf: INF - config =cache=/dev/vg00/rcachevol,APP_TYPE=FS,BACKUP_TIME=1327876893,POLICY_NAME=TEST-Flashbkup-UNIX,NBU_CLIENT=teocallib,NBU_MASTER=oxfordc,SCHED_NAME=full,SCHED_TYPE=unknown,POLICY_TYPE=20,PFI_BACKUP=0,NBU_CATALOG=0,VSS_REPLICA=0,GRAN_BACKUP=0,STREAM_ID=TEST-Flashbkup-UNIX+704,STREAM_NUMBER=1,DATABASE_SOURCE=0
15:41:34.851 [704] <2> do_cmd: execing cmd: /sbin/mount
15:41:34.851 [704] <2> do_cmd: 	argv[0]=/sbin/mount
15:41:34.851 [704] <2> do_cmd: 	argv[1]=-F
15:41:34.851 [704] <2> do_cmd: 	argv[2]=vxfs
15:41:34.851 [704] <2> do_cmd: 	argv[3]=-r
15:41:34.851 [704] <2> do_cmd: 	argv[4]=-o
15:41:34.851 [704] <2> do_cmd: 	argv[5]=snapof=/var/opt/ignite
15:41:34.851 [704] <2> do_cmd: 	argv[6]=/dev/vg00/cachevol
15:41:34.851 [704] <2> do_cmd: 	argv[7]=/var/tmp/VXSNAAAA000704
15:41:37.488 [704] <2> onlfi_freeze: INF - snapshot method=vxvm
15:41:37.488 [704] <2> onlfi_freeze: INF - snapshot method=BusinessCopy
15:41:37.488 [704] <2> onlfi_freeze: INF - snapshot method=EMC_CLARiiON_Snapview_Clone
15:41:37.488 [704] <2> onlfi_freeze: INF - snapshot method=EMC_CLARiiON_Snapview_Snapshot
15:41:37.488 [704] <2> onlfi_freeze: INF - snapshot method=EMC_TimeFinder_Clone
15:41:37.488 [704] <2> onlfi_freeze: INF - snapshot method=EMC_TimeFinder_Mirror
15:41:37.488 [704] <2> onlfi_freeze: INF - snapshot method=EMC_TimeFinder_Snap
15:41:37.488 [704] <2> onlfi_freeze: INF - snapshot method=Hitachi_ShadowImage
15:41:37.488 [704] <2> onlfi_freeze: INF - snapshot method=Hitachi_CopyOnWrite
15:41:37.488 [704] <2> onlfi_freeze: INF - snapshot method=HP_EVA_Vsnap
15:41:37.488 [704] <2> onlfi_freeze: INF - snapshot method=HP_EVA_Snapshot
15:41:37.488 [704] <2> onlfi_freeze: INF - snapshot method=HP_EVA_Snapclone
15:41:37.488 [704] <2> onlfi_freeze: INF - snapshot method=HP_XP_BusinessCopy
15:41:37.488 [704] <2> onlfi_freeze: INF - snapshot method=HP_XP_Snapshot
15:41:37.488 [704] <2> onlfi_freeze: INF - snapshot method=IBM_StorageManager_FlashCopy
15:41:37.488 [704] <2> onlfi_freeze: INF - snapshot method=RealTime
15:41:37.489 [704] <2> onlfi_dump_fim_list2: INF - fimlist_rec[0].fim_name=FlashSnap
15:41:37.489 [704] <2> onlfi_dump_fim_list2: INF - fimlist_rec[1].fim_name=ShadowImage
15:41:37.489 [704] <2> onlfi_dump_fim_list2: INF - fimlist_rec[2].fim_name=TimeFinder
15:41:37.489 [704] <2> onlfi_dump_fim_list2: INF - fimlist_rec[3].fim_name=NAS_Snapshot
15:41:37.489 [704] <2> onlfi_dump_fim_list2: INF - fimlist_rec[4].fim_name=VVR
15:41:37.489 [704] <2> onlfi_dump_fim_list2: INF - fimlist_rec[5].fim_name=auto
15:41:37.489 [704] <2> onlfi_dump_fim_list2: INF - fimlist_rec[6].fim_name=IBM_DiskStorage_FlashCopy
15:41:37.489 [704] <2> onlfi_dump_fim_list2: INF - fimlist_rec[7].fim_name=VxFS_Checkpoint
15:41:37.489 [704] <2> onlfi_dump_fim_list2: INF - fimlist_rec[9].fim_name=vxvm
15:41:37.489 [704] <2> onlfi_dump_fim_list2: INF - fimlist_rec[10].fim_name=BusinessCopy
15:41:37.489 [704] <2> onlfi_dump_fim_list2: INF - fimlist_rec[11].fim_name=EMC_CLARiiON_Snapview_Clone
15:41:37.489 [704] <2> onlfi_dump_fim_list2: INF - fimlist_rec[12].fim_name=EMC_CLARiiON_Snapview_Snapshot
15:41:37.489 [704] <2> onlfi_dump_fim_list2: INF - fimlist_rec[13].fim_name=EMC_TimeFinder_Clone
15:41:37.489 [704] <2> onlfi_dump_fim_list2: INF - fimlist_rec[14].fim_name=EMC_TimeFinder_Mirror
15:41:37.489 [704] <2> onlfi_dump_fim_list2: INF - fimlist_rec[15].fim_name=EMC_TimeFinder_Snap
15:41:37.489 [704] <2> onlfi_dump_fim_list2: INF - fimlist_rec[16].fim_name=Hitachi_ShadowImage
15:41:37.489 [704] <2> onlfi_dump_fim_list2: INF - fimlist_rec[17].fim_name=Hitachi_CopyOnWrite
15:41:37.489 [704] <2> onlfi_dump_fim_list2: INF - fimlist_rec[18].fim_name=HP_EVA_Vsnap
15:41:37.489 [704] <2> onlfi_dump_fim_list2: INF - fimlist_rec[19].fim_name=HP_EVA_Snapshot
15:41:37.489 [704] <2> onlfi_dump_fim_list2: INF - fimlist_rec[20].fim_name=HP_EVA_Snapclone
15:41:37.489 [704] <2> onlfi_dump_fim_list2: INF - fimlist_rec[21].fim_name=HP_XP_BusinessCopy
15:41:37.489 [704] <2> onlfi_dump_fim_list2: INF - fimlist_rec[22].fim_name=HP_XP_Snapshot
15:41:37.489 [704] <2> onlfi_dump_fim_list2: INF - fimlist_rec[23].fim_name=IBM_StorageManager_FlashCopy
15:41:37.489 [704] <2> onlfi_dump_fim_list2: INF - fimlist_rec[24].fim_name=RealTime
15:41:37.490 [704] <4> remap_file_name: INF - REMAP FILE BACKUP NEW_STREAM
15:41:37.490 [704] <4> remap_file_name: INF - REMAP FILE BACKUP /dev/vg00/rlvol9 USING /dev/vg00/rcachevol OPTIONS:ALT_PATH_PREFIX=/tmp/_vrts_frzn_img_704,FITYPE=COW,MNTPOINT=/var/opt/ignite,FSTYPE=vxfs
15:41:37.506 [704] <2> vnet_pbxConnect: pbxConnectEx Succeeded
15:41:37.507 [704] <2> logconnections: BPRD CONNECT FROM 169.143.74.248.53939 TO 169.143.74.127.1556 fd = 6
15:41:37.936 [704] <4> bpfis Exit: INF - EXIT STATUS 0: the requested operation was successfully completed
15:41:37.937 [704] <2> bpfis Exit: INF - Close of stdout complete
15:41:56.724 [754] <2> logparams: bpfis delete -nbu -id teocallib_1327876889 -bpstart_to 300 -bpend_to 300 -clnt teocallib -S oxfordc 
15:41:56.755 [754] <2> vnet_pbxConnect: pbxConnectEx Succeeded
15:41:56.755 [754] <2> logconnections: BPRD CONNECT FROM 169.143.74.248.53942 TO 169.143.74.127.1556 fd = 6
15:41:57.145 [754] <4> bpfis main: INF - BACKUP START 754
15:41:57.146 [754] <4> check_streams: INF - Stream TEST-Flashbkup-UNIX+d704+1 pid 754 is still active.
15:41:57.146 [754] <2> ol_initialize: INF - stream_in_control = TEST-Flashbkup-UNIX+d704+1, stream_name = TEST-Flashbkup-UNIX+d704+1, streams = 1
15:41:57.150 [754] <2> onlfi_vfms_logf: INF - FlashSnap FIM $Revision: 1.199.20.2 $
15:41:57.150 [754] <2> onlfi_vfms_logf: INF - pVfMS FIM config string parser $Revision: 1.9 $
15:41:57.150 [754] <2> onlfi_add_to_fim_list: INF - snapshot method=FlashSnap
15:41:57.151 [754] <2> onlfi_vfms_logf: INF - SHADOWIMAGE FIM $Revision: 1.58 $
15:41:57.151 [754] <2> onlfi_add_to_fim_list: INF - snapshot method=ShadowImage
15:41:57.153 [754] <2> onlfi_vfms_logf: INF - TimeFinder FIM $Revision: 1.62 $
15:41:57.153 [754] <2> onlfi_add_to_fim_list: INF - snapshot method=TimeFinder
15:41:57.157 [754] <2> onlfi_vfms_logf: INF - @(#) $Source: src/vfms/fim/nas_snapshot/nas_snapshot.c,v $ $Revision: 1.100.20.1 $ 
15:41:57.157 [754] <2> onlfi_add_to_fim_list: INF - snapshot method=NAS_Snapshot
15:41:57.159 [754] <2> onlfi_vfms_logf: INF - VVR FIM $Revision: 1.199.20.2 $
15:41:57.159 [754] <2> onlfi_add_to_fim_list: INF - snapshot method=VVR
15:41:57.160 [754] <2> onlfi_vfms_logf: INF - Automatic Snapshot Method $Revision: 1.8 $
15:41:57.160 [754] <2> onlfi_add_to_fim_list: INF - snapshot method=auto
15:41:57.160 [754] <2> onlfi_vfms_logf: INF - vfm_configure_fi_one: starting VxFI
15:41:57.165 [754] <2> read_vfm_conf: options=0x2
15:41:57.165 [754] <2> read_vfm_conf: Found FIM: FlashSnap
15:41:57.165 [754] <2> read_vfm_conf: Found library: /usr/openv/lib/libfi_FlashSnap.sl
15:41:57.165 [754] <2> parse_ssm_parms: Found keyword keep_fi
15:41:57.165 [754] <2> parse_ssm_parms: Found data type %b
15:41:57.165 [754] <2> parse_ssm_parms: Found value specification 0
15:41:57.165 [754] <2> parse_value_specification: Value specification='0'
15:41:57.165 [754] <2> parse_value_specification: Found default 0
15:41:57.165 [754] <2> parse_ssm_parms: Found prompt Keep snapshot after backup (not Instant Recovery)
15:41:57.165 [754] <2> parse_ssm_parms: Found keyword async_resync
15:41:57.165 [754] <2> parse_ssm_parms: Found data type %b
15:41:57.165 [754] <2> parse_ssm_parms: Found value specification 0
15:41:57.165 [754] <2> parse_value_specification: Value specification='0'
15:41:57.165 [754] <2> parse_value_specification: Found default 0
15:41:57.165 [754] <2> parse_ssm_parms: Found prompt Resynchronize mirror in background (not Instant Recovery)
15:41:57.165 [754] <2> parse_ssm_parms: Found keyword max_snapshots
15:41:57.165 [754] <2> parse_ssm_parms: Found data type %d
15:41:57.165 [754] <2> parse_ssm_parms: Found value specification 1-:1
15:41:57.165 [754] <2> parse_value_specification: Value specification='1-:1'
15:41:57.165 [754] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
15:41:57.165 [754] <2> parse_value_specification: Found default 1
15:41:57.165 [754] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
15:41:57.165 [754] <2> parse_ssm_parms: Found keyword dg_split_retry_times
15:41:57.165 [754] <2> parse_ssm_parms: Found data type %d
15:41:57.166 [754] <2> parse_ssm_parms: Found value specification 1
15:41:57.166 [754] <2> parse_value_specification: Value specification='1'
15:41:57.166 [754] <2> parse_value_specification: Found default 1
15:41:57.166 [754] <2> parse_ssm_parms: Found prompt Number of times to retry disk group split
15:41:57.166 [754] <2> parse_ssm_parms: Found keyword dg_split_retry_wait_period
15:41:57.166 [754] <2> parse_ssm_parms: Found data type %d
15:41:57.166 [754] <2> parse_ssm_parms: Found value specification 60-:60
15:41:57.166 [754] <2> parse_value_specification: Value specification='60-:60'
15:41:57.166 [754] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
15:41:57.166 [754] <2> parse_value_specification: Found default 60
15:41:57.166 [754] <2> parse_ssm_parms: Found prompt Delay in seconds between disk group split retries
15:41:57.166 [754] <2> parse_ssm_parms: Found keyword num_sync_vols
15:41:57.166 [754] <2> parse_ssm_parms: Found data type %d
15:41:57.166 [754] <2> parse_ssm_parms: Found value specification 1-32:1
15:41:57.166 [754] <2> parse_value_specification: Value specification='1-32:1'
15:41:57.166 [754] <2> parse_value_specification: Found default 1
15:41:57.166 [754] <2> parse_ssm_parms: Found prompt Maximum number of volumes to resynchronize concurrently
15:41:57.166 [754] <2> parse_ssm_parms: Found keyword iosize
15:41:57.166 [754] <2> parse_ssm_parms: Found data type %d
15:41:57.166 [754] <2> parse_ssm_parms: Found value specification 1-128:1
15:41:57.166 [754] <2> parse_value_specification: Value specification='1-128:1'
15:41:57.166 [754] <2> parse_value_specification: Found default 1
15:41:57.166 [754] <2> parse_ssm_parms: Found prompt Sync region size in MB (UNIX only)
15:41:57.166 [754] <2> parse_ssm_parms: Found keyword slow
15:41:57.166 [754] <2> parse_ssm_parms: Found data type %d
15:41:57.166 [754] <2> parse_ssm_parms: Found value specification 0-:0
15:41:57.166 [754] <2> parse_value_specification: Value specification='0-:0'
15:41:57.166 [754] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
15:41:57.166 [754] <2> parse_value_specification: Found default 0
15:41:57.166 [754] <2> parse_ssm_parms: Found prompt Sync I/O delay in milliseconds (UNIX only)
15:41:57.166 [754] <2> read_vfm_conf: Found FIM: ShadowImage
15:41:57.166 [754] <2> read_vfm_conf: Found library: /usr/openv/lib/libfi_ShadowImage.sl
15:41:57.166 [754] <2> parse_ssm_parms: Found keyword keep_fi
15:41:57.166 [754] <2> parse_ssm_parms: Found data type %b
15:41:57.166 [754] <2> parse_ssm_parms: Found value specification 0
15:41:57.166 [754] <2> parse_value_specification: Value specification='0'
15:41:57.166 [754] <2> parse_value_specification: Found default 0
15:41:57.166 [754] <2> parse_ssm_parms: Found prompt Keep snapshot after backup
15:41:57.166 [754] <2> parse_ssm_parms: Found keyword sync_at_start
15:41:57.166 [754] <2> parse_ssm_parms: Found data type %b
15:41:57.166 [754] <2> parse_ssm_parms: Found value specification 0
15:41:57.166 [754] <2> parse_value_specification: Value specification='0'
15:41:57.166 [754] <2> parse_value_specification: Found default 0
15:41:57.166 [754] <2> parse_ssm_parms: Found prompt Synchronize mirror before backup
15:41:57.166 [754] <2> parse_ssm_parms: Found keyword async_resync
15:41:57.166 [754] <2> parse_ssm_parms: Found data type %b
15:41:57.166 [754] <2> parse_ssm_parms: Found value specification 0
15:41:57.166 [754] <2> parse_value_specification: Value specification='0'
15:41:57.166 [754] <2> parse_value_specification: Found default 0
15:41:57.167 [754] <2> parse_ssm_parms: Found prompt Resynchronize mirror in background
15:41:57.167 [754] <2> parse_ssm_parms: Found keyword timeout
15:41:57.167 [754] <2> parse_ssm_parms: Found data type %d
15:41:57.167 [754] <2> parse_ssm_parms: Found value specification 3-3600:240
15:41:57.167 [754] <2> parse_value_specification: Value specification='3-3600:240'
15:41:57.167 [754] <2> parse_value_specification: Found default 240
15:41:57.167 [754] <2> parse_ssm_parms: Found prompt FS Freeze Timeout default 4 minutes
15:41:57.167 [754] <2> read_vfm_conf: Found FIM: TimeFinder
15:41:57.167 [754] <2> read_vfm_conf: Found library: /usr/openv/lib/libfi_TimeFinder.sl
15:41:57.167 [754] <2> parse_ssm_parms: Found keyword keep_fi
15:41:57.167 [754] <2> parse_ssm_parms: Found data type %b
15:41:57.167 [754] <2> parse_ssm_parms: Found value specification 0
15:41:57.167 [754] <2> parse_value_specification: Value specification='0'
15:41:57.167 [754] <2> parse_value_specification: Found default 0
15:41:57.167 [754] <2> parse_ssm_parms: Found prompt Keep snapshot after backup
15:41:57.167 [754] <2> read_vfm_conf: Found FIM: NAS_Snapshot
15:41:57.167 [754] <2> read_vfm_conf: Found library: /usr/openv/lib/libfi_NAS_Snapshot.sl
15:41:57.167 [754] <2> parse_ssm_parms: Found keyword max_snapshots
15:41:57.167 [754] <2> parse_ssm_parms: Found data type %d
15:41:57.167 [754] <2> parse_ssm_parms: Found value specification 1-:1
15:41:57.167 [754] <2> parse_value_specification: Value specification='1-:1'
15:41:57.167 [754] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
15:41:57.167 [754] <2> parse_value_specification: Found default 1
15:41:57.167 [754] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
15:41:57.167 [754] <2> read_vfm_conf: Found FIM: VVR
15:41:57.167 [754] <2> read_vfm_conf: Found library: /usr/openv/lib/libfi_VVR.sl
15:41:57.167 [754] <2> parse_ssm_parms: Found keyword keep_fi
15:41:57.167 [754] <2> parse_ssm_parms: Found data type %b
15:41:57.167 [754] <2> parse_ssm_parms: Found value specification 0
15:41:57.167 [754] <2> parse_value_specification: Value specification='0'
15:41:57.167 [754] <2> parse_value_specification: Found default 0
15:41:57.167 [754] <2> parse_ssm_parms: Found prompt Keep snapshot after backup
15:41:57.167 [754] <2> parse_ssm_parms: Found keyword send_timeout
15:41:57.167 [754] <2> parse_ssm_parms: Found data type %d
15:41:57.167 [754] <2> parse_ssm_parms: Found value specification 1-3600:60
15:41:57.167 [754] <2> parse_value_specification: Value specification='1-3600:60'
15:41:57.167 [754] <2> parse_value_specification: Found default 60
15:41:57.167 [754] <2> parse_ssm_parms: Found prompt IBC send timeout (seconds)
15:41:57.167 [754] <2> parse_ssm_parms: Found keyword receive_timeout
15:41:57.167 [754] <2> parse_ssm_parms: Found data type %d
15:41:57.167 [754] <2> parse_ssm_parms: Found value specification 1-3600:600
15:41:57.167 [754] <2> parse_value_specification: Value specification='1-3600:600'
15:41:57.167 [754] <2> parse_value_specification: Found default 600
15:41:57.167 [754] <2> parse_ssm_parms: Found prompt IBC receive timeout (seconds)
15:41:57.167 [754] <2> parse_ssm_parms: Found keyword async_resync
15:41:57.167 [754] <2> parse_ssm_parms: Found data type %b
15:41:57.167 [754] <2> parse_ssm_parms: Found value specification 0
15:41:57.168 [754] <2> parse_value_specification: Value specification='0'
15:41:57.168 [754] <2> parse_value_specification: Found default 0
15:41:57.168 [754] <2> parse_ssm_parms: Found prompt Resynchronize mirror in background
15:41:57.168 [754] <2> parse_ssm_parms: Found keyword max_snapshots
15:41:57.168 [754] <2> parse_ssm_parms: Found data type %d
15:41:57.168 [754] <2> parse_ssm_parms: Found value specification 1-:1
15:41:57.168 [754] <2> parse_value_specification: Value specification='1-:1'
15:41:57.168 [754] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
15:41:57.168 [754] <2> parse_value_specification: Found default 1
15:41:57.168 [754] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
15:41:57.168 [754] <2> read_vfm_conf: Found FIM: auto
15:41:57.168 [754] <2> read_vfm_conf: Found library: /usr/openv/lib/libfi_auto.sl
15:41:57.168 [754] <2> read_vfm_conf: Found FIM: IBM_DiskStorage_FlashCopy
15:41:57.168 [754] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:57.168 [754] <2> parse_ssm_parms: Found keyword snapshot_resource_spec
15:41:57.168 [754] <2> parse_ssm_parms: Found data type %s
15:41:57.168 [754] <2> parse_ssm_parms: Found prompt Snapshot Resource Specification
15:41:57.168 [754] <2> parse_ssm_parms: Found keyword flashcopy_wait
15:41:57.168 [754] <2> parse_ssm_parms: Found data type %b
15:41:57.168 [754] <2> parse_ssm_parms: Found value specification 0
15:41:57.168 [754] <2> parse_value_specification: Value specification='0'
15:41:57.168 [754] <2> parse_value_specification: Found default 0
15:41:57.168 [754] <2> parse_ssm_parms: Found prompt Wait for Flashcopy operation to complete.(Default is no wait)
15:41:57.168 [754] <2> read_vfm_conf: Found FIM: VxFS_Checkpoint
15:41:57.168 [754] <2> read_vfm_conf: Found library: /usr/openv/lib/libfi_vxfs_ckpt.sl
15:41:57.168 [754] <2> parse_ssm_parms: Found keyword max_snapshots
15:41:57.168 [754] <2> parse_ssm_parms: Found data type %d
15:41:57.168 [754] <2> parse_ssm_parms: Found value specification 1-:1
15:41:57.168 [754] <2> parse_value_specification: Value specification='1-:1'
15:41:57.168 [754] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
15:41:57.168 [754] <2> parse_value_specification: Found default 1
15:41:57.168 [754] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
15:41:57.168 [754] <2> read_vfm_conf: Found FIM: VxFS_Snapshot
15:41:57.168 [754] <2> read_vfm_conf: Found library: /usr/openv/lib/libfi_vxfs.sl
15:41:57.168 [754] <2> parse_ssm_parms: Found keyword cache
15:41:57.168 [754] <2> parse_ssm_parms: Found data type %c
15:41:57.168 [754] <2> parse_ssm_parms: Found prompt Cache device path
15:41:57.168 [754] <2> read_vfm_conf: Found FIM: vxvm
15:41:57.168 [754] <2> read_vfm_conf: Found library: /usr/openv/lib/libfi_vxvm.sl
15:41:57.168 [754] <2> parse_ssm_parms: Found keyword async_resync
15:41:57.168 [754] <2> parse_ssm_parms: Found data type %b
15:41:57.168 [754] <2> parse_ssm_parms: Found value specification 0
15:41:57.168 [754] <2> parse_value_specification: Value specification='0'
15:41:57.168 [754] <2> parse_value_specification: Found default 0
15:41:57.169 [754] <2> parse_ssm_parms: Found prompt Resynchronize mirror in background (not Instant Recovery)
15:41:57.169 [754] <2> parse_ssm_parms: Found keyword max_snapshots
15:41:57.169 [754] <2> parse_ssm_parms: Found data type %d
15:41:57.169 [754] <2> parse_ssm_parms: Found value specification 1-:1
15:41:57.169 [754] <2> parse_value_specification: Value specification='1-:1'
15:41:57.169 [754] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
15:41:57.169 [754] <2> parse_value_specification: Found default 1
15:41:57.169 [754] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
15:41:57.169 [754] <2> parse_ssm_parms: Found keyword sync_wait
15:41:57.169 [754] <2> parse_ssm_parms: Found data type %b
15:41:57.169 [754] <2> parse_ssm_parms: Found value specification 1
15:41:57.169 [754] <2> parse_value_specification: Value specification='1'
15:41:57.169 [754] <2> parse_value_specification: Found default 1
15:41:57.169 [754] <2> parse_ssm_parms: Found prompt Wait for mirror sync completion (Data Mover backups only)
15:41:57.169 [754] <2> parse_ssm_parms: Found keyword num_sync_vols
15:41:57.169 [754] <2> parse_ssm_parms: Found data type %d
15:41:57.169 [754] <2> parse_ssm_parms: Found value specification 1-32:1
15:41:57.169 [754] <2> parse_value_specification: Value specification='1-32:1'
15:41:57.169 [754] <2> parse_value_specification: Found default 1
15:41:57.169 [754] <2> parse_ssm_parms: Found prompt Maximum number of volumes to resynchronize concurrently
15:41:57.169 [754] <2> parse_ssm_parms: Found keyword iosize
15:41:57.169 [754] <2> parse_ssm_parms: Found data type %d
15:41:57.169 [754] <2> parse_ssm_parms: Found value specification 1-128:1
15:41:57.169 [754] <2> parse_value_specification: Value specification='1-128:1'
15:41:57.169 [754] <2> parse_value_specification: Found default 1
15:41:57.169 [754] <2> parse_ssm_parms: Found prompt Sync region size in MB (UNIX only)
15:41:57.169 [754] <2> parse_ssm_parms: Found keyword slow
15:41:57.169 [754] <2> parse_ssm_parms: Found data type %d
15:41:57.169 [754] <2> parse_ssm_parms: Found value specification 0-:0
15:41:57.169 [754] <2> parse_value_specification: Value specification='0-:0'
15:41:57.169 [754] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
15:41:57.169 [754] <2> parse_value_specification: Found default 0
15:41:57.169 [754] <2> parse_ssm_parms: Found prompt Sync I/O delay in milliseconds (UNIX only)
15:41:57.169 [754] <2> read_vfm_conf: Found FIM: BusinessCopy
15:41:57.169 [754] <2> read_vfm_conf: Found library: /usr/openv/lib/libfi_BusinessCopy.sl
15:41:57.169 [754] <2> parse_ssm_parms: Found keyword keep_fi
15:41:57.169 [754] <2> parse_ssm_parms: Found data type %b
15:41:57.169 [754] <2> parse_ssm_parms: Found value specification 0
15:41:57.169 [754] <2> parse_value_specification: Value specification='0'
15:41:57.169 [754] <2> parse_value_specification: Found default 0
15:41:57.169 [754] <2> parse_ssm_parms: Found prompt Keep snapshot after backup
15:41:57.169 [754] <2> parse_ssm_parms: Found keyword sync_at_start
15:41:57.169 [754] <2> parse_ssm_parms: Found data type %b
15:41:57.169 [754] <2> parse_ssm_parms: Found value specification 0
15:41:57.169 [754] <2> parse_value_specification: Value specification='0'
15:41:57.169 [754] <2> parse_value_specification: Found default 0
15:41:57.169 [754] <2> parse_ssm_parms: Found prompt Synchronize mirror before backup
15:41:57.169 [754] <2> parse_ssm_parms: Found keyword async_resync
15:41:57.169 [754] <2> parse_ssm_parms: Found data type %b
15:41:57.170 [754] <2> parse_ssm_parms: Found value specification 0
15:41:57.170 [754] <2> parse_value_specification: Value specification='0'
15:41:57.170 [754] <2> parse_value_specification: Found default 0
15:41:57.170 [754] <2> parse_ssm_parms: Found prompt Resynchronize mirror in background
15:41:57.170 [754] <2> read_vfm_conf: Found FIM: EMC_CLARiiON_Snapview_Clone
15:41:57.170 [754] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:57.170 [754] <2> parse_ssm_parms: Found keyword snapshot_resource_spec
15:41:57.170 [754] <2> parse_ssm_parms: Found data type %s
15:41:57.170 [754] <2> parse_ssm_parms: Found prompt Snapshot Resource Specification
15:41:57.170 [754] <2> read_vfm_conf: Found FIM: EMC_CLARiiON_Snapview_Snapshot
15:41:57.170 [754] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:57.170 [754] <2> parse_ssm_parms: Found keyword max_snapshots
15:41:57.170 [754] <2> parse_ssm_parms: Found data type %d
15:41:57.170 [754] <2> parse_ssm_parms: Found value specification 1-8:1
15:41:57.170 [754] <2> parse_value_specification: Value specification='1-8:1'
15:41:57.170 [754] <2> parse_value_specification: Found default 1
15:41:57.170 [754] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
15:41:57.170 [754] <2> read_vfm_conf: Found FIM: EMC_TimeFinder_Clone
15:41:57.170 [754] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:57.170 [754] <2> parse_ssm_parms: Found keyword snapshot_resource_spec
15:41:57.170 [754] <2> parse_ssm_parms: Found data type %s
15:41:57.170 [754] <2> parse_ssm_parms: Found prompt Snapshot Resource Specification
15:41:57.170 [754] <2> read_vfm_conf: Found FIM: EMC_TimeFinder_Mirror
15:41:57.170 [754] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:57.170 [754] <2> parse_ssm_parms: Found keyword snapshot_resource_spec
15:41:57.170 [754] <2> parse_ssm_parms: Found data type %s
15:41:57.170 [754] <2> parse_ssm_parms: Found prompt Snapshot Resource Specification
15:41:57.170 [754] <2> read_vfm_conf: Found FIM: EMC_TimeFinder_Snap
15:41:57.170 [754] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:57.170 [754] <2> parse_ssm_parms: Found keyword snapshot_resource_spec
15:41:57.170 [754] <2> parse_ssm_parms: Found data type %s
15:41:57.170 [754] <2> parse_ssm_parms: Found prompt Snapshot Resource Specification
15:41:57.170 [754] <2> parse_ssm_parms: Found keyword savedev_pool
15:41:57.170 [754] <2> parse_ssm_parms: Found data type %s
15:41:57.170 [754] <2> parse_ssm_parms: Found value specification Use_Default_Pool
15:41:57.170 [754] <2> parse_value_specification: Value specification='Use_Default_Pool'
15:41:57.170 [754] <2> parse_value_specification: Found default Use_Default_Pool
15:41:57.170 [754] <2> parse_ssm_parms: Found prompt SAVE Device Pool
15:41:57.170 [754] <2> read_vfm_conf: Found FIM: Hitachi_ShadowImage
15:41:57.170 [754] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:57.170 [754] <2> parse_ssm_parms: Found keyword snapshot_resource_spec
15:41:57.170 [754] <2> parse_ssm_parms: Found data type %s
15:41:57.170 [754] <2> parse_ssm_parms: Found prompt Snapshot Resource Specification
15:41:57.171 [754] <2> read_vfm_conf: Found FIM: Hitachi_CopyOnWrite
15:41:57.171 [754] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:57.171 [754] <2> parse_ssm_parms: Found keyword snapshot_resource_spec
15:41:57.171 [754] <2> parse_ssm_parms: Found data type %s
15:41:57.171 [754] <2> parse_ssm_parms: Found prompt Snapshot Resource Specification
15:41:57.171 [754] <2> read_vfm_conf: Found FIM: HP_EVA_Vsnap
15:41:57.171 [754] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:57.171 [754] <2> parse_ssm_parms: Found keyword max_snapshots
15:41:57.171 [754] <2> parse_ssm_parms: Found data type %d
15:41:57.171 [754] <2> parse_ssm_parms: Found value specification 1-:1
15:41:57.171 [754] <2> parse_value_specification: Value specification='1-:1'
15:41:57.171 [754] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
15:41:57.171 [754] <2> parse_value_specification: Found default 1
15:41:57.171 [754] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
15:41:57.171 [754] <2> read_vfm_conf: Found FIM: HP_EVA_Snapshot
15:41:57.171 [754] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:57.171 [754] <2> parse_ssm_parms: Found keyword max_snapshots
15:41:57.171 [754] <2> parse_ssm_parms: Found data type %d
15:41:57.171 [754] <2> parse_ssm_parms: Found value specification 1-:1
15:41:57.171 [754] <2> parse_value_specification: Value specification='1-:1'
15:41:57.171 [754] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
15:41:57.171 [754] <2> parse_value_specification: Found default 1
15:41:57.171 [754] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
15:41:57.171 [754] <2> read_vfm_conf: Found FIM: HP_EVA_Snapclone
15:41:57.171 [754] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:57.171 [754] <2> parse_ssm_parms: Found keyword max_snapshots
15:41:57.171 [754] <2> parse_ssm_parms: Found data type %d
15:41:57.171 [754] <2> parse_ssm_parms: Found value specification 1-:1
15:41:57.171 [754] <2> parse_value_specification: Value specification='1-:1'
15:41:57.171 [754] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
15:41:57.171 [754] <2> parse_value_specification: Found default 1
15:41:57.171 [754] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
15:41:57.171 [754] <2> read_vfm_conf: Found FIM: HP_XP_BusinessCopy
15:41:57.171 [754] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:57.171 [754] <2> parse_ssm_parms: Found keyword snapshot_resource_spec
15:41:57.171 [754] <2> parse_ssm_parms: Found data type %s
15:41:57.171 [754] <2> parse_ssm_parms: Found prompt Snapshot Resource Specification
15:41:57.171 [754] <2> read_vfm_conf: Found FIM: HP_XP_Snapshot
15:41:57.171 [754] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:57.171 [754] <2> parse_ssm_parms: Found keyword snapshot_resource_spec
15:41:57.172 [754] <2> parse_ssm_parms: Found data type %s
15:41:57.172 [754] <2> parse_ssm_parms: Found prompt Snapshot Resource Specification
15:41:57.172 [754] <2> read_vfm_conf: Found FIM: IBM_StorageManager_FlashCopy
15:41:57.172 [754] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:57.172 [754] <2> parse_ssm_parms: Found keyword max_snapshots
15:41:57.172 [754] <2> parse_ssm_parms: Found data type %d
15:41:57.172 [754] <2> parse_ssm_parms: Found value specification 1-4:1
15:41:57.172 [754] <2> parse_value_specification: Value specification='1-4:1'
15:41:57.172 [754] <2> parse_value_specification: Found default 1
15:41:57.172 [754] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
15:41:57.172 [754] <2> parse_ssm_parms: Found keyword repository_drive_capacity
15:41:57.172 [754] <2> parse_ssm_parms: Found data type %d
15:41:57.172 [754] <2> parse_ssm_parms: Found value specification 0-100:0
15:41:57.172 [754] <2> parse_value_specification: Value specification='0-100:0'
15:41:57.172 [754] <2> parse_value_specification: Found default 0
15:41:57.172 [754] <2> parse_ssm_parms: Found prompt Repository % of Base (100 for Instant Recovery)
15:41:57.172 [754] <2> read_vfm_conf: Found FIM: RealTime
15:41:57.172 [754] <2> read_vfm_conf: Found library: /usr/openv/lib/libvfms.sl
15:41:57.172 [754] <2> parse_ssm_parms: Found keyword max_snapshots
15:41:57.172 [754] <2> parse_ssm_parms: Found data type %d
15:41:57.172 [754] <2> parse_ssm_parms: Found value specification 1-:1
15:41:57.172 [754] <2> parse_value_specification: Value specification='1-:1'
15:41:57.172 [754] <2> parse_value_specification: Null maximum value; using INT_MAX (2147483647)
15:41:57.172 [754] <2> parse_value_specification: Found default 1
15:41:57.172 [754] <2> parse_ssm_parms: Found prompt Maximum Snapshots (Instant Recovery only)
15:41:57.172 [754] <2> onlfi_vfms_logf: INF - vfm_configure_fi_one: configuring VxFI credentials
15:41:57.175 [754] <2> vnet_pbxConnect: pbxConnectEx Succeeded
15:41:57.176 [754] <2> logconnections: BPRD CONNECT FROM 169.143.74.248.53943 TO 169.143.74.127.1556 fd = 7
15:41:57.557 [754] <2> bprd_read_text_file: Received status 131
15:41:57.557 [754] <2> onlfi_vfms_logf: INF - vfm_configure_fi_one: read credentials file failed
15:41:57.557 [754] <2> onlfi_add_to_fim_list: INF - snapshot method=IBM_DiskStorage_FlashCopy
15:41:57.558 [754] <2> onlfi_vfms_logf: INF - VxFS_Checkpoint FIM $Revision: 1.44 $
15:41:57.558 [754] <2> onlfi_add_to_fim_list: INF - snapshot method=VxFS_Checkpoint
15:41:57.560 [754] <2> onlfi_vfms_logf: INF - VxFS_Snapshot FIM $Revision: 1.30 $
15:41:57.560 [754] <2> onlfi_add_to_fim_list: INF - snapshot method=VxFS_Snapshot
15:41:57.561 [754] <2> onlfi_vfms_logf: INF - VxVM FIM $Revision: 1.199.20.2 $
15:41:57.561 [754] <2> onlfi_add_to_fim_list: INF - snapshot method=vxvm
15:41:57.562 [754] <2> onlfi_vfms_logf: INF - BusinessCopy FIM $Revision: 1.58 $
15:41:57.562 [754] <2> onlfi_add_to_fim_list: INF - snapshot method=BusinessCopy
15:41:57.562 [754] <2> onlfi_add_to_fim_list: INF - snapshot method=EMC_CLARiiON_Snapview_Clone
15:41:57.562 [754] <2> onlfi_add_to_fim_list: INF - snapshot method=EMC_CLARiiON_Snapview_Snapshot
15:41:57.562 [754] <2> onlfi_add_to_fim_list: INF - snapshot method=EMC_TimeFinder_Clone
15:41:57.562 [754] <2> onlfi_add_to_fim_list: INF - snapshot method=EMC_TimeFinder_Mirror
15:41:57.562 [754] <2> onlfi_add_to_fim_list: INF - snapshot method=EMC_TimeFinder_Snap
15:41:57.562 [754] <2> onlfi_add_to_fim_list: INF - snapshot method=Hitachi_ShadowImage
15:41:57.562 [754] <2> onlfi_add_to_fim_list: INF - snapshot method=Hitachi_CopyOnWrite
15:41:57.562 [754] <2> onlfi_add_to_fim_list: INF - snapshot method=HP_EVA_Vsnap
15:41:57.563 [754] <2> onlfi_add_to_fim_list: INF - snapshot method=HP_EVA_Snapshot
15:41:57.563 [754] <2> onlfi_add_to_fim_list: INF - snapshot method=HP_EVA_Snapclone
15:41:57.563 [754] <2> onlfi_add_to_fim_list: INF - snapshot method=HP_XP_BusinessCopy
15:41:57.563 [754] <2> onlfi_add_to_fim_list: INF - snapshot method=HP_XP_Snapshot
15:41:57.563 [754] <2> onlfi_add_to_fim_list: INF - snapshot method=IBM_StorageManager_FlashCopy
15:41:57.563 [754] <2> onlfi_add_to_fim_list: INF - snapshot method=RealTime
15:41:57.563 [754] <2> onlfi_add_to_fim_list: INF - snapshot method=VxFS_Snapshot
15:41:57.564 [754] <2> onlfi_thaw: INF - fim=VxFS_Snapshot
15:41:57.564 [754] <4> onlfi_thaw: INF - Thawing /dev/vg00/rlvol9 using snapshot method VxFS_Snapshot.
15:41:57.566 [754] <8> do_thaw: WRN - VfMS error 2; see following messages:
15:41:57.567 [754] <8> do_thaw: WRN - Feature is not supported
15:41:57.567 [754] <8> do_thaw: WRN - vfm_fi_ctl: Function is not supported for this method
15:41:57.567 [754] <2> do_cmd: execing cmd: /sbin/umount
15:41:57.567 [754] <2> do_cmd: 	argv[0]=/sbin/umount
15:41:57.567 [754] <2> do_cmd: 	argv[1]=/var/tmp/VXSNAAAA000704
15:41:58.278 [754] <4> onlfi_thaw: INF - do_thaw return value: 0
15:41:58.278 [754] <2> fis_delete_id: INF - removing /usr/openv/netbackup/online_util/fi_cntl/bpfis.fim.teocallib_1327876889.0
15:41:58.285 [754] <2> vnet_pbxConnect: pbxConnectEx Succeeded
15:41:58.285 [754] <2> logconnections: BPRD CONNECT FROM 169.143.74.248.53944 TO 169.143.74.127.1556 fd = 7
15:41:58.321 [754] <4> bpfis Exit: INF - EXIT STATUS 0: the requested operation was successfully completed
15:41:58.321 [754] <2> bpfis Exit: INF - Close of stdout complete