cancel
Showing results for 
Search instead for 
Did you mean: 

Error while running redolog backup from DB13

Former Member
0 Kudos

Error while running redolog backup from DB13


BR0002I BRARCHIVE 7.20 (23)
BR0006I Start of offline redolog processing: aemonejw.cds 2013-11-19 08.45.28
BR0484I BRARCHIVE log file: /oracle/SID/112_64/saparch/aemonejw.cds
BR0477I Oracle pfile /oracle/SID/112_64/dbs/initSID.ora created from spfile /oracle/SID/112_64/dbs/spfileSID.ora

BR0101I Parameters

Name                           Value

oracle_sid                     SID
oracle_home                    /oracle/SID/112_64
oracle_profile                 /oracle/SID/112_64/dbs/initSID.ora
sapdata_home                   /oracle/SID/112_64
sap_profile                    /oracle/SID/112_64/dbs/initSID.sap
backup_dev_type                util_file
util_par_file                  /oracle/SID/112_64/dbs/initSID.utl
archive_dupl_del               only
system_info                    dm6adm/dm6adm cpliqpp3 Linux 2.6.32-358.14.1.el6.x86_64 #1 SMP Mon Jun 17 15:54:20 EDT 2013 x86_64
oracle_info                    SID 11.2.0.3.0 8192 585 11526215 cpliqpp3 AL32UTF8 AL16UTF16 125489198 &SID
sap_info                       SAPSR3
make_info                      linuxx86_64 OCI_102 Apr  2 2012
command_line                   brarchive -jid LOG__20131119084527 -u / -sid SID -c force -p initSID.sap -cds

BR0280I BRARCHIVE time stamp: 2013-11-19 08.45.31
BR0008I Offline redolog processing for database instance: SID
BR0009I BRARCHIVE action ID: aemonejw
BR0010I BRARCHIVE function ID: cds
BR0048I Archive function: copy_delete_save
BR0011I 18 offline redolog files found for processing, total size 642.070 MB
BR0130I Backup device type: util_file
BR0109I Files will be saved by backup utility at file level
BR0134I Unattended mode with 'force' active - no operator confirmation allowed

BR0280I BRARCHIVE time stamp: 2013-11-19 08.45.31
BR0229I Calling backup utility with function 'backup'...
BR0278I Command output of '/usr/sap/DM6/SYS/exe/run/backint -u SID -f backup -i /oracle/SID/112_64/saparch/.aemonejw.lst -t file -p /oracle/SID/112_64/dbs/initSID.utl -c':

                        Data Protection for SAP(R)

            Interface between BR*Tools and Tivoli Storage Manager
            - Version 6, Release 3, Modification 0.0  for Linux x86_64 -
                  Build: 475X  compiled on Sep 22 2011
       (c) Copyright IBM Corporation, 1996, 2011, All Rights Reserved.

BKI2027I: Using TSM-API version 6.3.0.5 (compiled with 5.5.0.0).
BKI2000I: Successfully connected to ProLE on port tdpr3ora64.
BKI0005I: Start of program at: Tue 19 Nov 2013 08:45:31 AM EST.


-- Parameters --
Input File            : /oracle/SID/112_64/saparch/.aemonejw.lst
Profile               : /oracle/SID/112_64/dbs/initSID.utl
Configfile            : /oracle/SID/112_64/dbs/initSID.bki
Manual sorting file   : disabled
Tracefile             : disabled
Traceflags            : disabled
Parallel sessions     : 1
Multiplexed files     : 1
RL compression        : 0
Exit on error         : disabled
BATCH                 : enabled
Buffer size           : 131072
Buffer Copy Mode      : SIMPLE
Redologcopies         : 1
Versioning            : disabled
Backup Type           : unknown
TSM log server        : disabled
TSM server            : CPLIQPP3_SAP with 2 sessions configured, using 1 session
TSM client node      :
Days for backup      : Sun Mon Tue Wed Thu Fri Sat
Backup mgmt class    : DEFMGMT_CLASS
Archive mgmt class   : DEFMGMT_CLASS


