1:58:44.845 PM: [9204.6800] <4> ov_log::OVInit: INF - Starting log file: C:\Program Files\Veritas\NetBackup\logs\BPBKAR\052511.LOG 1:58:44.845 PM: [9204.6800] <4> ov_log::OVInit: GENERAL Log Level: 0 1:58:44.845 PM: [9204.6800] <4> ov_log::OVInit: TCP Log Level: 0 1:58:44.845 PM: [9204.6800] <4> ov_log::OVInit: INF - the log mutex: 544 BPBKAR NetBackup Backup/Archive 6.5GA [Jan 4 2010] Copyright 1993 - 2007 VERITAS Software Corporation All Rights Reserved. 1:58:44.861 PM: [9204.6800] <2> WinMain: DAT - _pgmptr = 'C:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe' 1:58:44.861 PM: [9204.6800] <2> WinMain: DAT - lpCmdLine = '-r 604800 -ru root -dt 344215 -to 0 -clnt ExchSrv -class Exchange -sched Daily -st CINC -bpstart_to 300 -bpend_to 300 -read_to 300 -blks_per_buffer 128 -use_otm -fso -b ExchSrv_1306324713 -kl 28 -ct 16 -use_ofb ' 1:58:44.861 PM: [9204.6800] <2> date_debug: DAT - timezone: Romance Standard Time, offset=-3600, dst: Romance Daylight Time 1:58:44.861 PM: [9204.6800] <2> date_debug: DAT - current time: 1306324724, 5/25/2011 1:58:44 PM 1:58:44.861 PM: [9204.6800] <2> date_debug: DAT - 01/01/94 UCT: 757382400, 1/1/1994 2:00:00 AM 1:58:44.861 PM: [9204.6800] <2> date_debug: DAT - 07/01/94 UCT: 773020800, 7/1/1994 2:00:00 AM 1:58:44.861 PM: [9204.6800] <2> WinMain: DAT - standard input handle = 616 1:58:44.861 PM: [9204.6800] <2> WinMain: DAT - standard output handle = 676 1:58:44.861 PM: [9204.6800] <2> WinMain: DAT - standard error handle = 640 1:58:44.939 PM: [9204.6800] <4> tar_backup::V_SetupJobData: INF - dwJobData: ffffffff 1:58:44.939 PM: [9204.6800] <4> tar_backup::V_SetupJobData: INF - dwJob: ffffffff 1:58:45.080 PM: [9204.6800] <4> dos_backup::V_PreProcessing: INF - backup privileges enabled, previous = 0 1:58:45.080 PM: [9204.6800] <4> dos_backup::V_PreProcessing: INF - restore privileges enabled, previous = 0 1:58:45.080 PM: [9204.6800] <4> dos_backup::V_PreProcessing: INF - security privileges enabled, previous = 0 1:58:45.080 PM: [9204.6800] <4> dos_backup::V_PreProcessing: INF - tcb privileges enabled, previous = 0 1:58:45.080 PM: [9204.6800] <4> dos_backup::V_PreProcessing: INF - create token privileges enabled, previous = 0 1:58:45.080 PM: [9204.6800] <4> dos_backup::V_PreProcessing: INF - user name: root 1:58:45.080 PM: [9204.6800] <4> dos_backup::V_PreProcessing: INF - no access token: scheduled backup 1:58:45.095 PM: [9204.6800] <2> ov_log::V_GlobalLog: INF - BEDS_Init() Enter InitFlags:0x0 1:58:46.330 PM: [9204.6800] <2> ov_log::V_GlobalLog: INF - BEDS_Init() BEDS debgging will be enabled - dwDebugLevel = 0. 1:58:46.330 PM: [9204.6800] <2> ov_log::V_GlobalLog: WRN - BEDS_Init() Microsoft Exchange Messaging API and Collaboration Data Objects package is required for Mailbox level backup and restore. This package can be found on the Microsoft Web Site. 1:58:54.049 PM: [9204.6800] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: C: 1:58:54.049 PM: [9204.6800] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: E: 1:58:54.049 PM: [9204.6800] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: L: 1:58:54.049 PM: [9204.6800] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Microsoft Terminal Services 1:58:54.049 PM: [9204.6800] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Microsoft Windows Network 1:58:54.049 PM: [9204.6800] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Web Client Network 1:58:54.049 PM: [9204.6800] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: \\ExchSrv\Microsoft Exchange Mailboxes 1:58:54.049 PM: [9204.6800] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: \\ExchSrv\Microsoft Exchange Public Folders 1:58:54.049 PM: [9204.6800] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: ExchSrv\SQLEXPRESS 1:58:54.049 PM: [9204.6800] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Shadow?Copy?Components 1:58:54.049 PM: [9204.6800] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: System?State 1:58:54.049 PM: [9204.6800] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Active Directory Application Mode 1:58:54.049 PM: [9204.6800] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: \\ExchSrv\Microsoft Information Store 1:58:54.049 PM: [9204.6800] <2> ov_log::V_GlobalLog: INF - DumpChildDleInfo() Child DLE Device Name: \\ExchSrv\Microsoft Information Store\Database01 1:58:54.049 PM: [9204.6800] <2> ov_log::V_GlobalLog: INF - DumpChildDleInfo() Child DLE Device Name: \\ExchSrv\Microsoft Information Store\Database02 1:58:54.049 PM: [9204.6800] <2> ov_log::V_GlobalLog: INF - DumpChildDleInfo() Child DLE Device Name: \\ExchSrv\Microsoft Information Store\Database03 1:58:54.049 PM: [9204.6800] <2> ov_log::V_GlobalLog: INF - DumpChildDleInfo() Child DLE Device Name: \\ExchSrv\Microsoft Information Store\Database04 1:58:54.049 PM: [9204.6800] <2> ov_log::V_GlobalLog: INF - DumpChildDleInfo() Child DLE Device Name: \\ExchSrv\Microsoft Information Store\Database05 1:58:54.361 PM: [9204.6800] <2> tar_backupt_tfi::create: TAR - Incremental backup using the archive bit 1:58:54.549 PM: [9204.6800] <2> tar_backup::V_SetupProcessContinue: TAR - CONTINUE BACKUP received 1:58:54.705 PM: [9204.6800] <2> tar_backup_tfi::setupFileDirectives: TAR - backup filename = Microsoft Information Store:\ 1:58:54.705 PM: [9204.8132] <4> tar_base::keepaliveThread: INF - keepalive thread is active with an interval of 60 seconds 1:58:54.705 PM: [9204.6800] <2> tar_backup_vxbsa::add: INF - called wDatabase03h 'Microsoft Information Store:\' 1:58:54.767 PM: [9204.6800] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'Microsoft Information Store:\' --> 10020020 1:58:54.767 PM: [9204.6800] <4> dos_backup::V_Initialize: INF - Exchange Backup - Disabling Open File Backups, Archive Bit processing, TIR and Job Estimating. 1:58:54.830 PM: [9204.6800] <4> backup_create: INF - NetBackup Temp Directory: 'C:\Program Files\Veritas\\NetBackup\Temp' 1:58:56.283 PM: [9204.6800] <4> dos_backup::tfs_include: INF - folder (Database01) has been created recently (since 5/21/2011 1:21:59 PM). Database03 will be backed up in full. 1:58:56.283 PM: [9204.6800] <2> tar_base::V_vTarMsgW: INF - Backing up Exchange ESE object C:\Program Files\Microsoft\Exchange Server\bin\ese.dll 2:00:51.877 PM: [9204.6800] <2> beds_ese_access::V_Read(): ERR - FS_ReadObj() Failed! (0xE000FEA9:The Backup Exec data store encountered a problem during the operation. See the job log for details. ) 2:00:51.877 PM: [9204.6800] <2> tar_base::V_vTarMsgW: ERR - failure reading file: Microsoft Information Store:\Database01\Log files (BEDS 0xE000FEA9: The Backup Exec data store encountered a problem during the operation. See the job log for details. ) 2:00:52.659 PM: [9204.6800] <4> dos_backup::tfs_include: INF - folder (Database02) has been created recently (since 5/21/2011 1:21:59 PM). Database03 will be backed up in full. 2:00:52.659 PM: [9204.6800] <2> tar_base::V_vTarMsgW: INF - Backing up Exchange ESE object C:\Program Files\Microsoft\Exchange Server\bin\ese.dll 2:00:53.096 PM: [9204.6800] <2> beds_ese_access::V_Read(): ERR - FS_ReadObj() Failed! (0xE000FEA9:The Backup Exec data store encountered a problem during the operation. See the job log for details. ) 2:00:53.096 PM: [9204.6800] <2> tar_base::V_vTarMsgW: ERR - failure reading file: Microsoft Information Store:\Database02\Log files (BEDS 0xE000FEA9: The Backup Exec data store encountered a problem during the operation. See the job log for details. ) 2:00:54.081 PM: [9204.6800] <4> dos_backup::tfs_include: INF - folder (Database03) has been created recently (since 5/21/2011 1:21:59 PM). Database03 will be backed up in full. 2:00:54.081 PM: [9204.6800] <2> tar_base::V_vTarMsgW: INF - Backing up Exchange ESE object C:\Program Files\Microsoft\Exchange Server\bin\ese.dll 2:00:54.721 PM: [9204.6800] <2> beds_ese_access::V_Read(): ERR - FS_ReadObj() Failed! (0xE000FEA9:The Backup Exec data store encountered a problem during the operation. See the job log for details. ) 2:00:54.721 PM: [9204.6800] <2> tar_base::V_vTarMsgW: ERR - failure reading file: Microsoft Information Store:\Database03\Log files (BEDS 0xE000FEA9: The Backup Exec data store encountered a problem during the operation. See the job log for details. ) 2:00:56.424 PM: [9204.6800] <4> dos_backup::tfs_include: INF - folder (Database04) has been created recently (since 5/21/2011 1:21:59 PM). Database03 will be backed up in full. 2:00:56.424 PM: [9204.6800] <2> tar_base::V_vTarMsgW: INF - Backing up Exchange ESE object C:\Program Files\Microsoft\Exchange Server\bin\ese.dll 2:00:56.674 PM: [9204.6800] <2> beds_ese_access::V_Read(): ERR - FS_ReadObj() Failed! (0xE000FEA9:The Backup Exec data store encountered a problem during the operation. See the job log for details. ) 2:00:56.674 PM: [9204.6800] <2> tar_base::V_vTarMsgW: ERR - failure reading file: Microsoft Information Store:\Database04\Log files (BEDS 0xE000FEA9: The Backup Exec data store encountered a problem during the operation. See the job log for details. ) 2:00:57.393 PM: [9204.6800] <4> dos_backup::tfs_include: INF - folder (Database05) has been created recently (since 5/21/2011 1:21:59 PM). Database03 will be backed up in full. 2:00:57.393 PM: [9204.6800] <2> tar_base::V_vTarMsgW: INF - Backing up Exchange ESE object C:\Program Files\Microsoft\Exchange Server\bin\ese.dll 2:00:57.721 PM: [9204.6800] <2> beds_ese_access::V_Read(): ERR - FS_ReadObj() Failed! (0xE000FEA9:The Backup Exec data store encountered a problem during the operation. See the job log for details. ) 2:00:57.721 PM: [9204.6800] <2> tar_base::V_vTarMsgW: ERR - failure reading file: Microsoft Information Store:\Database05\Log files (BEDS 0xE000FEA9: The Backup Exec data store encountered a problem during the operation. See the job log for details. ) 2:00:57.721 PM: [9204.6800] <2> tar_base::backup_finish: TAR - backup: 11 files 2:00:57.721 PM: [9204.6800] <2> tar_base::backup_finish: TAR - backup: file data: 0 bytes 2:00:57.721 PM: [9204.6800] <2> tar_base::backup_finish: TAR - backup: image data: 19335168 bytes 2:00:57.721 PM: [9204.6800] <2> tar_base::backup_finish: TAR - backup: elapsed time: 123 secs 157196 bps 2:00:57.737 PM: [9204.6800] <4> tar_backup::backup_done_state: INF - number of file directives not found: 0 2:00:57.737 PM: [9204.6800] <4> tar_backup::backup_done_state: INF - number of file directives found: 1 2:00:57.737 PM: [9204.8132] <4> tar_base::keepaliveThread: INF - keepalive thread terminating (reason: WAIT_OBJECT_0) 2:00:57.737 PM: [9204.6800] <4> tar_base::stopKeepaliveThread: INF - keepalive thread has exited. (reason: WAIT_OBJECT_0) 2:00:57.737 PM: [9204.6800] <2> tar_base::V_vTarMsgW: INF - EXIT STATUS 1: the requested operation was partially successful 2:01:04.737 PM: [9204.6800] <4> dos_backup::tfs_reset: INF - Snapshot deletion start 2:01:04.752 PM: [9204.6800] <4> OVStopCmd: INF - EXIT - status = 0 2:01:04.752 PM: [9204.6800] <2> tar_base::V_Close: closing... 2:01:04.752 PM: [9204.6800] <4> dos_backup::tfs_reset: INF - Snapshot deletion start 2:01:04.784 PM: [9204.6800] <2> ov_log::V_GlobalLog: INF - BEDS_Term(): enter - InitFlags:0x00000001 2:01:05.002 PM: [9204.6800] <4> OVShutdown: INF - Finished process 2:01:05.034 PM: [9204.6800] <4> WinMain: INF - Exiting C:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe 2:01:07.034 PM: [9204.6800] <4> ov_log::OVClose: INF - Closing log file: C:\Program Files\Veritas\NetBackup\logs\BPBKAR\052511.LOG