Solved: Have a look at the following

wannawin · ‎06-20-2012

Client server

Hardware is PC

OS is window 2003

NetBackup Client Protocol Level = 6.5.4
Product = NetBackup
Version Name = 6.5
Version Number = 650000

Master server: NetBackup-Solaris9 6.5.6

BPFIS LOGS:

09:02:35.673 [60392.33784] <2> logparams: C:\Program Files\Veritas\NetBackup\bin\bpfis create -owner NBU -fso -WOFB -fim VSS -id tus1citapppib09_1340119204 C:\ D:\ Shadow Copy Components:\

09:02:35.673 [60392.33784] <4> bpfis: INF - BACKUP START 60392

09:02:38.189 [60392.33784] <8> onlfi_initialize_vfms: VfMS error 10; see following messages:

09:02:38.189 [60392.33784] <8> onlfi_initialize_vfms: Non-fatal method error was reported

09:02:38.189 [60392.33784] <8> onlfi_initialize_vfms: vfm_configure_fi_one: method: FlashSnap, type: FIM, function: FlashSnap_init

09:02:38.189 [60392.33784] <8> onlfi_initialize_vfms: VfMS method error 3; see following message:

09:02:38.189 [60392.33784] <8> onlfi_initialize_vfms: FlashSnap_init: Veritas Volume Manager not installed.

09:02:38.282 [60392.33784] <8> onlfi_initialize_vfms: VfMS error 10; see following messages:

09:02:38.282 [60392.33784] <8> onlfi_initialize_vfms: Non-fatal method error was reported

09:02:38.282 [60392.33784] <8> onlfi_initialize_vfms: vfm_configure_fi_one: method: vxvm, type: FIM, function: vxvm_init

09:02:38.282 [60392.33784] <8> onlfi_initialize_vfms: VfMS method error 3; see following message:

09:02:38.282 [60392.33784] <8> onlfi_initialize_vfms: vxvm_init: Veritas Volume Manager not installed.

09:02:38.407 [60392.33784] <4> bpfis: INF - FIS_ID=tus1citapppib09_1340119204

09:02:38.407 [60392.33784] <2> AdjustUnboundedAssociations: Registry value VSS_MAXIMUM_STORAGE_SIZE is unavailable or the wrong type, staying with the default action of limiting unbounded associations

09:02:38.407 [60392.33784] <2> AdjustUnboundedAssociations: Modified override_fim=VSS:shadow_storage_size=-1

09:02:38.423 [60392.33784] <2> devtomp: matched GUID \\?\Volume{85c8f574-3bdb-11e0-838c-806e6f6e6963} to device \Device\HarddiskVolume1

09:02:38.423 [60392.33784] <2> onlfi_process_fs_list_fs_entry: Adding file system C:\ to list

09:02:38.423 [60392.33784] <2> devtomp: matched GUID \\?\Volume{85c8f575-3bdb-11e0-838c-806e6f6e6963} to device \Device\HarddiskVolume2

09:02:38.423 [60392.33784] <2> onlfi_process_fs_list_fs_entry: Adding file system D:\ to list

09:02:38.423 [60392.33784] <4> onlfi_fim_dev_info: Preparing freeze of C:\ using snapshot method VSS.

09:02:38.423 [60392.33784] <4> create_mount_point: Created mount point C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_C__60392

09:02:40.438 [60392.33784] <4> onlfi_fim_dev_info: Preparing freeze of D:\ using snapshot method VSS.

09:02:40.438 [60392.33784] <4> create_mount_point: Created mount point C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_D__60392

09:02:42.438 [60392.33784] <2> onlfi_vfms_logf: vfm_freeze_commit: config=shadow_storage_size=-1

09:02:48.954 [60392.33784] <2> onlfi_vfms_logf: snapshot services: emcclariionfi:Tue Jun 19 2012 09:02:48.954000 <Thread id - 33784> Unable to import any login credentials for any appliances.

09:02:49.375 [60392.33784] <2> onlfi_vfms_logf: snapshot services: hpevafi:Tue Jun 19 2012 09:02:49.375000 <Thread id - 33784> CHpEvaPlugin::init: CLI tool is not installed.

09:02:49.657 [60392.33784] <2> onlfi_vfms_logf: snapshot services: hpmsafi:Tue Jun 19 2012 09:02:49.657000 <Thread id - 33784> No array management credentials are available in configuration file.

09:02:49.828 [60392.33784] <2> onlfi_vfms_logf: snapshot services: ibmtsfi:Tue Jun 19 2012 09:02:49.828000 <Thread id - 33784> DSCLI not found at path=[C:\Program Files\IBM\DSCLI\]

09:02:50.235 [60392.33784] <2> onlfi_vfms_logf: snapshot services: vss:Tue Jun 19 2012 09:02:50.235000 <Thread id - 33784> check_service_status - STATUS=[4]

09:02:50.485 [60392.33784] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 09:02:50.485000 <Thread id - 33784> CSciToolBase:UpdateModePageString for page[131]...

09:02:50.485 [60392.33784] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 09:02:50.485000 <Thread id - 33784> CSciToolBase:UpdateModePageString for page[131] done

09:02:50.500 [60392.33784] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 09:02:50.500000 <Thread id - 33784> CSciToolBase:UpdateModePageString for page[128]...

09:02:50.500 [60392.33784] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 09:02:50.500000 <Thread id - 33784> CSciToolBase:UpdateModePageString for page[128] done

09:02:50.500 [60392.33784] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 09:02:50.500000 <Thread id - 33784> libscsitool: ERROR: CScsiTool::UpdateScsiAddressInfo() DeviceIoControl failed for device \\.\PHYSICALDRIVE1 with error 21556049.

09:02:50.516 [60392.33784] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 09:02:50.516000 <Thread id - 33784> libscsitool: ERROR: CScsiTool::UpdateScsiAddressInfo() failed for device \\.\PHYSICALDRIVE1.

09:02:50.532 [60392.33784] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 09:02:50.532000 <Thread id - 33784> CSciToolBase:UpdateModePageString for page[131]...

09:02:50.547 [60392.33784] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 09:02:50.532000 <Thread id - 33784> CSciToolBase:UpdateModePageString for page[131] done

09:02:50.547 [60392.33784] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 09:02:50.547000 <Thread id - 33784> CSciToolBase:UpdateModePageString for page[128]...

09:02:50.547 [60392.33784] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 09:02:50.547000 <Thread id - 33784> CSciToolBase:UpdateModePageString for page[128] done

09:02:50.547 [60392.33784] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 09:02:50.547000 <Thread id - 33784> CSciToolBase:UpdateModePageString for page[131]...

09:02:50.547 [60392.33784] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 09:02:50.547000 <Thread id - 33784> CSciToolBase:UpdateModePageString for page[131] done

09:02:50.547 [60392.33784] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 09:02:50.547000 <Thread id - 33784> CSciToolBase:UpdateModePageString for page[128]...

09:02:50.547 [60392.33784] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 09:02:50.547000 <Thread id - 33784> CSciToolBase:UpdateModePageString for page[128] done

09:02:50.610 [60392.33784] <2> onlfi_vfms_logf: snapshot services: vxfi_analyze fitype=[vss-autoselect-snapshot]

09:02:50.610 [60392.33784] <2> onlfi_vfms_logf: ;shadow_storage_size=-1

09:02:50.625 [60392.33784] <2> onlfi_vfms_logf: <SET_CONFIG_INFO_LIST> <SET_CONFIG_INFO key=shadow_storage_size value=-1 /> </SET_CONFIG_INFO_LIST>

09:03:17.374 [60392.33784] <2> onlfi_vfms_logf: vfm_freeze_commit: vfm_method_errno=[0]

09:03:17.374 [60392.33784] <2> onlfi_vfms_logf: snapshot services: Entering vfi_build_alttree

09:03:17.389 [60392.33784] <2> onlfi_vfms_logf: snapshot services: Exiting vfi_build_alttree with 0