BKI2017I: Blocksize is set to 131072 bytes
BKI0032E: Error opening file /oracle/SID/oraarch/1_567_826007280.dbf: Permission denied
BKI1230E: The following file was not processed: /oracle/SID/oraarch/1_567_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/SID/oraarch/1_567_826007280.dbf
BR0278E Command output of '/usr/sap/DM6/SYS/exe/run/backint -u SID -f backup -i /oracle/SID/112_64/saparch/.aemonejw.lst -t file -p /oracle/SID/112_64/dbs/initSID.utl -c':
BKI1230E: The following file was not processed: /oracle/SID/oraarch/1_568_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/SID/oraarch/1_568_826007280.dbf
BKI1230E: The following file was not processed: /oracle/SID/oraarch/1_569_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/SID/oraarch/1_569_826007280.dbf
BKI1230E: The following file was not processed: /oracle/SID/oraarch/1_570_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/SID/oraarch/1_570_826007280.dbf
BKI1230E: The following file was not processed: /oracle/SID/oraarch/1_571_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/SID/oraarch/1_571_826007280.dbf
BKI1230E: The following file was not processed: /oracle/SID/oraarch/1_572_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/SID/oraarch/1_572_826007280.dbf
BKI1230E: The following file was not processed: /oracle/SID/oraarch/1_573_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/SID/oraarch/1_573_826007280.dbf
BKI1230E: The following file was not processed: /oracle/SID/oraarch/1_574_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/SID/oraarch/1_574_826007280.dbf
BKI1230E: The following file was not processed: /oracle/SID/oraarch/1_575_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/SID/oraarch/1_575_826007280.dbf
BKI1230E: The following file was not processed: /oracle/SID/oraarch/1_576_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/SID/oraarch/1_576_826007280.dbf
BKI1230E: The following file was not processed: /oracle/SID/oraarch/1_577_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/SID/oraarch/1_577_826007280.dbf
BKI1230E: The following file was not processed: /oracle/SID/oraarch/1_578_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/SID/oraarch/1_578_826007280.dbf
BKI1230E: The following file was not processed: /oracle/SID/oraarch/1_579_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/SID/oraarch/1_579_826007280.dbf
BKI1230E: The following file was not processed: /oracle/SID/oraarch/1_580_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/SID/oraarch/1_580_826007280.dbf
BKI1230E: The following file was not processed: /oracle/SID/oraarch/1_581_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/SID/oraarch/1_581_826007280.dbf
BKI1230E: The following file was not processed: /oracle/SID/oraarch/1_582_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/SID/oraarch/1_582_826007280.dbf
BKI1230E: The following file was not processed: /oracle/SID/oraarch/1_583_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/SID/oraarch/1_583_826007280.dbf
BKI1230E: The following file was not processed: /oracle/SID/oraarch/1_584_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/SID/oraarch/1_584_826007280.dbf
BKI1215I: Average transmission rate was 0.000 GB/h (0.000 MB/sec).
BKI1227I: Average compression factor was 1.000.
BKI0020I: End of program at: Tue 19 Nov 2013 08:45:39 AM EST.
BKI0021I: Elapsed time: 08 sec.
BKI0024I: Return code is: 2.

BR0280I BRARCHIVE time stamp: 2013-11-19 08.45.39
BR0279E Return code from '/usr/sap/DM6/SYS/exe/run/backint -u SID -f backup -i /oracle/SID/112_64/saparch/.aemonejw.lst -t file -p /oracle/SID/112_64/dbs/initSID.utl -c': 2

BR0232E 0 of 18 files saved by backup utility
BR0280I BRARCHIVE time stamp: 2013-11-19 08.45.39
BR0231E Backup utility call failed

BR0016I 0 offline redolog files processed, total size 0.000 MB

BR0007I End of offline redolog processing: aemonejw.cds 2013-11-19 08.45.39
BR0280I BRARCHIVE time stamp: 2013-11-19 08.45.39
BR0005I BRARCHIVE terminated with errors

checked the sticky bit setting for brtools

-rwsrwxr-x 1 oraSID sapsys 6466617 Aug 21  2012 brarchive
-rwsrwxr-x 1 oraSID sapsys 6596893 Aug 21  2012 brbackup
-rwsrwxr-x 1 oraSID sapsys 8418234 Aug 21  2012 brconnect
-rwxr-xr-x 1 SIDadm sapsys 7043091 Aug 21  2012 brrecover
-rwxr-xr-x 1 SIDadm sapsys 2398807 Aug 21  2012 brrestore
-rwxr-xr-x 1 SIDadm sapsys 8856765 Aug 21  2012 brspace
-rwsrwxr-x 1 SIDadm sapsys 3279960 Aug 21  2012 brtools


But the file permissions in oraarch are as below.

