Video Screencast Help

SAP redo log backups failing with error code :- 6.

Created: 16 Apr 2013 | 5 comments

 

ob Detail Status :-

==========================================================================

04/17/2013 02:13:18 - requesting resource csbkpms1-hcart3-robot-tld-0

 

04/17/2013 02:13:18 - requesting resource chev1bkp2.NBU_CLIENT.MAXJOBS.cssapd12
04/17/2013 02:13:18 - requesting resource chev1bkp2.NBU_POLICY.MAXJOBS.sgm_dev_sapredolog
04/17/2013 02:13:18 - granted resource  chev1bkp2.NBU_CLIENT.MAXJOBS.cssapd12
04/17/2013 02:13:18 - granted resource  chev1bkp2.NBU_POLICY.MAXJOBS.sgm_dev_sapredolog
04/17/2013 02:13:18 - granted resource  csbkpms1-hcart3-robot-tld-0
04/17/2013 02:13:18 - estimated 0 kbytes needed
04/17/2013 02:13:19 - started process bpbrm (pid=16547)
04/17/2013 02:13:20 - connecting
04/17/2013 02:13:20 - connected; connect time: 0:00:00
04/17/2013 02:13:22 - end writing
the backup failed to back up the requested files (6)
=====================================================
For today backint logs did not create under backint :-
============
[root@cssapd12 - /usr/openv/netbackup/logs/backint ] # pwd
/usr/openv/netbackup/logs/backint
[root@cssapd12 - /usr/openv/netbackup/logs/backint ] # ls -l
total 123968
-rw-rw-rw-   1 orad16     dba        5965851 Apr  1 22:42 log.040113
-rw-rw-rw-   1 orad16     dba        5972250 Apr  2 22:47 log.040213
-rw-rw-rw-   1 orad16     dba        5972129 Apr  3 22:48 log.040313
-rw-rw-rw-   1 orad16     dba        5934623 Apr  4 23:03 log.040413
-rw-rw-rw-   1 orad16     dba        5955221 Apr  6 07:02 log.040513
-rw-rw-rw-   1 orad16     dba         162901 Apr  6 07:58 log.040613
-rw-rw-rw-   1 orad16     dba        1697872 Apr  7 23:36 log.040713
-rw-rw-rw-   1 orad16     dba        5941663 Apr  9 00:04 log.040813
-rw-rw-rw-   1 orad16     dba        6036639 Apr  9 23:45 log.040913
-rw-rw-rw-   1 orad16     dba        5951337 Apr 11 00:06 log.041013
-rw-rw-rw-   1 orad16     dba        5941692 Apr 12 00:26 log.041113
-rw-rw-rw-   1 orad16     dba        5975129 Apr 13 02:39 log.041213
-rw-rw-rw-   1 orad16     dba         171315 Apr 13 18:00 log.041313
-rw-rw-rw-   1 orad16     dba        1650197 Apr 14 18:03 log.041413
-rw-rw-rw-   1 orad16     dba          38992 Apr 15 06:22 log.041513
===============================================================
[root@cssapd12 - /usr/openv/netbackup/logs/backint ] # tail -50 log.041513
06:22:39.680 [24463] <2> get_bids: File </oracle/D16/saparch/archD16.log> in VxBSA_DONE status. No change of status needed.
06:22:39.680 [24463] <2> get_bids: File names did not match!
06:22:39.680 [24463] <2> get_bids: File </oracle/D16/saparch/archD16.log> in VxBSA_DONE status. No change of status needed.
06:22:39.680 [24463] <2> get_bids: File names did not match!
06:22:39.680 [24463] <2> get_bids: File </oracle/D16/saparch/archD16.log> in VxBSA_DONE status. No change of status needed.
06:22:39.680 [24463] <2> get_bids: File names did not match!
06:22:39.680 [24463] <2> get_bids: File </oracle/D16/saparch/archD16.log> in VxBSA_DONE status. No change of status needed.
06:22:39.680 [24463] <2> get_bids: File names did not match!
06:22:39.680 [24463] <2> get_bids: File </oracle/D16/saparch/archD16.log> in VxBSA_DONE status. No change of status needed.
06:22:39.680 [24463] <2> get_bids: File names did not match!
06:22:39.680 [24463] <2> get_bids: File </oracle/D16/saparch/archD16.log> in VxBSA_DONE status. No change of status needed.
06:22:39.680 [24463] <2> get_bids: File names did not match!
06:22:39.680 [24463] <2> get_bids: File </oracle/D16/saparch/archD16.log> in VxBSA_DONE status. No change of status needed.
06:22:39.680 [24463] <2> get_bids: File names did not match!
06:22:39.680 [24463] <2> get_bids: File </oracle/D16/saparch/archD16.log> in VxBSA_DONE status. No change of status needed.
06:22:39.680 [24463] <2> get_bids: File names did not match!
06:22:39.680 [24463] <2> get_bids: File </oracle/D16/saparch/archD16.log> in VxBSA_DONE status. No change of status needed.
06:22:39.680 [24463] <2> get_bids: File names did not match!
06:22:39.680 [24463] <2> get_bids: File </oracle/D16/saparch/archD16.log> in VxBSA_DONE status. No change of status needed.
06:22:39.680 [24463] <2> get_bids: File names did not match!
06:22:39.680 [24463] <2> get_bids: File </oracle/D16/saparch/archD16.log> in VxBSA_DONE status. No change of status needed.
06:22:39.680 [24463] <2> get_bids: File names did not match!
06:22:39.680 [24463] <2> get_bids: File </oracle/D16/saparch/archD16.log> in VxBSA_DONE status. No change of status needed.
06:22:39.680 [24463] <2> get_bids: File names did not match!
06:22:39.680 [24463] <2> get_bids: File </oracle/D16/saparch/archD16.log> in VxBSA_DONE status. No change of status needed.
06:22:39.680 [24463] <2> get_bids: File names did not match!
06:22:39.680 [24463] <2> get_bids: File </oracle/D16/saparch/archD16.log> in VxBSA_DONE status. No change of status needed.
06:22:39.680 [24463] <2> get_bids: File names did not match!
06:22:39.681 [24463] <2> get_bids: File </oracle/D16/saparch/archD16.log> in VxBSA_DONE status. No change of status needed.
06:22:39.681 [24463] <2> get_bids: File names did not match!
06:22:39.681 [24463] <2> get_bids: File </oracle/D16/saparch/archD16.log> in VxBSA_DONE status. No change of status needed.
06:22:39.681 [24463] <2> get_bids: File names did not match!
06:22:39.681 [24463] <2> get_bids: File </oracle/D16/saparch/archD16.log> in VxBSA_DONE status. No change of status needed.
06:22:39.681 [24463] <2> get_bids: File names did not match!
06:22:39.681 [24463] <2> get_bids: File </oracle/D16/saparch/archD16.log> in VxBSA_DONE status. No change of status needed.
06:22:39.681 [24463] <2> get_bids: File names did not match!
06:22:39.681 [24463] <2> get_bids: File </oracle/D16/saparch/archD16.log> in VxBSA_DONE status. No change of status needed.
06:22:39.681 [24463] <2> get_bids: File names did not match!
06:22:39.681 [24463] <2> get_bids: File </oracle/D16/saparch/archD16.log> in VxBSA_DONE status. No change of status needed.
06:22:39.681 [24463] <2> get_bids: File names did not match!
06:22:39.681 [24463] <2> get_bids: File </oracle/D16/saparch/archD16.log> in VxBSA_DONE status. No change of status needed.
06:22:39.681 [24463] <4> report_bids: Entering.
06:22:39.681 [24463] <4> report_bids: #SAVED VXF1365999710 /oracle/D16/102_64/dbs/initD16.ora
06:22:39.681 [24463] <4> report_bids: #SAVED VXF1365999710 /oracle/D16/102_64/dbs/initD16.sap
06:22:39.681 [24463] <4> report_bids: #SAVED VXF1365999710 /oracle/D16/102_64/dbs/initSAPredolog.utl
06:22:39.681 [24463] <4> report_bids: #SAVED VXF1365999710 /oracle/D16/sapreorg/spaceD16.log
06:22:39.681 [24463] <4> report_bids: #SAVED VXF1365999710 /oracle/D16/sapreorg/strucD16.log
06:22:39.681 [24463] <4> report_bids: #SAVED VXF1365999710 /oracle/D16/saparch/aekzfnmg.svd
06:22:39.681 [24463] <4> report_bids: #SAVED VXF1365999710 /oracle/D16/saparch/archD16.log
06:22:39.681 [24463] <4> /usr/sap/D16/SYS/exe/run/backint 6.5: ******************************************************************
============================================================
I have restarted the NB services on client and started the backup again but no result, BAckup failed again with error code :- 6.
---------------
Any help ??
=====================================