09:03:17.546 [60392.33784] <2> onlfi_vfms_logf: snapshot services: vxfi_fiid =[<?xml version="1.0" encoding="UTF-16" standalone="no" ?><FIID xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance" xsi:noNamespaceSchemaLocation="C:\Program Files\Common Files\Symantec Shared\VxFI\4\\Schema\vfiid_schema.xsd"><Node isGroup="0"><objid>root</objid><type>2050</type><Node isGroup="0"><objid>D:\</objid><type>2050</type><accessPoint>C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_D__60392</accessPoint><nodeId>D:\</nodeId><providerPrefix>winfsys</providerPrefix><Node isGroup="0"><objid><vss>\\?\Volume{85c8f575-3bdb-11e0-838c-806e6f6e6963}</objid><type>4098</type><fi_flags>9472</fi_flags><tmpobjid><ShadowCopyID>{71709420-F2A5-4CFC-8E01-DAA809D20163}</tmpobjid><altobjid>\\?\GLOBALROOT\Device\HarddiskVolumeShadowCopy78</altobjid><interposed_parent>D:\</interposed_parent><interposed>\\?\Volume{85c8f575-3bdb-11e0-838c-806e6f6e6963}</interposed><nodeId><vss>\\?\Volume{85c8f575-3bdb-11e0-838c-806e6f6e6963}</nodeId><providerPrefix>vss</providerPrefix><pluginBinaryData>PABTAE4AQQBQAFMASABPAFQAXwBJAEQAPgB7ADcAMQA3ADAAOQA0ADIAMAAt

09:03:19.546 [60392.33784] <4> delete_mount_point: Deleted mount point C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_C__60392

09:03:19.546 [60392.33784] <2> onlfi_vfms_logf: vfm_freeze_commit: config=shadow_storage_size=-1

09:03:21.545 [60392.33784] <4> delete_mount_point: Deleted mount point C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_D__60392

09:03:25.545 [60392.33784] <2> onlfi_fi_fs_unlock: buffered logs are flushed

09:03:25.545 [60392.33784] <2> onlfi_dump_fim_list: fimlist_rec[0].fim_name=auto

09:03:25.545 [60392.33784] <2> onlfi_dump_fim_list: fimlist_rec[2].fim_name=VSP

09:03:25.545 [60392.33784] <2> onlfi_dump_fim_list: fimlist_rec[3].fim_name=Hyper-V

09:03:25.545 [60392.33784] <2> onlfi_dump_fim_list: fimlist_rec[4].fim_name=VMware

09:03:25.545 [60392.33784] <2> onlfi_dump_fim_list: fimlist_rec[5].fim_name=NAS_Snapshot

09:03:25.545 [60392.33784] <2> onlfi_dump_fim_list: fimlist_rec[6].fim_name=VSS_Writer

09:03:25.545 [60392.33784] <4> bpfis: INF - REMAP FILE BACKUP C:\ USING \\?\GLOBALROOT\Device\HarddiskVolumeShadowCopy77\ OPTIONS:ALT_PATH_PREFIX=C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_60392,FITYPE=MIRROR,MNTPOINT=C:\,FSTYPE=NTFS

09:03:25.545 [60392.33784] <4> bpfis: INF - REMAP FILE BACKUP D:\ USING \\?\GLOBALROOT\Device\HarddiskVolumeShadowCopy78\ OPTIONS:ALT_PATH_PREFIX=C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_60392,FITYPE=MIRROR,MNTPOINT=D:\,FSTYPE=NTFS

09:03:25.545 [60392.33784] <4> bpfis: INF - REMAP FILE BACKUP Shadow Copy Components:\

09:03:25.576 [60392.33784] <4> bpfis: INF - EXIT STATUS 0: the requested operation was successfully completed

09:03:25.576 [60392.33784] <8> bpfis: WRN - Error closing stdout

09:42:39.577 [56884.59560] <2> logparams: C:\Program Files\Veritas\NetBackup\bin\bpfis.exe delete -nbu -id tus1citapppib09_1340119204 -bpstart_to 300 -bpend_to 300 -clnt tus1citapppib09 -S tus1bkpnbupib02

09:42:39.577 [56884.59560] <4> bpfis: INF - BACKUP START 56884

09:42:40.562 [56884.59560] <8> onlfi_initialize_vfms: VfMS error 10; see following messages:

09:42:40.562 [56884.59560] <8> onlfi_initialize_vfms: Non-fatal method error was reported

09:42:40.562 [56884.59560] <8> onlfi_initialize_vfms: vfm_configure_fi_one: method: FlashSnap, type: FIM, function: FlashSnap_init

09:42:40.562 [56884.59560] <8> onlfi_initialize_vfms: VfMS method error 3; see following message:

09:42:40.562 [56884.59560] <8> onlfi_initialize_vfms: FlashSnap_init: Veritas Volume Manager not installed.

09:42:40.562 [56884.59560] <8> onlfi_initialize_vfms: VfMS error 10; see following messages:

09:42:40.562 [56884.59560] <8> onlfi_initialize_vfms: Non-fatal method error was reported

09:42:40.562 [56884.59560] <8> onlfi_initialize_vfms: vfm_configure_fi_one: method: vxvm, type: FIM, function: vxvm_init

09:42:40.562 [56884.59560] <8> onlfi_initialize_vfms: VfMS method error 3; see following message:

09:42:40.562 [56884.59560] <8> onlfi_initialize_vfms: vxvm_init: Veritas Volume Manager not installed.

09:42:40.562 [56884.59560] <4> onlfi_thaw: Thawing C:\ using snapshot method VSS.

09:42:40.562 [56884.59560] <2> onlfi_vfms_logf: vfm_thaw: delete snapshot ...

09:42:40.562 [56884.59560] <2> onlfi_vfms_logf: snapshot services: Entering vfi_reaccess_tree

09:42:40.749 [56884.59560] <2> onlfi_vfms_logf: snapshot services: emcclariionfi:Tue Jun 19 2012 09:42:40.733000 <Thread id - 59560> Unable to import any login credentials for any appliances.

09:42:40.765 [56884.59560] <2> onlfi_vfms_logf: snapshot services: hpevafi:Tue Jun 19 2012 09:42:40.749000 <Thread id - 59560> CHpEvaPlugin::init: CLI tool is not installed.

09:42:40.765 [56884.59560] <2> onlfi_vfms_logf: snapshot services: hpmsafi:Tue Jun 19 2012 09:42:40.765000 <Thread id - 59560> No array management credentials are available in configuration file.

09:42:40.765 [56884.59560] <2> onlfi_vfms_logf: snapshot services: ibmtsfi:Tue Jun 19 2012 09:42:40.765000 <Thread id - 59560> DSCLI not found at path=[C:\Program Files\IBM\DSCLI\]

09:42:40.780 [56884.59560] <2> onlfi_vfms_logf: snapshot services: vss:Tue Jun 19 2012 09:42:40.780000 <Thread id - 59560> check_service_status - STATUS=[4]

09:42:41.592 [56884.59560] <2> onlfi_vfms_logf: snapshot services: Exiting vfi_reaccess_tree with 0

09:42:43.592 [56884.59560] <4> onlfi_thaw: do_thaw return value: 0

09:42:43.592 [56884.59560] <4> onlfi_thaw: Thawing D:\ using snapshot method VSS.

09:42:45.591 [56884.59560] <4> onlfi_thaw: do_thaw return value: 0

09:42:49.590 [56884.59560] <2> fis_delete_id: removing C:\Program Files\Veritas\NetBackup\online_util\fi_cntl\bpfis.fim.tus1citapppib09_1340119204.0

09:42:49.590 [56884.59560] <2> fis_delete_id: removing C:\Program Files\Veritas\NetBackup\online_util\fi_cntl\bpfis.fim.tus1citapppib09_1340119204.0.fiid

09:42:49.746 [56884.59560] <4> bpfis: INF - EXIT STATUS 0: the requested operation was successfully completed

09:46:26.269 [15716.32172] <2> logparams: bpfis query -id tus1citapppib09_1340124378

09:46:26.269 [15716.32172] <4> bpfis: INF - BACKUP START 15716

09:46:26.285 [15716.32172] <32> fis_rebuild_from_db: cannot open C:\Program Files\Veritas\NetBackup\online_util\fi_cntl\bpfis.fim.tus1citapppib09_1340124378.0

09:46:26.285 [15716.32172] <4> bpfis: INF - EXIT STATUS 12: file open failed

10:24:49.373 [46904.27120] <2> logparams: C:\Program Files\Veritas\NetBackup\bin\bpfis create -owner NBU -fso -WOFB -fim VSS -id tus1citapppib09_1340124378 C:\ D:\ Shadow Copy Components:\

10:24:49.373 [46904.27120] <4> bpfis: INF - BACKUP START 46904

10:24:50.326 [46904.27120] <8> onlfi_initialize_vfms: VfMS error 10; see following messages:

10:24:50.326 [46904.27120] <8> onlfi_initialize_vfms: Non-fatal method error was reported

10:24:50.326 [46904.27120] <8> onlfi_initialize_vfms: vfm_configure_fi_one: method: FlashSnap, type: FIM, function: FlashSnap_init

10:24:50.326 [46904.27120] <8> onlfi_initialize_vfms: VfMS method error 3; see following message:

10:24:50.326 [46904.27120] <8> onlfi_initialize_vfms: FlashSnap_init: Veritas Volume Manager not installed.

10:24:50.342 [46904.27120] <8> onlfi_initialize_vfms: VfMS error 10; see following messages:

10:24:50.342 [46904.27120] <8> onlfi_initialize_vfms: Non-fatal method error was reported

10:24:50.342 [46904.27120] <8> onlfi_initialize_vfms: vfm_configure_fi_one: method: vxvm, type: FIM, function: vxvm_init

10:24:50.342 [46904.27120] <8> onlfi_initialize_vfms: VfMS method error 3; see following message:

10:24:50.342 [46904.27120] <8> onlfi_initialize_vfms: vxvm_init: Veritas Volume Manager not installed.

10:24:50.342 [46904.27120] <4> bpfis: INF - FIS_ID=tus1citapppib09_1340124378

10:24:50.342 [46904.27120] <2> AdjustUnboundedAssociations: Registry value VSS_MAXIMUM_STORAGE_SIZE is unavailable or the wrong type, staying with the default action of limiting unbounded associations

10:24:50.342 [46904.27120] <2> AdjustUnboundedAssociations: Modified override_fim=VSS:shadow_storage_size=-1

10:24:50.342 [46904.27120] <2> devtomp: matched GUID \\?\Volume{85c8f574-3bdb-11e0-838c-806e6f6e6963} to device \Device\HarddiskVolume1

10:24:50.342 [46904.27120] <2> onlfi_process_fs_list_fs_entry: Adding file system C:\ to list

10:24:50.342 [46904.27120] <2> devtomp: matched GUID \\?\Volume{85c8f575-3bdb-11e0-838c-806e6f6e6963} to device \Device\HarddiskVolume2

10:24:50.342 [46904.27120] <2> onlfi_process_fs_list_fs_entry: Adding file system D:\ to list

10:24:50.342 [46904.27120] <4> onlfi_fim_dev_info: Preparing freeze of C:\ using snapshot method VSS.

10:24:50.342 [46904.27120] <4> create_mount_point: Created mount point C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_C__46904

10:24:52.341 [46904.27120] <4> onlfi_fim_dev_info: Preparing freeze of D:\ using snapshot method VSS.

10:24:52.341 [46904.27120] <4> create_mount_point: Created mount point C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_D__46904

10:24:54.341 [46904.27120] <2> onlfi_vfms_logf: vfm_freeze_commit: config=shadow_storage_size=-1

10:24:54.357 [46904.27120] <2> onlfi_vfms_logf: snapshot services: emcclariionfi:Tue Jun 19 2012 10:24:54.357000 <Thread id - 27120> Unable to import any login credentials for any appliances.

10:24:54.372 [46904.27120] <2> onlfi_vfms_logf: snapshot services: hpevafi:Tue Jun 19 2012 10:24:54.372000 <Thread id - 27120> CHpEvaPlugin::init: CLI tool is not installed.

10:24:54.372 [46904.27120] <2> onlfi_vfms_logf: snapshot services: hpmsafi:Tue Jun 19 2012 10:24:54.372000 <Thread id - 27120> No array management credentials are available in configuration file.

10:24:54.372 [46904.27120] <2> onlfi_vfms_logf: snapshot services: ibmtsfi:Tue Jun 19 2012 10:24:54.372000 <Thread id - 27120> DSCLI not found at path=[C:\Program Files\IBM\DSCLI\]

10:24:54.388 [46904.27120] <2> onlfi_vfms_logf: snapshot services: vss:Tue Jun 19 2012 10:24:54.388000 <Thread id - 27120> check_service_status - STATUS=[4]

10:24:54.466 [46904.27120] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 10:24:54.466000 <Thread id - 27120> CSciToolBase:UpdateModePageString for page[131]...

10:24:54.466 [46904.27120] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 10:24:54.466000 <Thread id - 27120> CSciToolBase:UpdateModePageString for page[131] done

10:24:54.466 [46904.27120] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 10:24:54.466000 <Thread id - 27120> CSciToolBase:UpdateModePageString for page[128]...

10:24:54.482 [46904.27120] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 10:24:54.482000 <Thread id - 27120> CSciToolBase:UpdateModePageString for page[128] done

10:24:54.482 [46904.27120] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 10:24:54.482000 <Thread id - 27120> libscsitool: ERROR: CScsiTool::UpdateScsiAddressInfo() DeviceIoControl failed for device \\.\PHYSICALDRIVE1 with error 21556049.

10:24:54.482 [46904.27120] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 10:24:54.482000 <Thread id - 27120> libscsitool: ERROR: CScsiTool::UpdateScsiAddressInfo() failed for device \\.\PHYSICALDRIVE1.

10:24:54.497 [46904.27120] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 10:24:54.497000 <Thread id - 27120> CSciToolBase:UpdateModePageString for page[131]...

10:24:54.497 [46904.27120] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 10:24:54.497000 <Thread id - 27120> CSciToolBase:UpdateModePageString for page[131] done

10:24:54.497 [46904.27120] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 10:24:54.497000 <Thread id - 27120> CSciToolBase:UpdateModePageString for page[128]...

10:24:54.497 [46904.27120] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 10:24:54.497000 <Thread id - 27120> CSciToolBase:UpdateModePageString for page[128] done

10:24:54.513 [46904.27120] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 10:24:54.513000 <Thread id - 27120> CSciToolBase:UpdateModePageString for page[131]...

10:24:54.513 [46904.27120] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 10:24:54.513000 <Thread id - 27120> CSciToolBase:UpdateModePageString for page[131] done

10:24:54.513 [46904.27120] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 10:24:54.513000 <Thread id - 27120> CSciToolBase:UpdateModePageString for page[128]...

10:24:54.513 [46904.27120] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 10:24:54.513000 <Thread id - 27120> CSciToolBase:UpdateModePageString for page[128] done

10:24:54.529 [46904.27120] <2> onlfi_vfms_logf: snapshot services: vxfi_analyze fitype=[vss-autoselect-snapshot]

10:24:54.529 [46904.27120] <2> onlfi_vfms_logf: ;shadow_storage_size=-1

10:24:54.529 [46904.27120] <2> onlfi_vfms_logf: <SET_CONFIG_INFO_LIST> <SET_CONFIG_INFO key=shadow_storage_size value=-1 /> </SET_CONFIG_INFO_LIST>

10:25:13.261 [46904.27120] <2> onlfi_vfms_logf: vfm_freeze_commit: vfm_method_errno=[0]

10:25:13.261 [46904.27120] <2> onlfi_vfms_logf: snapshot services: Entering vfi_build_alttree

10:25:13.261 [46904.27120] <2> onlfi_vfms_logf: snapshot services: Exiting vfi_build_alttree with 0

10:25:13.261 [46904.27120] <2> onlfi_vfms_logf: snapshot services: vxfi_fiid =[<?xml version="1.0" encoding="UTF-16" standalone="no" ?><FIID xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance" xsi:noNamespaceSchemaLocation="C:\Program Files\Common Files\Symantec Shared\VxFI\4\\Schema\vfiid_schema.xsd"><Node isGroup="0"><objid>root</objid><type>2050</type><Node isGroup="0"><objid>D:\</objid><type>2050</type><accessPoint>C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_D__46904</accessPoint><nodeId>D:\</nodeId><providerPrefix>winfsys</providerPrefix><Node isGroup="0"><objid><vss>\\?\Volume{85c8f575-3bdb-11e0-838c-806e6f6e6963}</objid><type>4098</type><fi_flags>9472</fi_flags><tmpobjid><ShadowCopyID>{260A66F1-F9C7-4BF4-8BDA-E5900C06AA0B}</tmpobjid><altobjid>\\?\GLOBALROOT\Device\HarddiskVolumeShadowCopy82</altobjid><interposed_parent>D:\</interposed_parent><interposed>\\?\Volume{85c8f575-3bdb-11e0-838c-806e6f6e6963}</interposed><nodeId><vss>\\?\Volume{85c8f575-3bdb-11e0-838c-806e6f6e6963}</nodeId><providerPrefix>vss</providerPrefix><pluginBinaryData>PABTAE4AQQBQAFMASABPAFQAXwBJAEQAPgB7ADIANgAwAEEANgA2AEYAMQAt

10:25:15.277 [46904.27120] <4> delete_mount_point: Deleted mount point C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_C__46904

10:25:15.277 [46904.27120] <2> onlfi_vfms_logf: vfm_freeze_commit: config=shadow_storage_size=-1

10:25:17.511 [46904.27120] <4> delete_mount_point: Deleted mount point C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_D__46904

10:25:21.510 [46904.27120] <2> onlfi_fi_fs_unlock: buffered logs are flushed

10:25:24.151 [46904.27120] <2> onlfi_dump_fim_list: fimlist_rec[0].fim_name=auto

10:25:24.151 [46904.27120] <2> onlfi_dump_fim_list: fimlist_rec[2].fim_name=VSP

10:25:24.151 [46904.27120] <2> onlfi_dump_fim_list: fimlist_rec[3].fim_name=Hyper-V

10:25:24.151 [46904.27120] <2> onlfi_dump_fim_list: fimlist_rec[4].fim_name=VMware

10:25:24.151 [46904.27120] <2> onlfi_dump_fim_list: fimlist_rec[5].fim_name=NAS_Snapshot

10:25:24.151 [46904.27120] <2> onlfi_dump_fim_list: fimlist_rec[6].fim_name=VSS_Writer

10:25:24.151 [46904.27120] <4> bpfis: INF - REMAP FILE BACKUP C:\ USING \\?\GLOBALROOT\Device\HarddiskVolumeShadowCopy81\ OPTIONS:ALT_PATH_PREFIX=C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_46904,FITYPE=MIRROR,MNTPOINT=C:\,FSTYPE=NTFS

10:25:24.151 [46904.27120] <4> bpfis: INF - REMAP FILE BACKUP D:\ USING \\?\GLOBALROOT\Device\HarddiskVolumeShadowCopy82\ OPTIONS:ALT_PATH_PREFIX=C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_46904,FITYPE=MIRROR,MNTPOINT=D:\,FSTYPE=NTFS

10:25:24.151 [46904.27120] <4> bpfis: INF - REMAP FILE BACKUP Shadow Copy Components:\

10:25:25.948 [46904.27120] <4> bpfis: INF - EXIT STATUS 0: the requested operation was successfully completed

10:25:25.948 [46904.27120] <8> bpfis: WRN - Error closing stdout

11:15:43.502 [15120.35552] <2> logparams: bpfis delete -id tus1citapppib09_1340124378

11:15:43.502 [15120.35552] <4> bpfis: INF - BACKUP START 15120

11:15:44.548 [15120.35552] <8> onlfi_initialize_vfms: VfMS error 10; see following messages:

11:15:44.548 [15120.35552] <8> onlfi_initialize_vfms: Non-fatal method error was reported

11:15:44.548 [15120.35552] <8> onlfi_initialize_vfms: vfm_configure_fi_one: method: FlashSnap, type: FIM, function: FlashSnap_init

11:15:44.564 [15120.35552] <8> onlfi_initialize_vfms: VfMS method error 3; see following message:

11:15:44.564 [15120.35552] <8> onlfi_initialize_vfms: FlashSnap_init: Veritas Volume Manager not installed.

11:15:44.564 [15120.35552] <8> onlfi_initialize_vfms: VfMS error 10; see following messages:

11:15:44.564 [15120.35552] <8> onlfi_initialize_vfms: Non-fatal method error was reported

11:15:44.564 [15120.35552] <8> onlfi_initialize_vfms: vfm_configure_fi_one: method: vxvm, type: FIM, function: vxvm_init

11:15:44.564 [15120.35552] <8> onlfi_initialize_vfms: VfMS method error 3; see following message:

11:15:44.564 [15120.35552] <8> onlfi_initialize_vfms: vxvm_init: Veritas Volume Manager not installed.

11:15:44.564 [15120.35552] <4> onlfi_thaw: Thawing C:\ using snapshot method VSS.

11:15:44.564 [15120.35552] <2> onlfi_vfms_logf: vfm_thaw: delete snapshot ...

11:15:44.564 [15120.35552] <2> onlfi_vfms_logf: snapshot services: Entering vfi_reaccess_tree

11:15:44.595 [15120.35552] <2> onlfi_vfms_logf: snapshot services: emcclariionfi:Tue Jun 19 2012 11:15:44.580000 <Thread id - 35552> Unable to import any login credentials for any appliances.

11:15:44.611 [15120.35552] <2> onlfi_vfms_logf: snapshot services: hpevafi:Tue Jun 19 2012 11:15:44.611000 <Thread id - 35552> CHpEvaPlugin::init: CLI tool is not installed.

11:15:44.611 [15120.35552] <2> onlfi_vfms_logf: snapshot services: hpmsafi:Tue Jun 19 2012 11:15:44.611000 <Thread id - 35552> No array management credentials are available in configuration file.

11:15:44.611 [15120.35552] <2> onlfi_vfms_logf: snapshot services: ibmtsfi:Tue Jun 19 2012 11:15:44.611000 <Thread id - 35552> DSCLI not found at path=[C:\Program Files\IBM\DSCLI\]

11:15:44.626 [15120.35552] <2> onlfi_vfms_logf: snapshot services: vss:Tue Jun 19 2012 11:15:44.626000 <Thread id - 35552> check_service_status - STATUS=[4]

11:15:44.689 [15120.35552] <2> onlfi_vfms_logf: snapshot services: Exiting vfi_reaccess_tree with 0

11:15:46.689 [15120.35552] <4> onlfi_thaw: do_thaw return value: 0

11:15:46.689 [15120.35552] <4> onlfi_thaw: Thawing D:\ using snapshot method VSS.

11:15:48.626 [40624.14692] <2> logparams: C:\Program Files\Veritas\NetBackup\bin\bpfis.exe delete -nbu -id tus1citapppib09_1340124378 -bpstart_to 300 -bpend_to 300 -clnt tus1citapppib09 -S tus1bkpnbupib02

11:15:48.626 [40624.14692] <4> bpfis: INF - BACKUP START 40624

11:15:48.689 [15120.35552] <4> onlfi_thaw: do_thaw return value: 0

11:15:49.813 [40624.14692] <8> onlfi_initialize_vfms: VfMS error 10; see following messages:

11:15:49.813 [40624.14692] <8> onlfi_initialize_vfms: Non-fatal method error was reported

11:15:49.813 [40624.14692] <8> onlfi_initialize_vfms: vfm_configure_fi_one: method: FlashSnap, type: FIM, function: FlashSnap_init

11:15:49.813 [40624.14692] <8> onlfi_initialize_vfms: VfMS method error 3; see following message:

11:15:49.813 [40624.14692] <8> onlfi_initialize_vfms: FlashSnap_init: Veritas Volume Manager not installed.

11:15:49.813 [40624.14692] <8> onlfi_initialize_vfms: VfMS error 10; see following messages:

11:15:49.813 [40624.14692] <8> onlfi_initialize_vfms: Non-fatal method error was reported

11:15:49.813 [40624.14692] <8> onlfi_initialize_vfms: vfm_configure_fi_one: method: vxvm, type: FIM, function: vxvm_init

11:15:49.813 [40624.14692] <8> onlfi_initialize_vfms: VfMS method error 3; see following message:

11:15:49.813 [40624.14692] <8> onlfi_initialize_vfms: vxvm_init: Veritas Volume Manager not installed.

11:15:49.829 [40624.14692] <4> onlfi_thaw: Thawing C:\ using snapshot method VSS.

11:15:49.829 [40624.14692] <2> onlfi_vfms_logf: vfm_thaw: delete snapshot ...

11:15:49.829 [40624.14692] <2> onlfi_vfms_logf: snapshot services: Entering vfi_reaccess_tree

11:15:49.845 [40624.14692] <2> onlfi_vfms_logf: snapshot services: emcclariionfi:Tue Jun 19 2012 11:15:49.845000 <Thread id - 14692> Unable to import any login credentials for any appliances.

11:15:49.860 [40624.14692] <2> onlfi_vfms_logf: snapshot services: hpevafi:Tue Jun 19 2012 11:15:49.860000 <Thread id - 14692> CHpEvaPlugin::init: CLI tool is not installed.

11:15:49.860 [40624.14692] <2> onlfi_vfms_logf: snapshot services: hpmsafi:Tue Jun 19 2012 11:15:49.860000 <Thread id - 14692> No array management credentials are available in configuration file.

11:15:49.876 [40624.14692] <2> onlfi_vfms_logf: snapshot services: ibmtsfi:Tue Jun 19 2012 11:15:49.876000 <Thread id - 14692> DSCLI not found at path=[C:\Program Files\IBM\DSCLI\]

11:15:49.876 [40624.14692] <2> onlfi_vfms_logf: snapshot services: vss:Tue Jun 19 2012 11:15:49.876000 <Thread id - 14692> check_service_status - STATUS=[4]

11:15:49.954 [40624.14692] <2> onlfi_vfms_logf: snapshot services: Exiting vfi_reaccess_tree with 0

11:15:51.954 [40624.14692] <4> onlfi_thaw: do_thaw return value: 0

11:15:51.954 [40624.14692] <4> onlfi_thaw: Thawing D:\ using snapshot method VSS.

11:15:52.688 [15120.35552] <2> fis_delete_id: removing C:\Program Files\Veritas\NetBackup\online_util\fi_cntl\bpfis.fim.tus1citapppib09_1340124378.0

11:15:52.688 [15120.35552] <2> fis_delete_id: removing C:\Program Files\Veritas\NetBackup\online_util\fi_cntl\bpfis.fim.tus1citapppib09_1340124378.0.fiid

11:15:52.704 [15120.35552] <4> bpfis: INF - EXIT STATUS 0: the requested operation was successfully completed

11:15:53.954 [40624.14692] <4> onlfi_thaw: do_thaw return value: 0

11:15:57.953 [40624.14692] <4> bpfis: INF - EXIT STATUS 0: the requested operation was successfully completed

20:05:15.112 [37180.49216] <2> logparams: bpfis query -id tus1citapppib09_1340161488

20:05:15.393 [37180.49216] <4> bpfis: INF - BACKUP START 37180

20:05:15.393 [37180.49216] <32> fis_rebuild_from_db: cannot open C:\Program Files\Veritas\NetBackup\online_util\fi_cntl\bpfis.fim.tus1citapppib09_1340161488.0

20:05:15.393 [37180.49216] <4> bpfis: INF - EXIT STATUS 12: file open failed

21:02:21.999 [56968.48260] <2> logparams: C:\Program Files\Veritas\NetBackup\bin\bpfis create -owner NBU -fso -WOFB -fim VSS -id tus1citapppib09_1340161488 C:\ D:\ Shadow Copy Components:\

21:02:22.015 [56968.48260] <4> bpfis: INF - BACKUP START 56968

21:02:25.920 [56968.48260] <8> onlfi_initialize_vfms: VfMS error 10; see following messages:

21:02:25.920 [56968.48260] <8> onlfi_initialize_vfms: Non-fatal method error was reported

21:02:25.920 [56968.48260] <8> onlfi_initialize_vfms: vfm_configure_fi_one: method: FlashSnap, type: FIM, function: FlashSnap_init

21:02:25.920 [56968.48260] <8> onlfi_initialize_vfms: VfMS method error 3; see following message:

21:02:25.920 [56968.48260] <8> onlfi_initialize_vfms: FlashSnap_init: Veritas Volume Manager not installed.

21:02:25.952 [56968.48260] <8> onlfi_initialize_vfms: VfMS error 10; see following messages:

21:02:25.952 [56968.48260] <8> onlfi_initialize_vfms: Non-fatal method error was reported

21:02:25.952 [56968.48260] <8> onlfi_initialize_vfms: vfm_configure_fi_one: method: vxvm, type: FIM, function: vxvm_init

21:02:25.952 [56968.48260] <8> onlfi_initialize_vfms: VfMS method error 3; see following message:

21:02:25.952 [56968.48260] <8> onlfi_initialize_vfms: vxvm_init: Veritas Volume Manager not installed.

21:02:26.077 [56968.48260] <4> bpfis: INF - FIS_ID=tus1citapppib09_1340161488

21:02:26.077 [56968.48260] <2> AdjustUnboundedAssociations: Registry value VSS_MAXIMUM_STORAGE_SIZE is unavailable or the wrong type, staying with the default action of limiting unbounded associations

21:02:26.077 [56968.48260] <2> AdjustUnboundedAssociations: Modified override_fim=VSS:shadow_storage_size=-1

21:02:26.077 [56968.48260] <2> devtomp: matched GUID \\?\Volume{85c8f574-3bdb-11e0-838c-806e6f6e6963} to device \Device\HarddiskVolume1

21:02:26.077 [56968.48260] <2> onlfi_process_fs_list_fs_entry: Adding file system C:\ to list

21:02:26.077 [56968.48260] <2> devtomp: matched GUID \\?\Volume{85c8f575-3bdb-11e0-838c-806e6f6e6963} to device \Device\HarddiskVolume2

21:02:26.077 [56968.48260] <2> onlfi_process_fs_list_fs_entry: Adding file system D:\ to list

21:02:26.077 [56968.48260] <4> onlfi_fim_dev_info: Preparing freeze of C:\ using snapshot method VSS.

21:02:26.124 [56968.48260] <4> create_mount_point: Created mount point C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_C__56968

21:02:28.123 [56968.48260] <4> onlfi_fim_dev_info: Preparing freeze of D:\ using snapshot method VSS.

21:02:28.123 [56968.48260] <4> create_mount_point: Created mount point C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_D__56968

21:02:30.123 [56968.48260] <2> onlfi_vfms_logf: vfm_freeze_commit: config=shadow_storage_size=-1

21:02:30.576 [56968.48260] <2> onlfi_vfms_logf: snapshot services: emcclariionfi:Tue Jun 19 2012 21:02:30.576000 <Thread id - 48260> Unable to import any login credentials for any appliances.

21:02:30.779 [56968.48260] <2> onlfi_vfms_logf: snapshot services: hpevafi:Tue Jun 19 2012 21:02:30.748000 <Thread id - 48260> CHpEvaPlugin::init: CLI tool is not installed.

21:02:30.904 [56968.48260] <2> onlfi_vfms_logf: snapshot services: hpmsafi:Tue Jun 19 2012 21:02:30.904000 <Thread id - 48260> No array management credentials are available in configuration file.

21:02:30.983 [56968.48260] <2> onlfi_vfms_logf: snapshot services: ibmtsfi:Tue Jun 19 2012 21:02:30.983000 <Thread id - 48260> DSCLI not found at path=[C:\Program Files\IBM\DSCLI\]

21:02:31.092 [56968.48260] <2> onlfi_vfms_logf: snapshot services: vss:Tue Jun 19 2012 21:02:31.092000 <Thread id - 48260> check_service_status - STATUS=[4]

21:02:31.233 [56968.48260] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 21:02:31.233000 <Thread id - 48260> CSciToolBase:UpdateModePageString for page[131]...

21:02:31.248 [56968.48260] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 21:02:31.233000 <Thread id - 48260> CSciToolBase:UpdateModePageString for page[131] done

21:02:31.248 [56968.48260] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 21:02:31.248000 <Thread id - 48260> CSciToolBase:UpdateModePageString for page[128]...

21:02:31.279 [56968.48260] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 21:02:31.248000 <Thread id - 48260> CSciToolBase:UpdateModePageString for page[128] done

21:02:31.279 [56968.48260] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 21:02:31.279000 <Thread id - 48260> libscsitool: ERROR: CScsiTool::UpdateScsiAddressInfo() DeviceIoControl failed for device \\.\PHYSICALDRIVE1 with error 21556049.

21:02:31.295 [56968.48260] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 21:02:31.279000 <Thread id - 48260> libscsitool: ERROR: CScsiTool::UpdateScsiAddressInfo() failed for device \\.\PHYSICALDRIVE1.

21:02:31.326 [56968.48260] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 21:02:31.295000 <Thread id - 48260> CSciToolBase:UpdateModePageString for page[131]...

21:02:31.326 [56968.48260] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 21:02:31.326000 <Thread id - 48260> CSciToolBase:UpdateModePageString for page[131] done

21:02:31.326 [56968.48260] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 21:02:31.326000 <Thread id - 48260> CSciToolBase:UpdateModePageString for page[128]...

21:02:31.342 [56968.48260] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 21:02:31.326000 <Thread id - 48260> CSciToolBase:UpdateModePageString for page[128] done

21:02:31.358 [56968.48260] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 21:02:31.358000 <Thread id - 48260> CSciToolBase:UpdateModePageString for page[131]...

21:02:31.358 [56968.48260] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 21:02:31.358000 <Thread id - 48260> CSciToolBase:UpdateModePageString for page[131] done

21:02:31.358 [56968.48260] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 21:02:31.358000 <Thread id - 48260> CSciToolBase:UpdateModePageString for page[128]...

21:02:31.358 [56968.48260] <2> onlfi_vfms_logf: snapshot services: devicefi:Tue Jun 19 2012 21:02:31.358000 <Thread id - 48260> CSciToolBase:UpdateModePageString for page[128] done

21:02:31.373 [56968.48260] <2> onlfi_vfms_logf: snapshot services: vxfi_analyze fitype=[vss-autoselect-snapshot]

21:02:31.373 [56968.48260] <2> onlfi_vfms_logf: ;shadow_storage_size=-1

21:02:31.389 [56968.48260] <2> onlfi_vfms_logf: <SET_CONFIG_INFO_LIST> <SET_CONFIG_INFO key=shadow_storage_size value=-1 /> </SET_CONFIG_INFO_LIST>

21:02:40.779 [56968.48260] <2> onlfi_vfms_logf: vfm_freeze_commit: vfm_method_errno=[0]

21:02:40.779 [56968.48260] <2> onlfi_vfms_logf: snapshot services: Entering vfi_build_alttree

21:02:40.779 [56968.48260] <2> onlfi_vfms_logf: snapshot services: Exiting vfi_build_alttree with 0

21:02:40.779 [56968.48260] <2> onlfi_vfms_logf: snapshot services: vxfi_fiid =[<?xml version="1.0" encoding="UTF-16" standalone="no" ?><FIID xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance" xsi:noNamespaceSchemaLocation="C:\Program Files\Common Files\Symantec Shared\VxFI\4\\Schema\vfiid_schema.xsd"><Node isGroup="0"><objid>root</objid><type>2050</type><Node isGroup="0"><objid>D:\</objid><type>2050</type><accessPoint>C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_D__56968</accessPoint><nodeId>D:\</nodeId><providerPrefix>winfsys</providerPrefix><Node isGroup="0"><objid><vss>\\?\Volume{85c8f575-3bdb-11e0-838c-806e6f6e6963}</objid><type>4098</type><fi_flags>9472</fi_flags><tmpobjid><ShadowCopyID>{2ABC32DE-EBB8-40EE-8C7E-3311F6CE473B}</tmpobjid><altobjid>\\?\GLOBALROOT\Device\HarddiskVolumeShadowCopy86</altobjid><interposed_parent>D:\</interposed_parent><interposed>\\?\Volume{85c8f575-3bdb-11e0-838c-806e6f6e6963}</interposed><nodeId><vss>\\?\Volume{85c8f575-3bdb-11e0-838c-806e6f6e6963}</nodeId><providerPrefix>vss</providerPrefix><pluginBinaryData>PABTAE4AQQBQAFMASABPAFQAXwBJAEQAPgB7ADIAQQBCAEMAMwAyAEQARQAt

21:02:42.794 [56968.48260] <4> delete_mount_point: Deleted mount point C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_C__56968

21:02:42.794 [56968.48260] <2> onlfi_vfms_logf: vfm_freeze_commit: config=shadow_storage_size=-1

21:02:44.794 [56968.48260] <4> delete_mount_point: Deleted mount point C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_D__56968

21:02:48.794 [56968.48260] <2> onlfi_fi_fs_unlock: buffered logs are flushed

21:02:48.794 [56968.48260] <2> onlfi_dump_fim_list: fimlist_rec[0].fim_name=auto

21:02:48.794 [56968.48260] <2> onlfi_dump_fim_list: fimlist_rec[2].fim_name=VSP

21:02:48.794 [56968.48260] <2> onlfi_dump_fim_list: fimlist_rec[3].fim_name=Hyper-V

21:02:48.794 [56968.48260] <2> onlfi_dump_fim_list: fimlist_rec[4].fim_name=VMware

21:02:48.794 [56968.48260] <2> onlfi_dump_fim_list: fimlist_rec[5].fim_name=NAS_Snapshot

21:02:48.794 [56968.48260] <2> onlfi_dump_fim_list: fimlist_rec[6].fim_name=VSS_Writer

21:02:48.794 [56968.48260] <4> bpfis: INF - REMAP FILE BACKUP C:\ USING \\?\GLOBALROOT\Device\HarddiskVolumeShadowCopy85\ OPTIONS:ALT_PATH_PREFIX=C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_56968,FITYPE=MIRROR,MNTPOINT=C:\,FSTYPE=NTFS

21:02:48.794 [56968.48260] <4> bpfis: INF - REMAP FILE BACKUP D:\ USING \\?\GLOBALROOT\Device\HarddiskVolumeShadowCopy86\ OPTIONS:ALT_PATH_PREFIX=C:\Program Files\Veritas\NetBackup\temp\_vrts_frzn_img_56968,FITYPE=MIRROR,MNTPOINT=D:\,FSTYPE=NTFS

21:02:48.794 [56968.48260] <4> bpfis: INF - REMAP FILE BACKUP Shadow Copy Components:\

21:02:48.825 [56968.48260] <4> bpfis: INF - EXIT STATUS 0: the requested operation was successfully completed

21:02:48.825 [56968.48260] <8> bpfis: WRN - Error closing stdout

BPBKAR LOGS:

9:46:25.926 AM: [30564.32000] <4> ov_log::OVInit: INF - Starting log file: C:\Program Files\Veritas\NetBackup\logs\BPBKAR\061912.LOG

9:46:25.926 AM: [30564.32000] <4> ov_log::OVInit: GENERAL Log Level: 0

9:46:25.926 AM: [30564.32000] <4> ov_log::OVInit: TCP Log Level: 0

9:46:25.926 AM: [30564.32000] <4> ov_log::OVInit: INF - the log mutex: 704

BPBKAR NetBackup Backup/Archive 6.5GA [Nov 5 2009]

9:46:25.941 AM: [30564.32000] <2> WinMain: DAT - _pgmptr = 'C:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe'

9:46:25.941 AM: [30564.32000] <2> WinMain: DAT - lpCmdLine = '-r 3024000 -ru root -dt 0 -to 0 -clnt tus1citapppib09 -class win_prod_citapp -sched Full -st FULL -bpstart_to 300 -bpend_to 300 -read_to 3600 -ckpt_time 900 -blks_per_buffer 511 -use_otm -use_ofb -b tus1citapppib09_1340124378 -kl 28 -fso -WOFB_enabled -WOFB_fim 1 -WOFB_usage 1 -WOFB_error 0 -ct 13 '

9:46:25.941 AM: [30564.32000] <2> date_debug: DAT - timezone: US Mountain Standard Time, offset=25200, dst: NONE

9:46:25.941 AM: [30564.32000] <2> date_debug: DAT - current time: 1340124385, 6/19/2012 9:46:25 AM

9:46:25.941 AM: [30564.32000] <2> date_debug: DAT - 01/01/94 UCT: 757382400, 12/31/1993 5:00:00 PM

9:46:25.941 AM: [30564.32000] <2> date_debug: DAT - 07/01/94 UCT: 773020800, 6/30/1994 5:00:00 PM

9:46:25.941 AM: [30564.32000] <2> WinMain: DAT - standard input handle = 652

9:46:25.941 AM: [30564.32000] <2> WinMain: DAT - standard output handle = 780

9:46:25.941 AM: [30564.32000] <2> WinMain: DAT - standard error handle = 792

9:46:25.957 AM: [30564.32000] <4> tar_backup::V_SetupJobData: INF - dwJobData: ffffffff

9:46:25.957 AM: [30564.32000] <4> tar_backup::V_SetupJobData: INF - dwJob: ffffffff

9:46:25.973 AM: [30564.32000] <4> dos_backup::V_PreProcessing: INF - backup privileges enabled, previous = 0

9:46:25.973 AM: [30564.32000] <4> dos_backup::V_PreProcessing: INF - restore privileges enabled, previous = 0

9:46:25.973 AM: [30564.32000] <4> dos_backup::V_PreProcessing: INF - security privileges enabled, previous = 0

9:46:25.973 AM: [30564.32000] <4> dos_backup::V_PreProcessing: INF - tcb privileges enabled, previous = 0

9:46:25.973 AM: [30564.32000] <4> dos_backup::V_PreProcessing: INF - create token privileges enabled, previous = 0

9:46:25.973 AM: [30564.32000] <4> dos_backup::V_PreProcessing: INF - user name: root

9:46:25.973 AM: [30564.32000] <4> dos_backup::V_PreProcessing: INF - no access token: scheduled backup

9:46:25.973 AM: [30564.32000] <2> ov_log::V_GlobalLog: INF - BEDS_Init() Enter InitFlags:0x0

9:46:26.019 AM: [30564.32000] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: C:

9:46:26.019 AM: [30564.32000] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: D:

9:46:26.019 AM: [30564.32000] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: G:

9:46:26.019 AM: [30564.32000] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Citrix Client Network

9:46:26.019 AM: [30564.32000] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Microsoft Terminal Services

9:46:26.019 AM: [30564.32000] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Microsoft Windows Network

9:46:26.019 AM: [30564.32000] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Symantec SNAC Network Provider

9:46:26.019 AM: [30564.32000] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Web Client Network

9:46:26.019 AM: [30564.32000] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Shadow?Copy?Components

9:46:26.019 AM: [30564.32000] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: System?State

9:46:26.019 AM: [30564.32000] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Active Directory Application Mode

9:46:26.144 AM: [30564.32000] <2> tar_backup::V_SetupProcessContinue: TAR - CONTINUE BACKUP received

9:46:26.144 AM: [30564.32000] <4> tar_backup_cpr::start: INF - checkpoint thread started

9:46:26.144 AM: [30564.32000] <2> tar_backup_tfi::setupFileDirectives: TAR - backup filename = ALL_LOCAL_DRIVES

9:46:26.144 AM: [30564.28280] <4> tar_base::keepaliveThread: INF - keepalive thread is active with an interval of 60 seconds

9:46:26.238 AM: [30564.32000] <4> V_Snapshot::V_Snapshot_Query: INF - Attempting to query volume snapshots: bpfis query -id tus1citapppib09_1340124378

9:46:27.238 AM: [30564.32000] <4> V_Snapshot::V_Snapshot_ParseBpfisOutput: INF - Snapshot creation, FIS_ID: tus1citapppib09_1340124378

9:46:27.238 AM: [30564.32000] <2> tar_backup_vxbsa::add: INF - called with '/'

9:46:27.238 AM: [30564.32000] <4> dos_backup::V_VerifyFileSystem: INF - Added: C:\

9:46:27.238 AM: [30564.32000] <4> dos_backup::V_VerifyFileSystem: INF - Added: D:\

9:46:27.238 AM: [30564.32000] <4> dos_backup::V_VerifyFileSystem: INF - Added: Shadow Copy Components:\

9:46:27.238 AM: [30564.32000] <4> dos_backup::V_VerifyFileSystem: INF - Added: System State:\

9:46:32.753 AM: [30564.32000] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'System State:\' --> 1002002d

9:46:32.753 AM: [30564.32000] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for '_BACKUP_SPECIAL_OBJECTS AFTER System State:' --> 1002002d

9:46:32.753 AM: [30564.32000] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'D:\' --> 10020002

9:46:34.018 AM: [30564.32000] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'Shadow Copy Components:\' --> 10020027

9:46:34.018 AM: [30564.32000] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\' --> 10020002

9:46:35.018 AM: [30564.32000] <4> VssSnapshot::V_VssSetMetadata(): INF - Unable to locate DFSR metadata

9:46:35.815 AM: [30564.32000] <4> dos_backup::V_InitializeShadowCopy: INF - ============================================

9:46:35.815 AM: [30564.32000] <4> dos_backup::V_InitializeShadowCopy: INF - ShadowCopy PrePost: Begin

9:46:36.674 AM: [30564.32000] <4> dos_backup::tfs_findfirst: WRN - unable to find first file: 'Shadow Copy Components:\System Service\Background Intelligent Transfer Service\'

9:46:36.705 AM: [30564.32000] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - Drive 'C:' added to VSS Volume Set

9:46:36.705 AM: [30564.32000] <4> SnapshotAssociation::SnapshotAssociation: INF - VSS_MAXIMUM_STORAGE_SIZE is unavailable or the wrong type, staying with the default action of limiting unbounded associations

9:46:36.705 AM: [30564.32000] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - checking association status for drive "C:\"

9:46:36.736 AM: [30564.32000] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - ingoring association which is not unbounded

9:46:36.736 AM: [30564.32000] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - enumeration finished, vemo->Next returned S_FALSE

9:47:11.231 AM: [30564.32000] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - VSS Volume Set snapped

9:47:11.231 AM: [30564.32000] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - About to commence post-snap unbounded association checks

9:47:11.246 AM: [30564.32000] <4> SnapshotAssociation::SnapshotAssociation: INF - VSS_MAXIMUM_STORAGE_SIZE is unavailable or the wrong type, staying with the default action of limiting unbounded associations

9:47:11.246 AM: [30564.32000] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - checking association status for drive "C:\"

9:47:11.246 AM: [30564.32000] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - ingoring association which is not unbounded

9:47:11.246 AM: [30564.32000] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - enumeration finished, vemo->Next returned S_FALSE

9:47:11.246 AM: [30564.32000] <4> dos_backup::V_InitializeShadowCopy: INF - ShadowCopy PrePost: End

9:47:11.246 AM: [30564.32000] <4> dos_backup::V_InitializeShadowCopy: INF - ============================================

9:47:11.246 AM: [30564.32000] <4> VssSnapshot::V_VssSetMetadata(): INF - Unable to locate DFSR metadata

9:47:18.464 AM: [30564.32000] <4> dos_backup::tfs_scanstart: INF - Backup Special Objects request AFTER System State:

9:47:18.886 AM: [30564.32000] <4> dos_backup::tfs_getinfo: INF - current object (System State:) is a parent of previous (object (System State:\COM+ Class Registration Database\COM+ REGDB)

9:47:19.089 AM: [30564.32000] <4> dos_backup::tfs_findfirst: WRN - unable to find first file: 'System State:\'

9:47:19.104 AM: [30564.32000] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - Drive 'C:' added to VSS Volume Set

9:47:19.104 AM: [30564.32000] <4> SnapshotAssociation::SnapshotAssociation: INF - VSS_MAXIMUM_STORAGE_SIZE is unavailable or the wrong type, staying with the default action of limiting unbounded associations

9:47:19.104 AM: [30564.32000] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - checking association status for drive "C:\"

9:47:19.120 AM: [30564.32000] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - ingoring association which is not unbounded

9:47:19.120 AM: [30564.32000] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - enumeration finished, vemo->Next returned S_FALSE

9:47:19.120 AM: [30564.32000] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - Drive 'c:' added to VSS Volume Set

9:47:19.120 AM: [30564.32000] <4> SnapshotAssociation::SnapshotAssociation: INF - VSS_MAXIMUM_STORAGE_SIZE is unavailable or the wrong type, staying with the default action of limiting unbounded associations

9:47:19.120 AM: [30564.32000] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - checking association status for drive "c:\"

9:47:19.136 AM: [30564.32000] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - ingoring association which is not unbounded

9:47:19.136 AM: [30564.32000] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - enumeration finished, vemo->Next returned S_FALSE

9:47:38.398 AM: [30564.32000] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - VSS Volume Set snapped

9:47:38.398 AM: [30564.32000] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - About to commence post-snap unbounded association checks

9:47:38.570 AM: [30564.32000] <4> SnapshotAssociation::SnapshotAssociation: INF - VSS_MAXIMUM_STORAGE_SIZE is unavailable or the wrong type, staying with the default action of limiting unbounded associations

9:47:38.570 AM: [30564.32000] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - checking association status for drive "C:\"

9:47:38.914 AM: [30564.32000] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - ingoring association which is not unbounded

9:47:38.914 AM: [30564.32000] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - enumeration finished, vemo->Next returned S_FALSE

9:47:38.945 AM: [30564.32000] <4> SnapshotAssociation::SnapshotAssociation: INF - VSS_MAXIMUM_STORAGE_SIZE is unavailable or the wrong type, staying with the default action of limiting unbounded associations

9:47:38.945 AM: [30564.32000] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - checking association status for drive "c:\"

9:47:38.960 AM: [30564.32000] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - ingoring association which is not unbounded

9:47:38.960 AM: [30564.32000] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - enumeration finished, vemo->Next returned S_FALSE

9:47:38.960 AM: [30564.32000] <4> backup_create: INF - NetBackup Temp Directory: 'C:\Program Files\Veritas\\NetBackup\Temp'

9:47:40.929 AM: [30564.32000] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.

9:47:44.944 AM: [30564.32000] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.

9:47:55.286 AM: [30564.32000] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.

10:23:40.801 AM: [30564.32000] <4> tar_backup_tfi::backup_send_chkp_data_state: INF - checkpoint message: CPR - 4088511 30564 0 0 3 0 0 0 4 1019575808 1 1 511 0 0 39 /System State/System Files/System Files

10:23:42.801 AM: [30564.32000] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.

10:23:42.957 AM: [30564.32000] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.

10:24:48.498 AM: [30564.32000] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.

10:24:48.592 AM: [30564.32000] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.

10:24:48.686 AM: [30564.32000] <4> dos_backup::tfs_scanstart: INF - Backup Special Objects request AFTER System State:

10:24:48.904 AM: [30564.32000] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (System State:), please wait...

10:24:48.904 AM: [30564.32000] <4> V_Snapshot::V_Snapshot_Create: INF - Adding Volume System State:\

10:24:48.904 AM: [30564.32000] <4> V_Snapshot::V_Snapshot_Create: INF - Unable to snapshot volume (Invalid source volume): System State:\

10:24:48.904 AM: [30564.32000] <2> tar_base::V_vTarMsgW: INF - Volume snapshots not enabled

10:24:49.123 AM: [30564.32000] <4> dos_backup::tfs_getinfo: INF - current object (System State:) is a parent of previous (object (System State:\COM+ Class Registration Database\COM+ REGDB)

10:24:49.326 AM: [30564.32000] <4> dos_backup::tfs_findfirst: WRN - unable to find first file: 'System State:\'

10:24:49.326 AM: [30564.32000] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (D:), please wait...

10:24:49.326 AM: [30564.32000] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{85c8f575-3bdb-11e0-838c-806e6f6e6963}\ for ''

10:24:49.326 AM: [30564.32000] <4> V_DetermineMountInfo: INF - Adding NTFS Volume D:\ ==> \\?\Volume{85c8f575-3bdb-11e0-838c-806e6f6e6963}\

10:24:49.326 AM: [30564.32000] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - ======================================================================

10:24:49.326 AM: [30564.32000] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Attempting to create snapshots for 'C:\'

10:24:49.326 AM: [30564.32000] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Attempting to create snapshots for 'D:\'

10:24:49.326 AM: [30564.32000] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Attempting to create snapshots for 'Shadow Copy Components:\'

10:24:49.326 AM: [30564.32000] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - CREATE request: C:\Program Files\Veritas\NetBackup\bin\bpfis create -owner NBU -fso -WOFB -fim VSS -id tus1citapppib09_1340124378 C:\ D:\ "Shadow Copy Components:\\"

10:25:26.323 AM: [30564.32000] <4> V_Snapshot::V_Snapshot_AddMappings: INF - Volume Snapshot Mapping: \\?\Volume{85c8f574-3bdb-11e0-838c-806e6f6e6963}\ --> GLOBALROOT\Device\HarddiskVolumeShadowCopy81

10:25:26.323 AM: [30564.32000] <4> V_Snapshot::V_Snapshot_AddMappings: INF - Volume Snapshot Mapping: \\?\Volume{85c8f575-3bdb-11e0-838c-806e6f6e6963}\ --> GLOBALROOT\Device\HarddiskVolumeShadowCopy82

10:25:26.323 AM: [30564.32000] <4> V_Snapshot::V_Snapshot_ParseBpfisOutput: INF - Snapshot creation, FIS_ID: tus1citapppib09_1340124378

10:25:26.323 AM: [30564.32000] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Snapshot creation was successful

10:25:26.323 AM: [30564.32000] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Snapshot provider: VSS

10:25:26.323 AM: [30564.32000] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - ======================================================================

10:25:26.323 AM: [30564.32000] <2> tar_base::V_vTarMsgW: INF - Volume snapshots enabled

10:25:26.401 AM: [30564.32000] <2> ov_log::V_GlobalLogEx: INF - file_access (constructor): 0 non-NTFS volumes

10:33:25.792 AM: [30564.32000] <4> tar_backup_tfi::backup_send_chkp_data_state: INF - checkpoint message: CPR - 5296004 30564 0 0 30 0 0 0 6 564070400 2 3 511 0 1 62 /D/ADMIN/Software/BMC Remedy Client 7/arclients701_windows.zip

10:46:50.590 AM: [30564.32000] <4> tar_backup_tfi::backup_send_chkp_data_state: INF - checkpoint message: CPR - 7078372 30564 0 0 47 0 0 0 6 402900992 3 3 511 0 1 56 /D/ADMIN/Software/CITRIX/Citrix/XenApp Components CD.zip

11:01:26.225 AM: [30564.32000] <4> tar_backup_tfi::backup_send_chkp_data_state: INF - checkpoint message: CPR - 9031925 30564 0 0 2714 0 0 0 6 329378304 4 3 511 0 1 201 /D/ADMIN/Software/CITRIX/Citrix/XenApp4.5 x64/1973/CPS45_EN_W2K3x64/Support/SqlExpress_2005_SP1/SqlExpress/setup/program files/microsoft sql server/90/tools/binn/windows/winsxs/p6hpravq.lm8/msvcm80.dll

11:15:38.158 AM: [30564.32000] <2> tar_base::V_vTarMsgW: ERR - failure reading file: D:\ADMIN\Software\Informatica 9.1\910HF2_Client_Installer_win32-x86.zip (WIN32 21: The device is not ready. )

11:15:38.158 AM: [30564.32000] <4> V_VSS_CheckForError: INF - Error Checking for GLOBALROOT\Device\HarddiskVolumeShadowCopy82

11:15:38.158 AM: [30564.32000] <4> V_VSS_CheckForError: INF - Error Status (GLOBALROOT\Device\HarddiskVolumeShadowCopy82): 55

11:15:38.158 AM: [30564.32000] <2> tar_base::V_vTarMsgW: ERR - Snapshot Error while reading file: GLOBALROOT\Device\HarddiskVolumeShadowCopy82\ADMIN\Software\Informatica 9.1\910HF2_Client_Installer_win32-x86.zip

11:15:38.158 AM: [30564.32000] <2> tar_base::V_vTarMsgW: FTL - Backup operation aborted!

11:15:38.158 AM: [30564.32000] <4> tar_backup::backup_done_state: INF - number of file directives not found: 0

11:15:38.158 AM: [30564.32000] <4> tar_backup::backup_done_state: INF - number of file directives found: 6

11:15:38.158 AM: [30564.28280] <4> tar_base::keepaliveThread: INF - keepalive thread terminating (reason: WAIT_OBJECT_0)

11:15:38.158 AM: [30564.32000] <4> tar_base::stopKeepaliveThread: INF - keepalive thread has exited. (reason: WAIT_OBJECT_0)

11:15:38.174 AM: [30564.32000] <2> tar_base::V_vTarMsgW: INF - EXIT STATUS 156: snapshot error encountered

11:15:42.408 AM: [30564.32000] <4> tar_backup::backup_done_state: INF - Not waiting for server status

11:15:43.455 AM: [30564.32000] <4> dos_backup::tfs_reset: INF - Snapshot deletion start

11:15:43.455 AM: [30564.32000] <4> V_Snapshot::V_Snapshot_Destroy: INF - Attempting to destroy volume snapshots: bpfis delete -id tus1citapppib09_1340124378

11:15:53.469 AM: [30564.32000] <4> V_Snapshot::V_Snapshot_Destroy: INF - Snapshot destruction was successful

11:15:53.516 AM: [30564.32000] <4> ov_log::OVLoop: Timestamp

11:15:53.516 AM: [30564.32000] <4> OVStopCmd: INF - EXIT - status = 0

11:15:53.516 AM: [30564.32000] <2> tar_base::V_Close: closing...

11:15:53.516 AM: [30564.32000] <4> dos_backup::tfs_reset: INF - Snapshot deletion start

11:15:53.516 AM: [30564.32000] <32> TransporterRemote::write[2](): FTL - SocketWriteException: send() call failed, could not write data to the socket, possible broken connection.

11:15:53.516 AM: [30564.32000] <32> Packer::close(): FTL - OperationFailedException: close operation failed.

11:15:53.610 AM: [30564.32000] <2> ov_log::V_GlobalLog: INF - BEDS_Term(): enter - InitFlags:0x00000001

11:15:53.626 AM: [30564.32000] <16> dtcp_read: TCP - failure: recv socket (652) (TCP 10053: Software caused connection abort)

11:15:53.626 AM: [30564.32000] <4> OVShutdown: INF - Finished process

11:15:53.641 AM: [30564.32000] <4> WinMain: INF - Exiting C:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe

11:15:55.641 AM: [30564.32000] <4> ov_log::OVClose: INF - Closing log file: C:\Program Files\Veritas\NetBackup\logs\BPBKAR\061912.LOG

8:05:14.144 PM: [23272.46184] <4> ov_log::OVInit: INF - Starting log file: C:\Program Files\Veritas\NetBackup\logs\BPBKAR\061912.LOG

8:05:14.144 PM: [23272.46184] <4> ov_log::OVInit: GENERAL Log Level: 0

8:05:14.144 PM: [23272.46184] <4> ov_log::OVInit: TCP Log Level: 0

8:05:14.144 PM: [23272.46184] <4> ov_log::OVInit: INF - the log mutex: 704

BPBKAR NetBackup Backup/Archive 6.5GA [Nov 5 2009]

8:05:14.190 PM: [23272.46184] <2> WinMain: DAT - _pgmptr = 'C:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe'

8:05:14.190 PM: [23272.46184] <2> WinMain: DAT - lpCmdLine = '-r 3024000 -ru root -dt 411547 -to 0 -clnt tus1citapppib09 -class win_prod_citapp -sched Differential-Inc -st INCR -bpstart_to 300 -bpend_to 300 -read_to 3600 -ckpt_time 900 -blks_per_buffer 511 -use_otm -use_ofb -b tus1citapppib09_1340161488 -kl 28 -fso -WOFB_enabled -WOFB_fim 1 -WOFB_usage 1 -WOFB_error 0 -ct 13 '

8:05:14.190 PM: [23272.46184] <2> date_debug: DAT - timezone: US Mountain Standard Time, offset=25200, dst: NONE

8:05:14.190 PM: [23272.46184] <2> date_debug: DAT - current time: 1340161514, 6/19/2012 8:05:14 PM

8:05:14.190 PM: [23272.46184] <2> date_debug: DAT - 01/01/94 UCT: 757382400, 12/31/1993 5:00:00 PM

8:05:14.190 PM: [23272.46184] <2> date_debug: DAT - 07/01/94 UCT: 773020800, 6/30/1994 5:00:00 PM

8:05:14.190 PM: [23272.46184] <2> WinMain: DAT - standard input handle = 676

8:05:14.190 PM: [23272.46184] <2> WinMain: DAT - standard output handle = 780

8:05:14.190 PM: [23272.46184] <2> WinMain: DAT - standard error handle = 788

8:05:14.284 PM: [23272.46184] <4> tar_backup::V_SetupJobData: INF - dwJobData: ffffffff

8:05:14.284 PM: [23272.46184] <4> tar_backup::V_SetupJobData: INF - dwJob: ffffffff

8:05:14.284 PM: [23272.46184] <4> dos_backup::V_PreProcessing: INF - backup privileges enabled, previous = 0

8:05:14.284 PM: [23272.46184] <4> dos_backup::V_PreProcessing: INF - restore privileges enabled, previous = 0

8:05:14.284 PM: [23272.46184] <4> dos_backup::V_PreProcessing: INF - security privileges enabled, previous = 0

8:05:14.284 PM: [23272.46184] <4> dos_backup::V_PreProcessing: INF - tcb privileges enabled, previous = 0

8:05:14.284 PM: [23272.46184] <4> dos_backup::V_PreProcessing: INF - create token privileges enabled, previous = 0

8:05:14.284 PM: [23272.46184] <4> dos_backup::V_PreProcessing: INF - user name: root

8:05:14.284 PM: [23272.46184] <4> dos_backup::V_PreProcessing: INF - no access token: scheduled backup

8:05:14.300 PM: [23272.46184] <2> ov_log::V_GlobalLog: INF - BEDS_Init() Enter InitFlags:0x0

8:05:14.862 PM: [23272.46184] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: C:

8:05:14.862 PM: [23272.46184] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: D:

8:05:14.862 PM: [23272.46184] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: G:

8:05:14.862 PM: [23272.46184] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Citrix Client Network

8:05:14.862 PM: [23272.46184] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Microsoft Terminal Services

8:05:14.862 PM: [23272.46184] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Microsoft Windows Network

8:05:14.862 PM: [23272.46184] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Symantec SNAC Network Provider

8:05:14.862 PM: [23272.46184] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Web Client Network

8:05:14.862 PM: [23272.46184] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Shadow?Copy?Components

8:05:14.862 PM: [23272.46184] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: System?State

8:05:14.862 PM: [23272.46184] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Active Directory Application Mode

8:05:14.862 PM: [23272.46184] <2> tar_backupt_tfi::create: TAR - Incremental backup using the archive bit

8:05:14.987 PM: [23272.46184] <2> tar_backup::V_SetupProcessContinue: TAR - CONTINUE BACKUP received

8:05:14.987 PM: [23272.46184] <4> tar_backup_cpr::start: INF - checkpoint thread started

8:05:14.987 PM: [23272.46184] <2> tar_backup_tfi::setupFileDirectives: TAR - backup filename = ALL_LOCAL_DRIVES

8:05:14.987 PM: [23272.53136] <4> tar_base::keepaliveThread: INF - keepalive thread is active with an interval of 60 seconds

8:05:15.065 PM: [23272.46184] <4> V_Snapshot::V_Snapshot_Query: INF - Attempting to query volume snapshots: bpfis query -id tus1citapppib09_1340161488

8:05:16.081 PM: [23272.46184] <4> V_Snapshot::V_Snapshot_ParseBpfisOutput: INF - Snapshot creation, FIS_ID: tus1citapppib09_1340161488

8:05:16.081 PM: [23272.46184] <2> tar_backup_vxbsa::add: INF - called with '/'

8:05:16.081 PM: [23272.46184] <4> dos_backup::V_VerifyFileSystem: INF - Added: C:\

8:05:16.081 PM: [23272.46184] <4> dos_backup::V_VerifyFileSystem: INF - Added: D:\

8:05:16.081 PM: [23272.46184] <4> dos_backup::V_VerifyFileSystem: INF - Added: Shadow Copy Components:\

8:05:16.081 PM: [23272.46184] <4> dos_backup::V_VerifyFileSystem: INF - Added: System State:\

8:05:20.456 PM: [23272.46184] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'System State:\' --> 1002002d

8:05:20.456 PM: [23272.46184] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for '_BACKUP_SPECIAL_OBJECTS AFTER System State:' --> 1002002d

8:05:20.456 PM: [23272.46184] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'D:\' --> 10020002

8:05:21.424 PM: [23272.46184] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'Shadow Copy Components:\' --> 10020027

8:05:21.424 PM: [23272.46184] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\' --> 10020002

8:05:22.221 PM: [23272.46184] <4> VssSnapshot::V_VssSetMetadata(): INF - Unable to locate DFSR metadata

8:05:22.908 PM: [23272.46184] <4> dos_backup::V_InitializeShadowCopy: INF - ============================================

8:05:22.908 PM: [23272.46184] <4> dos_backup::V_InitializeShadowCopy: INF - ShadowCopy PrePost: Begin

8:05:23.705 PM: [23272.46184] <4> dos_backup::tfs_findfirst: WRN - unable to find first file: 'Shadow Copy Components:\System Service\Background Intelligent Transfer Service\'

8:05:23.846 PM: [23272.46184] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - Drive 'C:' added to VSS Volume Set

8:05:23.861 PM: [23272.46184] <4> SnapshotAssociation::SnapshotAssociation: INF - VSS_MAXIMUM_STORAGE_SIZE is unavailable or the wrong type, staying with the default action of limiting unbounded associations

8:05:23.861 PM: [23272.46184] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - checking association status for drive "C:\"

8:05:23.877 PM: [23272.46184] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - ingoring association which is not unbounded

8:05:23.877 PM: [23272.46184] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - enumeration finished, vemo->Next returned S_FALSE

8:05:47.078 PM: [23272.46184] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - VSS Volume Set snapped

8:05:47.078 PM: [23272.46184] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - About to commence post-snap unbounded association checks

8:05:47.078 PM: [23272.46184] <4> SnapshotAssociation::SnapshotAssociation: INF - VSS_MAXIMUM_STORAGE_SIZE is unavailable or the wrong type, staying with the default action of limiting unbounded associations

8:05:47.078 PM: [23272.46184] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - checking association status for drive "C:\"

8:05:47.094 PM: [23272.46184] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - ingoring association which is not unbounded

8:05:47.094 PM: [23272.46184] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - enumeration finished, vemo->Next returned S_FALSE

8:05:47.094 PM: [23272.46184] <4> dos_backup::V_InitializeShadowCopy: INF - ShadowCopy PrePost: End

8:05:47.094 PM: [23272.46184] <4> dos_backup::V_InitializeShadowCopy: INF - ============================================

8:05:47.094 PM: [23272.46184] <4> VssSnapshot::V_VssSetMetadata(): INF - Unable to locate DFSR metadata

8:05:52.281 PM: [23272.46184] <4> dos_backup::tfs_scanstart: INF - Backup Special Objects request AFTER System State:

8:05:52.687 PM: [23272.46184] <4> dos_backup::tfs_getinfo: INF - current object (System State:) is a parent of previous (object (System State:\COM+ Class Registration Database\COM+ REGDB)

8:05:52.890 PM: [23272.46184] <4> dos_backup::tfs_findfirst: WRN - unable to find first file: 'System State:\'

8:05:52.906 PM: [23272.46184] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - Drive 'C:' added to VSS Volume Set

8:05:52.906 PM: [23272.46184] <4> SnapshotAssociation::SnapshotAssociation: INF - VSS_MAXIMUM_STORAGE_SIZE is unavailable or the wrong type, staying with the default action of limiting unbounded associations

8:05:52.906 PM: [23272.46184] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - checking association status for drive "C:\"

8:05:52.922 PM: [23272.46184] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - ingoring association which is not unbounded

8:05:52.922 PM: [23272.46184] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - enumeration finished, vemo->Next returned S_FALSE

8:05:52.922 PM: [23272.46184] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - Drive 'c:' added to VSS Volume Set

8:05:52.922 PM: [23272.46184] <4> SnapshotAssociation::SnapshotAssociation: INF - VSS_MAXIMUM_STORAGE_SIZE is unavailable or the wrong type, staying with the default action of limiting unbounded associations

8:05:52.922 PM: [23272.46184] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - checking association status for drive "c:\"

8:05:52.937 PM: [23272.46184] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - ingoring association which is not unbounded

8:05:52.937 PM: [23272.46184] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - enumeration finished, vemo->Next returned S_FALSE

8:06:07.280 PM: [23272.46184] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - VSS Volume Set snapped

8:06:07.280 PM: [23272.46184] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - About to commence post-snap unbounded association checks

8:06:07.280 PM: [23272.46184] <4> SnapshotAssociation::SnapshotAssociation: INF - VSS_MAXIMUM_STORAGE_SIZE is unavailable or the wrong type, staying with the default action of limiting unbounded associations

8:06:07.280 PM: [23272.46184] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - checking association status for drive "C:\"

8:06:07.295 PM: [23272.46184] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - ingoring association which is not unbounded

8:06:07.295 PM: [23272.46184] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - enumeration finished, vemo->Next returned S_FALSE

8:06:07.295 PM: [23272.46184] <4> SnapshotAssociation::SnapshotAssociation: INF - VSS_MAXIMUM_STORAGE_SIZE is unavailable or the wrong type, staying with the default action of limiting unbounded associations

8:06:07.295 PM: [23272.46184] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - checking association status for drive "c:\"

8:06:07.311 PM: [23272.46184] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - ingoring association which is not unbounded

8:06:07.311 PM: [23272.46184] <4> SnapshotAssociation::AdjustUnboundedAssocations: INF - enumeration finished, vemo->Next returned S_FALSE

8:06:07.311 PM: [23272.46184] <4> backup_create: INF - NetBackup Temp Directory: 'C:\Program Files\Veritas\\NetBackup\Temp'

8:06:09.764 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (System State:) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

8:06:09.905 PM: [23272.46184] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.

8:06:16.373 PM: [23272.46184] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.

8:06:22.669 PM: [23272.46184] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.

9:00:22.181 PM: [23272.46184] <4> tar_backup_tfi::backup_send_chkp_data_state: INF - checkpoint message: CPR - 4088511 23272 0 0 3 0 0 0 4 1019575808 1 1 511 0 0 39 /System State/System Files/System Files

9:00:24.181 PM: [23272.46184] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.

9:00:24.274 PM: [23272.46184] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.

9:02:21.249 PM: [23272.46184] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.

9:02:21.312 PM: [23272.46184] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.

9:02:21.405 PM: [23272.46184] <4> dos_backup::tfs_scanstart: INF - Backup Special Objects request AFTER System State:

9:02:21.608 PM: [23272.46184] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (System State:), please wait...

9:02:21.608 PM: [23272.46184] <4> V_Snapshot::V_Snapshot_Create: INF - Adding Volume System State:\

9:02:21.608 PM: [23272.46184] <4> V_Snapshot::V_Snapshot_Create: INF - Unable to snapshot volume (Invalid source volume): System State:\

9:02:21.608 PM: [23272.46184] <2> tar_base::V_vTarMsgW: INF - Volume snapshots not enabled

9:02:21.780 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (System State:) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:02:21.796 PM: [23272.46184] <4> dos_backup::tfs_getinfo: INF - current object (System State:) is a parent of previous (object (System State:\COM+ Class Registration Database\COM+ REGDB)

9:02:21.968 PM: [23272.46184] <4> dos_backup::tfs_findfirst: WRN - unable to find first file: 'System State:\'

9:02:21.968 PM: [23272.46184] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (D:), please wait...

9:02:21.968 PM: [23272.46184] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{85c8f575-3bdb-11e0-838c-806e6f6e6963}\ for ''

9:02:21.968 PM: [23272.46184] <4> V_DetermineMountInfo: INF - Adding NTFS Volume D:\ ==> \\?\Volume{85c8f575-3bdb-11e0-838c-806e6f6e6963}\

9:02:21.968 PM: [23272.46184] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - ======================================================================

9:02:21.968 PM: [23272.46184] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Attempting to create snapshots for 'C:\'

9:02:21.968 PM: [23272.46184] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Attempting to create snapshots for 'D:\'

9:02:21.968 PM: [23272.46184] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Attempting to create snapshots for 'Shadow Copy Components:\'

9:02:21.968 PM: [23272.46184] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - CREATE request: C:\Program Files\Veritas\NetBackup\bin\bpfis create -owner NBU -fso -WOFB -fim VSS -id tus1citapppib09_1340161488 C:\ D:\ "Shadow Copy Components:\\"

9:02:48.965 PM: [23272.46184] <4> V_Snapshot::V_Snapshot_AddMappings: INF - Volume Snapshot Mapping: \\?\Volume{85c8f574-3bdb-11e0-838c-806e6f6e6963}\ --> GLOBALROOT\Device\HarddiskVolumeShadowCopy85

9:02:48.965 PM: [23272.46184] <4> V_Snapshot::V_Snapshot_AddMappings: INF - Volume Snapshot Mapping: \\?\Volume{85c8f575-3bdb-11e0-838c-806e6f6e6963}\ --> GLOBALROOT\Device\HarddiskVolumeShadowCopy86

9:02:48.965 PM: [23272.46184] <4> V_Snapshot::V_Snapshot_ParseBpfisOutput: INF - Snapshot creation, FIS_ID: tus1citapppib09_1340161488

9:02:48.965 PM: [23272.46184] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Snapshot creation was successful

9:02:48.965 PM: [23272.46184] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Snapshot provider: VSS

9:02:48.965 PM: [23272.46184] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - ======================================================================

9:02:48.965 PM: [23272.46184] <2> tar_base::V_vTarMsgW: INF - Volume snapshots enabled

9:03:15.291 PM: [23272.46184] <2> ov_log::V_GlobalLogEx: INF - file_access (constructor): 0 non-NTFS volumes

9:03:16.744 PM: [23272.46184] <2> tar_base::V_vTarMsgW: INF - Excluded: D:\RECYCLER\S-1-5-21-1052817496-3633922909-2437041043-500

9:03:16.744 PM: [23272.46184] <2> tar_base::V_vTarMsgW: INF - Excluded: D:\RECYCLER\S-1-5-21-1396743565-2690911516-1417006489-500

9:03:16.744 PM: [23272.46184] <2> tar_base::V_vTarMsgW: INF - Excluded: D:\RECYCLER\S-1-5-21-166612637-1159953233-751966703-500

9:03:16.744 PM: [23272.46184] <2> tar_base::V_vTarMsgW: INF - Excluded: D:\RECYCLER\S-1-5-21-1687975731-1706073275-25400432-500

9:03:16.744 PM: [23272.46184] <2> tar_base::V_vTarMsgW: INF - Excluded: D:\RECYCLER\S-1-5-21-1906863924-3569300043-1981045352-500

9:03:16.744 PM: [23272.46184] <2> tar_base::V_vTarMsgW: INF - Excluded: D:\RECYCLER\S-1-5-21-2825267904-2915577158-350609081-500

9:03:16.744 PM: [23272.46184] <2> tar_base::V_vTarMsgW: INF - Excluded: D:\RECYCLER\S-1-5-21-3261588635-1593527717-3210988619-500

9:03:16.744 PM: [23272.46184] <2> tar_base::V_vTarMsgW: INF - Excluded: D:\RECYCLER\S-1-5-21-3304717520-3996485996-4060154516-500

9:03:16.744 PM: [23272.46184] <2> tar_base::V_vTarMsgW: INF - Excluded: D:\RECYCLER\S-1-5-21-3323693133-2029426191-2708261882-500

9:03:16.744 PM: [23272.46184] <2> tar_base::V_vTarMsgW: INF - Excluded: D:\RECYCLER\S-1-5-21-374325071-1725856517-738641044-500

9:03:16.744 PM: [23272.46184] <2> tar_base::V_vTarMsgW: INF - Excluded: D:\RECYCLER\S-1-5-21-3823784364-3157675369-3821386300-500

9:03:16.744 PM: [23272.46184] <2> tar_base::V_vTarMsgW: INF - Excluded: D:\RECYCLER\S-1-5-21-3857612042-1518227751-1359440082-500

9:03:16.744 PM: [23272.46184] <2> tar_base::V_vTarMsgW: INF - Excluded: D:\RECYCLER\S-1-5-21-3904390539-937010269-129372964-500

9:03:16.744 PM: [23272.46184] <2> tar_base::V_vTarMsgW: INF - Excluded: D:\RECYCLER\S-1-5-21-576657940-976819772-2441304078-500

9:03:27.556 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (gen_py) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:03:27.572 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (gen_py) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:03:28.556 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (System Service) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:08:53.076 PM: [23272.46184] <4> dos_backup::tfs_findfirst: WRN - unable to find first file: 'Shadow Copy Components:\System Service\Background Intelligent Transfer Service\'

9:08:53.091 PM: [23272.46184] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (C:), please wait...

9:08:53.091 PM: [23272.46184] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{85c8f574-3bdb-11e0-838c-806e6f6e6963}\ for ''

9:08:53.091 PM: [23272.46184] <4> V_DetermineMountInfo: INF - Adding NTFS Volume C:\ ==> \\?\Volume{85c8f574-3bdb-11e0-838c-806e6f6e6963}\

9:08:53.091 PM: [23272.46184] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled

9:08:53.091 PM: [23272.46184] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled

9:08:53.404 PM: [23272.46184] <4> tar_backup_tfi::backup_send_chkp_data_state: INF - checkpoint message: CPR - 4722662 23272 0 0 40 0 0 0 8 270519296 2 5 511 0 1 3 /C/

9:09:01.638 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (APRxA005) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:02.497 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (APRxA006) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:05.700 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (ASTxA253) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:05.887 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (ASTxA254) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:06.028 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (ASTxA255) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:06.309 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (ASTxA256) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:06.543 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (ASTxA257) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:06.825 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (ASTxA258) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:06.965 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (ASTxA259) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:07.059 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (ASTxA260) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:07.575 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (ASTxC070) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:07.606 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (ASTxC071) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:09.637 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (ASTxS057) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:09.653 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (ASTxS058) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:11.512 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Busin226) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:11.543 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Busin227) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:11.684 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Busin228) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:11.824 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Busin229) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:11.934 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Busin230) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:14.215 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CFGxB299) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:14.730 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CFGxB300) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:15.496 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CFGxB301) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:16.058 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CFGxB302) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:17.558 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CFGxB303) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:18.136 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CFGxB304) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:18.886 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxA034) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:18.933 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxA035) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:19.058 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxA036) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:19.152 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxA037) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:19.245 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxA038) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:19.636 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxA084) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:19.886 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxA085) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:19.995 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxA086) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:20.074 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxA087) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:23.526 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxC447) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:23.948 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxC448) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:25.292 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxC449) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:25.354 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxC450) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:25.464 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxC451) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:25.604 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxC452) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:25.636 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxC453) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:26.557 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxC454) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:27.042 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxC455) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:27.135 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxC456) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:27.495 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxC457) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:28.526 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxC458) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:28.604 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxC459) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:28.635 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxC460) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:29.042 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxC461) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:29.417 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxC462) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:29.557 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxC463) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:30.166 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxC464) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:31.166 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxC465) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:31.260 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxC466) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:31.479 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxC467) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:31.635 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxC468) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:32.713 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxC469) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:33.041 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxC470) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:33.479 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxC471) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:33.604 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxC472) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:33.822 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxC473) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:33.916 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxC474) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:39.619 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxI426) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:39.744 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxI427) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:39.838 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxI428) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:42.744 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxI429) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:42.962 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxI430) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:43.181 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxI431) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:43.587 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxI432) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:46.978 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxI433) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:47.196 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxI434) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:51.071 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxI435) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:51.493 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxI436) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:55.071 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxI437) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:55.211 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxI438) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:55.524 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxT017) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:55.617 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxT018) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:55.727 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxT019) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:57.149 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxW220) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:57.227 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxW221) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:57.336 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxW222) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:57.680 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxW223) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:57.899 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CHGxW224) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:58.195 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxL007) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:09:59.726 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP253) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:01.836 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP330) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:02.070 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP331) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:03.070 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP332) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:04.117 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP333) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:04.179 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP334) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:04.351 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP335) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:05.773 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP336) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:05.867 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP340) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:05.898 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP341) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:06.757 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP474) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:06.851 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP475) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:06.945 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP476) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:07.132 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP477) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:07.179 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP478) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:07.210 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP479) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:07.304 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP480) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:07.429 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP481) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:08.663 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP482) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:08.773 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP483) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:08.913 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP484) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:09.741 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP485) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:09.819 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP486) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:10.882 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP487) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:10.944 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP488) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:11.241 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP489) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:11.960 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP490) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:12.022 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP491) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:12.085 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP492) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:12.116 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP493) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:12.288 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP494) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:12.397 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP495) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:12.600 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxP496) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:13.960 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxS234) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:14.319 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxS235) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:14.569 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxS236) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:14.710 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxS237) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:14.788 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxS238) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:15.069 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxS239) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:15.256 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxS240) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:15.631 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxS241) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:16.100 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxS242) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:16.131 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (CTMxS243) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:17.131 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (FINxC189) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:17.163 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (FINxC190) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:17.178 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (FINxC191) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:17.209 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (FINxC192) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:17.256 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (FINxC193) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:17.272 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (FINxC194) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:17.319 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (FINxC195) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:17.334 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (FINxC196) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:17.381 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (FINxC197) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:17.413 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (FINxC198) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:17.428 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (FINxC199) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:17.459 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (FINxC200) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:17.491 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (FINxC201) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:17.538 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (FINxC202) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:18.194 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxA128) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:18.366 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxA129) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:18.897 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxA130) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:19.334 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxA131) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:19.615 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxA132) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:20.428 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxA133) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:20.600 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxA134) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:20.725 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxA135) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:20.834 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxA136) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:53.285 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxH307) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:57.815 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxH308) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:10:58.081 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxH309) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:01.378 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxH310) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:03.971 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxH311) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:04.112 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxH312) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:04.502 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxH313) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:08.533 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxH314) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:12.080 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxH315) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:15.830 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxH316) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:19.767 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxH317) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:23.626 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxH318) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:23.657 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxH319) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:23.688 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxH320) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:28.703 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxI236) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:29.032 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxI237) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:30.500 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxI238) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:31.516 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxI239) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:32.172 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxI240) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:33.812 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxI241) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:35.156 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxI242) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:35.672 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxI243) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:36.297 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxI244) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:36.750 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxI245) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:37.156 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxI246) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:38.203 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxT160) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:38.312 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxT161) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:38.593 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxT162) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:38.781 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxT163) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:38.999 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxT164) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:39.031 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxT165) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:39.390 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxT166) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:40.546 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxW197) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:41.171 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxW198) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:41.796 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxW199) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:42.265 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxW200) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:42.749 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxW201) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:42.874 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxW202) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:42.984 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxW203) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:43.249 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxW204) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:43.515 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (HPDxW205) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:45.093 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Homex306) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:45.140 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Homex307) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:45.202 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Homex308) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:45.452 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Homex309) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:45.483 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Homex310) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:45.530 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Homex311) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:45.561 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Homex312) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:45.671 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Homex313) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:45.765 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (NTExC005) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:46.108 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (NTExC006) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:46.264 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (NTExC007) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:46.733 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (NTExN051) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:46.968 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (NTExN052) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:47.655 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (PBMxI109) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:47.717 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (PBMxI110) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:48.624 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (PBMxP084) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:49.936 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (PBMxP085) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:51.264 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (PBMxS003) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:52.592 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (PCTxP081) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:52.701 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (PCTxP082) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:52.951 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (PCTxP083) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:53.061 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (PCTxP084) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:53.186 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (PCTxP085) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:53.373 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (PDLxPDxC) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:53.655 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (RRCxR005) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:53.983 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (RRCxR006) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:54.529 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SHRxA053) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:54.951 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SHRxA054) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:55.279 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SHRxO028) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:55.826 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SITxS007) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:55.951 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SITxS008) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:57.639 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SLMxE280) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:57.670 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SLMxE281) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:57.701 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SLMxE282) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:57.748 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SLMxE283) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:57.779 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SLMxE284) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:57.810 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SLMxE285) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:57.826 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SLMxE286) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:57.904 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SLMxE287) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:59.795 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SLMxM281) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:11:59.904 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SLMxM282) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:00.029 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SLMxM283) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:00.279 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SLMxM284) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:00.654 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SLMxM285) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:01.060 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SLMxM286) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:01.748 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SLMxM287) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:01.998 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SLMxM288) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:02.685 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRDxM113) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:02.716 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRDxM114) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:02.732 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRDxM115) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:02.763 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRDxM116) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:02.779 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRDxM117) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:02.810 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRDxM118) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:02.810 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRDxM119) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:03.122 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRDxS051) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:03.904 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRDxS052) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:04.497 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRDxS053) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:04.935 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRDxS054) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:05.825 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRDxS055) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:06.622 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRDxS056) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:07.856 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRMxR072) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:08.528 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRMxR073) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:09.372 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRMxR074) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:10.169 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRMxR075) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:10.981 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRMxR076) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:11.591 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRMxR077) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:12.294 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRMxR078) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:13.950 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRMxW101) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:14.372 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRMxW102) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:14.590 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRMxW103) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:14.856 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRMxW104) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:15.043 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRMxW105) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:15.153 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRMxW106) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:15.434 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRMxW107) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:15.715 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRSxA007) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:17.699 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRSxR111) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:18.121 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRSxR112) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:18.637 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRSxR113) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:19.262 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRSxR114) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:19.887 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRSxR115) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:21.121 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRSxR116) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:21.637 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRSxR117) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:22.902 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRSxS121) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:23.386 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRSxS122) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:27.120 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRSxS123) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:27.292 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRSxS124) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:31.105 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRSxS125) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:36.057 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRSxS126) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:36.323 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRSxS127) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:41.416 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRSxS128) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:41.916 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRSxS129) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:42.432 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SRSxS130) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:47.009 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SYSxA002) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:47.572 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SYSxM072) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:47.650 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SYSxM073) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:47.744 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SYSxM074) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:47.837 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SYSxM075) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:47.994 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (SYSxM076) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:48.884 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (TMSxA158) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:48.947 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (TMSxA159) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:48.962 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (TMSxA160) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:49.009 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (TMSxA161) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:49.041 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (TMSxA162) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:49.087 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (TMSxA163) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:49.119 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (TMSxA164) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:49.166 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (TMSxA165) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:49.197 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (TMSxA166) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:49.228 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (TMSxA167) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:49.259 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (TMSxA168) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:49.306 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (TMSxA169) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:49.353 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (TMSxA170) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:49.384 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (TMSxA171) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:49.415 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (TMSxA172) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:49.478 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (TMSxR002) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:51.525 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (TMSxT279) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:52.275 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (TMSxT280) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:53.587 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (TMSxT281) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:54.478 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (TMSxT282) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:56.071 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (TMSxT283) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:57.055 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (TMSxT284) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:12:58.383 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (TMSxT285) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:13:00.493 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (TMSxW056) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:13:00.571 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (TMSxW057) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:13:00.758 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (VISxH007) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:13:20.335 PM: [23272.46184] <4> dos_backup::tfs_startdir: INF - Stopping scan for Directory Junction: C:\Documents and Settings\All Users\Application Data\Symantec\Symantec Endpoint Protection\CurrentVersion

