Video Screencast Help

Backup Failed with status 13 for windows 2000 client

Created: 20 Feb 2013 | 18 comments

Hi Folks,

I am using netbackup 6.5.6 environment.

Backup failed with status 13 for windows 2000 client, both full/incremental failed with multistreaming and without multistreaming.

Backup slection is all local drives and the drives are C, D E all streams are failing with status 13.

Please suggest me the possible ways to reolve the problem

thanks in advance.

 

 

 

Operating Systems:

Comments 18 CommentsJump to latest comment

Marianne's picture

Two important facts before we troubleshoot status 13:

  1. Windows 2000 is no longer supported by Microsoft
  2. NBU 6,x is no longer supported by Symantec.

Let us look status 13:

 

>bperror -S 13 -r
file read failed
A read of a file or socket failed.
 
So, we see status 13 is either file/filesystem error or a network problem.
Step 1 in troubleshooting this error is to determine if this is file or network error.
The information in Details tab of the failed job is normally enough to make this distinction.
 
Please post all text in Details tab and let us take it from there.

 

Supporting Storage Foundation and VCS on Unix and Windows as well as NetBackup on Unix and Windows
Handy NBU Links

Venu_S's picture

Hi Marianne,

Thanks for the information provided,

The result sin detail tab are:

Feb 19, 2013 6:00:02 PM - requesting resource AD_h3mil061_h3mil062_LOAD_BALANCE-TR
Feb 19, 2013 6:00:02 PM - requesting resource aBCK01NB.ced.h3g.it.NBU_CLIENT.MAXJOBS.h3miw137bck.ced.h3g.it
Feb 19, 2013 6:00:02 PM - requesting resource aBCK01NB.ced.h3g.it.NBU_POLICY.MAXJOBS.BSS_DWH_rad_Win_FS
Feb 19, 2013 6:02:02 PM - granted resource  aBCK01NB.ced.h3g.it.NBU_CLIENT.MAXJOBS.h3miw137bck.ced.h3g.it
Feb 19, 2013 6:02:02 PM - granted resource  aBCK01NB.ced.h3g.it.NBU_POLICY.MAXJOBS.BSS_DWH_rad_Win_FS
Feb 19, 2013 6:02:02 PM - granted resource  MediaID=@aaaao;DiskVolume=/NBU_staging_area/DISK2;DiskPool=h3mil061-AD-STG-TR;Path=/NBU_staging_area/DISK2;StorageServer=h3mil061.ced.h3g.it;MediaServer=h3mil061.ced.h3g.it
Feb 19, 2013 6:02:02 PM - granted resource  AD_h3mil061-STG-TR
Feb 19, 2013 6:02:03 PM - estimated 0 kbytes needed
Feb 19, 2013 6:02:04 PM - started process bpbrm (pid=30640)
Feb 19, 2013 6:02:07 PM - connecting
Feb 19, 2013 6:02:07 PM - connected; connect time: 0:00:00
Feb 20, 2013 2:22:07 AM - Error bpbrm (pid=30640) socket read failed: errno = 62 - Timer expired
Feb 20, 2013 2:22:08 AM - end writing
file read failed  (13)
 

Waiting for the reply,

thanks.

 

 

 

Nagalla's picture

Did backup jobs writing any data before reporting error and failing?

 what is the connect timeout and read time out vaules? did you try increasing that?

if you got after even after increasing the timeout vaule

along with detail status, post bpbkar  and bpcd logs from Client and bpbrm and bptm logs from media server.

Venu_S's picture

Hi Marianne,

The  result of detail tab is :

Feb 19, 2013 6:02:02 PM - granted resource  AD_h3mil061-STG-TR
Feb 19, 2013 6:02:03 PM - estimated 0 kbytes needed
Feb 19, 2013 6:02:04 PM - started process bpbrm (pid=30640)
Feb 19, 2013 6:02:07 PM - connecting
Feb 19, 2013 6:02:07 PM - connected; connect time: 0:00:00
Feb 20, 2013 2:22:07 AM - Error bpbrm (pid=30640) socket read failed: errno = 62 - Timer expired
Feb 20, 2013 2:22:08 AM - end writing
file read failed  (13)
 