BPHDB logs :-

================

 

[root@cssapd12 - /usr/openv/netbackup/logs/bphdb ] # cat log.041713
02:13:33.860 [29041] <2> logparams: -sb -rdbms sap -S chev1bkp2 -to 300 -c sgm_dev_sapredolog -s Every6hours -clnt cssapd12 -FULL -kl 3 -b cssapd12_1366157598 -jobid 709553 
02:13:33.862 [29041] <4> bphdb: INF - setenv SAP_POLICY=sgm_dev_sapredolog
02:13:33.862 [29041] <4> bphdb: INF - setenv SAP_SNC_SCHED=Every6hours
02:13:33.862 [29041] <4> bphdb: INF - setenv SAP_SERVER=chev1bkp2
02:13:33.862 [29041] <4> bphdb: INF - setenv SAP_CLIENT=cssapd12
02:13:33.862 [29041] <4> bphdb: INF - setenv SAP_FULL=1
02:13:33.862 [29041] <4> bphdb: INF - setenv SAP_INCR=0
02:13:33.862 [29041] <4> bphdb: INF - setenv SAP_CINC=0
02:13:33.862 [29041] <4> bphdb: INF - setenv SAP_USER_INITIATED=0
02:13:33.862 [29041] <4> bphdb: INF - setenv SAP_SCHEDULED=1
02:13:33.862 [29041] <4> bphdb: INF - BACKUP START
02:13:33.919 [29041] <4> bphdb: INF - CONTINUE BACKUP message received.
02:13:33.919 [29041] <4> bphdb: INF - Processing /usr/openv/netbackup/sap_oracle_scripts/DEV/sap_redolog
02:13:33.921 [29041] <4> bphdb: INF - bphdb still working.
02:13:33.921 [29041] <4> bphdb: INF - Keepalives will be sent every 150 seconds.
02:13:33.921 [29041] <4> bphdb: INF - Waiting for the child status.
02:13:33.922 [29042] <4> bphdb: INF - Child executing /usr/openv/netbackup/sap_oracle_scripts/DEV/sap_redolog
02:13:34.853 [29041] <16> bphdb: ERR - Script exited with status = 1 <the requested operation was partially successful>
02:13:34.853 [29041] <16> bphdb: ERR - bphdb exit status = 6: the backup failed to back up the requested files
 
