TDP for Oracle restore error ANS1314E File data currently unavailable on server?

hungng89

hungng89

ADSM.ORG Member
Joined
May 25, 2010
Messages
115
Reaction score
2
Points
0
Location
VietNam
HI Everyone

I have installed tdp for oracle version 5.4.1.0 on sun solaris sparc 5.10

The backup is ok via 2 tape channel

Code: 
------- ---- -- ---------- ----------- ------------ ---------------
11966   Full    110.50G    SBT_TAPE    00:25:54     08-APR-11      
        BP Key: 13024   Status: AVAILABLE  Compressed: NO  Tag: TAG20110408T105111
        Handle: bem98k4v_1_1   Media: 
  List of Datafiles in backup set 11966
  File LV Type Ckp SCN    Ckp Time  Name
  ---- -- ---- ---------- --------- ----
  1       Full 9302022167524 08-APR-11 +DATA/goldprd/datafile/system.270.747494783
  3       Full 9302022167524 08-APR-11 +DATA/goldprd/datafile/sysaux.263.747492175
  4       Full 9302022167524 08-APR-11 +DATA/goldprd/datafile/undotbs1.274.747495549
  6       Full 9302022167524 08-APR-11 +DATA/goldprd/datafile/bkpdata.271.747495029
  8       Full 9302022167524 08-APR-11 +DATA/goldprd/datafile/prddata.284.747492175
  9       Full 9302022167524 08-APR-11 +DATA/goldprd/datafile/cardata.290.747492169
  11      Full 9302022167524 08-APR-11 +DATA/goldprd/datafile/prdind.259.747492175
  12      Full 9302022167524 08-APR-11 +DATA/goldprd/datafile/users.268.747494173
  13      Full 9302022167524 08-APR-11 +DATA/goldprd/datafile/stodata.291.747492167
  15      Full 9302022167524 08-APR-11 +DATA/goldprd/datafile/extidx.267.747494159
  21      Full 9302022167524 08-APR-11 +DATA/goldprd/datafile/raoind.287.747492173
  22      Full 9302022167524 08-APR-11 +DATA/goldprd/datafile/usrdata.285.747492173
  37      Full 9302022167524 08-APR-11 +DATA/goldprd/datafile/undotbs4.293.747492165

BS Key  Type LV Size       Device Type Elapsed Time Completion Time
------- ---- -- ---------- ----------- ------------ ---------------
11968   Full    111.20G    SBT_TAPE    01:02:33     08-APR-11      
        BP Key: 13026   Status: AVAILABLE  Compressed: NO  Tag: TAG20110408T105111
        Handle: bfm98k4v_1_1   Media: 
  List of Datafiles in backup set 11968
  File LV Type Ckp SCN    Ckp Time  Name
  ---- -- ---- ---------- --------- ----
  2       Full 9302022167524 08-APR-11 +DATA/goldprd/datafile/undotbs2.273.747495499
  5       Full 9302022167524 08-APR-11 +DATA/goldprd/datafile/users.265.747493915
  10      Full 9302022167524 08-APR-11 +DATA/goldprd/datafile/carind.286.747492173
  14      Full 9302022167524 08-APR-11 +DATA/goldprd/datafile/stoind.292.747492167
  16      Full 9302022167524 08-APR-11 +DATA/goldprd/datafile/sysaud.272.747495427
  17      Full 9302022167524 08-APR-11 +DATA/goldprd/datafile/parind1.269.747494707
  18      Full 9302022167524 08-APR-11 +DATA/goldprd/datafile/parind2.266.747494041
  19      Full 9302022167524 08-APR-11 +DATA/goldprd/datafile/parind3.264.747492175
  20      Full 9302022167524 08-APR-11 +DATA/goldprd/datafile/raodata.289.747492169
  23      Full 9302022167524 08-APR-11 +DATA/goldprd/datafile/usrind.262.747492175
  24      Full 9302022167524 08-APR-11 +DATA/goldprd/datafile/perfstat.288.747492171
  26      Full 9302022167524 08-APR-11 +DATA/goldprd/datafile/extdat.283.747492175
  36      Full 9302022167524 08-APR-11 +DATA/goldprd/datafile/undotbs3.294.747492165

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