@Nagalla,

Backup is not writiing any data on any stream

time out value on client is 400 sec

from master server GUI,

Client read timed out 300sec

file browse timed out 400 sec

i have increased the client time out value 300sec to 400 sec but there is no use.

thanks.

 

 

 

 

Marianne's picture

Error bpbrm (pid=30640) socket read failed: errno = 62 - Timer expired

This is Client Read timeout. See: http://www.symantec.com/docs/TECH71821

Increase to about 1800 on the media server.

Aging Client is probably suffering from bad fragmentation, overloaded, out-of-date NIC drivers and/or firmware, etc...

Supporting Storage Foundation and VCS on Unix and Windows as well as NetBackup on Unix and Windows
Handy NBU Links

Venu_S's picture

Hi Marianne,

I have the below values on media server alreday.

client connect timeout : 12000 sec

client read time out :20800 sec

 

Venu_S's picture

Backup is in active state around 10 hrs with out writing any data and after that it failed with above error.

Backup getting failed since long back and 1 month before we have rebooted the client and un installed and installed the NBU client software.

But still the probelm is same.

Nagalla's picture

hi,

try to make the backup of just  small file or Directory, and see how it goes...

 

Marianne's picture

Please also have another look at last line in my previous post:

Aging Client is probably suffering from bad fragmentation, overloaded, out-of-date NIC drivers and/or firmware, etc...

Get your server owners to perform health check on this machine. Best option will be to migrate to newer hardware and supported OS.

Do you have bpbkar log as per Nagalla's request above?

Please also test client's ability to read data from disk. See: http://www.symantec.com/docs/TECH17541

 

Supporting Storage Foundation and VCS on Unix and Windows as well as NetBackup on Unix and Windows
Handy NBU Links

Mark_Solutions's picture

Doesnt sound like the backup ever got going at all

Check the clients application and system event logs for error and usually more importantly in these for free disk space, especially on the system drive.

It can sometimes help to add that client to the Master Servers client attributes tab then for the open file backups section get it to use VSP - selecting individual drive snapshots and Disable snapshot and continue

Then open the clients host properties - Windows client section - VSP tab and select to customise the cache file - min 120MB, max 500 MB and see if that helps

But look for errors, disk space issues and even hung bpbkar32 / bpfis errors first on the client

Authorised Symantec Consultant

Don't forget to "Mark as Solution" if someones advice has solved your issue - and please bring back the Thumbs Up!!.

Venu_S's picture

Hi All,

Thanks all of you for your valuable updates, below is the bpbkar log, please suggest further

2:57:56.970 AM: [8584.5652] <4> ov_log::OVInit: INF - Starting log file: C:\Program Files\Veritas\NetBackup\logs\BPBKAR\022113.LOG

2:57:56.970 AM: [8584.5652] <4> ov_log::OVInit: GENERAL Log Level: 0
2:57:56.970 AM: [8584.5652] <4> ov_log::OVInit: TCP Log Level: 0
2:57:56.970 AM: [8584.5652] <4> ov_log::OVInit: INF - the log mutex: 768
BPBKAR  NetBackup Backup/Archive  6.5GA  [Apr 23 2010]
Copyright 1993 - 2007 VERITAS Software Corporation
All Rights Reserved.

