loong - Java 命令 - jstack - 使用案例

最新推荐文章于 2024-05-16 10:23:10 发布

7-Moon

最新推荐文章于 2024-05-16 10:23:10 发布

阅读量388

点赞数 4

文章标签： java python 开发语言

本文链接：https://blog.csdn.net/weixin_45894132/article/details/138157064

版权

loong - Java - jstack

jstack 功能介绍

jstack命令用于生成虚拟机当前时刻的线程快照。
线程快照是当前虚拟机内每一条线程正在执行的方法堆栈的集合，生成线程快照的主要目的是定位线程出现长时间停顿的原因，如线程间死锁、死循环、请求外部资源导致的长时间等待等问题。
线程出现停顿的时候通过jstack来查看各个线程的调用堆栈，就可以知道没有响应的线程到底在后台做什么事情，或者等待什么资源。
如果java程序崩溃生成core文件，jstack工具可以用来获得core文件的java stack和native stack的信息，从而可以轻松地知道java程序是如何崩溃和在程序何处发生问题。
另外，jstack工具还可以附属到正在运行的java程序中，看到当时运行的java程序的java stack和native stack的信息, 如果现在运行的java程序呈现hung的状态，jstack是非常有用的。

jstack 用法

PS D:\loong-workspace\loong-test> jstack -help
Usage:
    jstack [-l] <pid>                                          
        (to connect to running process)                        
    jstack -F [-m] [-l] <pid>                                  
        (to connect to a hung process)                         
    jstack [-m] [-l] <executable> <core>                       
        (to connect to a core file)                            
    jstack [-m] [-l] [server_id@]<remote server IP or hostname>
        (to connect to a remote debug server)                  

Options:
    -F  to force a thread dump. Use when jstack <pid> does not respond (process is hung)
    -m  to print both java and native frames (mixed mode)
    -l  long listing. Prints additional information about locks
    -h or -help to print this help message
    
    -F： 当正常输出的请求不被响应时，强制输出线程堆栈
	-m： 如果调用到本地方法的话，可以显示C/C++的堆栈
	-l： 除堆栈外，显示关于锁的附加信息，在发生死锁时可以用jstack -l pid来观察锁持有情况
	-h： 打印帮助信息

死锁排查示例

死锁代码

package com.loong.test.jstack;

import java.util.concurrent.locks.Lock;
import java.util.concurrent.locks.ReentrantLock;

/**
 * @Author 
 * @Date 2024-02-02 16:05
 * @Version 1.0
 */
public class DeathLockTest {

    private static Lock lock1 = new ReentrantLock();
    private static Lock lock2 = new ReentrantLock();

    public static void deathLock() {
        Thread t1 = new Thread() {
            @Override
            public void run() {
                try {
                    lock1.lock();
                    System.out.println(Thread.currentThread().getName() + " get the lock1");
                    Thread.sleep(1000);
                    lock2.lock();
                    System.out.println(Thread.currentThread().getName() + " get the lock2");
                } catch (InterruptedException e) {
                    e.printStackTrace();
                }
            }
        };
        Thread t2 = new Thread() {
            @Override
            public void run() {
                try {
                    lock2.lock();
                    System.out.println(Thread.currentThread().getName() + " get the lock2");
                    Thread.sleep(1000);
                    lock1.lock();
                    System.out.println(Thread.currentThread().getName() + " get the lock1");
                } catch (InterruptedException e) {
                    e.printStackTrace();
                }
            }
        };
        // 设置线程名字，方便分析堆栈信息
        t1.setName("mythread-t1");
        t2.setName("mythread-t2");
        t1.start();
        t2.start();
    }

    public static void main(String[] args) {
        deathLock();
    }
}

运行结果

mythread-t1 get the lock1
mythread-t2 get the lock2

jstack排查死锁步骤

在终端中输入jsp查看当前运行的java程序
使用 jstack -l pid 查看线程堆栈信息
分析堆栈信息

步骤一：jps查看当前运行程序

PS D:\loong-workspace\loong-test> jps
19540 Jps
25860 DeathLockTest ## 定位Java程序
26532 RemoteMavenServer36
1036 Launcher
25580

步骤二：使用 jstack -l pid 查看线程堆栈信息

