14:14:47.083 [5888.6620] <2> logparams: C:\Program Files\Veritas\NetBackup\bin\bpfis.exe create -nbu -owner NBU -id exa.main.vgk_1364552076 -bpstart_to 300 -bpend_to 300 -backup_copy 0 -ru root -pt 16 -clnt exa.main.vgk -rg other -fim VSS:prov_type=0,snap_attr=0,max_snapshots=1 -class Exchange_Archive -sched Full -st FULL -ds 3 -fso -S backupivc.main.vgk -jobid 1223 14:14:47.083 [5888.6620] <2> bpfis main: received FIM as [43] VSS:prov_type=0,snap_attr=0,max_snapshots=1 14:14:47.083 [5888.6620] <2> bpfis main: VSS provider type: 0 14:14:47.083 [5888.6620] <4> bpfis: Starting keep alive thread. 14:14:47.083 [5888.6620] <4> bpfis: INF - BACKUP START 5888 14:14:47.083 [5888.6620] <2> bpfis main: receive filelist: 14:14:47.083 [5888.6620] <2> bpfis main: receive filelist: 14:14:47.083 [5888.6620] <2> bpfis main: receive filelist: 14:14:47.301 [5888.6620] <2> bpfis main: receive filelist: 14:14:47.317 [5888.6620] <2> vnet_pbxConnect: pbxConnectEx Succeeded 14:14:47.317 [5888.6620] <2> logconnections: BPRD CONNECT FROM 172.16.2.66.45070 TO 172.16.1.25.1556 fd = 628 14:14:47.317 [5888.6620] <8> vnet_check_vxss_client_magic_with_info: [vnet_vxss_helper.c:871] Ignoring VxSS authentication 2 0x2 14:14:47.473 [5888.6620] <2> vnet_pbxConnect: pbxConnectEx Succeeded 14:14:47.489 [5888.6620] <2> logconnections: BPRD CONNECT FROM 172.16.2.66.45071 TO 172.16.1.25.1556 fd = 628 14:14:47.489 [5888.6620] <8> vnet_check_vxss_client_magic_with_info: [vnet_vxss_helper.c:871] Ignoring VxSS authentication 2 0x2 14:14:48.255 [5888.6620] <8> bpfis: WRN - VfMS error 10; see following messages: 14:14:48.255 [5888.6620] <8> bpfis: WRN - Non-fatal method error was reported 14:14:48.255 [5888.6620] <8> bpfis: WRN - vfm_configure_fi_one: method: FlashSnap, type: FIM, function: FlashSnap_init 14:14:48.255 [5888.6620] <8> bpfis: WRN - VfMS method error 3; see following message: 14:14:48.255 [5888.6620] <8> bpfis: WRN - FlashSnap_init: Veritas Volume Manager not installed. 14:14:48.255 [5888.6620] <8> bpfis: WRN - VfMS error 10; see following messages: 14:14:48.255 [5888.6620] <8> bpfis: WRN - Non-fatal method error was reported 14:14:48.255 [5888.6620] <8> bpfis: WRN - vfm_configure_fi_one: method: vxvm, type: FIM, function: vxvm_init 14:14:48.255 [5888.6620] <8> bpfis: WRN - VfMS method error 3; see following message: 14:14:48.255 [5888.6620] <8> bpfis: WRN - vxvm_init: Veritas Volume Manager not installed. 14:14:48.255 [5888.6620] <4> bpfis: INF - FIS_ID=exa.main.vgk_1364552076 14:14:48.255 [5888.6620] <4> bpfis: Failed to open EVENT_bpinetd_flushCJDB 14:14:48.255 [5888.6620] <4> bpfis: INF - Preparing freeze of NEW_STREAM0 using snapshot method VSS_Writer. 14:14:48.255 [5888.6620] <4> bpfis: INF - Created mount point C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_NEW_STREAM0_5888_1 14:14:48.270 [5888.6620] <2> vnet_pbxConnect: pbxConnectEx Succeeded 14:14:48.270 [5888.6620] <2> logconnections: BPRD CONNECT FROM 172.16.2.66.45072 TO 172.16.1.25.1556 fd = 656 14:14:48.270 [5888.6620] <8> vnet_check_vxss_client_magic_with_info: [vnet_vxss_helper.c:871] Ignoring VxSS authentication 2 0x2 14:14:48.317 [5888.6620] <4> bpfis: INF - Preparing freeze of Microsoft Information Store:\VGK_Archive using snapshot method VSS_Writer. 14:14:48.317 [5888.6620] <4> bpfis: INF - Created mount point C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_Microsoft Information Store_VGK_Archive_5888_1 14:15:25.849 [5888.6620] <4> bpfis: INF - Preparing freeze of Microsoft Information Store:\FGK_Archive2 using snapshot method VSS_Writer. 14:15:25.849 [5888.6620] <4> bpfis: INF - Created mount point C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_Microsoft Information Store_FGK_Archive2_5888_1 14:15:32.302 [5888.6620] <32> bpfis: FTL - VfMS error 11; see following messages: 14:15:32.302 [5888.6620] <32> bpfis: FTL - Fatal method error was reported 14:15:32.302 [5888.6620] <32> bpfis: FTL - vfm_freeze_commit: method: VSS_Writer, type: FIM, function: VSS_Writer_freeze_commit 14:15:32.302 [5888.6620] <32> bpfis: FTL - VfMS method error 4; see following message: 14:15:32.302 [5888.6620] <32> bpfis: FTL - VSS_Writer_freeze_commit: snapshot create failed 14:15:32.302 [5888.6620] <32> bpfis: FTL - VfMS error 11; see following messages: 14:15:32.302 [5888.6620] <32> bpfis: FTL - Fatal method error was reported 14:15:32.302 [5888.6620] <32> bpfis: FTL - vfm_freeze_commit: method: VSS_Writer, type: FIM, function: VSS_Writer_freeze_commit 14:15:32.302 [5888.6620] <32> bpfis: FTL - VfMS method error 4; see following message: 14:15:32.302 [5888.6620] <32> bpfis: FTL - VSS_Writer_freeze_commit: snapshot create failed 14:15:32.302 [5888.6620] <4> bpfis: INF - Thawing NEW_STREAM0 using snapshot method VSS_Writer. 14:15:32.302 [5888.6620] <4> bpfis: INF - do_thaw return value: 0 14:15:32.302 [5888.6620] <4> bpfis: INF - Deleted mount point C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_NEW_STREAM0_5888_1 14:15:32.302 [5888.6620] <4> bpfis: INF - Thawing Microsoft Information Store:\VGK_Archive using snapshot method VSS_Writer. 14:15:32.302 [5888.6620] <4> bpfis: INF - do_thaw return value: 0 14:15:32.302 [5888.6620] <4> bpfis: INF - Deleted mount point C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_Microsoft Information Store_VGK_Archive_5888_1 14:15:32.302 [5888.6620] <4> bpfis: INF - Thawing Microsoft Information Store:\FGK_Archive2 using snapshot method VSS_Writer. 14:15:32.302 [5888.6620] <4> bpfis: INF - do_thaw return value: 0 14:15:32.302 [5888.6620] <4> bpfis: INF - Deleted mount point C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_Microsoft Information Store_FGK_Archive2_5888_1 14:15:32.302 [5888.6620] <16> bpfis: FTL - snapshot creation failed - Error attempting to gather metadata., status 130 14:15:32.302 [5888.6620] <4> bpfis: INF - Thawing NEW_STREAM0 using snapshot method VSS_Writer. 14:15:32.302 [5888.6620] <8> bpfis: WRN - NEW_STREAM0 is not frozen 14:15:32.302 [5888.6620] <4> bpfis: INF - Thawing Microsoft Information Store:\VGK_Archive using snapshot method VSS_Writer. 14:15:32.302 [5888.6620] <8> bpfis: WRN - Microsoft Information Store:\VGK_Archive is not frozen 14:15:32.302 [5888.6620] <4> bpfis: INF - Thawing Microsoft Information Store:\FGK_Archive2 using snapshot method VSS_Writer. 14:15:32.302 [5888.6620] <8> bpfis: WRN - Microsoft Information Store:\FGK_Archive2 is not frozen 14:15:32.302 [5888.6620] <8> bpfis: WRN - snapshot delete returned status 20 14:15:32.302 [5888.6620] <4> bpfis: INF - EXIT STATUS 130: system error occurred 14:15:34.458 [5888.6620] <4> bpfis: Starting keep alive thread. 14:15:40.880 [7044.7068] <2> logparams: C:\Program Files\Veritas\NetBackup\bin\bpfis.exe delete -nbu -id exa.main.vgk_1364552076 -bpstart_to 300 -bpend_to 300 -clnt exa.main.vgk -pt 16 -st FULL -status 130 -S backupivc.main.vgk -jobid 1223 -copy 1 -fim VSS:prov_type=0,snap_attr=0,max_snapshots=1 14:15:40.880 [7044.7068] <2> bpfis main: received FIM as [43] VSS:prov_type=0,snap_attr=0,max_snapshots=1 14:15:40.880 [7044.7068] <4> bpfis: Starting keep alive thread. 14:15:40.880 [7044.7068] <4> bpfis: Acquiring snapshot lock:retry count [0] 14:15:40.880 [7044.7068] <2> getFileName: FileName is [C:\Program Files\Veritas\NetBackup\online_util\fi_cntl\exa.main.vgk_1364552076_copy1.lock] 14:15:40.896 [7044.7068] <2> vnet_pbxConnect: pbxConnectEx Succeeded 14:15:40.896 [7044.7068] <2> logconnections: BPRD CONNECT FROM 172.16.2.66.45105 TO 172.16.1.25.1556 fd = 600 14:15:40.896 [7044.7068] <8> vnet_check_vxss_client_magic_with_info: [vnet_vxss_helper.c:871] Ignoring VxSS authentication 2 0x2 14:15:42.052 [7044.7068] <2> vnet_pbxConnect: pbxConnectEx Succeeded 14:15:42.052 [7044.7068] <2> logconnections: BPRD CONNECT FROM 172.16.2.66.45108 TO 172.16.1.25.1556 fd = 624 14:15:42.052 [7044.7068] <8> vnet_check_vxss_client_magic_with_info: [vnet_vxss_helper.c:871] Ignoring VxSS authentication 2 0x2 14:15:42.099 [7044.7068] <4> bpfis: INF - BACKUP START 7044 14:15:42.099 [7044.7068] <32> bpfis: FTL - cannot open C:\Program Files\Veritas\NetBackup\online_util\fi_cntl\bpfis.fim.exa.main.vgk_1364552076.1.0 14:15:42.099 [7044.7068] <4> bpfis main: Overriding original online_util() status <12> with <1542>. 14:15:42.099 [7044.7068] <4> bpfis: INF - Attempt to send status to the bpfis create process 14:15:43.099 [7044.7068] <4> bpfis: Starting keep alive thread. 14:15:43.099 [7044.7068] <2> deleteReference: reference not found in the list 14:15:43.099 [7044.7068] <4> bpfis: Delete reference: status [-4] 14:15:43.099 [7044.7068] <2> writeSnapshotLockFile: Writing type[2] refcount[0] 14:15:43.099 [7044.7068] <2> getFileName: FileName is [C:\Program Files\Veritas\NetBackup\online_util\fi_cntl\exa.main.vgk_1364552076_copy1.lock] 14:15:43.099 [7044.7068] <2> unlockSnapshot: file[C:\Program Files\Veritas\NetBackup\online_util\fi_cntl\exa.main.vgk_1364552076_copy1.lock] : zero reference count 14:15:43.099 [7044.7068] <4> bpfis: Released snapshot lock: status [0] 14:15:43.099 [7044.7068] <4> bpfis Exit: Deleting snapshot lock files from client for id [exa.main.vgk_1364552076] and copy_number [1] 14:15:43.099 [7044.7068] <2> getFileName: FileName is [C:\Program Files\Veritas\NetBackup\online_util\fi_cntl\exa.main.vgk_1364552076_copy1.lock] 14:15:43.099 [7044.7068] <2> deleteSnapshotLockFile: file[C:\Program Files\Veritas\NetBackup\online_util\fi_cntl\exa.main.vgk_1364552076_copy1.lock] deleted: status[0] 14:15:43.099 [7044.7068] <4> bpfis: INF - EXIT STATUS 1542: An existing snapshot is no longer valid and cannot be mounted for subsequent operations