My Oracle Support Banner

RMAN RESTORE HANGS ON THE RAC DB FOR PLUGGABLE DATABASE (Doc ID 2641843.1)

Last updated on FEBRUARY 27, 2020

Applies to:

Oracle Database - Enterprise Edition - Version 12.2.0.1 and later
Information in this document applies to any platform.

Symptoms

Facing  issue while doing the restore of the pluggable database ., full database restore is working fine .Issue comes up when rman restore finished and the prompt is not displayed . While using only one instance the restore works fine,but when both instance are up , rman recovery hangs after completion .

Hanganalysis output while the restore was hanging
-----------------------------------


Oracle session identified by:
    {
                instance: 1 (instance)
                   os id: 4728
              process id: 144, ORACLE.EXE (SHAD)
              session id: 24
        session serial #: 59111
                  pdb id: 11 (<PDB>)
    }
    is waiting for 'PX Deq: Execute Reply' with wait info:
    {
                      p1: 'sleeptime/senderid'=0x1
                      p2: 'passes'=0x1
            time in wait: 0.000029 sec (last interval)
            time in wait: 1 min 40 sec (total)
           timeout after: never
                 wait id: 81410
                blocking: 0 sessions
             current sql: select /*+ rule */ round(sum(MBYTES_PROCESSED)), round(sum(INPUT_BYTES)), round(sum(OUTPUT_BYTES)) from V$RMAN_STATUS START WITH RECID = :row_id and STAMP = :row_stamp CONNECT BY PRIOR RECID = parent_recid
             short stack: ksedsts()+390<-ksdxfstk()+65<-ksdxcb()+1296<-ssthreadsrgruncallback()+365<-OracleOradebugThreadStart()+790<-00007FF917B613D2<-00007FF919BA54F4<-ksxprcv_int()+8770<-ksxprcvimdwctx()+112<-kxfpqidqr()+11855<-kxfpqdqr()+365<-kxfxcw()+420<-qerpxFetch()+1126<-rwsfcd()+150<-rwsfcd()+150<-qersoProcessULS()+304<-qersoFetchSimple()+1628<-qersoFetch()+200<-qerjoFetch()+1317<-qervwFetch()+193<-qersoProcessULS()+304<-qersoFetch()+7851<-qerjoFetch()+519<-qerflFetch()+203<-rwsfcd()+150<-qercbiFilterData()+849<-qercbiFetch()+498<
            wait history:
              * time between current wait and wait #1: 0.000000 sec
              1.       event: 'PX Deq: reap credit'
                 time waited: 0.000010 sec
                     wait id: 2158390          
              * time between wait #1 and #2: 0.000000 sec
              2.       event: 'PX Deq: Execute Reply'
                 time waited: 0.000003 sec (last interval)
                 time waited: 1 min 40 sec (total)
                     wait id: 81410            p1: 'sleeptime/senderid'=0x1
                                               p2: 'passes'=0x1
              * time between wait #2 and #3: 0.000000 sec
              3.       event: 'PX Deq: reap credit'
                 time waited: 0.000001 sec
                     wait id: 2158389          
    }
    and is blocked by
 => Oracle session identified by:
    {
                instance: 1 (instance)
                   os id: 12332
              process id: 126, ORACLE.EXE (PPA7)
              session id: 14
        session serial #: 27960
                  pdb id: 11 (<PDB>)
    }
    which is waiting for 'PX Deq: Execution Msg' with wait info:
    {
                      p1: 'sleeptime/senderid'=0x1001ffff
                      p2: 'passes'=0x1d19a
                      p3: ''=0xe269308b98
            time in wait: 1 min 40 sec
           timeout after: never
                 wait id: 2
                blocking: 1 session
             current sql: SELECT "R"."RECID", "R"."STAMP", "R"."PARENT_RECID", "R"."ROW_LEVEL" FROM "GV$RMAN_STATUS_CURRENT" "R"
             short stack: ksedsts()+390<-ksdxfstk()+65<-ksdxcb()+1296<-ssthreadsrgruncallback()+365<-OracleOradebugThreadStart()+790<-00007FF917B613D2<-00007FF919BA54F4<-00007FF917FD1355<-00007FF9164F1895<-00007FF9164F2033<-00007FF917FD1A15<-sipcgxp_poll()+281<-ipcgxp_selectex()+477<-ipclw_wait()+1536<-ksxpwait_ipclw()+4265<-ksxpwait_int()+25471<-ksxpwait()+931<-ksliwat()+13308<-kslwaitctx()+208<-kxfpqidqr()+2591<-kxfpqdqr()+365<-kxfxgs..0()+72<-kxfxmai()+671<-kxfprdp_int()+2668<-kxfprdp_cbk()+18<-ksbdispatch()+160<-opirip()+769<-opidrv()+
            wait history:
              * time between current wait and wait #1: 0.000164 sec
              1.       event: 'PX Deq: Execution Msg'
                 time waited: 0.004395 sec
                     wait id: 1                p1: 'sleeptime/senderid'=0x1001ffff
                                               p2: 'passes'=0x2
                                               p3: ''=0xe269308b98
              * time between wait #1 and #2: 0.004763 sec
              2.       event: 'PX Deq: Execution Msg'
                 time waited: 0.004273 sec
                     wait id: 0                p1: 'sleeptime/senderid'=0x1001ffff
                                               p2: 'passes'=0x2
                                               p3: ''=0xe269308b98
    }
 
