expdp备份缓慢问题分析

23ee

--导出问题分析
--两个时间语句分析，该语句只导出4,059,292  数据，10分钟后数据没有继续导出
             Snap Id  Snap Time  Sessions  Cursors/Session
Begin Snap:  39396  13-Jul-14 18:30:32  558  1.7
End Snap:    39407  13-Jul-14 20:20:07  556  1.7
Elapsed:     109.58 (mins)      
DB Time:     16.76 (mins)
           Snap Id Snap Time Sessions Cursors/Session
Begin Snap: 39396 13-Jul-14 18:30:32 558 1.7
End Snap:   39398 13-Jul-14 18:50:37 557 1.7
Elapsed:   20.09 (mins)   
DB Time:   3.51 (mins)
            Snap Id Snap Time Sessions Cursors/Session
Begin Snap: 39396 13-Jul-14 18:30:32 558 1.7
End Snap:   39417 13-Jul-14 22:00:18 559 1.7
Elapsed:    209.77 (mins)     
DB Time:    27.15 (mins)
            Begin Snap Time Sessions Cursors/Session
            39396 13-Jul-14 18:30:32 558 1.7
End Snap:   39397 13-Jul-14 18:40:34 557 1.7
Elapsed:    10.03 (mins)     
DB Time:    1.64 (mins)

--语句没执行完毕
# Plan Hash Value Total Elapsed Time(ms) Executions 1st Capture Snap ID Last Capture Snap ID
1 2193842017            7,218            0               39397 39397

--问题时候的导出资源使用
Stat Name Statement Total Per Execution % Snap Total
Elapsed Time (ms) 7,218   0.72
CPU Time (ms) 3,035   0.35
Executions 0   
Buffer Gets 139,102   0.34
Disk Reads 0   0.00
Parse Calls 0   0.00
Rows 4,059,292    -------------------------其实我获取两个 awrsqlrpt报告分析，两个时间，也就是18点50 以后，没有数据导出
User I/O Wait Time (ms) 0   
Cluster Wait Time (ms) 0   
Application Wait Time (ms) 0   
Concurrency Wait Time (ms) 0   
Invalidations 0   
Version Count 2   
Sharable Mem(KB) 44

--22点导出时候资源使用
Snap Id Snap Time Sessions Cursors/Session
Begin Snap: 39421 13-Jul-14 22:40:22 557 1.7
End Snap: 39422 13-Jul-14 22:50:23 558 1.7
Elapsed:   10.02 (mins)     
DB Time:   1.38 (mins)
Stat Name Statement Total Per Execution % Snap Total
Elapsed Time (ms) 18,405 18,404.69 22.24
CPU Time (ms) 7,555 7,554.87 10.43
Executions 1   
Buffer Gets 354,583 354,583.00 35.03
Disk Reads 0 0.00 0.00
Parse Calls 1 1.00 0.05
Rows 10,555,042 10,555,042.00    ---一共导出怎么多数据（可以正常导出）
User I/O Wait Time (ms) 0   
Cluster Wait Time (ms) 0   
Application Wait Time (ms) 0   
Concurrency Wait Time (ms) 0   
Invalidations 0   
Version Count 2   
Sharable Mem(KB) 44
--以上问题给予语句分析：
SQL Id SQL   Text
bcjy9a9sp1uw9 SELECT /*+NESTED_TABLE_GET_REFS+*/ "KDTA_HIS"."H_ACK_DIVIDEND".* FROM "KDTA_HIS"."H_ACK_DIVIDEND"
--分析：导出发生意外，中止或者等待，或者LMON 引起latch
--会话等待事件分析：
SQL> select substrb(session_id,1,6)||'.'||substrb(session_serial#,1,4),
  2         substrb(event,1,15),
  3         BLOCKING_SESSION,
  4         to_char(SAMPLE_TIME, 'yyyymmdd hh24miss'),
  5         INSTANCE_NUMBER,
  6         sql_id,
  7         (select username
  8            from dba_users b
  9           where b.user_id = a.USER_ID
10             and rownum = 1) username,
11         substrb(program,1,10)
12    from DBA_HIST_ACTIVE_SESS_HISTORY a
13   where (SAMPLE_TIME >=
14         to_date('2014-07-13 01:00:00', 'yyyy-mm-dd hh24:mi:ss') and
15         SAMPLE_TIME <=
16         to_date('2014-07-14 01:10:00', 'yyyy-mm-dd hh24:mi:ss'))
17     and a.module like '%exp%'
18   order by session_id,SAMPLE_TIME;
  SUBSTRB(SES SUBSTRB(EVENT,1 BLOCKING_SESSION TO_CHAR(SAMPLE_ INSTANCE_NUMBER SQL_ID        USERNAME                       SUBSTRB(PR
----------- --------------- ---------------- --------------- --------------- ------------- ------------------------------ ----------

7638.4126                                    20140713 184020               1 88jm6j85t5b8z KDTA_HIS                       exp.exe
7638.4126   latch free                   529 20140713 184151               1               KDTA_HIS                       exp.exe--------
7638.4126                                    20140713 184643               1 g4kubvga4gnxc KDTA_HIS                       exp.exe
7638.4126   SQL*Net more da                  20140713 185145               1 dvjmxz20wf8xz KDTA_HIS                       exp.exe

--529 会话分析
SQL> select substrb(session_id,1,6)||'.'||substrb(session_serial#,1,4),
  2         substrb(event,1,15),
  3         BLOCKING_SESSION,
  4         to_char(SAMPLE_TIME, 'yyyymmdd hh24miss'),
  5         INSTANCE_NUMBER,
  6         sql_id,
  7         substrb(program,1,30)
  8    from DBA_HIST_ACTIVE_SESS_HISTORY a
  9   where (SAMPLE_TIME >=
10         to_date('2014-07-13 18:30:00', 'yyyy-mm-dd hh24:mi:ss') and
11         SAMPLE_TIME <=
12         to_date('2014-07-13 18:45:00', 'yyyy-mm-dd hh24:mi:ss'))
13     and a.session_id=529
14   order by session_id,SAMPLE_TIME;
SUBSTRB(SES SUBSTRB(EVENT,1 BLOCKING_SESSION TO_CHAR(SAMPLE_ INSTANCE_NUMBER SQL_ID        SUBSTRB(PROGRAM,1,30)
----------- --------------- ---------------- --------------- --------------- ------------- ------------------------------
529.1                                        20140713 183204               2              oracle@KXYEB02 (LMON)
529.1                                        20140713 183215               2              oracle@KXYEB02 (LMON)
529.1                                        20140713 183609               1              oracle@KXYEB01 (LMON)
529.1                                        20140713 184151               1              oracle@KXYEB01 (LMON)------------
529.1                                        20140713 184218               2              oracle@KXYEB02 (LMON)
529.1                                        20140713 184332               1              oracle@KXYEB01 (LMON)
--dump systemstate 已经无法分析当时数据
--分析awr报告，没有发现latch 问题
-- 下次遇到这个问题的是及时进行一下操作
--1 登录数据库
sqlplus /nolog
conn / as sysdba
oradebug setmypid
oradebug dump systemstate 10
oradebug tracefile_name

--2 可以的话再执行一次
1  获取process id
ps -ef|grep expdp
id
2 10046分析
SQL> select to_char(a.last_analyzed,'yyyymmdd hh24miss') from dba_tables a where table_name='H_ACK_DIVIDEND';
TO_CHAR(A.LAST_
---------------
20140713 181130
SQL>

异常中止或者lmon引起等待挂起，根源原因分析不出来!