在 TDA 工具裡看到 Java Thread State 的第一反應是

weixin_34292959發表於2018-02-26
Javathread
轉載：http://itindex.net/detail/43158-tda-%E5%B7%A5%E5%85%B7-java
 
使用 TDA 工具，看到大量 Java Thread State 的第一反應是：
1，執行緒狀態為“waiting for monitor entry”：
意味著它  在等待進入一個臨界區 ，所以它在”Entry Set“佇列中等待。
此時執行緒狀態一般都是 Blocked：
  • java.lang.Thread.State:  BLOCKED (on object monitor)
 
 
2，執行緒狀態為“waiting on condition”：
說明它 在等待另一個條件的發生，來把自己喚醒，或者乾脆它是呼叫了 sleep(N)。
此時執行緒狀態大致為以下幾種：
  • java.lang.Thread.State:  WAITING (parking)：一直等那個條件發生；
  • java.lang.Thread.State:  TIMED_WAITING (parking或sleeping)：定時的，那個條件不到來，也將定時喚醒自己。
 
3，如果大量執行緒在 “waiting for monitor entry”：
可能是一個全域性鎖阻塞住了大量執行緒。
如果短時間內列印的 thread dump 檔案反映，隨著時間流逝，waiting for monitor entry 的執行緒越來越多，沒有減少的趨勢，可能意味著 某些執行緒在臨界區裡呆的時間太長了，以至於越來越多新執行緒遲遲無法進入臨界區。
 
 
 
4，如果大量執行緒在 “ waiting on condition ”：
可能是它們又跑去獲取第三方資源， 尤其是第三方網路資源，遲遲獲取不到Response，導致大量執行緒進入等待狀態。
所以如果你發現有大量的執行緒都處在 Wait on condition，從執行緒堆疊看，正等待網路讀寫 ，這可能是一個網路瓶頸的徵兆，因為網路阻塞導致執行緒無法執行。
 
執行緒狀態為“in Object.wait()”：
說明它 獲得了監視器之後，又呼叫了 java.lang.Object.wait() 方法。
每個 Monitor在某個時刻，只能被一個執行緒擁有，該執行緒就是 “Active Thread”，而其它執行緒都是 “Waiting Thread”，分別在兩個佇列 “ Entry Set”和 “Wait Set”裡面等候。在 “Entry Set”中等待的執行緒狀態是 “Waiting for monitor entry”，而在 “Wait Set”中等待的執行緒狀態是 “in Object.wait()”。
當執行緒獲得了 Monitor，如果發現執行緒繼續執行的條件沒有滿足，它則呼叫物件（一般就是被 synchronized 的物件）的 wait() 方法，放棄了 Monitor，進入 “Wait Set”佇列。
此時執行緒狀態大致為以下幾種：
  • java.lang.Thread.State:  TIMED_WAITING (on object monitor)；
  • java.lang.Thread.State:  WAITING (on object monitor)；
一般都是RMI相關執行緒（RMI RenewClean、 GC Daemon、RMI Reaper），GC執行緒（Finalizer），引用物件垃圾回收執行緒（Reference Handler）等系統執行緒處於這種狀態。
 
Java Monitor
 
圖1 A Java Monitor
 
示範一：
下面這個執行緒在等待這個鎖  0x00000000fe7e3b50，等待進入臨界區：
"RMI TCP Connection(64896)-172.16.52.118" daemon prio=10 tid=0x00000000405a6000 nid=0x68fe waiting for monitor entry [0x00007f2be65a3000]
   java.lang.Thread.State: BLOCKED (on object monitor)
at com.xyz.goods.service.impl.GoodsServiceImpl. findChanellGoodsCountWithCache(GoodsServiceImpl.java:1734)
-  waiting to lock <0x00000000fe7e3b50> (a java.lang.String)

那麼誰持有這個鎖呢？
是另一個先呼叫了 findChanellGoodsCountWithCache 函式的執行緒：
"RMI TCP Connection(64878)-172.16.52.117" daemon prio=10 tid=0x0000000040822000 nid=0x6841 runnable [0x00007f2be76b3000]
   java.lang.Thread.State: RUNNABLE