Chain 1 Signature: 'PX Deq: Execution Msg'<='PX Deq: Execute Reply'
Chain 1 Signature Hash: 0x60729394
 
Node 1: <SID>_ora_<PID>.trc

WAIT #54035055320: nam='PX Deq: reap credit' ela= 32 p1=0 p2=0 p3=0 obj#=-1 tim=657096037607
*** 2018-06-27T11:35:51.134041+08:00 (SPU2DEV6(11))
WAIT #54035055320: nam='PX Deq: reap credit' ela= 23 p1=0 p2=0 p3=0 obj#=-1 tim=657281048475

*** 2018-06-27T11:35:52.001772+08:00 (SPU2DEV6(11))
WAIT #54035055320: nam='PX Deq: Execution Msg' ela= 604929857 sleeptime/senderid=268632063 passes=534 p3=164246591680 obj#=-1 tim=657281916990
STAT #54035055320 id=1 cnt=0 pid=0 pos=1 obj=-15231 op='VIEW  GV$RMAN_STATUS_CURRENT (cr=0 pr=0 pw=0 str=0 time=0 us)'
STAT #54035055320 id=2 cnt=0 pid=1 pos=1 obj=0 op='PX COORDINATOR  (cr=0 pr=0 pw=0 str=0 time=0 us)'
STAT #54035055320 id=3 cnt=0 pid=2 pos=1 obj=0 op='PX SEND QC (RANDOM) :TQ10000 (cr=0 pr=0 pw=0 str=0 time=0 us)'
STAT #54035055320 id=4 cnt=0 pid=3 pos=1 obj=-15231 op='VIEW  GV$RMAN_STATUS_CURRENT (cr=0 pr=0 pw=0 str=1 time=15 us)'
STAT #54035055320 id=5 cnt=0 pid=4 pos=1 obj=0 op='FIXED TABLE FULL X$KRBMRST (cr=0 pr=0 pw=0 str=1 time=12 us)'
CLOSE #54035055320:c=0,e=243,dep=1,type=0,tim=657281917398

Node2: <SID>_ora_<PID>.trc

WAIT #744175878608: nam='PX Deq: reap credit' ela= 2 p1=0 p2=0 p3=0 obj#=-1 tim=656743145552
WAIT #744175878608: nam='PX Deq: reap credit' ela= 13 p1=0 p2=0 p3=0 obj#=-1 tim=656743145590
WAIT #744175878608: nam='PX Deq: reap credit' ela= 1 p1=0 p2=0 p3=0 obj#=-1 tim=656743145699
WAIT #744175878608: nam='PX Deq: reap credit' ela= 13 p1=0 p2=0 p3=0 obj#=-1 tim=656743145736

Changes

Restoring RMAN backup in RAC environment

Cause

To view full details, sign in with your My Oracle Support account.

Don't have a My Oracle Support account? Click to get started!


In this Document
Symptoms
Changes
Cause
Solution
References


My Oracle Support provides customers with access to over a million knowledge articles and a vibrant support community of peers and Oracle experts.