Forum Discussion

bharatgangawane's avatar
11 years ago

Backup Getting Failed with 156 Status Code.

Hi All ,

One of the Windows system backup getting failed with 156 Status code with below information.

"ERR - Volume resolution error for (System State:\System Files\System Files)"

All the system writers are in Stable mode with no error. Also the logs were not getrated for bpfis.

Master Server = Windows 2008  / 7.5.0.6

Client = 7.5

 

Thanks in Advance.

Bharat

 

  • What is the Windows version on this client?

    You have selected Windows 8 as OS.

    If this is the case, how did you manage to install NBU 7.5 on this client?
    Windows 8 is only supported as from 7.5.0.6 with this installation media:

    NB_7.5.0.6.winnt.x64.Client.Win2012.exe provides a full installer for NetBackup 7.5.0.6 Client onWindows 2012 Server and Windows 8 Client
    www.symantec.com/docs/TECH204661

    Please also show us what you have in Backup Selection for this client.
    Ensure that bpbkar and bpfis folders exist under netbackup\logs on this client.
    bpbkar log should also help to tell us if snapshots were attempted. Please post as File attachment.
    show us all text in Details tab as well.

8 Replies

  • Hi Nicolai ,

    If we exclude this binary path then we are able to recover the sytem state at the time of recovery.

    Bharat

  • Restore ?

    Is this topic not about "Volume resolution error" during backup ?

    Can you please elaborate ?

  • As per the Tech Note

    "all binary paths that should be excluded from the system state backup operation"

    If we excluded all binary path from system state backup then we are able to recover the full system state if the system get crashed.

  • What is the Windows version on this client?

    You have selected Windows 8 as OS.

    If this is the case, how did you manage to install NBU 7.5 on this client?
    Windows 8 is only supported as from 7.5.0.6 with this installation media:

    NB_7.5.0.6.winnt.x64.Client.Win2012.exe provides a full installer for NetBackup 7.5.0.6 Client onWindows 2012 Server and Windows 8 Client
    www.symantec.com/docs/TECH204661

    Please also show us what you have in Backup Selection for this client.
    Ensure that bpbkar and bpfis folders exist under netbackup\logs on this client.
    bpbkar log should also help to tell us if snapshots were attempted. Please post as File attachment.
    show us all text in Details tab as well.

  • Sorry - I do not know. But reading the MS tech note I would say you are in a elevated risk.

    Source : http://support.microsoft.com/kb/980794

    • If you use this method to exclude the service data from the system state backup scope, you have to back up the service data on the shared volume manually.
    • If you assign a drive letter to a shared volume that is excluded from the system state backup scope, you have to manually re-enter all the registry keys again by using a new path because the assigned drive letter does not function any longer.

     

  • Hi Marriane,

    I' getting same above issue, so that i had update NBU 7.5.0.6,

    even im getting same issue, the following message is fro bpbkar log.

    could you please support on this.

     

     

    12:30:16.400 AM: [8336.12524] <4> ov_log::OVInit: INF - Starting log file: C:\Program Files\Veritas\NetBackup\logs\BPBKAR\073114.LOG

    12:30:16.400 AM: [8336.12524] <4> ov_log::OVInit: GENERAL Log Level: 0
    12:30:16.400 AM: [8336.12524] <4> ov_log::OVInit: TCP Log Level: 0
    12:30:16.400 AM: [8336.12524] <4> ov_log::OVInit: INF - the log mutex: 564
    BPBKAR  NetBackup Backup/Archive  7.1GA  [Feb  3 2011]
    Copyright © 1993 - 2011 Symantec Corporation, All Rights Reserved.
    All Rights Reserved.

    12:30:16.400 AM: [8336.12524] <2> WinMain: DAT - _pgmptr = 'C:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe'
    12:30:16.400 AM: [8336.12524] <2> WinMain: DAT - lpCmdLine = '-r 604800 -ru root -dt 0 -to 0 -bpstart_time 1406784914 -clnt dca-qa-48 -class nt_dev_fs1 -sched weekly_full -st FULL -bpstart_to 1500 -bpend_to 1500 -read_to 24400 -blks_per_buffer 512 -use_otm -nfsok -b dca-qa-48_1406784614 -kl 28 -WOFB_enabled -WOFB_fim 1 -WOFB_usage 0 -WOFB_error 0 -ct 13 -use_ofb '
    12:30:16.400 AM: [8336.12524] <2> date_debug: DAT - timezone: Central Standard Time, offset=21600, dst: Central Daylight Time
    12:30:16.400 AM: [8336.12524] <2> date_debug: DAT - current time: 1406784616, 7/31/2014 12:30:16 AM
    12:30:16.400 AM: [8336.12524] <2> date_debug: DAT - 01/01/94 UCT:  757382400, 12/31/1993 7:00:00 PM
    12:30:16.400 AM: [8336.12524] <2> date_debug: DAT - 07/01/94 UCT:  773020800, 6/30/1994 7:00:00 PM
    12:30:16.400 AM: [8336.12524] <2> WinMain: DAT - standard input handle = 556
    12:30:16.400 AM: [8336.12524] <2> WinMain: DAT - standard output handle = 292
    12:30:16.400 AM: [8336.12524] <2> WinMain: DAT - standard error handle = 552
    12:30:16.432 AM: [8336.12524] <8> tar_process_backup_args: WRN - invalid option: -bpstart_time 1406784914
    12:30:16.432 AM: [8336.12524] <4> tar_backup::V_SetupJobData: INF - dwJobData: ffffffff
    12:30:16.432 AM: [8336.12524] <4> tar_backup::V_SetupJobData: INF -     dwJob: ffffffff
    12:30:16.510 AM: [8336.12524] <4> dos_backup::V_PreProcessing: INF - backup privileges enabled, previous = 0
    12:30:16.510 AM: [8336.12524] <4> dos_backup::V_PreProcessing: INF - restore privileges enabled, previous = 0
    12:30:16.510 AM: [8336.12524] <4> dos_backup::V_PreProcessing: INF - security privileges enabled, previous = 0
    12:30:16.510 AM: [8336.12524] <4> dos_backup::V_PreProcessing: INF - tcb privileges enabled, previous = 0
    12:30:16.510 AM: [8336.12524] <4> dos_backup::V_PreProcessing: INF - create token privileges enabled, previous = 0
    12:30:16.510 AM: [8336.12524] <4> dos_backup::V_PreProcessing: INF - user name: root
    12:30:16.510 AM: [8336.12524] <4> dos_backup::V_PreProcessing: INF - no access token: scheduled backup
    12:30:16.510 AM: [8336.12524] <2> ov_log::V_GlobalLog: WRN - ubsDetermineExchangeVersion(): RegOpenKeyEx() failed for HKLM\SOFTWARE\MICROSOFT\ExchangeServer\v14\Setup - 0x2.
    12:30:16.510 AM: [8336.12524] <2> ov_log::V_GlobalLog: INF - BEDS_Init() Enter InitFlags:0x0
    12:30:16.666 AM: [8336.12524] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: C:
    12:30:16.666 AM: [8336.12524] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Microsoft Terminal Services
    12:30:16.666 AM: [8336.12524] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Microsoft Windows Network
    12:30:16.666 AM: [8336.12524] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Shadow?Copy?Components
    12:30:16.666 AM: [8336.12524] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: System?State
    12:30:16.666 AM: [8336.12524] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Active Directory Application Mode
    12:30:16.666 AM: [8336.12524] <2> tar_base::V_vTarMsgW: INF - BACKUP START 8336
    12:30:16.666 AM: [8336.12524] <2> tar_backup::V_SetupProcessContinue: TAR - CONTINUE BACKUP received
    12:30:16.666 AM: [8336.12524] <2> tar_base::V_vTarMsgW: INF - CONTINUE BACKUP message received
    12:30:16.666 AM: [8336.12524] <2> tar_backup_tfi::setupFileDirectives: TAR - backup filename = ALL_LOCAL_DRIVES
    12:30:16.666 AM: [8336.3128] <4> tar_base::keepaliveThread: INF - keepalive thread is active with an interval of 60 seconds
    12:30:16.775 AM: [8336.12524] <2> tar_backup_vxbsa::add: INF - called with '/'
    12:30:16.775 AM: [8336.12524] <4> dos_backup::V_VerifyFileSystem: INF - Added: C:\
    12:30:16.775 AM: [8336.12524] <4> dos_backup::V_VerifyFileSystem: INF - Added: Shadow Copy Components:\
    12:30:16.775 AM: [8336.12524] <4> dos_backup::V_VerifyFileSystem: INF - Added: System State:\
    12:30:16.775 AM: [8336.12524] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'C:\' --> 10020002
    12:30:21.985 AM: [8336.12524] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'Shadow Copy Components:\' --> 10020027
    12:30:24.700 AM: [8336.12524] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'System State:\' --> 1002002d
    12:30:24.700 AM: [8336.12524] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for '_BACKUP_SPECIAL_OBJECTS AFTER System State:' --> 1002002d
    12:30:27.321 AM: [8336.12524] <4> VssSnapshot::V_VssSetMetadata(): INF - Unable to locate DFSR metadata
    12:30:28.428 AM: [8336.12524] <4> dos_backup::V_InitializeShadowCopy: INF - ============================================
    12:30:28.428 AM: [8336.12524] <4> dos_backup::V_InitializeShadowCopy: INF - ShadowCopy PrePost: Begin
    12:30:32.859 AM: [8336.12524] <4> dos_backup::tfs_findfirst: INF - unable to find first file: 'Shadow Copy Components:\System Service\Background Intelligent Transfer Service\'
    12:30:33.218 AM: [8336.12524] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - Drive 'C:' added to VSS Volume Set
    12:30:40.019 AM: [8336.12524] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - VSS Volume Set snapped
    12:30:40.019 AM: [8336.12524] <4> VssSnapshot::V_VssVolumeSnapshot(): INF - About to commence post-snap unbounded association checks
    12:30:40.019 AM: [8336.12524] <4> dos_backup::V_InitializeShadowCopy: INF - ShadowCopy PrePost: End
    12:30:40.019 AM: [8336.12524] <4> dos_backup::V_InitializeShadowCopy: INF - ============================================
    12:30:40.019 AM: [8336.12524] <4> VssSnapshot::V_VssSetMetadata(): INF - Unable to locate DFSR metadata
    12:30:46.478 AM: [8336.12524] <16> dos_backup::V_InitializeSystemState: ERR - FS_AddToSnapshotSet() Failed! (System State:\System Files\System Files) 0xE0000352:The specified volume does not exist. Recreate the volume, and then try the job again.

    12:30:46.478 AM: [8336.12524] <2> tar_base::V_vTarMsgW: ERR - Volume resolution error for (System State:\System Files\System Files)
    12:30:46.478 AM: [8336.12524] <2> tar_base::V_vTarMsgW: INF - EXIT STATUS 156: snapshot error encountered
    12:30:46.478 AM: [8336.12524] <4> backup_create: INF - NetBackup Temp Directory: 'C:\Program Files\Veritas\\NetBackup\Temp'
    12:30:46.493 AM: [8336.12524] <4> tar_backup_tfi::UpdateExcludeListWithVHD: INF - UpdateExludeListWithVHD begin
    12:30:47.071 AM: [8336.12524] <4> OVStopCmd: INF - EXIT - status = 0
    12:30:47.071 AM: [8336.12524] <2> tar_base::V_Close: closing...
    12:30:47.071 AM: [8336.12524] <4> dos_backup::tfs_reset: INF - Snapshot deletion start
    12:30:47.305 AM: [8336.12524] <2> ov_log::V_GlobalLog: INF - BEDS_Term(): enter - InitFlags:0x00000001
    12:30:47.320 AM: [8336.12524] <16> dtcp_read: TCP - failure: recv socket (556) (TCP 10053: Software caused connection abort)
    12:30:48.334 AM: [8336.12524] <16> dtcp_read: TCP - failure: recv socket (556) (TCP 10053: Software caused connection abort)
    12:30:48.334 AM: [8336.12524] <4> OVShutdown: INF - Finished process
    12:30:48.334 AM: [8336.12524] <4> WinMain: INF - Exiting C:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe
    12:30:50.362 AM: [8336.12524] <4> ov_log::OVClose: INF - Closing log file: C:\Program Files\Veritas\NetBackup\logs\BPBKAR\073114.LOG

     

     

    Thanks

    Nelluri