2:57:56.970 AM: [8584.5652] <2> WinMain: DAT - _pgmptr = 'C:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe'
2:57:56.970 AM: [8584.5652] <2> WinMain: DAT - lpCmdLine = '-r 604800 -ru root -dt 0 -to 3600 -clnt h3miw137bck.ced.h3g.it -class BSS_DWH_rad_Win_FS -sched Full-Weekly -st FULL -bpstart_to 7200 -bpend_to 7200 -read_to 30000 -stream_count 4 -stream_number 1 -jobgrpid 6337836 -blks_per_buffer 2048 -use_otm -fso -b h3miw137bck.ced.h3g.it_1361411873 -kl 3 -ct 13 -use_ofb '
2:57:56.970 AM: [8584.5652] <2> date_debug: DAT - timezone: W. Europe Standard Time, offset=-3600, dst: W. Europe Daylight Time
2:57:56.970 AM: [8584.5652] <2> date_debug: DAT - current time: 1361411876, 2/21/2013 2:57:56 AM
2:57:56.970 AM: [8584.5652] <2> date_debug: DAT - 01/01/94 UCT:  757382400, 1/1/1994 1:00:00 AM
2:57:56.970 AM: [8584.5652] <2> date_debug: DAT - 07/01/94 UCT:  773020800, 7/1/1994 1:00:00 AM
2:57:56.970 AM: [8584.5652] <2> WinMain: DAT - standard input handle = 460
2:57:56.970 AM: [8584.5652] <2> WinMain: DAT - standard output handle = 908
2:57:56.970 AM: [8584.5652] <2> WinMain: DAT - standard error handle = 716

5:07:33.376 AM: [7360.8700] <4> ov_log::OVInit: INF - Starting log file: C:\Program Files\Veritas\NetBackup\logs\BPBKAR\022113.LOG

5:07:33.376 AM: [7360.8700] <4> ov_log::OVInit: GENERAL Log Level: 0
5:07:33.376 AM: [7360.8700] <4> ov_log::OVInit: TCP Log Level: 0
5:07:33.376 AM: [7360.8700] <4> ov_log::OVInit: INF - the log mutex: 768
BPBKAR  NetBackup Backup/Archive  6.5GA  [Apr 23 2010]
Copyright 1993 - 2007 VERITAS Software Corporation
All Rights Reserved.

5:07:33.892 AM: [7360.8700] <2> WinMain: DAT - _pgmptr = 'C:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe'
5:07:33.892 AM: [7360.8700] <2> WinMain: DAT - lpCmdLine = '-r 604800 -ru root -dt 0 -to 3600 -clnt h3miw137bck.ced.h3g.it -class BSS_DWH_rad_Win_FS -sched Full-Weekly -st FULL -bpstart_to 3600 -bpend_to 7200 -read_to 20800 -stream_count 4 -stream_number 1 -jobgrpid 6338410 -blks_per_buffer 2048 -use_otm -fso -b h3miw137bck.ced.h3g.it_1361419649 -kl 3 -ct 13 -use_ofb '
5:07:33.892 AM: [7360.8700] <2> date_debug: DAT - timezone: W. Europe Standard Time, offset=-3600, dst: W. Europe Daylight Time
5:07:33.892 AM: [7360.8700] <2> date_debug: DAT - current time: 1361419653, 2/21/2013 5:07:33 AM
5:07:33.892 AM: [7360.8700] <2> date_debug: DAT - 01/01/94 UCT:  757382400, 1/1/1994 1:00:00 AM
5:07:33.892 AM: [7360.8700] <2> date_debug: DAT - 07/01/94 UCT:  773020800, 7/1/1994 1:00:00 AM
5:07:33.892 AM: [7360.8700] <2> WinMain: DAT - standard input handle = 468
5:07:33.892 AM: [7360.8700] <2> WinMain: DAT - standard output handle = 908
5:07:33.892 AM: [7360.8700] <2> WinMain: DAT - standard error handle = 716

5:46:11.814 AM: [2812.8176] <4> ov_log::OVInit: INF - Starting log file: C:\Program Files\Veritas\NetBackup\logs\BPBKAR\022113.LOG

5:46:11.814 AM: [2812.8176] <4> ov_log::OVInit: GENERAL Log Level: 0
5:46:11.814 AM: [2812.8176] <4> ov_log::OVInit: TCP Log Level: 0
5:46:11.814 AM: [2812.8176] <4> ov_log::OVInit: INF - the log mutex: 768
BPBKAR  NetBackup Backup/Archive  6.5GA  [Apr 23 2010]
Copyright 1993 - 2007 VERITAS Software Corporation
All Rights Reserved.

