posts - 42,comments - 83,trackbacks - 0
                首先介紹一個(gè)JDBC參數(shù)InactiveConnectionTImeout,該參數(shù)用于強(qiáng)制回收那些被泄露的連接(長(zhǎng)時(shí)間不使用的連接、未被程序正確釋放的連接),避免連接池因?yàn)樾孤秾?dǎo)致無(wú)連接可用。當(dāng)然該參數(shù)只是起輔助作用,解決問題知道還是在于完善應(yīng)用程序。

                本文和該參數(shù)有關(guān),早期的8.1\9.2中,設(shè)定該參數(shù)時(shí),定時(shí)器(內(nèi)部的連接池維護(hù)Task)只會(huì)清理那些長(zhǎng)期未被使用的空閑連接(從名字上可以看出來(lái)),即對(duì)于運(yùn)行一個(gè)長(zhǎng)時(shí)間執(zhí)行SQL的連接而言,它是不受影響的。但不知道從10.3哪個(gè)版本開始(我測(cè)試的是10.3.5),該參數(shù)對(duì)于長(zhǎng)時(shí)間執(zhí)行SQL的連接也進(jìn)行強(qiáng)制回收了(這個(gè)比較不合理,雖然對(duì)于正在執(zhí)行的Tx影響不大)。Debug了一下,發(fā)現(xiàn)SQL執(zhí)行時(shí)間大于4*InactiveConnectionTimeout時(shí),這個(gè)SQL執(zhí)行完成時(shí),會(huì)出現(xiàn) <BEA-001153> <Forcibly releasing inactive connection "weblogic.jdbc.wrapper.PoolConnection_oracle_jdbc_driver_T4CConnection@1" back into the connection pool "TestDS", currently reserved by: java.lang.Exception這樣的錯(cuò)誤。

          //該線程為內(nèi)部Task執(zhí)行線程,該線程目前處于被阻塞狀態(tài),等待SQL執(zhí)行結(jié)束后回收連接
          "[STUCK] ExecuteThread: '20' for queue: 'weblogic.kernel.Default (self-tuning)'" daemon prio=2 tid=0x2c4d3400 nid=0x1a14 waiting for monitor entry [0x
          319bf000]
             java.lang.Thread.State: BLOCKED (on object monitor)
                  at oracle.jdbc.driver.PhysicalConnection.rollback(PhysicalConnection.java:3896)
                  - waiting to lock <0x0e6191d8> (a oracle.jdbc.driver.T4CConnection)
                  at weblogic.jdbc.wrapper.Connection.forcedCleanup(Connection.java:156)
                  at weblogic.common.resourcepool.ResourcePoolImpl.timeoutInactiveResources(ResourcePoolImpl.java:1955)
                  at weblogic.common.resourcepool.ResourcePoolImpl.access$8(ResourcePoolImpl.java:1916)
                  at weblogic.common.resourcepool.ResourcePoolImpl$ResourcePoolMaintanenceTask.timerExpired(ResourcePoolImpl.java:2680)
                  at weblogic.timers.internal.TimerImpl.run(TimerImpl.java:273)
                  at weblogic.work.SelfTuningWorkManagerImpl$WorkAdapterImpl.run(SelfTuningWorkManagerImpl.java:528)
                  at weblogic.work.ExecuteThread.execute(ExecuteThread.java:209)
                  at weblogic.work.ExecuteThread.run(ExecuteThread.java:178)

          //該線程為應(yīng)用執(zhí)行線程,目前該線程SQL正在運(yùn)行,他阻塞(阻塞對(duì)象為T4CConnection)了內(nèi)部Task執(zhí)行線程
          "[STUCK] ExecuteThread: '0' for queue: 'weblogic.kernel.Default (self-tuning)'" daemon prio=2 tid=0x2c7b4c00 nid=0x1100 runnable [0x2cf7e000]
             java.lang.Thread.State: RUNNABLE
                  at java.net.SocketInputStream.socketRead0(Native Method)
                  ......
                  at oracle.jdbc.driver.OracleStatement.doExecuteWithTimeout(OracleStatement.java:1315)
                  at oracle.jdbc.driver.OraclePreparedStatement.executeInternal(OraclePreparedStatement.java:3576)
                  at oracle.jdbc.driver.OraclePreparedStatement.execute(OraclePreparedStatement.java:3677)
                  - locked <0x0e6191d8> (a oracle.jdbc.driver.T4CConnection)
                  at oracle.jdbc.driver.OraclePreparedStatementWrapper.execute(OraclePreparedStatementWrapper.java:1374)
                  at weblogic.jdbc.wrapper.PreparedStatement.execute(PreparedStatement.java:102)
                  at com.bea.cs.test.jdbc.DriverTest.inactiveTimeoutTest(DriverTest.java:537)
                  at jsp_servlet.__ds._jspService(__ds.java:86)

                  從上面的線程堆??梢钥吹剑瑑?nèi)部Task線程正在調(diào)用connection的rollback,即回滾連接上的本地事務(wù)。如果應(yīng)用線程上使用的連接設(shè)為auto commit的話,該SQL執(zhí)行不會(huì)被rollback,否則該SQL雖然執(zhí)行完成也會(huì)被rollback調(diào)(全局事務(wù)中,某個(gè)事務(wù)分支使用的連接一定是非auto commit的),所以該問題對(duì)涉及全局事務(wù)的應(yīng)用影響比較大。

                  下面我們?cè)诳纯催B接被回收的時(shí)間點(diǎn)為什么會(huì)出現(xiàn)在3-4個(gè)InactiveConnectionTimeout之間。當(dāng)內(nèi)部Task執(zhí)行,發(fā)現(xiàn)到了InactiveConnectionTimeout時(shí)間點(diǎn)后,它會(huì)調(diào)用timeoutInactiveResources()方法開始進(jìn)行連接清理。那么為什么正在執(zhí)行SQL的連接會(huì)被標(biāo)志為非活動(dòng)連接呢?這里涉及連接狀態(tài)的三個(gè)標(biāo)志位,分別為:conn_in_use,connUsed,hang_state,這三個(gè)標(biāo)志位是其中的關(guān)鍵(getUsed()和setUsed()方法中會(huì)進(jìn)行標(biāo)志位操作及讀取,如果對(duì)于某個(gè)連接getUsed()返回false的話,該連接會(huì)被清理)。下面我們看看其中標(biāo)志位的變化過程: SQL開始執(zhí)行時(shí),preInvokeHandler會(huì)被這三個(gè)標(biāo)志位進(jìn)行設(shè)定。

          初始值如下:
          conn_in_use-->true
          hang_state-->conn_state_in_use
          connUsed-->true

          第一次InactiveConnectionTimeout檢查,getUsed返回true,同時(shí)調(diào)用setUsed(false),標(biāo)志位變化如下:
          conn_in_use-->true
          hang_state-->conn_state_idle_suspect
          connUsed-->true

          第二次InactiveConnectionTimeout檢查,getUsed返回true,同時(shí)調(diào)用setUsed(false),標(biāo)志位變化如下:
          conn_in_use-->false
          hang_state-->conn_state_hang_suspect
          connUsed-->false

          第三次InactiveConnectionTimeout檢查,getUsed返回true,
          hang_state-->conn_state_in_use(從conn_state_hang_suspect變成conn_state_in_use)
          同時(shí)調(diào)用setUsed(false),標(biāo)志位變化如下:
          conn_in_use-->false
          connUsed-->false
          hang_state-->conn_state_idle_suspect(從conn_state_in_use變成conn_state_idle_suspect)

          第四次InactiveConnectionTimeout檢查,getUsed返回false,開始回收該連接。

          從上面的變化時(shí)間點(diǎn)可以看到從第一次到第四次檢查經(jīng)歷了完整的3個(gè)InactiveConnectionTimout周期,而從SQL執(zhí)行到第一次檢查點(diǎn),這個(gè)時(shí)間小于一個(gè)InactiveConnectionTimeout,所以連接開始被回收的時(shí)間點(diǎn)介于3-4個(gè)InactiveConnectionTimeout之間。




          posted @ 2013-10-10 16:18 走走停停又三年 閱讀(7667) | 評(píng)論 (1)編輯 收藏
               摘要: Weblogic10.3.0, connection pool, disable, Weblogic10.3.4, weblogic.resourcepool.max_test_wait_secs  閱讀全文
          posted @ 2011-03-22 14:45 走走停停又三年 閱讀(2858) | 評(píng)論 (1)編輯 收藏
               摘要:   閱讀全文
          posted @ 2010-09-10 11:22 走走停停又三年 閱讀(2224) | 評(píng)論 (5)編輯 收藏
          主站蜘蛛池模板: 美姑县| 万载县| 五台县| 永济市| 黄平县| 棋牌| 永州市| 炉霍县| 阜新| 扎囊县| 台北市| 盐津县| 永州市| 罗山县| 漳浦县| 汽车| 永德县| 会东县| 平阳县| 白银市| 广宁县| 安新县| 梓潼县| 昌平区| 安溪县| 江北区| 玛曲县| 甘南县| 宜城市| 留坝县| 甘孜| 安图县| 靖江市| 奉贤区| 厦门市| 绍兴市| 葫芦岛市| 高平市| 元江| 通江县| 鲁山县|