9:13:20.835 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Alpesh_Lad) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:14:06.378 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Brian_Allen) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:14:11.534 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\Brian_Allen\NTUSER.DAT.LOG

9:14:34.875 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\Brian_Allen\Local Settings\Application Data\Microsoft\Windows\UsrClass.dat.LOG

9:15:05.779 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Chris_Truka) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:15:07.013 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\Chris_Truka\NTUSER.DAT.LOG

9:15:14.857 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\Chris_Truka\Local Settings\Application Data\Microsoft\Windows\UsrClass.dat.LOG

9:15:36.511 PM: [23272.46184] <4> dos_backup::_tfs_handle_search_state: INF - Skipping file: C:\Documents and Settings\Ctx_StreamingSvc\NTUSER.DAT.LOG

9:15:36.558 PM: [23272.46184] <4> dos_backup::_tfs_handle_search_state: INF - Skipping file: C:\Documents and Settings\Ctx_StreamingSvc\Local Settings\Application Data\Microsoft\Windows\UsrClass.dat.LOG

9:15:36.745 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Fairuuz_Azmi) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:15:40.370 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\Fairuuz_Azmi\NTUSER.DAT.LOG

9:18:20.013 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\Fairuuz_Azmi\Local Settings\Application Data\Microsoft\Windows\UsrClass.dat.LOG