5:46:11.814 AM: [2812.8176] <2> WinMain: DAT - _pgmptr = 'C:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe'
5:46:11.814 AM: [2812.8176] <2> WinMain: DAT - lpCmdLine = '-r 604800 -ru root -dt 0 -to 3600 -clnt h3miw137bck.ced.h3g.it -class BSS_DWH_rad_Win_FS -sched Full-Weekly -st FULL -bpstart_to 3600 -bpend_to 7200 -read_to 20800 -stream_count 4 -stream_number 2 -jobgrpid 6338410 -blks_per_buffer 2048 -use_otm -fso -b h3miw137bck.ced.h3g.it_1361421968 -kl 3 -ct 13 -use_ofb '
5:46:11.814 AM: [2812.8176] <2> date_debug: DAT - timezone: W. Europe Standard Time, offset=-3600, dst: W. Europe Daylight Time
5:46:11.814 AM: [2812.8176] <2> date_debug: DAT - current time: 1361421971, 2/21/2013 5:46:11 AM
5:46:11.814 AM: [2812.8176] <2> date_debug: DAT - 01/01/94 UCT:  757382400, 1/1/1994 1:00:00 AM
5:46:11.814 AM: [2812.8176] <2> date_debug: DAT - 07/01/94 UCT:  773020800, 7/1/1994 1:00:00 AM
5:46:11.814 AM: [2812.8176] <2> WinMain: DAT - standard input handle = 464
5:46:11.814 AM: [2812.8176] <2> WinMain: DAT - standard output handle = 908
5:46:11.814 AM: [2812.8176] <2> WinMain: DAT - standard error handle = 716

5:46:13.345 AM: [7692.7216] <4> ov_log::OVInit: INF - Starting log file: C:\Program Files\Veritas\NetBackup\logs\BPBKAR\022113.LOG

5:46:13.345 AM: [7692.7216] <4> ov_log::OVInit: GENERAL Log Level: 0
5:46:13.345 AM: [7692.7216] <4> ov_log::OVInit: TCP Log Level: 0
5:46:13.345 AM: [7692.7216] <4> ov_log::OVInit: INF - the log mutex: 768
BPBKAR  NetBackup Backup/Archive  6.5GA  [Apr 23 2010]
Copyright 1993 - 2007 VERITAS Software Corporation
All Rights Reserved.

5:46:13.376 AM: [7692.7216] <2> WinMain: DAT - _pgmptr = 'C:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe'
5:46:13.376 AM: [7692.7216] <2> WinMain: DAT - lpCmdLine = '-r 604800 -ru root -dt 0 -to 3600 -clnt h3miw137bck.ced.h3g.it -class BSS_DWH_rad_Win_FS -sched Full-Weekly -st FULL -bpstart_to 3600 -bpend_to 7200 -read_to 20800 -stream_count 4 -stream_number 4 -jobgrpid 6338410 -blks_per_buffer 2048 -use_otm -fso -b h3miw137bck.ced.h3g.it_1361421970 -kl 3 -ct 13 -use_ofb '
5:46:13.376 AM: [7692.7216] <2> date_debug: DAT - timezone: W. Europe Standard Time, offset=-3600, dst: W. Europe Daylight Time
5:46:13.376 AM: [7692.7216] <2> date_debug: DAT - current time: 1361421973, 2/21/2013 5:46:13 AM
5:46:13.376 AM: [7692.7216] <2> date_debug: DAT - 01/01/94 UCT:  757382400, 1/1/1994 1:00:00 AM
5:46:13.376 AM: [7692.7216] <2> date_debug: DAT - 07/01/94 UCT:  773020800, 7/1/1994 1:00:00 AM
5:46:13.376 AM: [7692.7216] <2> WinMain: DAT - standard input handle = 472
5:46:13.376 AM: [7692.7216] <2> WinMain: DAT - standard output handle = 908
5:46:13.376 AM: [7692.7216] <2> WinMain: DAT - standard error handle = 716

5:46:28.345 AM: [7252.8540] <4> ov_log::OVInit: INF - Starting log file: C:\Program Files\Veritas\NetBackup\logs\BPBKAR\022113.LOG