2024-02-02 16:17:29
Full thread dump Java HotSpot(TM) 64-Bit Server VM (25.333-b02 mixed mode):

"DestroyJavaVM" #14 prio=5 os_prio=0 tid=0x000001e987c53800 nid=0xf28 waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

   Locked ownable synchronizers:
        - None
#####################################划重点(deadlock)#####################################
"mythread-t2" #13 prio=5 os_prio=0 tid=0x000001e9a4976000 nid=0x1304 waiting on condition [0x000000204acff000]
   java.lang.Thread.State: WAITING (parking)
        at sun.misc.Unsafe.park(Native Method)
        - parking to wait for  <0x000000076becdd10> (a java.util.concurrent.locks.ReentrantLock$NonfairSync)
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:836)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireQueued(AbstractQueuedSynchronizer.java:870)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:1199)
        at java.util.concurrent.locks.ReentrantLock$NonfairSync.lock(ReentrantLock.java:209)
        at java.util.concurrent.locks.ReentrantLock.lock(ReentrantLock.java:285)
        at com.loong.test.jstack.DeathLockTest$2.run(DeathLockTest.java:38)

   Locked ownable synchronizers:
        - <0x000000076becdd40> (a java.util.concurrent.locks.ReentrantLock$NonfairSync)

"mythread-t1" #12 prio=5 os_prio=0 tid=0x000001e9a4909800 nid=0x424c waiting on condition [0x000000204abff000]
   java.lang.Thread.State: WAITING (parking)
        at sun.misc.Unsafe.park(Native Method)
        - parking to wait for  <0x000000076becdd40> (a java.util.concurrent.locks.ReentrantLock$NonfairSync)
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:836)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireQueued(AbstractQueuedSynchronizer.java:870)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:1199)
        at java.util.concurrent.locks.ReentrantLock$NonfairSync.lock(ReentrantLock.java:209)
        at java.util.concurrent.locks.ReentrantLock.lock(ReentrantLock.java:285)
        at com.loong.test.jstack.DeathLockTest$1.run(DeathLockTest.java:24)

   Locked ownable synchronizers:
        - <0x000000076becdd10> (a java.util.concurrent.locks.ReentrantLock$NonfairSync)
#####################################划重点(deadlock)#####################################

"Service Thread" #11 daemon prio=9 os_prio=0 tid=0x000001e9a4878000 nid=0x5074 runnable [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

   Locked ownable synchronizers:
        - None

"C1 CompilerThread3" #10 daemon prio=9 os_prio=2 tid=0x000001e9a47e5000 nid=0x5568 waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

   Locked ownable synchronizers:
        - None

"C2 CompilerThread2" #9 daemon prio=9 os_prio=2 tid=0x000001e9a47e1800 nid=0x2094 waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

   Locked ownable synchronizers:
        - None

"C2 CompilerThread1" #8 daemon prio=9 os_prio=2 tid=0x000001e9a47c6000 nid=0xacc waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

   Locked ownable synchronizers:
        - None

"C2 CompilerThread0" #7 daemon prio=9 os_prio=2 tid=0x000001e9a47c2000 nid=0x25f4 waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

   Locked ownable synchronizers:
        - None

"Monitor Ctrl-Break" #6 daemon prio=5 os_prio=0 tid=0x000001e9a47a7000 nid=0x2700 runnable [0x000000204a4ff000]
   java.lang.Thread.State: RUNNABLE
        at java.net.SocketInputStream.socketRead0(Native Method)
        at java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
        at java.net.SocketInputStream.read(SocketInputStream.java:171)
        at java.net.SocketInputStream.read(SocketInputStream.java:141)
        at sun.nio.cs.StreamDecoder.readBytes(StreamDecoder.java:284)
        at sun.nio.cs.StreamDecoder.implRead(StreamDecoder.java:326)
        at sun.nio.cs.StreamDecoder.read(StreamDecoder.java:178)
        - locked <0x000000076bfd4e80> (a java.io.InputStreamReader)
        at java.io.InputStreamReader.read(InputStreamReader.java:184)
        at java.io.BufferedReader.fill(BufferedReader.java:161)
        at java.io.BufferedReader.readLine(BufferedReader.java:324)
        - locked <0x000000076bfd4e80> (a java.io.InputStreamReader)
        at java.io.BufferedReader.readLine(BufferedReader.java:389)
        at com.intellij.rt.execution.application.AppMainV2$1.run(AppMainV2.java:53)

   Locked ownable synchronizers:
        - None

