[20170825]11G備庫啟用DRCP連接3.txt

--//昨天測試了11G備庫啟用DRCP連接,要設置alter system set audit_trail=none scope=spfile ;
--//參考鏈接http://blog.itpub.net/267265/viewspace-2144036/.
--//在測試過程中我遇到1個奇怪問題,就是如果主庫沒有打開drcp,備庫執行exec dbms_connection_pool.start_pool();失敗.
--//今天分析看看.

1.環境:
[email protected]> @ ver1
PORT_STRING VERSION BANNER
------------------------------ -------------- --------------------------------------------------------------------------------
x86_64/Linux 2.4.xx 11.2.0.4.0 Oracle Database 11g Enterprise Edition Release 11.2.0.4.0 - 64bit Production

[email protected]> exec dbms_connection_pool.start_pool();
BEGIN dbms_connection_pool.start_pool(); END;

*
ERROR at line 1:
ORA-56501: DRCP: Pool startup failed
ORA-56501: DRCP: Pool startup failed
ORA-06512: at "SYS.DBMS_CONNECTION_POOL", line 4
ORA-06512: at line 1

--//在主庫沒有啟動drcp的情況下,在備庫啟動會報錯.

$ oerr ora 56501
56501, 0000, "DRCP: Pool startup failed"
// *Cause: The connection pool failed to start up.
// *Action: Check logs for details.

2.分析:
--//先做一個10046跟蹤看看.

[email protected]> @ &r/10046on 12
old 1: alter session set events ‘10046 trace name context forever, level &1‘
new 1: alter session set events ‘10046 trace name context forever, level 12‘
Session altered.

[email protected]> exec dbms_connection_pool.start_pool();
BEGIN dbms_connection_pool.start_pool(); END;
*
ERROR at line 1:
ORA-56501: DRCP: Pool startup failed
ORA-56501: DRCP: Pool startup failed
ORA-06512: at "SYS.DBMS_CONNECTION_POOL", line 4
ORA-06512: at line 1

[email protected]> @ &r/10046off
Session altered.

--//檢查跟蹤文件發現如下:
...
=====================
PARSING IN CURSOR #182929053448 len=274 dep=1 uid=0 oct=3 lid=0 tim=1503624921300601 hv=3872345143 ad=‘7e890610‘ sqlid=‘2s0zgjvmcym1r‘
SELECT connection_pool_name, status, minsize, maxsize, incrsize, session_cached_cursors, inactivity_timeout,
max_think_time, max_use_session, max_lifetime_session, num_cbrok, maxconn_cbrok FROM cpool$ WHERE (connection_pool_name = :1)
END OF STMT
BINDS #182929053448:
Bind#0
oacdty=01 mxl=32(27) mxlc=00 mal=00 scl=00 pre=00
oacflg=00 fl2=0000 frm=01 csi=852 siz=32 off=0
kxsbbbfp=2a97747a38 bln=32 avl=27 flg=05
value="SYS_DEFAULT_CONNECTION_POOL"
EXEC #182929053448:c=999,e=178,p=0,cr=0,cu=0,mis=0,r=0,dep=1,og=1,plh=1895327128,tim=1503624921300745
FETCH #182929053448:c=0,e=30,p=0,cr=2,cu=0,mis=0,r=1,dep=1,og=1,plh=1895327128,tim=1503624921300818
EXEC #182928806584:c=999,e=502,p=0,cr=2,cu=0,mis=0,r=0,dep=0,og=1,plh=0,tim=1503624921300951
ERROR #182928806584:err=56501 tim=1503624921300974
WAIT #182928806584: nam=‘SQL*Net break/reset to client‘ ela= 4 driver id=1650815232 break?=1 p3=0 obj#=5762 tim=1503624921301028
WAIT #182928806584: nam=‘SQL*Net break/reset to client‘ ela= 53 driver id=1650815232 break?=0 p3=0 obj#=5762 tim=1503624921301103
WAIT #182928806584: nam=‘SQL*Net message to client‘ ela= 2 driver id=1650815232 #bytes=1 p3=0 obj#=5762 tim=1503624921301128

*** 2017-08-25 09:35:25.227
WAIT #182928806584: nam=‘SQL*Net message from client‘ ela= 3926451 driver id=1650815232 #bytes=1 p3=0 obj#=5762 tim=1503624925227651
CLOSE #182928806584:c=0,e=41,dep=0,type=0,tim=1503624925227808
=====================