5:46:28.345 AM: [7252.8540] <4> ov_log::OVInit: GENERAL Log Level: 0
5:46:28.345 AM: [7252.8540] <4> ov_log::OVInit: TCP Log Level: 0
5:46:28.345 AM: [7252.8540] <4> ov_log::OVInit: INF - the log mutex: 768
BPBKAR  NetBackup Backup/Archive  6.5GA  [Apr 23 2010]
Copyright 1993 - 2007 VERITAS Software Corporation
All Rights Reserved.

5:46:28.345 AM: [7252.8540] <2> WinMain: DAT - _pgmptr = 'C:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe'
5:46:28.345 AM: [7252.8540] <2> WinMain: DAT - lpCmdLine = '-r 604800 -ru root -dt 0 -to 3600 -clnt h3miw137bck.ced.h3g.it -class BSS_DWH_rad_Win_FS -sched Full-Weekly -st FULL -bpstart_to 3600 -bpend_to 7200 -read_to 20800 -stream_count 4 -stream_number 3 -jobgrpid 6338410 -blks_per_buffer 2048 -use_otm -fso -b h3miw137bck.ced.h3g.it_1361421969 -kl 3 -ct 13 -use_ofb '
5:46:28.345 AM: [7252.8540] <2> date_debug: DAT - timezone: W. Europe Standard Time, offset=-3600, dst: W. Europe Daylight Time
5:46:28.345 AM: [7252.8540] <2> date_debug: DAT - current time: 1361421988, 2/21/2013 5:46:28 AM
5:46:28.345 AM: [7252.8540] <2> date_debug: DAT - 01/01/94 UCT:  757382400, 1/1/1994 1:00:00 AM
5:46:28.345 AM: [7252.8540] <2> date_debug: DAT - 07/01/94 UCT:  773020800, 7/1/1994 1:00:00 AM
5:46:28.345 AM: [7252.8540] <2> WinMain: DAT - standard input handle = 456
5:46:28.345 AM: [7252.8540] <2> WinMain: DAT - standard output handle = 908
5:46:28.345 AM: [7252.8540] <2> WinMain: DAT - standard error handle = 716

6:42:36.607 PM: [8308.7772] <4> ov_log::OVInit: INF - Starting log file: C:\Program Files\Veritas\NetBackup\logs\BPBKAR\022113.LOG

6:42:36.607 PM: [8308.7772] <4> ov_log::OVInit: GENERAL Log Level: 0
6:42:36.607 PM: [8308.7772] <4> ov_log::OVInit: TCP Log Level: 0
6:42:36.607 PM: [8308.7772] <4> ov_log::OVInit: INF - the log mutex: 768
BPBKAR  NetBackup Backup/Archive  6.5GA  [Apr 23 2010]
Copyright 1993 - 2007 VERITAS Software Corporation
All Rights Reserved.

6:42:36.623 PM: [8308.7772] <2> WinMain: DAT - _pgmptr = 'C:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe'
6:42:36.623 PM: [8308.7772] <2> WinMain: DAT - lpCmdLine = '-r 604800 -ru root -dt 0 -to 3600 -clnt h3miw137bck.ced.h3g.it -class BSS_DWH_rad_Win_FS -sched Differential-inc -st INCR -bpstart_to 7200 -bpend_to 7200 -read_to 30000 -stream_count 4 -stream_number 1 -jobgrpid 6343308 -blks_per_buffer 2048 -use_otm -fso -b h3miw137bck.ced.h3g.it_1361468553 -kl 3 -ct 13 -use_ofb '
6:42:36.623 PM: [8308.7772] <2> date_debug: DAT - timezone: W. Europe Standard Time, offset=-3600, dst: W. Europe Daylight Time
6:42:36.623 PM: [8308.7772] <2> date_debug: DAT - current time: 1361468556, 2/21/2013 6:42:36 PM
6:42:36.623 PM: [8308.7772] <2> date_debug: DAT - 01/01/94 UCT:  757382400, 1/1/1994 1:00:00 AM
6:42:36.623 PM: [8308.7772] <2> date_debug: DAT - 07/01/94 UCT:  773020800, 7/1/1994 1:00:00 AM
6:42:36.623 PM: [8308.7772] <2> WinMain: DAT - standard input handle = 460
6:42:36.623 PM: [8308.7772] <2> WinMain: DAT - standard output handle = 908
6:42:36.623 PM: [8308.7772] <2> WinMain: DAT - standard error handle = 716