9:20:14.832 PM: [23272.46184] <4> tar_backup_tfi::backup_send_chkp_data_state: INF - checkpoint message: CPR - 5603115 23272 0 0 5975 0 0 0 8 721311232 2 5 511 0 1 89 /C/Documents and Settings/Fairuuz_Azmi/Oracle Jar Cache/fndforms.jar-166e384-1d12ba8b.zip

9:23:33.081 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (John_Spiegel) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:24:11.328 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\John_Spiegel\NTUSER.DAT.LOG

9:35:19.647 PM: [23272.46184] <4> tar_backup_tfi::backup_send_chkp_data_state: INF - checkpoint message: CPR - 7210721 23272 0 0 8447 0 0 0 8 470663680 3 5 511 0 1 83 /C/Documents and Settings/John_Spiegel/Application Data/Microsoft/Word/~WRL0124.tmp

9:47:14.087 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\John_Spiegel\Local Settings\Application Data\Microsoft\Windows\UsrClass.dat.LOG

9:51:41.034 PM: [23272.46184] <4> tar_backup_tfi::backup_send_chkp_data_state: INF - checkpoint message: CPR - 8852053 23272 0 0 11518 0 0 0 8 237283840 4 5 511 0 1 63 /C/Documents and Settings/John_Spiegel/My Documents/archive.pst