at java.net.SocketInputStream.socketRead0(Native Method)
at java.net.SocketInputStream.read(SocketInputStream.java:129)
at java.io.BufferedInputStream.fill(BufferedInputStream.java:218)
at java.io.BufferedInputStream.read1(BufferedInputStream.java:258)
at java.io.BufferedInputStream.read(BufferedInputStream.java:317)
- locked <0x00000000af4ed638> (a java.io.BufferedInputStream)
at org.bson.io.Bits.readFully(Bits.java:35)
at org.bson.io.Bits.readFully(Bits.java:28)
at com.mongodb.Response.<init>(Response.java:35)
at com.mongodb.DBPort.go(DBPort.java:110)
- locked <0x00000000af442d48> (a com.mongodb.DBPort)
at com.mongodb.DBPort.go(DBPort.java:75)
- locked <0x00000000af442d48> (a com.mongodb.DBPort)
at com.mongodb.DBPort.call(DBPort.java:65)
at com.mongodb.DBTCPConnector.call(DBTCPConnector.java:202)
at com.mongodb.DBApiLayer$MyCollection.__find(DBApiLayer.java:296)
at com.mongodb.DB.command(DB.java:152)
at com.mongodb.DBCollection.getCount(DBCollection.java:760)
at com.mongodb.DBCollection.getCount(DBCollection.java:731)
at com.mongodb.DBCollection.count(DBCollection.java:697)
at com.xyz.goods.manager.MongodbManager.count(MongodbManager.java:202)
at com.xyz.goods.service.impl.GoodsServiceImpl.findChanellGoodsCount(GoodsServiceImpl.java:1787)
at com.xyz.goods.service.impl.GoodsServiceImpl. findChanellGoodsCountWithCache(GoodsServiceImpl.java:1739)
-  locked <0x00000000fe7e3b50> (a java.lang.String)
示範二：
等待另一個條件發生來將自己喚醒：
"RMI TCP Connection(idle)" daemon prio=10 tid=0x00007fd50834e800 nid=0x56b2  waiting on condition [0x00007fd4f1a59000]
   java.lang.Thread.State:  TIMED_WAITING (parking)
at sun.misc.Unsafe.park(Native Method)
-  parking to wait for  <0x00000000acd84de8> (a java.util.concurrent.SynchronousQueue$TransferStack)
at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:198)
at java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:424)
at java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:323)
at java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:874)
at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:945)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907)
at java.lang.Thread.run(Thread.java:662)
1）“ TIMED_WAITING (parking)”中的 timed_waiting 指等待狀態，但這裡指定了時間，到達指定的時間後自動退出等待狀態；parking指執行緒處於掛起中。
2）“ waiting on condition”需要與堆疊中的“ parking to wait for  <0x00000000acd84de8> (a java.util.concurrent.SynchronousQueue$TransferStack)” 結合來看。首先，本執行緒肯定是在等待某個條件的發生，來把自己喚醒。其次，SynchronousQueue 並不是一個佇列，只是執行緒之間移交資訊的機制，當我們把一個元素放入到 SynchronousQueue 中時必須有另一個執行緒正在等待接受移交的任務，因此這就是本執行緒在等待的條件。
 
示範三：
"RMI RenewClean-[172.16.50.182:4888]" daemon prio=10 tid=0x0000000040d2c800 nid=0x97e  in Object.wait() [0x00007f9ccafd0000]
   java.lang.Thread.State:  TIMED_WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x0000000799b032d8> (a java.lang.ref.ReferenceQueue$Lock)
at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:118)
- locked <0x0000000799b032d8> (a java.lang.ref.ReferenceQueue$Lock)
at sun.rmi.transport.DGCClient$EndpointEntry$RenewCleanThread.run(DGCClient.java:516)
at java.lang.Thread.run(Thread.java:662)
 
參考資源：
1）CUBRID，2012， How to Analyze Java Thread Dumps；

相關文章