7:30:33.094 PM: [2468.8052] <4> ov_log::OVInit: INF - Starting log file: C:\Program Files\Veritas\NetBackup\logs\BPBKAR\022113.LOG

7:30:33.094 PM: [2468.8052] <4> ov_log::OVInit: GENERAL Log Level: 0
7:30:33.094 PM: [2468.8052] <4> ov_log::OVInit: TCP Log Level: 0
7:30:33.094 PM: [2468.8052] <4> ov_log::OVInit: INF - the log mutex: 768
BPBKAR  NetBackup Backup/Archive  6.5GA  [Apr 23 2010]
Copyright 1993 - 2007 VERITAS Software Corporation
All Rights Reserved.

7:30:33.110 PM: [2468.8052] <2> WinMain: DAT - _pgmptr = 'C:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe'
7:30:33.110 PM: [2468.8052] <2> WinMain: DAT - lpCmdLine = '-r 604800 -ru root -dt 0 -to 3600 -clnt h3miw137bck.ced.h3g.it -class BSS_DWH_rad_Win_FS -sched Differential-inc -st INCR -bpstart_to 7200 -bpend_to 7200 -read_to 30000 -stream_count 4 -stream_number 2 -jobgrpid 6343308 -blks_per_buffer 2048 -use_otm -fso -b h3miw137bck.ced.h3g.it_1361471428 -kl 3 -ct 13 -use_ofb '
7:30:33.110 PM: [2468.8052] <2> date_debug: DAT - timezone: W. Europe Standard Time, offset=-3600, dst: W. Europe Daylight Time
7:30:33.110 PM: [2468.8052] <2> date_debug: DAT - current time: 1361471433, 2/21/2013 7:30:33 PM
7:30:33.110 PM: [2468.8052] <2> date_debug: DAT - 01/01/94 UCT:  757382400, 1/1/1994 1:00:00 AM
7:30:33.110 PM: [2468.8052] <2> date_debug: DAT - 07/01/94 UCT:  773020800, 7/1/1994 1:00:00 AM
7:30:33.110 PM: [2468.8052] <2> WinMain: DAT - standard input handle = 456
7:30:33.110 PM: [2468.8052] <2> WinMain: DAT - standard output handle = 908
7:30:33.110 PM: [2468.8052] <2> WinMain: DAT - standard error handle = 720

7:30:33.813 PM: [8228.7840] <4> ov_log::OVInit: INF - Starting log file: C:\Program Files\Veritas\NetBackup\logs\BPBKAR\022113.LOG

7:30:33.813 PM: [8228.7840] <4> ov_log::OVInit: GENERAL Log Level: 0
7:30:33.813 PM: [8228.7840] <4> ov_log::OVInit: TCP Log Level: 0
7:30:33.813 PM: [8228.7840] <4> ov_log::OVInit: INF - the log mutex: 768
BPBKAR  NetBackup Backup/Archive  6.5GA  [Apr 23 2010]
Copyright 1993 - 2007 VERITAS Software Corporation
All Rights Reserved.

