14:01:25.304: [6244.7276] <4> ov_log::OVInit: INF - Starting log file: C:\Program Files\VERITAS\NetBackup\logs\BPBKAR\082115.LOG

14:01:25.304: [6244.7276] <4> ov_log::OVInit: GENERAL Log Level: 0
14:01:25.304: [6244.7276] <4> ov_log::OVInit: TCP Log Level: 0
14:01:25.304: [6244.7276] <4> ov_log::OVInit: INF - the log mutex: 444
BPBKAR  NetBackup Backup/Archive  7.1GA  [Mar 17 2012]
Copyright © 1993 - 2012 Symantec Corporation, All Rights Reserved.
All Rights Reserved.

14:01:25.304: [6244.7276] <2> WinMain: DAT - _pgmptr = 'C:\Program Files\VERITAS\NetBackup\bin\bpbkar32.exe'
14:01:25.304: [6244.7276] <2> WinMain: DAT - lpCmdLine = '-r 3888000 -ru root -dt 0 -to 0 -clnt server X -class Policy_name -sched Full -st FULL -bpstart_to 300 -bpend_to 300 -read_to 1800 -ost_shmcd -resume_nbr 20 -ckpt_time 300 -blks_per_buffer 512 -use_otm -fso -b server X_1440140581 -kl 12 -WOFB_enabled -WOFB_fim 0 -WOFB_usage 0 -WOFB_error 0 -ct 13 -use_ofb '
14:01:25.304: [6244.7276] <2> date_debug: DAT - timezone: GMT Standard Time, offset=0, dst: GMT Daylight Time
14:01:25.304: [6244.7276] <2> date_debug: DAT - current time: 1440162085, 21/08/2015 14:01:25
14:01:25.304: [6244.7276] <2> date_debug: DAT - 01/01/94 UCT:  757382400, 01/01/1994 01:00:00
14:01:25.304: [6244.7276] <2> date_debug: DAT - 07/01/94 UCT:  773020800, 01/07/1994 01:00:00
14:01:25.304: [6244.7276] <2> WinMain: DAT - standard input handle = 412
14:01:25.304: [6244.7276] <2> WinMain: DAT - standard output handle = 256
14:01:25.304: [6244.7276] <2> WinMain: DAT - standard error handle = 376
14:01:25.320: [6244.7276] <4> tar_backup::V_SetupJobData: INF - dwJobData: ffffffff
14:01:25.320: [6244.7276] <4> tar_backup::V_SetupJobData: INF -     dwJob: ffffffff
14:01:25.367: [6244.7276] <4> dos_backup::V_PreProcessing: INF - backup privileges enabled, previous = 0
14:01:25.367: [6244.7276] <4> dos_backup::V_PreProcessing: INF - restore privileges enabled, previous = 0
14:01:25.367: [6244.7276] <4> dos_backup::V_PreProcessing: INF - security privileges enabled, previous = 0
14:01:25.367: [6244.7276] <4> dos_backup::V_PreProcessing: INF - tcb privileges enabled, previous = 0
14:01:25.382: [6244.7276] <4> dos_backup::V_PreProcessing: INF - create token privileges enabled, previous = 0
14:01:25.382: [6244.7276] <4> dos_backup::V_PreProcessing: INF - user name: root
14:01:25.382: [6244.7276] <4> dos_backup::V_PreProcessing: INF - no access token: scheduled backup
14:01:25.382: [6244.7276] <2> ov_log::V_GlobalLog: WRN - ubsDetermineExchangeVersion(): RegOpenKeyEx() failed for HKLM\SOFTWARE\MICROSOFT\ExchangeServer\v14\Setup - 0x2.
14:01:25.382: [6244.7276] <2> ov_log::V_GlobalLog: INF - BEDS_Init() Enter InitFlags:0x0
14:01:25.429: [6244.7276] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: C:
14:01:25.429: [6244.7276] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: D:
14:01:25.429: [6244.7276] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: G:
14:01:25.429: [6244.7276] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: I:
14:01:25.429: [6244.7276] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: J:
14:01:25.429: [6244.7276] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: L:
14:01:25.429: [6244.7276] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: P:
14:01:25.429: [6244.7276] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: W:
14:01:25.429: [6244.7276] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Microsoft Terminal Services
14:01:25.429: [6244.7276] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Microsoft Windows Network
14:01:25.429: [6244.7276] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Shadow?Copy?Components
14:01:25.429: [6244.7276] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: System?State
14:01:25.429: [6244.7276] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Active Directory Application Mode
14:01:25.429: [6244.7276] <2> tar_base::V_vTarMsgW: INF - BACKUP START 6244
14:01:25.726: [6244.7276] <2> tar_backup::V_SetupProcessContinue: TAR - CONTINUE BACKUP received
14:01:25.726: [6244.7276] <2> tar_base::V_vTarMsgW: INF - CONTINUE BACKUP message received
14:01:25.726: [6244.7276] <4> tar_backup_cpr::start: INF - checkpoint thread started
14:01:25.945: [6244.7276] <2> tar_backup_cpr::parse: INF - checkpoint restart message - 9959424 964 0 0 32950 0 0 0 8 804257792 4 5 512 0 1 44 /J/Data02/Shared/IT/WP51/PRINTERS/ACLP76.PRS