"Attach Listener" #5 daemon prio=5 os_prio=2 tid=0x000001e9a2901000 nid=0x20b8 waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

   Locked ownable synchronizers:
        - None

"Signal Dispatcher" #4 daemon prio=9 os_prio=2 tid=0x000001e9a28f0800 nid=0x2310 runnable [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

   Locked ownable synchronizers:
        - None

"Finalizer" #3 daemon prio=8 os_prio=1 tid=0x000001e9a287d000 nid=0x15fc in Object.wait() [0x000000204a1fe000]
   java.lang.Thread.State: WAITING (on object monitor)
        at java.lang.Object.wait(Native Method)
        - waiting on <0x000000076bd08ee8> (a java.lang.ref.ReferenceQueue$Lock)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:150)
        - locked <0x000000076bd08ee8> (a java.lang.ref.ReferenceQueue$Lock)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:171)
        at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:216)

   Locked ownable synchronizers:
        - None

"Reference Handler" #2 daemon prio=10 os_prio=2 tid=0x000001e9a2869800 nid=0x4c4 in Object.wait() [0x000000204a0ff000]
   java.lang.Thread.State: WAITING (on object monitor)
        at java.lang.Object.wait(Native Method)
        - waiting on <0x000000076bd06c00> (a java.lang.ref.Reference$Lock)
        at java.lang.Object.wait(Object.java:502)
        at java.lang.ref.Reference.tryHandlePending(Reference.java:191)
        - locked <0x000000076bd06c00> (a java.lang.ref.Reference$Lock)
        at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:153)

   Locked ownable synchronizers:
        - None

"VM Thread" os_prio=2 tid=0x000001e9a2840000 nid=0x207c runnable
"GC task thread#0 (ParallelGC)" os_prio=0 tid=0x000001e987c6b800 nid=0x3f0 runnable
"GC task thread#1 (ParallelGC)" os_prio=0 tid=0x000001e987c6c800 nid=0x6210 runnable
"GC task thread#2 (ParallelGC)" os_prio=0 tid=0x000001e987c6e000 nid=0x6180 runnable
"GC task thread#3 (ParallelGC)" os_prio=0 tid=0x000001e987c6f000 nid=0x6618 runnable
"GC task thread#4 (ParallelGC)" os_prio=0 tid=0x000001e987c71000 nid=0x415c runnable
"GC task thread#5 (ParallelGC)" os_prio=0 tid=0x000001e987c72000 nid=0x1714 runnable
"GC task thread#6 (ParallelGC)" os_prio=0 tid=0x000001e987c75000 nid=0x6620 runnable
"GC task thread#7 (ParallelGC)" os_prio=0 tid=0x000001e987c76000 nid=0x552c runnable
"VM Periodic Task Thread" os_prio=2 tid=0x000001e9a48c7000 nid=0x2ea8 waiting on condition

JNI global references: 12

#####################################划重点(deadlock)#####################################
Found one Java-level deadlock:
=============================
"mythread-t2":
  waiting for ownable synchronizer 0x000000076becdd10, (a java.util.concurrent.locks.ReentrantLock$NonfairSync),
  which is held by "mythread-t1"
"mythread-t1":
  waiting for ownable synchronizer 0x000000076becdd40, (a java.util.concurrent.locks.ReentrantLock$NonfairSync),
  which is held by "mythread-t2"

Java stack information for the threads listed above:
===================================================
"mythread-t2":
        at sun.misc.Unsafe.park(Native Method)
        - parking to wait for  <0x000000076becdd10> (a java.util.concurrent.locks.ReentrantLock$NonfairSync)
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:836)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireQueued(AbstractQueuedSynchronizer.java:870)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:1199)
        at java.util.concurrent.locks.ReentrantLock$NonfairSync.lock(ReentrantLock.java:209)
        at java.util.concurrent.locks.ReentrantLock.lock(ReentrantLock.java:285)
        at com.loong.test.jstack.DeathLockTest$2.run(DeathLockTest.java:38)