-rw-r----- 1 oraSID dba  28239872 Nov 18 10:09 1_567_826007280.dbf
-rw-r----- 1 oraSID dba  41085440 Nov 18 14:00 1_568_826007280.dbf
-rw-r----- 1 oraSID dba  41085440 Nov 18 14:00 1_569_826007280.dbf
-rw-r----- 1 oraSID dba  41085440 Nov 18 16:00 1_570_826007280.dbf
-rw-r----- 1 oraSID dba  37042176 Nov 18 16:00 1_571_826007280.dbf
-rw-r----- 1 oraSID dba  41707520 Nov 18 18:00 1_572_826007280.dbf
-rw-r----- 1 oraSID dba  41085440 Nov 18 18:00 1_573_826007280.dbf
-rw-r----- 1 oraSID dba  41085440 Nov 18 20:00 1_574_826007280.dbf
-rw-r----- 1 oraSID dba  41085440 Nov 18 20:00 1_575_826007280.dbf
-rw-r----- 1 oraSID dba  28259840 Nov 18 21:01 1_576_826007280.dbf
-rw-r----- 1 oraSID dba  43183616 Nov 18 22:00 1_577_826007280.dbf
-rw-r----- 1 oraSID dba  31368192 Nov 18 22:00 1_578_826007280.dbf
-rw-r----- 1 oraSID dba  44175872 Nov 18 22:00 1_579_826007280.dbf
-rw-r----- 1 oraSID dba  29386240 Nov 18 22:09 1_580_826007280.dbf
-rw-r----- 1 oraSID dba  34818560 Nov 19 00:00 1_581_826007280.dbf
-rw-r----- 1 oraSID dba  41085440 Nov 19 00:01 1_582_826007280.dbf
-rw-r----- 1 oraSID dba  35398144 Nov 19 02:00 1_583_826007280.dbf
-rw-r----- 1 oraSID dba  32081408 Nov 19 06:00 1_584_826007280.dbf


this is MDM environment
BRTOOLS are explicitly installed.

Please let us know how to solve this issue.

Accepted Solutions (0)

Answers (2)

Answers (2)

fidel_vales
Employee
Employee
0 Kudos

the error is given by the backint program not by the BR*TOOLS therefore you must review the configuration of those external programs

Former Member
0 Kudos

Check owner and s-bit of backint program as well.

Former Member
0 Kudos

Hello Josef,

Even after applying the s bit for backint and backfm the issue was not solved.

Former Member
0 Kudos

For cleariication:

Which backint are you referring to?
I know there is more than one, from
http://scn.sap.com/thread/3457323

I am referring to the one in /opt/tivoli/tsm/tdp_r3/ora64/

Former Member
0 Kudos

Yeah Josef,

I am also referring to the same backint in /opt/tivoli/tsm/tdp_r3/ora64

Former Member
0 Kudos

So one more check please:

Try from OS prompt, both as user orasid and as user sidadm.

If one fails, we can investigate further.

If both work, then it will definitely be a problem with TSM configuration, and this will not be a question for an Oracle forum.

(I am not famliar with Tivoli, sorry.)

Former Member
0 Kudos

Please provide output of ls -l for backint.

Former Member
0 Kudos

Hello Josef,

It works on both orasid and sidadm.

Actually the Db13 is being run from other server which connects to this server with a gateway with different SIDadm user.

Former Member
0 Kudos

The output as you asked

$ pwd

/opt/tivoli/tsm/tdp_r3/ora64

$ ls -l backint

-rwsrwxr-x 1 root root 11675969 Sep 30  2011 backint

Former Member
0 Kudos

chmod 775 backint

(clear s-bit) and try again.

Former Member
0 Kudos

Dear Roman,

Still same issue.

Former Member
0 Kudos

Can you provide new log file?

Former Member
0 Kudos

BR0002I BRARCHIVE 7.20 (23)
BR0006I Start of offline redolog processing: aemortfd.cds 2013-11-20 07.04.09
BR0484I BRARCHIVE log file: /oracle/OD1/112_64/saparch/aemortfd.cds
BR0477I Oracle pfile /oracle/OD1/112_64/dbs/initOD1.ora created from spfile /oracle/OD1/112_64/dbs/spfileOD1.ora

BR0101I Parameters

Name                           Value