9:54:46.440 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Juls_May) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

9:54:50.346 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\Juls_May\NTUSER.DAT.LOG

9:55:46.639 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\Juls_May\Local Settings\Application Data\Microsoft\Windows\UsrClass.dat.LOG

10:00:04.945 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Keith_Peterson) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:00:08.523 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\Keith_Peterson\NTUSER.DAT.LOG

10:03:23.585 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\Keith_Peterson\Local Settings\Application Data\Microsoft\Windows\UsrClass.dat.LOG

10:06:09.462 PM: [23272.46184] <4> tar_backup_tfi::backup_send_chkp_data_state: INF - checkpoint message: CPR - 10311469 23272 0 0 15352 0 0 0 8 984504832 4 5 511 0 1 135 /C/Documents and Settings/Keith_Peterson/My Documents/Old Enterprise Citrix My Docs/My Documents/Microsoft_Office_Communicator_2007.exe

10:09:04.197 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Kenneth_Wong.SYMC.000) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:21:52.930 PM: [23272.46184] <4> tar_backup_tfi::backup_send_chkp_data_state: INF - checkpoint message: CPR - 11825051 23272 0 0 16765 0 0 0 8 685716992 5 5 511 0 1 83 /C/Documents and Settings/Kenneth_Wong.SYMC.000/My Documents/captures/tuswae01.pcap