"mythread-t1":
        at sun.misc.Unsafe.park(Native Method)
        - parking to wait for  <0x000000076becdd40> (a java.util.concurrent.locks.ReentrantLock$NonfairSync)
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:836)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireQueued(AbstractQueuedSynchronizer.java:870)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:1199)
        at java.util.concurrent.locks.ReentrantLock$NonfairSync.lock(ReentrantLock.java:209)
        at java.util.concurrent.locks.ReentrantLock.lock(ReentrantLock.java:285)
        at com.loong.test.jstack.DeathLockTest$1.run(DeathLockTest.java:24)

#####################################划重点(Found 1 deadlock.)#####################################
Found 1 deadlock.

### 这段代码是从上方打印结果中截取的
# 可以看到mythread-t2 持有锁(0x000000076becdd40) 等待获取锁(0x000000076becdd10)
# 可以看到mythread-t1 持有锁(0x000000076becdd10) 等待获取锁(0x000000076becdd40)

"mythread-t2" #13 prio=5 os_prio=0 tid=0x000001e9a4976000 nid=0x1304 waiting on condition [0x000000204acff000]
   java.lang.Thread.State: WAITING (parking) ###### 线程 mythread-t2 处于WAITING (parking)
        at sun.misc.Unsafe.park(Native Method)
        ###### 线程mythread-t2 等待获取锁(0x000000076becdd10)
        - parking to wait for  <0x000000076becdd10> (a java.util.concurrent.locks.ReentrantLock$NonfairSync)
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:836)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireQueued(AbstractQueuedSynchronizer.java:870)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:1199)
        at java.util.concurrent.locks.ReentrantLock$NonfairSync.lock(ReentrantLock.java:209)
        at java.util.concurrent.locks.ReentrantLock.lock(ReentrantLock.java:285)
        at com.loong.test.jstack.DeathLockTest$2.run(DeathLockTest.java:38)

   Locked ownable synchronizers:
   		###### 线程mythread-t2 现在持有的锁(0x000000076becdd40)
        - <0x000000076becdd40> (a java.util.concurrent.locks.ReentrantLock$NonfairSync)

"mythread-t1" #12 prio=5 os_prio=0 tid=0x000001e9a4909800 nid=0x424c waiting on condition [0x000000204abff000]
   java.lang.Thread.State: WAITING (parking) ###### 线程 mythread-t1 处于WAITING (parking)
        at sun.misc.Unsafe.park(Native Method)
        ###### 线程mythread-t2 等待获取锁(0x000000076becdd40)
        - parking to wait for  <0x000000076becdd40> (a java.util.concurrent.locks.ReentrantLock$NonfairSync)
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:836)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireQueued(AbstractQueuedSynchronizer.java:870)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:1199)
        at java.util.concurrent.locks.ReentrantLock$NonfairSync.lock(ReentrantLock.java:209)
        at java.util.concurrent.locks.ReentrantLock.lock(ReentrantLock.java:285)
        at com.loong.test.jstack.DeathLockTest$1.run(DeathLockTest.java:24)

   Locked ownable synchronizers:
   		###### 线程mythread-t2 现在持有的锁(0x000000076becdd10)
        - <0x000000076becdd10> (a java.util.concurrent.locks.ReentrantLock$NonfairSync)

总结

可以看到mythread-t2 处于等待(WAITING (parking)) 持有锁(0x000000076becdd40) 等待获取锁(0x000000076becdd10)
可以看到mythread-t1 处于等待(WAITING (parking)) 持有锁(0x000000076becdd10) 等待获取锁(0x000000076becdd40)

CPU过高示例

代码示例

package com.loong.test.jstack;

import java.util.concurrent.ExecutorService;
import java.util.concurrent.Executors;

/**
 * @Author 
 * @Date 2024-02-02 16:32
 * @Version 1.0
 */
public class CpuHighTest {

    private static final ExecutorService THREAD_POOL = Executors.newFixedThreadPool(5);

    public static Object lock = new Object();

    static class Task implements Runnable {

        public void run() {
            synchronized (lock) {
                long sum = 0L;
                while (true) {
                    sum += 1;
                }
            }
        }
    }

    public static void main(String[] args) {
        Task task1 = new Task();
        Task task2 = new Task();
        THREAD_POOL.execute(task1);
        THREAD_POOL.execute(task2);
    }
}