oracle_sid                     OD1
oracle_home                    /oracle/OD1/112_64
oracle_profile                 /oracle/OD1/112_64/dbs/initOD1.ora
sapdata_home                   /oracle/OD1/112_64
sap_profile                    /oracle/OD1/112_64/dbs/initOD1.sap
backup_dev_type                util_file
util_par_file                  /oracle/OD1/112_64/dbs/initOD1.utl
archive_dupl_del               only
system_info                    OD2adm/OD2adm hostname Linux 2.6.32-358.14.1.el6.x86_64 #1 SMP Mon Jun 17 15:54:20 EDT 2013 x86_64
oracle_info                    OD1 11.2.0.3.0 8192 591 11754080 hostname AL32UTF8 AL16UTF16 125489198 &OD1
sap_info                       SAPSR3
make_info                      linuxx86_64 OCI_102 Apr  2 2012
command_line                   brarchive -jid LOG__20131120070408 -u / -sid OD1 -c force -p initOD1.sap -cds

BR0280I BRARCHIVE time stamp: 2013-11-20 07.04.11
BR0008I Offline redolog processing for database instance: OD1
BR0009I BRARCHIVE action ID: aemortfd
BR0010I BRARCHIVE function ID: cds
BR0048I Archive function: copy_delete_save
BR0011I 24 offline redolog files found for processing, total size 803.535 MB
BR0130I Backup device type: util_file
BR0109I Files will be saved by backup utility at file level
BR0134I Unattended mode with 'force' active - no operator confirmation allowed

BR0280I BRARCHIVE time stamp: 2013-11-20 07.04.11
BR0229I Calling backup utility with function 'backup'...
BR0278I Command output of '/usr/sap/OD2/SYS/exe/run/backint -u OD1 -f backup -i /oracle/OD1/112_64/saparch/.aemortfd.lst -t file -p /oracle/OD1/112_64/dbs/initOD1.utl -c':

                        Data Protection for SAP(R)

            Interface between BR*Tools and Tivoli Storage Manager
            - Version 6, Release 3, Modification 0.0  for Linux x86_64 -
                  Build: 475X  compiled on Sep 22 2011
       (c) Copyright IBM Corporation, 1996, 2011, All Rights Reserved.

BKI2027I: Using TSM-API version 6.3.0.5 (compiled with 5.5.0.0).
BKI2000I: Successfully connected to ProLE on port tdpr3ora64.
BKI0005I: Start of program at: Wed 20 Nov 2013 07:04:11 AM EST.


-- Parameters --
Input File            : /oracle/OD1/112_64/saparch/.aemortfd.lst
Profile               : /oracle/OD1/112_64/dbs/initOD1.utl
Configfile            : /oracle/OD1/112_64/dbs/initOD1.bki
Manual sorting file   : disabled
Tracefile             : disabled
Traceflags            : disabled
Parallel sessions     : 1
Multiplexed files     : 1
RL compression        : 0
Exit on error         : disabled
BATCH                 : enabled
Buffer size           : 131072
Buffer Copy Mode      : SIMPLE
Redologcopies         : 1
Versioning            : disabled
Backup Type           : unknown
TSM log server        : disabled
TSM server            : hostname_SAP with 2 sessions configured, using 1 session
TSM client node      :
Days for backup      : Sun Mon Tue Wed Thu Fri Sat
Backup mgmt class    : DEFMGMT_CLASS
Archive mgmt class   : DEFMGMT_CLASS