10:22:24.615 PM: [23272.46184] <4> dos_backup::_tfs_handle_search_state: INF - Skipping file: C:\Documents and Settings\LocalService\ntuser.dat.LOG

10:22:24.709 PM: [23272.46184] <4> dos_backup::_tfs_handle_search_state: INF - Skipping file: C:\Documents and Settings\LocalService\Local Settings\Application Data\Microsoft\Windows\UsrClass.dat.LOG

10:22:25.427 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (MataEErum_Soleman.SYMC) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:24:18.668 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (MingChun_Chan.SYMC) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:24:19.652 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\MingChun_Chan.SYMC\NTUSER.DAT.LOG

10:24:23.480 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\MingChun_Chan.SYMC\Local Settings\Application Data\Microsoft\Windows\UsrClass.dat.LOG

10:26:31.798 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (MohamadShafie_Abu_Ha.SYMC) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:26:59.889 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Nagashri_C) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:26:59.905 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Nagashri_C) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:28:54.786 PM: [23272.46184] <4> dos_backup::_tfs_handle_search_state: INF - Skipping file: C:\Documents and Settings\NetworkService\ntuser.dat.LOG

10:28:54.864 PM: [23272.46184] <4> dos_backup::_tfs_handle_search_state: INF - Skipping file: C:\Documents and Settings\NetworkService\Local Settings\Application Data\Microsoft\Windows\UsrClass.dat.LOG