7:30:33.813 PM: [8228.7840] <2> WinMain: DAT - _pgmptr = 'C:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe'
7:30:33.813 PM: [8228.7840] <2> WinMain: DAT - lpCmdLine = '-r 604800 -ru root -dt 0 -to 3600 -clnt h3miw137bck.ced.h3g.it -class BSS_DWH_rad_Win_FS -sched Differential-inc -st INCR -bpstart_to 7200 -bpend_to 7200 -read_to 30000 -stream_count 4 -stream_number 3 -jobgrpid 6343308 -blks_per_buffer 2048 -use_otm -fso -b h3miw137bck.ced.h3g.it_1361471430 -kl 3 -ct 13 -use_ofb '
7:30:33.813 PM: [8228.7840] <2> date_debug: DAT - timezone: W. Europe Standard Time, offset=-3600, dst: W. Europe Daylight Time
7:30:33.813 PM: [8228.7840] <2> date_debug: DAT - current time: 1361471433, 2/21/2013 7:30:33 PM
7:30:33.813 PM: [8228.7840] <2> date_debug: DAT - 01/01/94 UCT:  757382400, 1/1/1994 1:00:00 AM
7:30:33.813 PM: [8228.7840] <2> date_debug: DAT - 07/01/94 UCT:  773020800, 7/1/1994 1:00:00 AM
7:30:33.813 PM: [8228.7840] <2> WinMain: DAT - standard input handle = 472
7:30:33.813 PM: [8228.7840] <2> WinMain: DAT - standard output handle = 908
7:30:33.813 PM: [8228.7840] <2> WinMain: DAT - standard error handle = 716

7:30:36.126 PM: [8568.7680] <4> ov_log::OVInit: INF - Starting log file: C:\Program Files\Veritas\NetBackup\logs\BPBKAR\022113.LOG

7:30:36.126 PM: [8568.7680] <4> ov_log::OVInit: GENERAL Log Level: 0
7:30:36.126 PM: [8568.7680] <4> ov_log::OVInit: TCP Log Level: 0
7:30:36.126 PM: [8568.7680] <4> ov_log::OVInit: INF - the log mutex: 768
BPBKAR  NetBackup Backup/Archive  6.5GA  [Apr 23 2010]
Copyright 1993 - 2007 VERITAS Software Corporation
All Rights Reserved.

7:30:36.126 PM: [8568.7680] <2> WinMain: DAT - _pgmptr = 'C:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe'
7:30:36.126 PM: [8568.7680] <2> WinMain: DAT - lpCmdLine = '-r 604800 -ru root -dt 0 -to 3600 -clnt h3miw137bck.ced.h3g.it -class BSS_DWH_rad_Win_FS -sched Differential-inc -st INCR -bpstart_to 7200 -bpend_to 7200 -read_to 30000 -stream_count 4 -stream_number 4 -jobgrpid 6343308 -blks_per_buffer 2048 -use_otm -fso -b h3miw137bck.ced.h3g.it_1361471432 -kl 3 -ct 13 -use_ofb '
7:30:36.126 PM: [8568.7680] <2> date_debug: DAT - timezone: W. Europe Standard Time, offset=-3600, dst: W. Europe Daylight Time
7:30:36.126 PM: [8568.7680] <2> date_debug: DAT - current time: 1361471436, 2/21/2013 7:30:36 PM
7:30:36.126 PM: [8568.7680] <2> date_debug: DAT - 01/01/94 UCT:  757382400, 1/1/1994 1:00:00 AM
7:30:36.126 PM: [8568.7680] <2> date_debug: DAT - 07/01/94 UCT:  773020800, 7/1/1994 1:00:00 AM
7:30:36.126 PM: [8568.7680] <2> WinMain: DAT - standard input handle = 468
7:30:36.126 PM: [8568.7680] <2> WinMain: DAT - standard output handle = 908
7:30:36.126 PM: [8568.7680] <2> WinMain: DAT - standard error handle = 716

Venu_S's picture

I see the below error from bpcd log

02:46:51.361 [8408.8620] <2> bpcd valid_server: comparing h3fal028.ced.h3g.it and h3miw137bck.ced.h3g.it
02:46:51.361 [8408.8620] <4> bpcd valid_server: h3miw137bck.ced.h3g.it is not a master server
02:46:51.361 [8408.8620] <16> bpcd valid_server: h3miw137bck.ced.h3g.it is not a media server either
02:46:51.361 [8408.8620] <2> bpcd main: output socket port number = 1
02:46:51.361 [8408.8620] <2> bpcd main: Duplicated vnetd socket on stderr
02:46:51.361 [8408.8620] <2> bpcd main: <---- NetBackup 6.5 0 ------------initiated
02:46:51.361 [8408.8620] <2> bpcd main: VERBOSE = 0
02:46:51.361 [8408.8620] <2> bpcd exit_bpcd: exit status 46  ----------->exiting
02:46:51.361 [8408.8620] <4> bpcd exit_bpcd: FTL - BPCD EXIT STATUS 46