--//很明顯因為訪問底層基表cpool$
[email protected]> @ &r/pt2 ‘select * from cpool$‘;
ROW_NUM COL_NUM COL_NAME COL_VALUE
------- ------- ---------------------- ----------------------------
1 1 CONNECTION_POOL_NAME SYS_DEFAULT_CONNECTION_POOL
2 STATUS INACTIVE
3 MINSIZE 4
4 MAXSIZE 40
5 INCRSIZE 2
6 SESSION_CACHED_CURSORS 20
7 INACTIVITY_TIMEOUT 300
8 MAX_THINK_TIME 120
9 MAX_USE_SESSION 500000
10 MAX_LIFETIME_SESSION 86400
11 NUM_CBROK 1
12 MAXCONN_CBROK 40000
12 rows selected.

--//而且在執行成功後STATUS=‘ACTIVE‘.也就是exec dbms_connection_pool.start_pool();後如果STATUS=‘INACTIVE‘要變成‘狀態是‘ACTIVE‘.
--//執行類似的dml語句,這在備庫read only的情況下是不可行的.知道這個道理就明白為什麽要在主庫先執行exec dbms_connection_pool.start_pool();
--//修改STATUS=‘ACTIVE‘,這樣備庫也跟著修改.在備庫執行exec dbms_connection_pool.start_pool();才能OK了.

3.有了以上知識,就可以通過一個特殊的例子說明問題.

--//在主庫上執行如下,啟動drcp.
[email protected]> exec dbms_connection_pool.start_pool()
PL/SQL procedure successfully completed.

--//檢查備庫
[email protected]> @ &r/pt2 ‘select * from cpool$‘;
ROW_NUM COL_NUM COL_NAME COL_VALUE
------- ---------- ---------------------- ---------------------------
1 1 CONNECTION_POOL_NAME SYS_DEFAULT_CONNECTION_POOL
2 STATUS ACTIVE
3 MINSIZE 4
4 MAXSIZE 40
5 INCRSIZE 2
6 SESSION_CACHED_CURSORS 20
7 INACTIVITY_TIMEOUT 300
8 MAX_THINK_TIME 120
9 MAX_USE_SESSION 500000
10 MAX_LIFETIME_SESSION 86400
11 NUM_CBROK 1
12 MAXCONN_CBROK 40000
12 rows selected.

--//取消redo應用.
[email protected]> alter database recover managed standby database cancel ;
Database altered.

--//在主庫上執行如下,停止drcp.
[email protected]> exec dbms_connection_pool.stop_pool()
PL/SQL procedure successfully completed.

[email protected]> select CONNECTION_POOL_NAME,STATUS from cpool$;
CONNECTION_POOL_NAME STATUS
--------------------------- ---------
SYS_DEFAULT_CONNECTION_POOL INACTIVE

--//由於停止備庫的日誌應用,cpool$的記錄不會修改.依舊是status=‘ACTIVE‘
[email protected]> select CONNECTION_POOL_NAME,STATUS from cpool$;
CONNECTION_POOL_NAME STATUS
--------------------------- -------
SYS_DEFAULT_CONNECTION_POOL ACTIVE

[email protected]> exec dbms_connection_pool.start_pool();
PL/SQL procedure successfully completed.

$ sqlplus scott/[email protected]:1521/bookdg:POOLED
--//測試連接ok.

--//同樣的道理在當前的狀態,無法在備庫執行exec dbms_connection_pool.stop_pool();因為這樣要修改staus,
--//而只讀數據庫是無法執行dml語句的.
[email protected]> exec dbms_connection_pool.stop_pool();
BEGIN dbms_connection_pool.stop_pool(); END;
*
ERROR at line 1:
ORA-56506: DRCP: Pool shutdown failed
ORA-56506: DRCP: Pool shutdown failed
ORA-06512: at "SYS.DBMS_CONNECTION_POOL", line 16
ORA-06512: at line 1

--//而同步應用日誌後,status變成了‘INACTIVE‘,在備庫再執行停止drcp就ok了.
[email protected]> alter database recover managed standby database using current logfile disconnect ;
Database altered.

[email protected]> select CONNECTION_POOL_NAME,STATUS from cpool$;
CONNECTION_POOL_NAME STATUS
--------------------------- ---------
SYS_DEFAULT_CONNECTION_POOL INACTIVE

[email protected]> exec dbms_connection_pool.stop_pool();
PL/SQL procedure successfully completed.

[20170825]11G備庫啟用DRCP連接3.txt