10:28:55.629 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (PratapSN_Simha) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:30:49.339 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Pravisha_Prabhakaran.SYMC) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:30:55.213 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Rakshith_hc) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:33:10.467 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (6ed48902-15d21041-n) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:33:10.671 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (28cb5c9e-6dfa091a-n) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:33:10.796 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (splash) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:33:11.014 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Custom Settings) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:33:11.202 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (RE CRQ000000686232 - FCR Phase 3 - Required Business Owner Approval_files) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:33:11.233 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (RE CRQ000000686232 - FCR Phase 3 - Required Business Owner Approval_kelly_george_files) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:33:17.920 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Revathy_Jeevanandham.SYMC.000) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:33:19.982 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\Revathy_Jeevanandham.SYMC.000\NTUSER.DAT.LOG

10:33:26.669 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\Revathy_Jeevanandham.SYMC.000\Local Settings\Application Data\Microsoft\Windows\UsrClass.dat.LOG

10:34:22.321 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Custom Settings) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:34:22.493 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (ONetConfig) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:34:22.680 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\Rodolfo_Abadia\Local Settings\Application Data\Microsoft\Windows\UsrClass.dat.LOG

10:34:22.696 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (MSHist012012060420120611) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:34:22.727 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (MSHist012012061120120618) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:34:22.758 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (MSHist012012061820120619) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:34:25.211 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Content.Outlook) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:34:26.071 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Susan_Goh) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:34:30.023 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\Susan_Goh\NTUSER.DAT.LOG