After that i tried to restore via 2 channel
Code: 
run { 
allocate channel t1 type 'sbt_tape' parms 'ENV=(TDPO_OPTFILE=/opt/tivoli/tsm/client/oracle/bin64/tdpo.opt)'; 
allocate channel t2 type 'sbt_tape' parms 'ENV=(TDPO_OPTFILE=/opt/tivoli/tsm/client/oracle/bin64/tdpo.opt)';
restore database from tag="TAG20110407T144857";
release channel t1;
release channel t2;
}

The problem appears

Code: 
root@golddb03 # cat tdpoerror.log
04/08/11   14:10:12 TID<29255> ==> ANS1314E (RC14)   File data currently unavailable on server

/11   16:10:33 ANS1088E File space '' does not exist
04/07/11   16:10:33 ANS1088E File space '' does not exist
04/07/11   17:05:25 ANS4994S TDP Oracle SUN ANU0599 TDP for Oracle: (21122): =>(GOLDDB03_ORA) ANU2602E The object /adsmorc//c-2812138182-20110407-01 was not found on the TSM Server
04/07/11   18:27:13 ANS4994S TDP Oracle SUN ANU0599 TDP for Oracle: (21122): =>(GOLDDB03_ORA) ANU2602E The object /adsmorc//c-2812138182-20110407-02 was not found on the TSM Server
04/08/11   11:53:54 ANS4994S TDP Oracle SUN ANU0599 TDP for Oracle: (27893): =>(GOLDDB03_ORA) ANU2602E The object /adsmorc//c-2812138182-20110408-01 was not found on the TSM Server
04/08/11   14:09:32 ANS1314E File data currently unavailable on server
04/08/11   14:10:12 ANS1314E File data currently unavailable on server

I wonder what happened to my tsm server , it newly created and only for supporting oracle .
The oracle tdp can backup successfully , backup and restore via TCPIP.
The volume acc is read write .
The server and the database host can ping eachother?

THis is the first time i encounter this error , beside that ibm redbook for oracle tdp didn't mention any clearly example about restoring oracle database.

Hope to see any one advices.
Thanks and best regards.
 
Hi,

all the tdpoerror.log messages are irrelevant - except the last two (ANS1314E File data currently unavailable on server) - and they won't help you. You need to look in the server activity log. (show us)

Harry
 
HI Harry
I think i should post the command i used to backup oracle database i get it from my dba
Code: 
run {  allocate channel t1 type 'sbt_tape' parms 'ENV=(TDPO_OPTFILE=/opt/tivoli/tsm/client/oracle/bin64/tdpo.opt)';  allocate channel t2 type 'sbt_tape' parms 'ENV=(TDPO_OPTFILE=/opt/tivoli/tsm/client/oracle/bin64/tdpo.opt)'; backup database include current controlfile;[FONT=Courier New] }[/FONT]
But if i use Oracle command to backup a single table space ex: users
I can restore successfully via TDP for oracle .

I think there may be config problem in oracle ?

I wonder where do RMAN store information about location of the backup

