shadow copy components failing with 128

is 128 is Netbackups is error code it giving when it failed to take the backup of shadow copy components..?

Did you check the bpbkar log in the client side...

if possible please past here..

Hi,

Can you please post the detailed status of the job thats fails.

NetBackup status code: 128
Message: NB database recovery failed, a process has encountered an exceptional condition

This doesn't seem to be the correct error code as 128 should only occur when you're doing a catalog recovery.

I agree with previous requests - please post client's bpbkar (as attachment), contents of Details tab as well as policy output:
On master from cmd: <install-path>\veritas\netbackup\bin\admincmd\bppllist <policy-name> -U

I think that the status 128 is a 'red herring'.  I have seen this previously when a client was a higher patch level than the master (doesn't seem to be te case here).

D:\VERITAS\NetBackup\bin\admincmd>bppllist RD.N.Backups -U
------------------------------------------------------------

Policy Name:       RD.N.Backups

  Policy Type:         MS-Windows-NT
  Active:              yes
  Effective date:      09/16/2005 18:03:02
  Backup network drvs: no
  Collect TIR info:    no
  Mult. Data Streams:  no
  Client Encrypt:      no
  Checkpoint:          yes
       Interval:       15
  Policy Priority:     55
  Max Jobs/Policy:     99
  Disaster Recovery:   0
  Collect BMR info:    no
  Residence:           cntusmanbu06-hcart2-robot-tld-0
  Volume Pool:         DAILY
  Server Group:        *ANY*
  Keyword:             (none specified)
  Data Classification:       -
  Residence is Storage Lifecycle Policy:    no

Granular Restore Info:  no
  HW/OS/Client:  PC            WindowsNET    CNTUSMARPS03
                 PC            WindowsNET    CNTUSMARPS04
                 PC            WindowsNET    CNTUSMARCTS04
                 PC            Windows2003   CNTUSMARCTS05
                 PC            Windows2000   CNTUSMARCLS02
                 PC            Windows2000   CNTUSMARCON01
                 PC            WindowsNET    CNTUSMARCRP01
                 PC            WindowsNET    CNTUSMARCRP02
                 PC            Windows2000   CNTUSMARCTS03
                 PC            WindowsNET    CNTUSMARPDL01
                 PC            Windows2000   CNTUSMAACS1
                 PC            Windows2000   CNTUSMAACS2
                 PC            Windows2000   CNTUSMACBL1
                 PC            Windows2000   CNTUSMACBL2
                 PC            Windows2000   CNTUSMAECC2
                 PC            WindowsNET    CNTUSMARCTS06
                 PC            WindowsNET    CNTUSMARCTS07
                 PC            WindowsNET    CNTUSMARCTS08
                 PC            WindowsNET    CNTUSMARCBL04
                 PC            WindowsNET    CNTUSMARCLS01
                 PC            WindowsNET    CNTUSMARCBL13
                 PC            WindowsNET    CNTUSMARCBL14

  Include:  ALL_LOCAL_DRIVES

  Schedule:          Weekly-Full
    Type:            Full Backup
    Frequency:       every 3 days
    Maximum MPX:     10
    Synthetic:       0
    PFI Recovery:    0
    Retention Level: 5 (3 months)
    Number Copies:   1
    Fail on Error:   0
    Residence:       (specific storage unit not required)
    Volume Pool:     WEEKLY
    Server Group:    (same as specified for policy)
      EXCLUDE DATE 0 - 12/28/2007
      EXCLUDE DATE 1 - 12/29/2007
    Residence is Storage Lifecycle Policy:     0
    Daily Windows:
          Friday     22:00:00  -->  Sunday     05:50:00

  Schedule:          Daily-Incremental
    Type:            Cumulative Incremental Backup
    Frequency:       every 14 hours
    Maximum MPX:     10
    Synthetic:       0
    PFI Recovery:    0
    Retention Level: 2 (3 weeks)
    Number Copies:   1
    Fail on Error:   0
    Residence:       (specific storage unit not required)
    Volume Pool:     DAILY
    Server Group:    (same as specified for policy)
    Residence is Storage Lifecycle Policy:     0
    Daily Windows:
          Monday     22:00:00  -->  Tuesday    04:00:00
          Tuesday    22:00:00  -->  Wednesday  04:00:00
          Wednesday  22:00:00  -->  Thursday   04:00:00
          Thursday   22:00:00  -->  Friday     04:00:00

Rest of requested info as well, please:

client's bpbkar (as attachment) and contents of Details tab.

You said the problem is with shadow copy components, but your policy is for ALL_LOCAL_DRIVES with "Mult. Data Streams:  no"   (i.e. all local drives in a single stream)  - what makes you say the problem is with shadow copy components?

11:39:58.459 AM: [1448.6004] <4> ov_log::OVInit: INF - Starting log file: C:\VERITAS\NetBackup\logs\BPBKAR\021411.LOG

11:39:58.459 AM: [1448.6004] <4> ov_log::OVInit: GENERAL Log Level: 0
11:39:58.459 AM: [1448.6004] <4> ov_log::OVInit: TCP Log Level: 0
11:39:58.459 AM: [1448.6004] <4> ov_log::OVInit: INF - the log mutex: 1772
BPBKAR  NetBackup Backup/Archive  6.5GA  [Apr 23 2010]
Copyright 1993 - 2007 VERITAS Software Corporation
All Rights Reserved.

11:39:58.459 AM: [1448.6004] <2> WinMain: DAT - _pgmptr = 'C:\VERITAS\NetBackup\bin\bpbkar32.exe'
11:39:58.459 AM: [1448.6004] <2> WinMain: DAT - lpCmdLine = '-r 5356800 -ru root -dt 0 -to 2700 -clnt cntusmarcts05.na.jnj.com -class Backup.Standard -sched Weekly-Full -st FULL -bpstart_to 1800 -bpend_to 1800 -read_to 1800 -ckpt_time 900 -blks_per_buffer 255 -use_otm -use_ofb -b cntusmarcts05.na.jnj.com_1297701588 -kl 20 -fso -ct 13 '
11:39:58.459 AM: [1448.6004] <2> date_debug: DAT - timezone: Eastern Standard Time, offset=18000, dst: Eastern Daylight Time
11:39:58.459 AM: [1448.6004] <2> date_debug: DAT - current time: 1297701598, 2/14/2011 11:39:58 AM
11:39:58.459 AM: [1448.6004] <2> date_debug: DAT - 01/01/94 UCT:  757382400, 12/31/1993 7:00:00 PM
11:39:58.459 AM: [1448.6004] <2> date_debug: DAT - 07/01/94 UCT:  773020800, 6/30/1994 7:00:00 PM
11:39:58.459 AM: [1448.6004] <2> WinMain: DAT - standard input handle = 492
11:39:58.459 AM: [1448.6004] <2> WinMain: DAT - standard output handle = 1844
11:39:58.459 AM: [1448.6004] <2> WinMain: DAT - standard error handle = 1856
11:39:58.553 AM: [1448.6004] <4> tar_backup::V_SetupJobData: INF - dwJobData: ffffffff
11:39:58.553 AM: [1448.6004] <4> tar_backup::V_SetupJobData: INF -     dwJob: ffffffff
11:39:58.553 AM: [1448.6004] <4> dos_backup::V_PreProcessing: INF - backup privileges enabled, previous = 0
11:39:58.553 AM: [1448.6004] <4> dos_backup::V_PreProcessing: INF - restore privileges enabled, previous = 0
11:39:58.553 AM: [1448.6004] <4> dos_backup::V_PreProcessing: INF - security privileges enabled, previous = 0
11:39:58.553 AM: [1448.6004] <4> dos_backup::V_PreProcessing: INF - tcb privileges enabled, previous = 0
11:39:58.553 AM: [1448.6004] <4> dos_backup::V_PreProcessing: INF - create token privileges enabled, previous = 0
11:39:58.553 AM: [1448.6004] <4> dos_backup::V_PreProcessing: INF - user name: root
11:39:58.553 AM: [1448.6004] <4> dos_backup::V_PreProcessing: INF - no access token: scheduled backup
11:39:58.569 AM: [1448.6004] <2> ov_log::V_GlobalLog: INF - BEDS_Init() Enter InitFlags:0x0
11:39:58.615 AM: [1448.6004] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: C:
11:39:58.615 AM: [1448.6004] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: E:
11:39:58.615 AM: [1448.6004] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Microsoft Terminal Services
11:39:58.615 AM: [1448.6004] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Microsoft Windows Network
11:39:58.615 AM: [1448.6004] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Web Client Network
11:39:58.615 AM: [1448.6004] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Shadow?Copy?Components
11:39:58.615 AM: [1448.6004] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: System?State
11:39:58.615 AM: [1448.6004] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Active Directory Application Mode
11:39:58.850 AM: [1448.6004] <2> tar_backup::V_SetupProcessContinue: TAR - CONTINUE BACKUP received
11:39:58.850 AM: [1448.6004] <4> tar_backup_cpr::start: INF - checkpoint thread started
11:39:58.990 AM: [1448.6004] <2> tar_backup_tfi::setupFileDirectives: TAR - backup filename = ALL_LOCAL_DRIVES
11:39:58.990 AM: [1448.1380] <4> tar_base::keepaliveThread: INF - keepalive thread is active with an interval of 60 seconds
11:40:00.053 AM: [1448.6004] <2> tar_backup_vxbsa::add: INF - called with '/'
11:40:00.053 AM: [1448.6004] <4> dos_backup::V_VerifyFileSystem: INF - Added: C:\
11:40:00.053 AM: [1448.6004] <4> dos_backup::V_VerifyFileSystem: INF - Added: E:\
11:40:00.053 AM: [1448.6004] <4> dos_backup::V_VerifyFileSystem: INF - Added: Shadow Copy Components:\
11:40:00.053 AM: [1448.6004] <4> dos_backup::V_VerifyFileSystem: INF - Added: System State:\
11:40:02.147 AM: [1448.6004] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'System State:\' --> 1002002d
11:40:02.147 AM: [1448.6004] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for '_BACKUP_SPECIAL_OBJECTS AFTER System State:' --> 1002002d
11:40:02.147 AM: [1448.6004] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'E:\' --> 10020002
11:40:03.240 AM: [1448.6004] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'Shadow Copy Components:\' --> 10020027
11:40:03.240 AM: [1448.6004] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\' --> 10020002
11:40:04.194 AM: [1448.6004] <4> VssSnapshot::V_VssSetMetadata(): INF - Unable to locate DFSR metadata
11:40:04.865 AM: [1448.6004] <4> dos_backup::V_InitializeShadowCopy: INF - ============================================
11:40:04.865 AM: [1448.6004] <4> dos_backup::V_InitializeShadowCopy: INF - ShadowCopy PrePost: Begin
11:40:06.037 AM: [1448.6004] <4> dos_backup::tfs_findfirst: WRN - unable to find first file: 'Shadow Copy Components:\System Service\Background Intelligent Transfer Service\'
11:40:06.194 AM: [1448.6004] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - Drive 'C:' added to VSS Volume Set
11:40:09.412 AM: [1448.6004] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - VSS Volume Set snapped
11:40:09.412 AM: [1448.6004] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - About to commence post-snap unbounded association checks
11:40:09.412 AM: [1448.6004] <4> dos_backup::V_InitializeShadowCopy: INF - ShadowCopy PrePost: End
11:40:09.412 AM: [1448.6004] <4> dos_backup::V_InitializeShadowCopy: INF - ============================================
11:40:09.412 AM: [1448.6004] <4> VssSnapshot::V_VssSetMetadata(): INF - Unable to locate DFSR metadata
11:40:13.944 AM: [1448.6004] <4> dos_backup::tfs_scanstart: INF - Backup Special Objects request AFTER System State:
11:40:14.584 AM: [1448.6004] <4> dos_backup::tfs_getinfo: INF - current object (System State:) is a parent of previous (object (System State:\Internet Information Services\IISMETABASE)
11:40:14.897 AM: [1448.6004] <4> dos_backup::tfs_findfirst: WRN - unable to find first file: 'System State:\'
11:40:14.897 AM: [1448.6004] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - Drive 'C:' added to VSS Volume Set
11:40:14.912 AM: [1448.6004] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - Drive 'c:' added to VSS Volume Set
11:40:18.115 AM: [1448.6004] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - VSS Volume Set snapped
11:40:18.115 AM: [1448.6004] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - About to commence post-snap unbounded association checks
11:40:18.162 AM: [1448.6004] <4> backup_create: INF - NetBackup Temp Directory: 'C:\VERITAS\\NetBackup\Temp'
11:40:20.365 AM: [1448.6004] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.
11:40:20.772 AM: [1448.6004] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.
11:40:26.022 AM: [1448.6004] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.
11:44:24.553 AM: [1448.6004] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.
11:44:24.678 AM: [1448.6004] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.
11:44:24.819 AM: [1448.6004] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.
11:44:24.959 AM: [1448.6004] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.
11:44:27.522 AM: [1448.6004] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.
11:44:27.631 AM: [1448.6004] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.
11:44:27.803 AM: [1448.6004] <4> dos_backup::tfs_scanstart: INF - Backup Special Objects request AFTER System State:
11:44:28.428 AM: [1448.6004] <4> dos_backup::tfs_getinfo: INF - current object (System State:) is a parent of previous (object (System State:\Internet Information Services\IISMETABASE)
11:44:28.740 AM: [1448.6004] <4> dos_backup::tfs_findfirst: WRN - unable to find first file: 'System State:\'
11:44:29.803 AM: [1448.6004] <4> folder_access::V_OpenForRead: INF - obtained disk quota data: E:
11:44:29.803 AM: [1448.6004] <2> ov_log::V_GlobalLogEx: INF - file_access (constructor): 0 non-NTFS volumes
11:46:30.600 AM: [1448.6004] <4> dos_backup::tfs_findfirst: WRN - unable to find first file: 'Shadow Copy Components:\System Service\Background Intelligent Transfer Service\'
11:46:30.600 AM: [1448.6004] <4> folder_access::V_OpenForRead: INF - obtained disk quota data: C:
11:46:45.444 AM: [1448.6004] <2> tar_base::V_vTarMsgW: INF - Excluded: C:\Documents and Settings\All Users\Application Data\Network Associates\BOPDATA\_Date-20070724_Time-105748859_EnterceptExceptions.dat
11:46:45.444 AM: [1448.6004] <2> tar_base::V_vTarMsgW: INF - Excluded: C:\Documents and Settings\All Users\Application Data\Network Associates\BOPDATA\_Date-20070724_Time-105748859_EnterceptRules.dat
11:46:45.444 AM: [1448.6004] <2> tar_base::V_vTarMsgW: INF - Excluded: C:\Documents and Settings\All Users\Application Data\Network Associates\BOPDATA\_Date-20070724_Time-115523484_EnterceptExceptions.dat
11:46:45.444 AM: [1448.6004] <2> tar_base::V_vTarMsgW: INF - Excluded: C:\Documents and Settings\All Users\Application Data\Network Associates\BOPDATA\_Date-20070724_Time-115523484_EnterceptRules.dat
11:46:45.444 AM: [1448.6004] <2> tar_base::V_vTarMsgW: INF - Excluded: C:\Documents and Settings\All Users\Application Data\Network Associates\BOPDATA\_Date-20070724_Time-120558843_EnterceptExceptions.dat
11:46:45.444 AM: [1448.6004] <2> tar_base::V_vTarMsgW: INF - Excluded: C:\Documents and Settings\All Users\Application Data\Network Associates\BOPDATA\_Date-20070724_Time-120558843_EnterceptRules.dat
11:46:45.444 AM: [1448.6004] <2> tar_base::V_vTarMsgW: INF - Excluded: C:\Documents and Settings\All Users\Application Data\Network Associates\BOPDATA\_Date-20070725_Time-070101171_EnterceptExceptions.dat
11:46:45.444 AM: [1448.6004] <2> tar_base::V_vTarMsgW: INF - Excluded: C:\Documents and Settings\All Users\Application Data\Network Associates\BOPDATA\_Date-20070725_Time-070101171_EnterceptRules.dat
11:46:45.444 AM: [1448.6004] <2> tar_base::V_vTarMsgW: INF - Excluded: C:\Documents and Settings\All Users\Application Data\Network Associates\BOPDATA\_Date-20070725_Time-071349468_EnterceptExceptions.dat
11:46:45.444 AM: [1448.6004] <2> tar_base::V_vTarMsgW: INF - Excluded: C:\Documents and Settings\All Users\Application Data\Network Associates\BOPDATA\_Date-20070725_Time-071349468_EnterceptRules.dat
11:46:45.444 AM: [1448.6004] <2> tar_base::V_vTarMsgW: INF - Excluded: C:\Documents and Settings\All Users\Application Data\Network Associates\BOPDATA\_Date-20070725_Time-071836343_EnterceptExceptions.dat
11:46:45.444 AM: [1448.6004] <2> tar_base::V_vTarMsgW: INF - Excluded: C:\Documents and Settings\All Users\Application Data\Network Associates\BOPDATA\_Date-20070725_Time-071836343_EnterceptRules.dat
11:46:45.444 AM: [1448.6004] <2> tar_base::V_vTarMsgW: INF - Excluded: C:\Documents and Settings\All Users\Application Data\Network Associates\BOPDATA\_Date-20110210_Time-151353078_EnterceptExceptions.dat
11:46:45.444 AM: [1448.6004] <2> tar_base::V_vTarMsgW: INF - Excluded: C:\Documents and Settings\All Users\Application Data\Network Associates\BOPDATA\_Date-20110210_Time-151353078_EnterceptRules.dat
11:46:45.444 AM: [1448.6004] <2> tar_base::V_vTarMsgW: INF - Excluded: C:\Documents and Settings\All Users\Application Data\Network Associates\BOPDATA\_Date-20110210_Time-153110765_EnterceptExceptions.dat
11:46:45.459 AM: [1448.6004] <2> tar_base::V_vTarMsgW: INF - Excluded: C:\Documents and Settings\All Users\Application Data\Network Associates\BOPDATA\_Date-20110210_Time-153110765_EnterceptRules.dat
11:54:58.865 AM: [1448.6004] <4> tar_backup_tfi::backup_send_chkp_data_state: INF - checkpoint message: CPR - 9263895 1448 0 0 10654 0 0 0 8 448146944 4 5 255 0 0 112 /C/Documents and Settings/Jjohnson99/Desktop/psp/W2K3x64/Current ITS Standard ProLiant Support Pack/cp013209.exe
11:55:48.412 AM: [1448.6004] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\LocalService\ntuser.dat.LOG
11:55:48.475 AM: [1448.6004] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\LocalService\Local Settings\Application Data\Microsoft\Windows\UsrClass.dat.LOG
11:55:48.522 AM: [1448.6004] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\NetworkService\ntuser.dat.LOG
11:55:48.569 AM: [1448.6004] <4> dos_backup::tfs_scannext: INF - Skipping file: C:\Documents and Settings\NetworkService\Local Settings\Application Data\Microsoft\Windows\UsrClass.dat.LOG
12:04:35.194 PM: [1448.6004] <2> tar_base::V_vTarMsgW: INF - Excluded: C:\SCOM\Health Service State\Health Service Store\HealthServiceStore.edb
12:04:35.194 PM: [1448.6004] <2> tar_base::V_vTarMsgW: INF - Excluded: C:\SCOM\Health Service State\Health Service Store\edb.log
12:04:36.006 PM: [1448.6004] <2> tar_base::V_vTarMsgW: INF - Excluded: C:\SCOM\Health Service State\Health Service Store\edbtmp.log
12:04:37.037 PM: [1448.6004] <2> tar_base::V_vTarMsgW: INF - Excluded: C:\SCOM\Health Service State\Health Service Store\tmp.edb
12:09:59.100 PM: [1448.6004] <4> tar_backup_tfi::backup_send_chkp_data_state: INF - checkpoint message: CPR - 20573145 1448 0 0 31090 0 0 0 8 869773824 9 5 255 0 0 96 /C/WINDOWS/Installer/$PatchCache$/Managed/00002109030000000000000000F01FEC/12.0.4518/XL12CNV.EXE
12:11:11.240 PM: [1448.6004] <4> dos_backup::tfs_startdir: INF - Stopping scan for Directory Junction: C:\WINDOWS\assembly\GAC_32\System.EnterpriseServices\2.0.0.0__b03f5f7f11d50a3a
12:11:25.381 PM: [1448.6004] <2> tar_base::V_vTarMsgW: INF - Excluded: C:\WINDOWS\assembly\NativeImages_v2.0.50727_32\Temp\ZAP211.tmp
12:11:52.537 PM: [1448.6004] <2> tar_base::V_vTarMsgW: INF - Excluded: C:\WINDOWS\system32\CONFIG.TMP
12:12:53.944 PM: [1448.6004] <2> tar_base::backup_finish: TAR - backup:                     41378 files
12:12:53.944 PM: [1448.6004] <2> tar_base::backup_finish: TAR - backup:          file data:  934501191 bytes  10 gigabytes
12:12:53.944 PM: [1448.6004] <2> tar_base::backup_finish: TAR - backup:         image data: 1040716800 bytes  10 gigabytes
12:12:53.944 PM: [1448.6004] <2> tar_base::backup_finish: TAR - backup:       elapsed time:       1954 secs      6027704 bps
12:12:53.975 PM: [1448.6004] <4> tar_backup::backup_done_state: INF - number of file directives not found: 0
12:12:53.975 PM: [1448.6004] <4> tar_backup::backup_done_state: INF -     number of file directives found: 8
12:12:53.975 PM: [1448.1380] <4> tar_base::keepaliveThread: INF - keepalive thread terminating (reason: WAIT_OBJECT_0)
12:12:53.975 PM: [1448.6004] <4> tar_base::stopKeepaliveThread: INF - keepalive thread has exited. (reason: WAIT_OBJECT_0)
12:12:53.975 PM: [1448.6004] <2> tar_base::V_vTarMsgW: INF - EXIT STATUS 0: the requested operation was successfully completed
12:13:03.444 PM: [1448.6004] <4> dos_backup::tfs_reset: INF - Snapshot deletion start
12:13:03.444 PM: [1448.6004] <4> OVStopCmd: INF - EXIT - status = 0
12:13:03.444 PM: [1448.6004] <2> tar_base::V_Close: closing...
12:13:03.444 PM: [1448.6004] <4> dos_backup::tfs_reset: INF - Snapshot deletion start
12:13:03.444 PM: [1448.6004] <2> ov_log::V_GlobalLog: INF - BEDS_Term(): enter - InitFlags:0x00000001
12:13:03.444 PM: [1448.6004] <4> OVShutdown: INF - Finished process
12:13:03.444 PM: [1448.6004] <4> WinMain: INF - Exiting C:\VERITAS\NetBackup\bin\bpbkar32.exe
12:13:05.444 PM: [1448.6004] <4> ov_log::OVClose: INF - Closing log file: C:\VERITAS\NetBackup\logs\BPBKAR\021411.LOG

3:15:40.772 PM: [744.5800] <4> ov_log::OVInit: INF - Starting log file: C:\VERITAS\NetBackup\logs\BPBKAR\021411.LOG

3:15:40.772 PM: [744.5800] <4> ov_log::OVInit: GENERAL Log Level: 0
3:15:40.772 PM: [744.5800] <4> ov_log::OVInit: TCP Log Level: 0
3:15:40.772 PM: [744.5800] <4> ov_log::OVInit: INF - the log mutex: 1772
BPBKAR  NetBackup Backup/Archive  6.5GA  [Apr 23 2010]
Copyright 1993 - 2007 VERITAS Software Corporation
All Rights Reserved.

3:15:40.772 PM: [744.5800] <2> WinMain: DAT - _pgmptr = 'C:\VERITAS\NetBackup\bin\bpbkar32.exe'
3:15:40.772 PM: [744.5800] <2> WinMain: DAT - lpCmdLine = '-r 8035200 -ru root -dt 0 -to 2700 -clnt CNTUSMARCTS05 -class RD.N.Backups -sched Weekly-Full -st FULL -bpstart_to 300 -bpend_to 300 -read_to 1800 -ckpt_time 900 -blks_per_buffer 255 -use_otm -use_ofb -b CNTUSMARCTS05_1297714527 -kl 20 -fso -ct 13 '
3:15:40.772 PM: [744.5800] <2> date_debug: DAT - timezone: Eastern Standard Time, offset=18000, dst: Eastern Daylight Time
3:15:40.772 PM: [744.5800] <2> date_debug: DAT - current time: 1297714540, 2/14/2011 3:15:40 PM
3:15:40.772 PM: [744.5800] <2> date_debug: DAT - 01/01/94 UCT:  757382400, 12/31/1993 7:00:00 PM
3:15:40.772 PM: [744.5800] <2> date_debug: DAT - 07/01/94 UCT:  773020800, 6/30/1994 7:00:00 PM
3:15:40.772 PM: [744.5800] <2> WinMain: DAT - standard input handle = 520
3:15:40.772 PM: [744.5800] <2> WinMain: DAT - standard output handle = 1844
3:15:40.772 PM: [744.5800] <2> WinMain: DAT - standard error handle = 1856
3:15:40.803 PM: [744.5800] <4> tar_backup::V_SetupJobData: INF - dwJobData: ffffffff
3:15:40.803 PM: [744.5800] <4> tar_backup::V_SetupJobData: INF -     dwJob: ffffffff
3:15:40.803 PM: [744.5800] <4> dos_backup::V_PreProcessing: INF - backup privileges enabled, previous = 0
3:15:40.803 PM: [744.5800] <4> dos_backup::V_PreProcessing: INF - restore privileges enabled, previous = 0
3:15:40.803 PM: [744.5800] <4> dos_backup::V_PreProcessing: INF - security privileges enabled, previous = 0
3:15:40.803 PM: [744.5800] <4> dos_backup::V_PreProcessing: INF - tcb privileges enabled, previous = 0
3:15:40.803 PM: [744.5800] <4> dos_backup::V_PreProcessing: INF - create token privileges enabled, previous = 0
3:15:40.803 PM: [744.5800] <4> dos_backup::V_PreProcessing: INF - user name: root
3:15:40.803 PM: [744.5800] <4> dos_backup::V_PreProcessing: INF - no access token: scheduled backup
3:15:40.819 PM: [744.5800] <2> ov_log::V_GlobalLog: INF - BEDS_Init() Enter InitFlags:0x0
3:15:40.881 PM: [744.5800] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: C:
3:15:40.881 PM: [744.5800] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: E:
3:15:40.881 PM: [744.5800] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Microsoft Terminal Services
3:15:40.881 PM: [744.5800] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Microsoft Windows Network
3:15:40.881 PM: [744.5800] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Web Client Network
3:15:40.881 PM: [744.5800] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Shadow?Copy?Components
3:15:40.881 PM: [744.5800] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: System?State
3:15:40.881 PM: [744.5800] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Active Directory Application Mode
3:15:41.053 PM: [744.5800] <2> tar_backup::V_SetupProcessContinue: TAR - CONTINUE BACKUP received
3:15:41.053 PM: [744.5800] <4> tar_backup_cpr::start: INF - checkpoint thread started
3:15:41.178 PM: [744.5800] <2> tar_backup_tfi::setupFileDirectives: TAR - backup filename = ALL_LOCAL_DRIVES
3:15:41.178 PM: [744.2896] <4> tar_base::keepaliveThread: INF - keepalive thread is active with an interval of 60 seconds
3:15:42.240 PM: [744.5800] <2> tar_backup_vxbsa::add: INF - called with '/'
3:15:42.240 PM: [744.5800] <4> dos_backup::V_VerifyFileSystem: INF - Added: C:\
3:15:42.240 PM: [744.5800] <4> dos_backup::V_VerifyFileSystem: INF - Added: E:\
3:15:42.240 PM: [744.5800] <4> dos_backup::V_VerifyFileSystem: INF - Added: Shadow Copy Components:\
3:15:42.240 PM: [744.5800] <4> dos_backup::V_VerifyFileSystem: INF - Added: System State:\
3:15:44.256 PM: [744.5800] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'System State:\' --> 1002002d
3:15:44.256 PM: [744.5800] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for '_BACKUP_SPECIAL_OBJECTS AFTER System State:' --> 1002002d
3:15:44.256 PM: [744.5800] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'E:\' --> 10020002
3:15:45.397 PM: [744.5800] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'Shadow Copy Components:\' --> 10020027
3:15:45.397 PM: [744.5800] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\' --> 10020002
3:15:46.381 PM: [744.5800] <4> VssSnapshot::V_VssSetMetadata(): INF - Unable to locate DFSR metadata
3:15:47.006 PM: [744.5800] <4> dos_backup::V_InitializeShadowCopy: INF - ============================================
3:15:47.006 PM: [744.5800] <4> dos_backup::V_InitializeShadowCopy: INF - ShadowCopy PrePost: Begin
3:15:48.131 PM: [744.5800] <4> dos_backup::tfs_findfirst: WRN - unable to find first file: 'Shadow Copy Components:\System Service\Background Intelligent Transfer Service\'
3:15:48.225 PM: [744.5800] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - Drive 'C:' added to VSS Volume Set
3:15:50.178 PM: [744.5800] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - VSS Volume Set snapped
3:15:50.178 PM: [744.5800] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - About to commence post-snap unbounded association checks
3:15:50.178 PM: [744.5800] <4> dos_backup::V_InitializeShadowCopy: INF - ShadowCopy PrePost: End
3:15:50.178 PM: [744.5800] <4> dos_backup::V_InitializeShadowCopy: INF - ============================================
3:15:50.178 PM: [744.5800] <4> VssSnapshot::V_VssSetMetadata(): INF - Unable to locate DFSR metadata
3:15:54.553 PM: [744.5800] <4> dos_backup::tfs_scanstart: INF - Backup Special Objects request AFTER System State:
3:15:55.194 PM: [744.5800] <4> dos_backup::tfs_getinfo: INF - current object (System State:) is a parent of previous (object (System State:\Internet Information Services\IISMETABASE)
3:15:55.506 PM: [744.5800] <4> dos_backup::tfs_findfirst: WRN - unable to find first file: 'System State:\'
3:15:55.506 PM: [744.5800] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - Drive 'C:' added to VSS Volume Set
3:15:55.522 PM: [744.5800] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - Drive 'c:' added to VSS Volume Set
3:15:58.022 PM: [744.5800] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - VSS Volume Set snapped
3:15:58.022 PM: [744.5800] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - About to commence post-snap unbounded association checks
3:15:58.022 PM: [744.5800] <4> backup_create: INF - NetBackup Temp Directory: 'C:\VERITAS\\NetBackup\Temp'
3:15:59.725 PM: [744.5800] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.
3:16:00.037 PM: [744.5800] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.
3:16:05.225 PM: [744.5800] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.
3:18:11.772 PM: [744.5800] <32> TransporterRemote::write[2](): FTL - SocketWriteException: send() call failed, could not write data to the socket, possible broken connection.
3:18:11.787 PM: [744.5800] <16> NBUException::traceException(): (
An Exception of type [Symantec::NetBackup::Ncf::OperationFailedException] was thrown. Details about the exception follow...:
Error code  = (-1008).
Src file    = (D:\656\src\cl\clientpc\util\tar_tfi.cpp).
Src Line    = (276).
Description = (%s getBuffer operation failed).
Operation type=().
)
3:18:11.787 PM: [744.5800] <16> NBUException::traceException(): (
An Exception of type [Symantec::NetBackup::Ncf::SocketWriteException] was thrown. Details about the exception follow...:
Error code  = (-1027).
Src file    = (TransporterRemote.cpp).
Src Line    = (310).
Description = (send() call failed, could not write data to the socket, possible broken connection).
Local IP=(). Remote IP=(). Remote Port No.=(0).
No. of bytes to write=(262144) while No. of bytes written=(0).
)
3:18:11.787 PM: [744.5800] <2> tar_base::V_vTarMsgW: FTL - socket write failed
3:18:11.787 PM: [744.5800] <16> dtcp_write: TCP - failure: send socket (1856) (TCP 10054: Connection reset by peer)
3:18:11.787 PM: [744.5800] <16> dtcp_write: TCP - failure: attempted to send 26 bytes
3:18:11.787 PM: [744.5800] <4> tar_backup::backup_done_state: INF - number of file directives not found: 0
3:18:11.787 PM: [744.5800] <4> tar_backup::backup_done_state: INF -     number of file directives found: 4
3:18:11.787 PM: [744.2896] <4> tar_base::keepaliveThread: INF - keepalive thread terminating (reason: WAIT_OBJECT_0)
3:18:11.787 PM: [744.5800] <4> tar_base::stopKeepaliveThread: INF - keepalive thread has exited. (reason: WAIT_OBJECT_0)
3:18:11.787 PM: [744.5800] <2> tar_base::V_vTarMsgW: INF - EXIT STATUS 24: socket write failed
3:18:11.787 PM: [744.5800] <16> dtcp_write: TCP - failure: send socket (1856) (TCP 10054: Connection reset by peer)
3:18:11.787 PM: [744.5800] <16> dtcp_write: TCP - failure: attempted to send 42 bytes
3:18:11.787 PM: [744.5800] <4> tar_backup::backup_done_state: INF - Not waiting for server status
3:18:13.022 PM: [744.5800] <4> OVStopCmd: INF - EXIT - status = 0
3:18:13.022 PM: [744.5800] <2> tar_base::V_Close: closing...
3:18:13.022 PM: [744.5800] <4> dos_backup::tfs_reset: INF - Snapshot deletion start
3:18:13.240 PM: [744.5800] <2> ov_log::V_GlobalLog: INF - BEDS_Term(): enter - InitFlags:0x00000001
3:18:13.240 PM: [744.5800] <4> OVShutdown: INF - Finished process
3:18:13.240 PM: [744.5800] <4> WinMain: INF - Exiting C:\VERITAS\NetBackup\bin\bpbkar32.exe
3:18:15.240 PM: [744.5800] <4> ov_log::OVClose: INF - Closing log file: C:\VERITAS\NetBackup\logs\BPBKAR\021411.LOG

3:28:24.569 PM: [3204.3612] <4> ov_log::OVInit: INF - Starting log file: C:\VERITAS\NetBackup\logs\BPBKAR\021411.LOG

3:28:24.569 PM: [3204.3612] <4> ov_log::OVInit: GENERAL Log Level: 0
3:28:24.569 PM: [3204.3612] <4> ov_log::OVInit: TCP Log Level: 0
3:28:24.569 PM: [3204.3612] <4> ov_log::OVInit: INF - the log mutex: 1772
BPBKAR  NetBackup Backup/Archive  6.5GA  [Apr 23 2010]
Copyright 1993 - 2007 VERITAS Software Corporation
All Rights Reserved.

3:28:24.569 PM: [3204.3612] <2> WinMain: DAT - _pgmptr = 'C:\VERITAS\NetBackup\bin\bpbkar32.exe'
3:28:24.569 PM: [3204.3612] <2> WinMain: DAT - lpCmdLine = '-r 8035200 -ru root -dt 0 -to 2700 -clnt CNTUSMARCTS05 -class RD.N.Backups -sched Weekly-Full -st FULL -bpstart_to 300 -bpend_to 300 -read_to 1800 -ckpt_time 900 -blks_per_buffer 255 -use_otm -use_ofb -b CNTUSMARCTS05_1297714527 -kl 20 -fso -ct 13 '
3:28:24.569 PM: [3204.3612] <2> date_debug: DAT - timezone: Eastern Standard Time, offset=18000, dst: Eastern Daylight Time
3:28:24.569 PM: [3204.3612] <2> date_debug: DAT - current time: 1297715304, 2/14/2011 3:28:24 PM
3:28:24.569 PM: [3204.3612] <2> date_debug: DAT - 01/01/94 UCT:  757382400, 12/31/1993 7:00:00 PM
3:28:24.569 PM: [3204.3612] <2> date_debug: DAT - 07/01/94 UCT:  773020800, 6/30/1994 7:00:00 PM
3:28:24.569 PM: [3204.3612] <2> WinMain: DAT - standard input handle = 524
3:28:24.569 PM: [3204.3612] <2> WinMain: DAT - standard output handle = 1844
3:28:24.569 PM: [3204.3612] <2> WinMain: DAT - standard error handle = 1856
3:28:24.600 PM: [3204.3612] <4> tar_backup::V_SetupJobData: INF - dwJobData: ffffffff
3:28:24.600 PM: [3204.3612] <4> tar_backup::V_SetupJobData: INF -     dwJob: ffffffff
3:28:24.600 PM: [3204.3612] <4> dos_backup::V_PreProcessing: INF - backup privileges enabled, previous = 0
3:28:24.600 PM: [3204.3612] <4> dos_backup::V_PreProcessing: INF - restore privileges enabled, previous = 0
3:28:24.600 PM: [3204.3612] <4> dos_backup::V_PreProcessing: INF - security privileges enabled, previous = 0
3:28:24.600 PM: [3204.3612] <4> dos_backup::V_PreProcessing: INF - tcb privileges enabled, previous = 0
3:28:24.600 PM: [3204.3612] <4> dos_backup::V_PreProcessing: INF - create token privileges enabled, previous = 0
3:28:24.600 PM: [3204.3612] <4> dos_backup::V_PreProcessing: INF - user name: root
3:28:24.600 PM: [3204.3612] <4> dos_backup::V_PreProcessing: INF - no access token: scheduled backup
3:28:24.615 PM: [3204.3612] <2> ov_log::V_GlobalLog: INF - BEDS_Init() Enter InitFlags:0x0
3:28:24.678 PM: [3204.3612] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: C:
3:28:24.678 PM: [3204.3612] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: E:
3:28:24.678 PM: [3204.3612] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Microsoft Terminal Services
3:28:24.678 PM: [3204.3612] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Microsoft Windows Network
3:28:24.678 PM: [3204.3612] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Web Client Network
3:28:24.678 PM: [3204.3612] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Shadow?Copy?Components
3:28:24.678 PM: [3204.3612] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: System?State
3:28:24.678 PM: [3204.3612] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Active Directory Application Mode
3:28:24.819 PM: [3204.3612] <2> tar_backup::V_SetupProcessContinue: TAR - CONTINUE BACKUP received
3:28:24.819 PM: [3204.3612] <4> tar_backup_cpr::start: INF - checkpoint thread started
3:28:24.975 PM: [3204.3612] <2> tar_backup_tfi::setupFileDirectives: TAR - backup filename = ALL_LOCAL_DRIVES
3:28:24.975 PM: [3204.2228] <4> tar_base::keepaliveThread: INF - keepalive thread is active with an interval of 60 seconds
3:28:26.037 PM: [3204.3612] <2> tar_backup_vxbsa::add: INF - called with '/'
3:28:26.037 PM: [3204.3612] <4> dos_backup::V_VerifyFileSystem: INF - Added: C:\
3:28:26.037 PM: [3204.3612] <4> dos_backup::V_VerifyFileSystem: INF - Added: E:\
3:28:26.037 PM: [3204.3612] <4> dos_backup::V_VerifyFileSystem: INF - Added: Shadow Copy Components:\
3:28:26.037 PM: [3204.3612] <4> dos_backup::V_VerifyFileSystem: INF - Added: System State:\
3:28:27.928 PM: [3204.3612] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'System State:\' --> 1002002d
3:28:27.928 PM: [3204.3612] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for '_BACKUP_SPECIAL_OBJECTS AFTER System State:' --> 1002002d
3:28:27.928 PM: [3204.3612] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'E:\' --> 10020002
3:28:29.115 PM: [3204.3612] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'Shadow Copy Components:\' --> 10020027
3:28:29.115 PM: [3204.3612] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\' --> 10020002
3:28:30.084 PM: [3204.3612] <4> VssSnapshot::V_VssSetMetadata(): INF - Unable to locate DFSR metadata
3:28:30.772 PM: [3204.3612] <4> dos_backup::V_InitializeShadowCopy: INF - ============================================
3:28:30.772 PM: [3204.3612] <4> dos_backup::V_InitializeShadowCopy: INF - ShadowCopy PrePost: Begin
3:28:31.897 PM: [3204.3612] <4> dos_backup::tfs_findfirst: WRN - unable to find first file: 'Shadow Copy Components:\System Service\Background Intelligent Transfer Service\'
3:28:32.006 PM: [3204.3612] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - Drive 'C:' added to VSS Volume Set
3:28:33.865 PM: [3204.3612] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - VSS Volume Set snapped
3:28:33.865 PM: [3204.3612] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - About to commence post-snap unbounded association checks
3:28:33.865 PM: [3204.3612] <4> dos_backup::V_InitializeShadowCopy: INF - ShadowCopy PrePost: End
3:28:33.865 PM: [3204.3612] <4> dos_backup::V_InitializeShadowCopy: INF - ============================================
3:28:33.865 PM: [3204.3612] <4> VssSnapshot::V_VssSetMetadata(): INF - Unable to locate DFSR metadata
3:28:38.256 PM: [3204.3612] <4> dos_backup::tfs_scanstart: INF - Backup Special Objects request AFTER System State:
3:28:38.897 PM: [3204.3612] <4> dos_backup::tfs_getinfo: INF - current object (System State:) is a parent of previous (object (System State:\Internet Information Services\IISMETABASE)
3:28:39.209 PM: [3204.3612] <4> dos_backup::tfs_findfirst: WRN - unable to find first file: 'System State:\'
3:28:39.209 PM: [3204.3612] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - Drive 'C:' added to VSS Volume Set
3:28:39.209 PM: [3204.3612] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - Drive 'c:' added to VSS Volume Set
3:28:41.740 PM: [3204.3612] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - VSS Volume Set snapped
3:28:41.740 PM: [3204.3612] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - About to commence post-snap unbounded association checks
3:28:41.740 PM: [3204.3612] <4> backup_create: INF - NetBackup Temp Directory: 'C:\VERITAS\\NetBackup\Temp'
3:28:43.428 PM: [3204.3612] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.
3:28:43.740 PM: [3204.3612] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.
3:28:43.740 PM: [3204.3612] <16> dtcp_write: TCP - failure: send socket (1856) (TCP 10054: Connection reset by peer)
3:28:43.740 PM: [3204.3612] <16> dtcp_write: TCP - failure: attempted to send 108 bytes
3:28:49.162 PM: [3204.3612] <2> ov_log::V_GlobalLogEx: INF - beds_ss_access::V_OpenForRead(): FS_OpenObj() Successful.
3:28:49.162 PM: [3204.3612] <32> TransporterRemote::write[2](): FTL - SocketWriteException: send() call failed, could not write data to the socket, possible broken connection.
3:28:49.162 PM: [3204.3612] <16> NBUException::traceException(): (
An Exception of type [Symantec::NetBackup::Ncf::OperationFailedException] was thrown. Details about the exception follow...:
Error code  = (-1008).
Src file    = (D:\656\src\cl\clientpc\util\tar_tfi.cpp).
Src Line    = (276).
Description = (%s getBuffer operation failed).
Operation type=().
)
3:28:49.162 PM: [3204.3612] <16> NBUException::traceException(): (
An Exception of type [Symantec::NetBackup::Ncf::SocketWriteException] was thrown. Details about the exception follow...:
Error code  = (-1027).
Src file    = (TransporterRemote.cpp).
Src Line    = (310).
Description = (send() call failed, could not write data to the socket, possible broken connection).
Local IP=(). Remote IP=(). Remote Port No.=(0).
No. of bytes to write=(262144) while No. of bytes written=(0).
)
3:28:49.162 PM: [3204.3612] <2> tar_base::V_vTarMsgW: FTL - socket write failed
3:28:49.162 PM: [3204.3612] <16> dtcp_write: TCP - failure: send socket (1856) (TCP 10054: Connection reset by peer)
3:28:49.162 PM: [3204.3612] <16> dtcp_write: TCP - failure: attempted to send 26 bytes
3:28:49.162 PM: [3204.3612] <4> tar_backup::backup_done_state: INF - number of file directives not found: 0
3:28:49.162 PM: [3204.3612] <4> tar_backup::backup_done_state: INF -     number of file directives found: 4
3:28:49.162 PM: [3204.2228] <4> tar_base::keepaliveThread: INF - keepalive thread terminating (reason: WAIT_OBJECT_0)
3:28:49.162 PM: [3204.3612] <4> tar_base::stopKeepaliveThread: INF - keepalive thread has exited. (reason: WAIT_OBJECT_0)
3:28:49.162 PM: [3204.3612] <2> tar_base::V_vTarMsgW: INF - EXIT STATUS 24: socket write failed
3:28:49.162 PM: [3204.3612] <16> dtcp_write: TCP - failure: send socket (1856) (TCP 10054: Connection reset by peer)
3:28:49.162 PM: [3204.3612] <16> dtcp_write: TCP - failure: attempted to send 42 bytes
3:28:49.162 PM: [3204.3612] <4> tar_backup::backup_done_state: INF - Not waiting for server status
3:28:50.397 PM: [3204.3612] <4> OVStopCmd: INF - EXIT - status = 0
3:28:50.397 PM: [3204.3612] <2> tar_base::V_Close: closing...
3:28:50.397 PM: [3204.3612] <4> dos_backup::tfs_reset: INF - Snapshot deletion start
3:28:50.615 PM: [3204.3612] <2> ov_log::V_GlobalLog: INF - BEDS_Term(): enter - InitFlags:0x00000001
3:28:50.631 PM: [3204.3612] <4> OVShutdown: INF - Finished process
3:28:50.631 PM: [3204.3612] <4> WinMain: INF - Exiting C:\VERITAS\NetBackup\bin\bpbkar32.exe
3:28:52.631 PM: [3204.3612] <4> ov_log::OVClose: INF - Closing log file: C:\VERITAS\NetBackup\logs\BPBKAR\021411.LOG

i tried run backup for this client in multi streams, where i found the issue is with shadow copy components.

2/24/2011 5:41:50 PM - requesting resource cntusmanbu06-hcart2-robot-tld-0
2/24/2011 5:41:50 PM - requesting resource cntusmanbu01.na.jnj.com.NBU_CLIENT.MAXJOBS.CNTUSMARCTS05
2/24/2011 5:41:50 PM - requesting resource cntusmanbu01.na.jnj.com.NBU_POLICY.MAXJOBS.RD.N.Backups_Makeup
2/24/2011 5:41:51 PM - granted resource cntusmanbu01.na.jnj.com.NBU_CLIENT.MAXJOBS.CNTUSMARCTS05
2/24/2011 5:41:51 PM - granted resource cntusmanbu01.na.jnj.com.NBU_POLICY.MAXJOBS.RD.N.Backups_Makeup
2/24/2011 5:41:51 PM - granted resource M05060
2/24/2011 5:41:51 PM - granted resource HP.ULTRIUM2-SCSI.007
2/24/2011 5:41:51 PM - granted resource cntusmanbu06-hcart2-robot-tld-0
2/24/2011 5:41:51 PM - estimated 0 kbytes needed
2/24/2011 5:42:05 PM - connecting
2/24/2011 5:42:06 PM - connected; connect time: 00:00:01
2/24/2011 5:42:06 PM - begin writing
2/24/2011 5:42:28 PM - end writing; write time: 00:00:22
NB database recovery failed, a process has encountered an exceptional condition(128)

It normally helps to mention all relevant info........

If you told us in the opening post that the media server was on 6.5.4, we would've told you to upgrade... Client cannot be higher version than master or media server.