02:13:34.854 [29041] <4> bphdb: INF - EXIT STATUS 6: the backup failed to back up the requested files
 
02:23:38.305 [29573] <2> logparams: -sb -rdbms sap -S chev1bkp2 -to 300 -c sgm_dev_sapredolog -s Every6hours -clnt cssapd12 -FULL -kl 3 -b cssapd12_1366158202 -jobid 709553 
02:23:38.307 [29573] <4> bphdb: INF - setenv SAP_POLICY=sgm_dev_sapredolog
02:23:38.307 [29573] <4> bphdb: INF - setenv SAP_SNC_SCHED=Every6hours
02:23:38.307 [29573] <4> bphdb: INF - setenv SAP_SERVER=chev1bkp2
02:23:38.307 [29573] <4> bphdb: INF - setenv SAP_CLIENT=cssapd12
02:23:38.307 [29573] <4> bphdb: INF - setenv SAP_FULL=1
02:23:38.307 [29573] <4> bphdb: INF - setenv SAP_INCR=0
02:23:38.307 [29573] <4> bphdb: INF - setenv SAP_CINC=0
02:23:38.307 [29573] <4> bphdb: INF - setenv SAP_USER_INITIATED=0
02:23:38.307 [29573] <4> bphdb: INF - setenv SAP_SCHEDULED=1
02:23:38.307 [29573] <4> bphdb: INF - BACKUP START
02:23:38.367 [29573] <4> bphdb: INF - CONTINUE BACKUP message received.
02:23:38.368 [29573] <4> bphdb: INF - Processing /usr/openv/netbackup/sap_oracle_scripts/DEV/sap_redolog
02:23:38.369 [29573] <4> bphdb: INF - bphdb still working.
02:23:38.369 [29573] <4> bphdb: INF - Keepalives will be sent every 150 seconds.
02:23:38.369 [29573] <4> bphdb: INF - Waiting for the child status.
02:23:38.370 [29574] <4> bphdb: INF - Child executing /usr/openv/netbackup/sap_oracle_scripts/DEV/sap_redolog
02:23:39.305 [29573] <16> bphdb: ERR - Script exited with status = 1 <the requested operation was partially successful>
02:23:39.305 [29573] <16> bphdb: ERR - bphdb exit status = 6: the backup failed to back up the requested files
 
02:23:39.305 [29573] <4> bphdb: INF - EXIT STATUS 6: the backup failed to back up the requested files
========================================
 
Any help ??

 

Operating Systems:

Comments 5 CommentsJump to latest comment

Nicolai's picture

Check host names in bp.conf and .util files. They must match - e.g srv1 and srv1.acme.com is not the same  server in Netbackup term.

Netbackup uses bplist to ensure files names in the files list actual are present in the backup images. Maybe enable the bplist folder in /usr/openv/netbackup/logs will give you a additional clue.

Assumption is the mother of all mess ups.

If this post answered your'e qustion -  Please mark as a soloution.

Dyneshia's picture
If the above does not work, upload : 
bpbkar
bphdb
backint
bpcd
jim dalton's picture

and increase verbosity please, the logs are usually very helpful but you might also need a SAP (+ whatever Db its running with) resource to get to the bottom of it.

Jim

Mack Disouza's picture

Backup Successful after installing the BR tools by SAP team.