When we restore , the location backup inventory file of it will be replace by the older version ( which don't know where the backup data is ) , and than it can't not restore any further. Sorry that i don't have much knowledge of rman to describe exactly what i think

Below is the actlog
Code: 
 [FONT=&quot]04/08/2011 02:17:29      ANR8379I Mount point in device class LTO5 is waiting for  [/FONT]
  [FONT=&quot]                          the volume mount to complete, status: WAITING FOR VOLUME.[/FONT]
  [FONT=&quot]                          (SESSION: 376)                                           [/FONT]
  [FONT=&quot]04/08/2011 02:17:29      ANR8334I         2 matches found. (SESSION: 376)          [/FONT]
  [FONT=&quot]04/08/2011 02:17:30      ANR2017I Administrator ADMIN issued command: QUERY VOLUME [/FONT]
  [FONT=&quot]                          (SESSION: 376)                                           [/FONT]
  [FONT=&quot]04/08/2011 02:17:41      ANR2017I Administrator ADMIN issued command: QUERY MOUNT  [/FONT]
  [FONT=&quot]                          (SESSION: 376)                                           [/FONT]
  [FONT=&quot]04/08/2011 02:17:41      ANR8330I LTO volume 130AALL5 is mounted R/W in drive BI1  [/FONT]
  [FONT=&quot]                          (\\.\TAPE0), status: IN USE. (SESSION: 376)              [/FONT]
  [FONT=&quot]04/08/2011 02:17:41      ANR8379I Mount point in device class LTO5 is waiting for  [/FONT]
  [FONT=&quot]                          the volume mount to complete, status: WAITING FOR VOLUME.[/FONT]
  [FONT=&quot]                          (SESSION: 376)                                           [/FONT]
  [FONT=&quot]04/08/2011 02:17:41      ANR8334I         2 matches found. (SESSION: 376)          [/FONT]
  [FONT=&quot]04/08/2011 02:17:42      ANR2017I Administrator ADMIN issued command: QUERY SESSION[/FONT]
  [FONT=&quot]                           (SESSION: 376)                                          [/FONT]
  [FONT=&quot]04/08/2011 02:17:45      ANR2017I Administrator ADMIN issued command: QUERY VOLUME [/FONT]
  [FONT=&quot]                          (SESSION: 376)                                           [/FONT]
  [FONT=&quot]04/08/2011 02:17:46      ANR2017I Administrator ADMIN issued command: QUERY SESSION[/FONT]
  [FONT=&quot]                           (SESSION: 376)                                          [/FONT]
  [FONT=&quot]04/08/2011 02:21:23      ANR8779E Unable to open drive \\.\TAPE3, error number=    [/FONT]
  [FONT=&quot]                          68676. (SESSION: 377)                                    [/FONT]
  [FONT=&quot]04/08/2011 02:21:23      ANR8779E Unable to open drive \\.\TAPE3, error number=    [/FONT]
  [FONT=&quot]                          68676. (SESSION: 377)                                    [/FONT]
  [FONT=&quot]04/08/2011 02:21:58      ANR8381E LTO volume 131AALL5 could not be mounted in drive[/FONT]
  [FONT=&quot]                          BI4 (\\.\TAPE3). (SESSION: 377)                          [/FONT]
  [FONT=&quot]04/08/2011 02:21:58      ANR1401W Mount request denied for volume 131AALL5 - mount [/FONT]
  [FONT=&quot]                          failed. (SESSION: 377)                                   [/FONT]
  [FONT=&quot]04/08/2011 02:22:38      ANR8337I LTO volume 132AALL5 mounted in drive BI2         [/FONT]
  [FONT=&quot]                          (\\.\TAPE1). (SESSION: 377)                              [/FONT]
  [FONT=&quot]04/08/2011 02:22:43      ANR0511I Session 377 opened output volume 132AALL5.       [/FONT]
  [FONT=&quot]                          (SESSION: 377)                                           [/FONT]
  [FONT=&quot]04/08/2011 02:26:09      ANE4991I (Session: 377, Node: GOLDDB03_ORA)  TDP Oracle   [/FONT]
  [FONT=&quot]                          SUN ANU0599  TDP for Oracle: (799): =>(GOLDDB03_ORA)     [/FONT]
  [FONT=&quot]                          ANU2535I File /adsmorc//c0m999lr_1_1 = 20961820672 bytes [/FONT]
  [FONT=&quot]                          sent (SESSION: 377)                                      [/FONT]
  [FONT=&quot]04/08/2011 02:26:09      ANR0514I Session 377 closed volume 132AALL5. (SESSION:    [/FONT]
  [FONT=&quot]                          377)                                                     [/FONT]
  [FONT=&quot]04/08/2011 02:26:09      ANR0403I Session 377 ended for node GOLDDB03_ORA (TDP     [/FONT]
  [FONT=&quot]                          Oracle SUN). (SESSION: 377)                              [/FONT]
  [FONT=&quot]04/08/2011 02:26:14      ANR0406I Session 380 started for node GOLDDB03_ORA (TDP   [/FONT]
  [FONT=&quot]                          Oracle SUN) (Tcp/Ip 192.168.100.121(51437)). (SESSION:   [/FONT]
  [FONT=&quot]                          380)                                                     [/FONT]
  [FONT=&quot]04/08/2011 02:26:14      ANR0403I Session 380 ended for node GOLDDB03_ORA (TDP     [/FONT]
  [FONT=&quot]                          Oracle SUN). (SESSION: 380)                              [/FONT]
  [FONT=&quot]04/08/2011 02:32:49      ANR0482W Session 376 for node ADMIN (WinNT) terminated -  [/FONT]
  [FONT=&quot]                          idle for more than 15 minutes. (SESSION: 376)            [/FONT]
  [FONT=&quot]04/08/2011 02:43:23      ANR0407I Session 382 started for administrator            [/FONT]
  [FONT=&quot]                          ADMIN_CENTER (DSMAPI) (Tcp/Ip WIN-1EUJ6GCGBDF(50411)).   [/FONT]
  [FONT=&quot]                          (SESSION: 382)                                           [/FONT]
  [FONT=&quot]04/08/2011 02:43:24      ANR2017I Administrator ADMIN_CENTER issued command: QUERY [/FONT]
  [FONT=&quot]                          DB F=D  (SESSION: 382)                                   [/FONT]
  [FONT=&quot]04/08/2011 02:43:24      ANR2017I Administrator ADMIN_CENTER issued command: QUERY [/FONT]
  [FONT=&quot]                          LIBRARY F=D  (SESSION: 382)                              [/FONT]
  [FONT=&quot]04/08/2011 02:43:24      ANR2017I Administrator ADMIN_CENTER issued command: QUERY [/FONT]
  [FONT=&quot]                          DRIVE F=D  (SESSION: 382)                                [/FONT]
  [FONT=&quot]04/08/2011 02:43:24      ANR2017I Administrator ADMIN_CENTER issued command: QUERY [/FONT]
  [FONT=&quot]                          PATH F=D  (SESSION: 382)                                 [/FONT]
  [FONT=&quot] [/FONT]
 
Hi,

no problem with oracle setting - this is obviously mount error

04/08/2011 02:21:23 ANR8779E Unable to open drive \\.\TAPE3, error number=
68676. (SESSION: 377)
04/08/2011 02:21:58 ANR8381E LTO volume 131AALL5 could not be mounted in drive
BI4 (\\.\TAPE3). (SESSION: 377)

Check the drives, paths ... etc.

Harry
 
Dear Harry

I have fixed the error and i want to share the solution.

For TSM TDP for Oracle restore , the Oracle RMAN must be configured to use Recovery Catalog , otherwise the restore will be very slow .
From the TSM server actlog i found out that it check all oracle backup file sequentially if the recovery catalog hasn't been configured on Oracle .
Because of that it will generate the error below :

04/08/11 11:53:54 ANS4994S TDP Oracle SUN ANU0599 TDP for Oracle: (27893): =>(GOLDDB03_ORA) ANU2602E The object /adsmorc//c-2812138182-20110408-01 was not found on the TSM Server 04/08/11 14:09:32 ANS1314E File data currently unavailable on server
Click to expand...

 
Hello,
these errors are normal - as Oracle generates the name of the file randomly, it must first check whether or not this file already exists in the TSM to prevent overwriting. So it tries to query the name. If it fails (no object found) then it is safe to use this name.

Harry
 
Dear Harry

You said that Oracle generates the name of file in Restore process , i think when it try to restore it need to search for a backed up file not generates a new name . Am i wrong ?
Beside , when Rman using Recovery Catalog , the errors don't happen again , and the restore speed is X 10 faster .

Thanks and Best Regards
 
Hi,

sorry, did not understand properly - these messages are normal during BACKUP.
Not an oracle expert to say why the restore without recovery catalog is slow - but should not be related to TSM - TSM must be given the name of the piece to be restored - the method of retrieving that name is irrelevant.
Getting the list of all pieces backed up is a single select to the DB - so it is matter of seconds.

Harry
 
Dear Harry

My situation is :

if i using Oracle default backup channel ( backup to local disk ) the restore process is normal with or without a recovery catalog .

if i using Oracle sbt tape channel ( backup via tsm to tape or even disk pool ) the restore process is extremely slow without recovery catalog on rman and the actlog keep saying that file data currently unavailable on server.

Finally , with the recovery catalog setup , before each restore , it doing cross check with tsmserver , and the restore go fast .

Personally i think , may be with out the recovery catalog , oracle don't know exactly where the backup remain.Rman will search for the backup pieces by it self.

Yes , i agree with you , after the installation of tdp , i haven't change any configuration in tsm but the restore now go smoothly .

Thanks and Best Regards
 
You must log in or register to reply here.

Data Privacy Impact Assessment

Compliance Assurance in Every Byte: Discover the Impact of Our DPIA Services.

Sponsor ADSM.ORG

If you are reading this, so are your potential customer. Advertise at ADSM.ORG right now.

Navigation Menu

Forums
   IBM TSM
   EMC Backup and Recovery
   Symantec NetBackup  
   SAN  
   NAS
   Platforms / OS
Mailing List Archives
   ADSM-L
User Groups

NordVPN 3 Months FREE

Help Support ADSM.ORG and Get NordVPN with 64% Off and 3 Months FREE.

NordVPN with 64% off + 3 months FREE

Forum statistics

Threads
31,978
Messages
135,460
Members
21,953
Latest member
jrogers
Back
Top