14:01:25.945: [6244.7276] <2> tar_backup_tfi::setupFileDirectives: TAR - backup filename = ALL_LOCAL_DRIVES
14:01:25.945: [6244.8092] <4> tar_base::keepaliveThread: INF - keepalive thread is active with an interval of 60 seconds
14:01:27.117: [6244.7276] <4> V_Snapshot::V_Snapshot_Query: INF - Attempting to query volume snapshots: bpfis query -id server X_1440140581
14:01:58.117: [6244.7276] <4> V_Snapshot::V_Snapshot_AddMappings: INF - V_Snapshot_AddMappings input parameters: 
 source path = "J:\"
 snap path = "\\?\GLOBALROOT\Device\HarddiskVolumeShadowCopy1221\"
 mount path = "(null)"
14:01:58.117: [6244.7276] <4> V_Snapshot::V_GetSourceVolume: INF - source = "J:\"
 snapshot = "\\?\GLOBALROOT\Device\HarddiskVolumeShadowCopy1221\"
14:01:58.117: [6244.7276] <4> V_Snapshot::V_Snapshot_AddMappings: INF - Volume Snapshot Mapping: \\?\Volume{009d848f-2338-11e2-96ad-806e6f6e6963}\ --> GLOBALROOT\Device\HarddiskVolumeShadowCopy1221
14:01:58.117: [6244.7276] <4> V_Snapshot::V_Snapshot_ParseBpfisOutput: INF - Snapshot creation, FIS_ID: server X_1440140581
14:01:58.117: [6244.7276] <4> V_Snapshot::V_Snapshot_Query: INF - Snapshot query was successful
14:01:58.117: [6244.7276] <4> V_Snapshot::V_Snapshot_Query: INF - Snapshot provider: VSP
14:01:58.117: [6244.7276] <2> tar_backup_vxbsa::add: INF - called with '/'
14:01:58.117: [6244.7276] <4> dos_backup::V_VerifyFileSystem: INF - Added: C:\
14:01:58.117: [6244.7276] <4> dos_backup::V_VerifyFileSystem: INF - Added: D:\
14:01:58.117: [6244.7276] <4> dos_backup::V_VerifyFileSystem: INF - Added: G:\
14:01:58.117: [6244.7276] <4> dos_backup::V_VerifyFileSystem: INF - Added: I:\
14:01:58.117: [6244.7276] <4> dos_backup::V_VerifyFileSystem: INF - Added: J:\
14:01:58.117: [6244.7276] <4> dos_backup::V_VerifyFileSystem: INF - Added: L:\
14:01:58.117: [6244.7276] <4> dos_backup::V_VerifyFileSystem: INF - Added: P:\
14:01:58.117: [6244.7276] <4> dos_backup::V_VerifyFileSystem: INF - Added: W:\
14:01:58.117: [6244.7276] <4> dos_backup::V_VerifyFileSystem: INF - Added: Shadow Copy Components:\
14:01:58.117: [6244.7276] <4> dos_backup::V_VerifyFileSystem: INF - Added: System State:\
14:01:58.117: [6244.7276] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\' --> 10020002
14:01:58.117: [6244.7276] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'D:\' --> 10020002
14:01:58.117: [6244.7276] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'G:\' --> 10020002
14:01:58.117: [6244.7276] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'I:\' --> 10020002
14:01:58.117: [6244.7276] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'J:\' --> 10020002
14:01:58.117: [6244.7276] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'L:\' --> 10020002
14:01:58.117: [6244.7276] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'P:\' --> 10020002
14:01:58.117: [6244.7276] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'W:\' --> 10020002
14:02:05.195: [6244.7276] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'Shadow Copy Components:\' --> 10020027
14:02:11.617: [6244.7276] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'System State:\' --> 1002002d
14:02:11.617: [6244.7276] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for '_BACKUP_SPECIAL_OBJECTS AFTER System State:' --> 1002002d
14:02:18.054: [6244.7276] <4> VssSnapshot::V_VssSetMetadata(): INF - Unable to locate DFSR metadata
14:02:18.804: [6244.7276] <4> dos_backup::V_InitializeShadowCopy: INF - ============================================
14:02:18.804: [6244.7276] <4> dos_backup::V_InitializeShadowCopy: INF - ShadowCopy PrePost: Begin
14:02:36.257: [6244.7276] <4> dos_backup::tfs_findfirst: INF - unable to find first file: 'Shadow Copy Components:\System Service\Background Intelligent Transfer Service\'
14:02:36.257: [6244.7276] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - Drive 'C:' added to VSS Volume Set
14:02:36.257: [6244.7276] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - Drive 'G:' added to VSS Volume Set
14:02:41.132: [6244.7276] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - VSS Volume Set snapped
14:02:41.132: [6244.7276] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - About to commence post-snap unbounded association checks
14:02:41.132: [6244.7276] <4> dos_backup::V_InitializeShadowCopy: INF - ShadowCopy PrePost: End
14:02:41.132: [6244.7276] <4> dos_backup::V_InitializeShadowCopy: INF - ============================================
14:02:41.132: [6244.7276] <4> VssSnapshot::V_VssSetMetadata(): INF - Unable to locate DFSR metadata
14:03:09.992: [6244.7276] <4> dos_backup::tfs_scanstart: INF - Backup Special Objects request AFTER System State:
14:03:21.554: [6244.7276] <4> dos_backup::tfs_getinfo: INF - current object (System State:) is a parent of previous (object (System State:\Internet Information Services\IISMETABASE)
14:03:27.257: [6244.7276] <4> dos_backup::tfs_findfirst: INF - unable to find first file: 'System State:\'
14:03:27.257: [6244.7276] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - Drive 'C:' added to VSS Volume Set
14:03:27.257: [6244.7276] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - Drive 'W:' added to VSS Volume Set
14:03:27.273: [6244.7276] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - Drive 'c:' added to VSS Volume Set
14:03:31.976: [6244.7276] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - VSS Volume Set snapped
14:03:31.976: [6244.7276] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - About to commence post-snap unbounded association checks
14:03:31.992: [6244.7276] <2> tar_tfi::createTransport: backup_id: server X_1440140581, resume_nbr: 20
14:03:31.992: [6244.7276] <2> tar_tfi::createTransport: resume_backup_id: server X_1440140581_R20
14:03:32.992: [6244.7276] <4> backup_create: INF - NetBackup Temp Directory: 'C:\Program Files\VERITAS\\NetBackup\Temp'
14:03:32.992: [6244.7276] <16> tar_backup::SetExcludeFileList: **** DBG **** - alternate client fileter file is null
14:03:32.992: [6244.7276] <4> tar_backup_tfi::UpdateExcludeListWithVHD: INF - UpdateExludeListWithVHD begin
14:03:37.039: [6244.7276] <2> tar_base::V_vTarMsgW: INF - Enabling volume snapshots for (J:), please wait...
14:03:37.039: [6244.7276] <4> V_DetermineMountInfo: INF - Checking Volume \\?\Volume{009d848f-2338-11e2-96ad-806e6f6e6963}\ for ''
14:03:37.039: [6244.7276] <4> V_DetermineMountInfo: INF -   Adding NTFS Volume J:\ ==> \\?\Volume{009d848f-2338-11e2-96ad-806e6f6e6963}\
14:03:37.039: [6244.7276] <4> V_Snapshot::V_Snapshot_CreateSnapshot: INF - Volume snapshots already enabled
14:03:37.039: [6244.7276] <2> tar_base::V_vTarMsgW: INF - Volume snapshots already enabled
14:03:38.195: [6244.7276] <2> ov_log::V_GlobalLogEx: INF - file_access (constructor): 0 non-NTFS volumes
14:03:38.664: [6244.7276] <2> tar_backup_cpr::position: INF - checkpoint restart position - /J/Data02/Shared/IT/WP51/PRINTERS/AEOLCORO.PRS
14:06:26.101: [6244.7276] <4> tar_backup_tfi::backup_send_chkp_data_state: INF - checkpoint message: CPR - 10818560 964 0 0 34983 0 0 0 8 170393600 5 5 512 0 1 50 /J/Data02/Shared/Work/New folder (3)/Cuba trio.JPG
14:37:57.132: [6244.7276] <4> tar_backup_tfi::backup_send_chkp_data_state: INF - checkpoint message: CPR - 10825216 964 0 0 34984 0 0 0 8 173801472 5 5 512 0 1 49 /J/Data02/Shared/Work/New folder (3)/DSC01629.JPG
14:37:59.179: [6244.7276] <4> tar_backup::backup_done_state: INF - number of file directives not found: 0
14:37:59.179: [6244.7276] <4> tar_backup::backup_done_state: INF -     number of file directives found: 8
14:37:59.226: [6244.8092] <4> tar_base::keepaliveThread: INF - keepalive thread terminating (reason: WAIT_OBJECT_0)
14:37:59.226: [6244.7276] <4> tar_base::stopKeepaliveThread: INF - keepalive thread has exited. (reason: WAIT_OBJECT_0)
14:37:59.226: [6244.7276] <4> send_msg_to_monitor: INF - in send_msg_to_monitor()...
14:37:59.226: [6244.7276] <2> tar_base::V_vTarMsgW: INF - EXIT STATUS 40: network connection broken
14:37:59.226: [6244.7276] <4> tar_backup::backup_done_state: INF - Not waiting for server status
14:38:00.835: [6244.7276] <4> OVStopCmd: INF - EXIT - status = 0
14:38:00.835: [6244.7276] <2> tar_base::V_Close: closing...
14:38:00.835: [6244.7276] <4> dos_backup::tfs_reset: INF - Snapshot deletion start
14:38:00.835: [6244.7276] <4> V_Snapshot::V_Snapshot_Destroy: INF - No snapshot ID, snapshot destruction failed
14:38:02.070: [6244.7276] <2> ov_log::V_GlobalLog: INF - BEDS_Term(): enter - InitFlags:0x00000001
14:38:05.085: [6244.7276] <4> OVShutdown: INF - Finished process
14:38:05.085: [6244.7276] <4> WinMain: INF - Exiting C:\Program Files\VERITAS\NetBackup\bin\bpbkar32.exe
14:38:07.085: [6244.7276] <4> ov_log::OVClose: INF - Closing log file: C:\Program Files\VERITAS\NetBackup\logs\BPBKAR\082115.LOG