02:46:51.361 [8408.8620] <16> bpcd main: Server access denied
02:46:51.439 [7236.8728] <2> bpcd main: offset to GMT -3600
02:46:51.454 [7236.8728] <2> bpcd main: Got socket for input 464
02:46:51.454 [7236.8728] <2> logconnections: BPCD ACCEPT FROM 10.213.165.213.3010 TO 10.213.165.213.13724
02:46:51.454 [7236.8728] <2> bpcd main: setup_sockopts complete

But communication is working fine from both ends

Marianne's picture

We see bpbkar starting, but never getting to read actual data.

please suggest further 

We already have.

Please see Mark's post:

It can sometimes help to add that client to the Master Servers client attributes tab then for the open file backups section get it to use VSP - selecting individual drive snapshots and Disable snapshot and continue

Then open the clients host properties - Windows client section - VSP tab and select to customise the cache file - min 120MB, max 500 MB and see if that helps

.... look for errors, disk space issues and even hung bpbkar32 / bpfis errors first on the client 

Have you done this? Have you checked Task Manager on the client?

Please see my post:

Aging Client is probably suffering from bad fragmentation, overloaded, out-of-date NIC drivers and/or firmware, etc...

Get your server owners to perform health check on this machine. Best option will be to migrate to newer hardware and supported OS.
Please also test client's ability to read data from disk. See
http://www.symantec.com/docs/TECH17541

One more suggestion:

Try to disable WOFB in Master server Client Attributes.

PS: If you decide to try bpbkar32 test as per TECH17541, FIRST check Task Manager for hanging bpbkar and/or bpfis processes and end processes if they exist. once done, please copy bpbkar log to bpbkar.txt and post as File attachment.

Supporting Storage Foundation and VCS on Unix and Windows as well as NetBackup on Unix and Windows
Handy NBU Links

Venu_S's picture

Hi Marianne/Mark,

I tried with all the options you suggested but there is no change.

I have reverted the setiings to original and ran the below command 3times each as suggested by Marianne

and attahced the bpbkar log here

 

bpbkar32 -nocont D:\ 1> nul 2> nul

bpbkar32 -nocont C:\ 1> nul 2> nul

 

Waiting for you reply..

AttachmentSize
bpbkar.txt 53.45 KB
Mark_Solutions's picture

Based on your log i have a couple of questions:

Is this server virtual?

Does it have oracle on it?

If the answer to both is yes then it is possible that when starting the backup and its snapshot is called it leverages the VMWare tools and trues to also snapshot the applications on the client.

That may not be possible or take too long so try following this tech note - using option B to edit the tools.conf file: http://www.symantec.com/docs/TECH141518

Also take a good look at what is on that server and if there are live databases etc, set excludes for them before trying the next backup

Let us know if this helps

Authorised Symantec Consultant

Don't forget to "Mark as Solution" if someones advice has solved your issue - and please bring back the Thumbs Up!!.

Venu_S's picture

We have un insatll and re insatll the nbu software and rebooted the client.

Both diff and full backup completed successfully for 1 day.

Aagin backup failing with EC 13 every day.

Every time bpbkar process on client going to hund state once the backup started.

Please help

Marianne's picture

I have nothing else to suggest. Just a repeat of previous suggestion:

Best option will be to migrate to newer hardware and supported OS. 
You can then install supported NBU version.

Supporting Storage Foundation and VCS on Unix and Windows as well as NetBackup on Unix and Windows
Handy NBU Links

Mark_Solutions's picture

You never did answer my questions - is it virtual - does it have Otracle on it?

If so did you try my suggestion relating to the VMWare tools.conf?

Authorised Symantec Consultant

Don't forget to "Mark as Solution" if someones advice has solved your issue - and please bring back the Thumbs Up!!.