BKI2017I: Blocksize is set to 131072 bytes
BKI0032E: Error opening file /oracle/OD1/oraarch/1_567_826007280.dbf: Permission denied
BKI1230E: The following file was not processed: /oracle/OD1/oraarch/1_567_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/OD1/oraarch/1_567_826007280.dbf
BR0278E Command output of '/usr/sap/OD2/SYS/exe/run/backint -u OD1 -f backup -i /oracle/OD1/112_64/saparch/.aemortfd.lst -t file -p /oracle/OD1/112_64/dbs/initOD1.utl -c':
BKI1230E: The following file was not processed: /oracle/OD1/oraarch/1_568_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/OD1/oraarch/1_568_826007280.dbf
BKI1230E: The following file was not processed: /oracle/OD1/oraarch/1_569_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/OD1/oraarch/1_569_826007280.dbf
BKI1230E: The following file was not processed: /oracle/OD1/oraarch/1_570_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/OD1/oraarch/1_570_826007280.dbf
BKI1230E: The following file was not processed: /oracle/OD1/oraarch/1_571_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/OD1/oraarch/1_571_826007280.dbf
BKI1230E: The following file was not processed: /oracle/OD1/oraarch/1_572_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/OD1/oraarch/1_572_826007280.dbf
BKI1230E: The following file was not processed: /oracle/OD1/oraarch/1_573_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/OD1/oraarch/1_573_826007280.dbf
BKI1230E: The following file was not processed: /oracle/OD1/oraarch/1_574_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/OD1/oraarch/1_574_826007280.dbf
BKI1230E: The following file was not processed: /oracle/OD1/oraarch/1_575_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/OD1/oraarch/1_575_826007280.dbf
BKI1230E: The following file was not processed: /oracle/OD1/oraarch/1_576_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/OD1/oraarch/1_576_826007280.dbf
BKI1230E: The following file was not processed: /oracle/OD1/oraarch/1_577_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/OD1/oraarch/1_577_826007280.dbf
BKI1230E: The following file was not processed: /oracle/OD1/oraarch/1_578_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/OD1/oraarch/1_578_826007280.dbf
BKI1230E: The following file was not processed: /oracle/OD1/oraarch/1_579_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/OD1/oraarch/1_579_826007280.dbf
BKI1230E: The following file was not processed: /oracle/OD1/oraarch/1_580_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/OD1/oraarch/1_580_826007280.dbf
BKI1230E: The following file was not processed: /oracle/OD1/oraarch/1_581_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/OD1/oraarch/1_581_826007280.dbf
BKI1230E: The following file was not processed: /oracle/OD1/oraarch/1_582_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/OD1/oraarch/1_582_826007280.dbf
BKI1230E: The following file was not processed: /oracle/OD1/oraarch/1_583_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/OD1/oraarch/1_583_826007280.dbf
BKI1230E: The following file was not processed: /oracle/OD1/oraarch/1_584_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/OD1/oraarch/1_584_826007280.dbf
BKI1230E: The following file was not processed: /oracle/OD1/oraarch/1_585_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/OD1/oraarch/1_585_826007280.dbf
BKI1230E: The following file was not processed: /oracle/OD1/oraarch/1_586_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/OD1/oraarch/1_586_826007280.dbf
BKI1230E: The following file was not processed: /oracle/OD1/oraarch/1_587_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/OD1/oraarch/1_587_826007280.dbf
BKI1230E: The following file was not processed: /oracle/OD1/oraarch/1_588_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/OD1/oraarch/1_588_826007280.dbf
BKI1230E: The following file was not processed: /oracle/OD1/oraarch/1_589_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/OD1/oraarch/1_589_826007280.dbf
BKI1230E: The following file was not processed: /oracle/OD1/oraarch/1_590_826007280.dbf.

BR0233E Backup utility has reported an error while saving file /oracle/OD1/oraarch/1_590_826007280.dbf
BKI1215I: Average transmission rate was 0.000 GB/h (0.000 MB/sec).
BKI1227I: Average compression factor was 1.000.
BKI0020I: End of program at: Wed 20 Nov 2013 07:04:19 AM EST.
BKI0021I: Elapsed time: 08 sec.
BKI0024I: Return code is: 2.

BR0280I BRARCHIVE time stamp: 2013-11-20 07.04.19
BR0279E Return code from '/usr/sap/OD2/SYS/exe/run/backint -u OD1 -f backup -i /oracle/OD1/112_64/saparch/.aemortfd.lst -t file -p /oracle/OD1/112_64/dbs/initOD1.utl -c': 2

BR0232E 0 of 24 files saved by backup utility
BR0280I BRARCHIVE time stamp: 2013-11-20 07.04.19
BR0231E Backup utility call failed

BR0016I 0 offline redolog files processed, total size 0.000 MB

BR0007I End of offline redolog processing: aemortfd.cds 2013-11-20 07.04.19
BR0280I BRARCHIVE time stamp: 2013-11-20 07.04.19
BR0005I BRARCHIVE terminated with errors

Former Member
0 Kudos

Here OD1 is the actual SID and

OD2 is the gateway.

Former Member
0 Kudos

What installation type you have?

Former Member
0 Kudos

This is MDM environment.

OD1 is the actual SID

OD2 is the gateway userID with which the solmon speaks to the OD1 environment.

Please let me know if you need more info.

Former Member
0 Kudos

Hi,

These file permissions of yours:

rw-r----- 1 oraSID dba  28239872 Nov 18 10:09 1_567_826007280.dbf

-rw-r----- 1 oraSID dba  41085440 Nov 18 14:00 1_568_826007280.dbf

-rw-r----- 1 oraSID dba  41085440 Nov 18 14:00 1_569_826007280.dbf


is oraSID actually oraod1 or oraod2 ??


Also in kernel directory a root user execute .saproot.sh OD1  and ./oraroot.sh OD1


Please revert and advise.