10:34:38.944 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\Susan_Goh\Local Settings\Application Data\Microsoft\Windows\UsrClass.dat.LOG

10:35:10.879 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Venkatesh_R.SYMC) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:35:12.129 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\Venkatesh_R.SYMC\NTUSER.DAT.LOG

10:35:14.660 PM: [23272.46184] <4> tar_backup_tfi::backup_send_chkp_data_state: INF - checkpoint message: CPR - 13130145 23272 0 0 25437 0 0 0 8 280183296 6 5 511 0 1 127 /C/Documents and Settings/Venkatesh_R.SYMC/Application Data/Microsoft/CryptnetUrlCache/Content/96D7A99548C36B10D2E8035A3E0DCA1A

10:35:20.082 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\Venkatesh_R.SYMC\Local Settings\Application Data\Microsoft\Windows\UsrClass.dat.LOG

10:35:36.518 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (alicia_etchamendi) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:35:40.439 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\alicia_etchamendi\NTUSER.DAT.LOG

10:35:59.735 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\alicia_etchamendi\Local Settings\Application Data\Microsoft\Windows\UsrClass.dat.LOG

10:37:08.245 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (anuja_wagh.SYMC) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:37:16.181 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\anuja_wagh.SYMC\NTUSER.DAT.LOG

10:43:20.698 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\anuja_wagh.SYMC\Local Settings\Application Data\Microsoft\Windows\UsrClass.dat.LOG

10:44:51.815 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (archana_gnanasekaran) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:47:38.708 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Credentials) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:47:39.130 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (Custom Settings) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:47:39.801 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (MSHist012012061120120618) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:47:39.864 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (MSHist012012061820120619) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:47:39.880 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (MSHist012012061920120620) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:48:01.221 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (WLT50IMZ) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:49:11.997 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (bob_rolofson) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:49:14.965 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\bob_rolofson\NTUSER.DAT.LOG

10:50:06.117 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\bob_rolofson\Local Settings\Application Data\Microsoft\Windows\UsrClass.dat.LOG

10:51:54.061 PM: [23272.46184] <4> tar_backup_tfi::backup_send_chkp_data_state: INF - checkpoint message: CPR - 14831775 23272 0 0 34374 0 0 0 8 77676032 7 5 511 0 1 67 /C/Documents and Settings/bob_rolofson/My Documents/archive_new.pst

10:52:01.451 PM: [23272.46184] <4> dos_backup::tfs_include: INF - folder (carmen_gonzalez.SYMC) has been created recently (since 6/15/2012 12:46:07 AM). It will be backed up in full.

10:53:12.555 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\carmen_gonzalez.SYMC\NTUSER.DAT.LOG

11:05:15.464 PM: [23272.46184] <4> tar_backup_tfi::backup_send_chkp_data_state: INF - checkpoint message: CPR - 16069928 23272 0 0 38323 0 0 0 8 711610368 7 5 511 0 1 114 /C/Documents and Settings/carmen_gonzalez.SYMC/Application Data/Sun/Java/Deployment/cache/6.0/46/778eb96e-108e7229

11:21:46.709 PM: [23272.46184] <4> tar_backup_tfi::backup_send_chkp_data_state: INF - checkpoint message: CPR - 17666803 23272 0 0 40048 0 0 0 8 455468544 8 5 511 0 1 89 /C/Documents and Settings/carmen_gonzalez.SYMC/LOGS/BI_ATLANTIS_KRT_CHECK_REPLICA log.txt

11:23:40.137 PM: [23272.46184] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\carmen_gonzalez.SYMC\Local Settings\Application Data\Microsoft\Windows\UsrClass.dat.LOG

12:04:23.715 AM: [23272.46184] <4> tar_backup_tfi::backup_send_chkp_data_state: INF - checkpoint message: CPR - 22118124 23272 0 0 40672 0 0 0 8 587061248 10 5 511 0 1 72 /C/Documents and Settings/carmen_gonzalez.SYMC/My Documents/archive2.pst

12:08:01.588 AM: [23272.46184] <2> tar_base::V_vTarMsgW: ERR - failure reading file: C:\Documents and Settings\carmen_gonzalez.SYMC\My Documents\archive3.pst (WIN32 21: The device is not ready. )

12:08:01.588 AM: [23272.46184] <4> dos_backup::tfs_readdata: INF - will skip file when clearing archive bits: 'C:\Documents and Settings\carmen_gonzalez.SYMC\My Documents\archive3.pst'

12:08:01.588 AM: [23272.46184] <4> V_VSS_CheckForError: INF - Error Checking for GLOBALROOT\Device\HarddiskVolumeShadowCopy85

12:08:01.588 AM: [23272.46184] <4> V_VSS_CheckForError: INF - Error Status (GLOBALROOT\Device\HarddiskVolumeShadowCopy85): 2

12:08:01.588 AM: [23272.46184] <2> tar_base::V_vTarMsgW: ERR - Snapshot Error while reading file: GLOBALROOT\Device\HarddiskVolumeShadowCopy85\Documents and Settings\carmen_gonzalez.SYMC\My Documents\archive3.pst

12:08:01.588 AM: [23272.46184] <4> dos_backup::tfs_readdata: INF - will skip file when clearing archive bits: 'C:\Documents and Settings\carmen_gonzalez.SYMC\My Documents\archive3.pst'

12:08:02.056 AM: [23272.46184] <4> tar_backup_tfi::backup_send_chkp_data_state: INF - checkpoint message: CPR - 22507506 23272 0 0 40672 1 0 0 8 786424832 10 5 511 0 1 72 /C/Documents and Settings/carmen_gonzalez.SYMC/My Documents/archive3.pst

12:08:09.056 AM: [23272.46184] <2> tar_base::V_vTarMsgW: FTL - Backup operation aborted!

12:08:09.056 AM: [23272.46184] <4> tar_backup::backup_done_state: INF - number of file directives not found: 0

12:08:09.056 AM: [23272.46184] <4> tar_backup::backup_done_state: INF - number of file directives found: 8

12:08:09.056 AM: [23272.53136] <4> tar_base::keepaliveThread: INF - keepalive thread terminating (reason: WAIT_OBJECT_0)

12:08:09.056 AM: [23272.46184] <4> tar_base::stopKeepaliveThread: INF - keepalive thread has exited. (reason: WAIT_OBJECT_0)

12:08:09.056 AM: [23272.46184] <2> tar_base::V_vTarMsgW: INF - EXIT STATUS 156: snapshot error encountered

12:08:09.056 AM: [23272.46184] <4> tar_backup::backup_done_state: INF - Not waiting for server status

12:08:10.056 AM: [23272.46184] <4> dos_backup::tfs_reset: INF - Snapshot deletion start

12:08:10.056 AM: [23272.46184] <4> V_Snapshot::V_Snapshot_Destroy: INF - Attempting to destroy volume snapshots: bpfis delete -id tus1citapppib09_1340161488

12:08:20.055 AM: [23272.46184] <4> V_Snapshot::V_Snapshot_Destroy: INF - Snapshot destruction was successful

12:08:20.102 AM: [23272.46184] <4> ov_log::OVLoop: INF - Cycling log file

12:08:20.102 AM: [23272.46184] <4> ov_log::OVClose: INF - Closing log file: C:\Program Files\Veritas\NetBackup\logs\BPBKAR\061912.LOG

.

Marianne · ‎06-21-2012

Have a look at the following error in bpfis log:

11:15:38.158 AM: [30564.32000] <2> tar_base::V_vTarMsgW: ERR - Snapshot Error while reading file: GLOBALROOT\Device\HarddiskVolumeShadowCopy82\ADMIN\Software\Informatica 9.1\910HF2_Client_Installer_win32-x86.zip

You need to find this zip file and the reason for its existence as this seems to be the reason for snapshot failure.

**** EDIT ****

PLEASE post log files as attachments. Rename them to reflect process name (e.g. bpfis.txt) and use 'File attachments' link at the bottom of the screen.

Handy NetBackup Links

View solution in original post

Marianne · ‎06-21-2012

Have a look at the following error in bpfis log:

11:15:38.158 AM: [30564.32000] <2> tar_base::V_vTarMsgW: ERR - Snapshot Error while reading file: GLOBALROOT\Device\HarddiskVolumeShadowCopy82\ADMIN\Software\Informatica 9.1\910HF2_Client_Installer_win32-x86.zip

You need to find this zip file and the reason for its existence as this seems to be the reason for snapshot failure.

**** EDIT ****

PLEASE post log files as attachments. Rename them to reflect process name (e.g. bpfis.txt) and use 'File attachments' link at the bottom of the screen.

Handy NetBackup Links

VOX

Snapshot error(not in cluster)