Java线程＜二＞ _ Thread Dump日志分析

已于 2022-04-05 11:53:27 修改
阅读量3.3k 收藏 5
点赞数 1
分类专栏： thread 文章标签： java 并发编程 多线程
于 2022-01-25 22:09:42 首次发布
版权声明：本文为博主原创文章，遵循 CC 4.0 BY-SA 版权协议，转载请附上原文出处链接和本声明。
本文链接：https://blog.csdn.net/m0_37543627/article/details/122574283
版权

目录

一、查看CPU上下文切换

1. vmstat命令

2. pidstat命令

二、JVM的jstack命令

1. JVM的jstack命令

2. 堆栈信息的线程状态

三、 Thread Dump日志分析

1. 导出堆栈信息

2. 堆栈信息实例

        实例一：BLOCKED (on object monitor)

        实例二：TIMED_WAITING (sleeping)

        实例三：TIMED_WAITING (on object monitor)

        实例四：WAITING (parking)

四、参考资料

一、查看CPU上下文切换

1. vmstat命令

        vmstat是一个常用的系统性能分析工具，主要用来分析系统的内存使用情况和分析CPU上下文切换和中断的次数。vmstat默认是1秒采集一次。

所属内容描述
procs

r

(Running or Runnable)

1. 运行队列长度：多少个进程真的分配到CPU

2. 值超出CPU核数，就会出现CPU瓶颈了。也和top负载有关系

b(Blocked）阻塞：处于不可中断睡眠状态的进程数

memory

(byte)

swdp

1. 虚拟内存已使用的大小

2. 大于0，表示机器物理内存不足或者内存泄露

free空闲的物理内存的大小
buffIO数据结构的缓存区缓存
cache从磁盘读取文件的内容缓存
swapsi

1. 每秒从磁盘读入虚拟内存的大小

2. 大于0，表示物理内存不够用或者内存泄露

so

1. 每秒虚拟内存写入磁盘的大小

2. 大于0，表示物理内存不够用或者内存泄露

iobi

1. 块设备(所有的磁盘和其他块设备)每秒接收的块数量，如写磁盘等

2. 要接近0，不然就是IO过于频繁

bo

1. 块设备(所有的磁盘和其他块设备)每秒发送的块数量，如读取文件

2. 要接近0，不然就是IO过于频繁

system

(每秒次数)

in(interrupt)每秒CPU的中断次数，包括时间中断
cs(context switch)

1. 每秒上下文切换次数，如线程/进程切换、调用系统函数

2. 值越小越好，进行性能压测的重要参数

cpu

(百分比)

us

用户CPU时间

sy

1. 系统CPU时间

2. 太高，表示系统调用时间长，如IO操作频繁

id空闲CPU时间，us + sy + id = 100
wd

1. 等待IO时间

2. 过高时，说明io等待比较严重，可能磁盘大量随机访问造成

st虚拟机偷取的CPU时间

2. pidstat命令

        pidstat -w可以查看每个进程的上下文切换次数。

#CentOS使用pidstat
yum install sysstat

主要参数：

 -u：默认的参数，显示各个进程的cpu使用统计
-r：显示各个进程的内存使用统计
-d：显示各个进程的IO使用情况
-p：指定进程号
-w：显示每个进程的上下文切换情况

所属内容描述
-uPID当前进程ID
%usr当前进程在用户空间占用cpu的百分比
%system当前进程在内核空间占用cpu的百分比
%guest当前进程在虚拟机占用cpu的百分比
%CPU当前进程占用cpu的百分比
CPU处理当前进程的cpu编号
Command当前进程对应的命令
-wcswch/s

1. 每秒主动任务上下文切换数量

2. 说明进程等待资源，有可能发生了I/O等其他问题

nvcswch/s

1. 每秒被动任务上下文切换数量

2. 说明进程被强制调度，都在争抢CPU，说明CPU的确成了瓶颈

-rminflt/s

每秒次缺页错误次数(minor page faults)，即：虚拟内存地址映射成物理内存地址产生的page fault次数

majflt/s每秒主缺页错误次数(major page faults)，即：主缺页错误次数（虚拟内存地址映射成物理内存地址时，相应的page在swap中），一般在内存使用紧张时产生
VSZ进程使用的虚拟内存（kB）
RSS进程使用的物理内存（kB）
%MEM进程使用内存的百分比

二、JVM的jstack命令

1. JVM的jstack命令

        jstack(Java Stack Trace)查看某个Java进程内的线程堆栈信息。如果java程序崩溃生成core文件，jstack工具获得core文件的java stack和native stack的信息，可以轻松地知道java程序是如何崩溃和在程序何处发生问题。也可以获取正在运行的java程序java stack和native stack的信息，用以优化代码等。

        如下图所示，jstack命令使用。

-F：当正常输出的请求不被响应时，强制输出线程堆栈
-m：如果调用到本地方法的话，可以显示 C/C++ 的堆栈
-l：除堆栈外，显示关于锁的附加信息，在发生死锁时可以用 jstack -l pid 来观察锁持有情况

"mysql-cj-abandoned-connection-cleanup" #53 daemon prio=5 os_prio=0 tid=0x00007fd891d4c800 nid=0x60d in Object.wait() [0x00007fd7fc3de000]
   java.lang.Thread.State: TIMED_WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:144)
	- locked <0x00000000c335c7d8> (a java.lang.ref.ReferenceQueue$Lock)
	at com.mysql.cj.jdbc.AbandonedConnectionCleanupThread.run(AbandonedConnectionCleanupThread.java:85)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
	at java.lang.Thread.run(Thread.java:748)

以上是堆栈信息，主要参数：

  • "mysql-cj-abandoned-connection-cleanup"：线程名
  • #53：堆栈序号
  • daemon：有daemon，表示当前线程是守护线程；无，则不是
  • prio=5：JVM线程优先级
  • os_prio=0：OS层次的线程优先级
  • tid=0x00007fd891d4c800：线程标识
  • nid=0x60d：线程ID

2. 堆栈信息的线程状态

线程状态参考：Java线程＜一＞ _ 介绍

  • 死锁：deadlock（重点关注） 
  • 执行中：Runnable 
  • 等待资源：waiting on condition（重点关注） 
  • 等待获取监视器：waiting for monitor entry（重点关注）
  • 暂停，Suspended
  • 对象等待中，Object.wait() 或 TIMED_WAITING
  • 阻塞，Blocked（重点关注）  
  • 停止，Parked

三、 Thread Dump日志分析

1. 导出堆栈信息

step1：进入JDK的bin目录下，执行jstack命令

        jstack -l 2605 > /home/dump2605

step2：统计线程所处状态

grep java.lang.Thread.State /home/dump2605 | awk '{print $2$3$4$5}' | sort | uniq -c

step3：导出dump2605文件

2. 堆栈信息实例

        实例一：BLOCKED (on object monitor)

（1）线程状态是BLOCKED，实际是死锁。"Thread-11"与"Thread-10"为死锁；

（2）locked <0x00000000c0002388>：线程"Thread-11"已经锁住0x00000000c0002388这个地址的对象；

（3）waiting to lock <0x00000000c0002370>：线程"Thread-11"等待给0x00000000c0002370这个地址的对象上锁，已进入对象的锁池中（Entry Set队列）；

（4）waiting for monitor entry [0x00007f108ab65000]：线程"Thread-11"等待获取监控对象（对象的锁对象）。

"Thread-11" #121 daemon prio=5 os_prio=0 tid=0x00007f10e02e0000 nid=0xb93 waiting for monitor entry [0x00007f108ab65000]
   java.lang.Thread.State: BLOCKED (on object monitor)
	at com.common.instance.test.service.impl.NginxCacheServiceImpl$3.run(NginxCacheServiceImpl.java:110)
	- waiting to lock <0x00000000c0002370> (a java.lang.String)
	- locked <0x00000000c0002388> (a java.lang.String)
	at java.lang.Thread.run(Thread.java:748)

   Locked ownable synchronizers:
	- None

"Thread-10" #120 daemon prio=5 os_prio=0 tid=0x00007f10e0378800 nid=0xb92 waiting for monitor entry [0x00007f108abe6000]
   java.lang.Thread.State: BLOCKED (on object monitor)
	at com.common.instance.test.service.impl.NginxCacheServiceImpl$2.run(NginxCacheServiceImpl.java:100)
	- waiting to lock <0x00000000c0002388> (a java.lang.String)
	- locked <0x00000000c0002370> (a java.lang.String)
	at java.lang.Thread.run(Thread.java:748)

   Locked ownable synchronizers:
	- None



Found one Java-level deadlock:
=============================
"Thread-11":
  waiting to lock monitor 0x00007f10d4010248 (object 0x00000000c0002370, a java.lang.String),
  which is held by "Thread-10"
"Thread-10":
  waiting to lock monitor 0x00007f10cc295ab8 (object 0x00000000c0002388, a java.lang.String),
  which is held by "Thread-11"

Java stack information for the threads listed above:
===================================================
"Thread-11":
	at com.common.instance.test.service.impl.NginxCacheServiceImpl$3.run(NginxCacheServiceImpl.java:110)
	- waiting to lock <0x00000000c0002370> (a java.lang.String)
	- locked <0x00000000c0002388> (a java.lang.String)
	at java.lang.Thread.run(Thread.java:748)
"Thread-10":
	at com.common.instance.test.service.impl.NginxCacheServiceImpl$2.run(NginxCacheServiceImpl.java:100)
	- waiting to lock <0x00000000c0002388> (a java.lang.String)
	- locked <0x00000000c0002370> (a java.lang.String)
	at java.lang.Thread.run(Thread.java:748)

Found 1 deadlock.

        实例二：TIMED_WAITING (sleeping)

（1）线程状态是TIMED_WAITING，限时等待。Druid连接池中的连接等待销毁；

（2）waiting on condition [0x00007f1091cf2000]：该线程在等待sleep()结束，把自己唤醒。

"Druid-ConnectionPool-Destroy-1324165839" #61 daemon prio=5 os_prio=0 tid=0x00007f1171ef8000 nid=0xb58 waiting on condition [0x00007f1091cf2000]
   java.lang.Thread.State: TIMED_WAITING (sleeping)
	at java.lang.Thread.sleep(Native Method)
	at com.alibaba.druid.pool.DruidDataSource$DestroyConnectionThread.run(DruidDataSource.java:2913)

   Locked ownable synchronizers:
	- None

        实例三：TIMED_WAITING (on object monitor)

（1）线程状态是TIMED_WAITING，限期等待对象锁。某个对象的锁对象被其他占用；

（2）locked <0x00000000c3dc02b0>："Atomikos:1"已锁住0x00000000c3dc02b0地址的对象；

（3）waiting on <0x00000000c3dc02b0>："Atomikos:1"等待获取锁（发生自锁）；

（4）in Object.wait() [0x00007f1091a71000]："Atomikos:1"等待0x00000000c3dc02b0地址的对象的锁对象0x00007f1091a71000；

（5） Locked ownable synchronizers：发生自锁。

"Atomikos:1" #63 daemon prio=5 os_prio=0 tid=0x00007f1171fe8000 nid=0xb59 in Object.wait() [0x00007f1091a71000]
   java.lang.Thread.State: TIMED_WAITING (on object monitor)
	at java.lang.Object.wait(Native Method)
	- waiting on <0x00000000c3dc02b0> (a java.lang.Object)
	at com.atomikos.timing.PooledAlarmTimer.doWait(PooledAlarmTimer.java:105)
	- locked <0x00000000c3dc02b0> (a java.lang.Object)
	at com.atomikos.timing.PooledAlarmTimer.run(PooledAlarmTimer.java:71)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
	at java.lang.Thread.run(Thread.java:748)

   Locked ownable synchronizers:
	- <0x00000000c3dc0330> (a java.util.concurrent.ThreadPoolExecutor$Worker)

        实例四：WAITING (parking)

（1）线程状态是WAITING ，无限期等待。Druid连接池中的连接等待创建；

（2）parking to wait for  <0x00000000c1c790d0>：无限期等待，直至某个条件（创建连接）。

"Druid-ConnectionPool-Create-1324165839" #60 daemon prio=5 os_prio=0 tid=0x00007f1171ef5000 nid=0xb57 waiting on condition [0x00007f1091d73000]
   java.lang.Thread.State: WAITING (parking)
	at sun.misc.Unsafe.park(Native Method)
	- parking to wait for  <0x00000000c1c790d0> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
	at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
	at com.alibaba.druid.pool.DruidDataSource$CreateConnectionThread.run(DruidDataSource.java:2813)

   Locked ownable synchronizers:
	- None

四、参考资料

Java线程＜一＞ _ 介绍_爱我所爱0505-CSDN博客

JVM 性能调优监控工具_慕课手记

三个实例演示 Java Thread Dump 日志分析 - 旁观者 - 博客园

JVM监控命令详解(转) - 舒润 - 博客园

CPU 上下文切换是什么意思？（下）_一亩三分地-CSDN博客

爱我所爱0505
关注
  • 1
    点赞
  • 踩
  • 5
    收藏
    觉得还不错? 一键收藏
  • 0
    评论
专栏目录
Java线程堆栈分析
weixin_34348111的博客
05-30 1879
线程堆栈也称作线程调用堆栈。Java线程堆栈是虚拟机中线程（包括锁）状态的一个瞬间快照，即系统在某个时刻所有线程的运行状态，包括每一个线程的调用堆栈，锁的持有情况等信息。对于已经消失而又没留有痕迹的信息，线程堆栈是无法进行历史追踪的。线程堆栈的信息包括：（1）线程的名字，id，线程的数量等（2）线程的运行状态，锁的状态（锁被哪个线程持有，哪个线程再等待锁等）（3）调用堆栈（即函数的调用层次关系），...
java线程栈日志_Java线程堆栈
weixin_39713317的博客
02-28 1052
线程堆栈信息以及解决的问题1、线程堆栈的信息都包含:线程的名字，ID，线程的数量等。线程的运行状态，锁的状态(锁被哪个线程持有，哪个线程再等待锁等)。调用堆栈(函数的调用层次关系)。调用堆栈包含完整的类名，执行的方法，源代* 码的行数。具体打印出的堆栈信息依赖于你的系统的复杂程度。2、通过线程堆栈可以解决的问题无缘无故CPU过高系统挂起，无响应系统运行越来越慢(资源争用或者锁竞争)线程死锁问题由于...
web应用程序似乎启动了一个名为[mysql-cj-abandoned-connection-cleanup]的线程，但未停止，可能会造成内存泄漏...
热门推荐
学习使我快乐_玉祥
04-15 2万+
在Tomcat关闭或重启的时候，会报这样的异常信息。 解决方法：设置监听器，在服务器注销的时候运行这句话就不会有问题了。 AbandonedConnectionCleanupThread.uncheckedShutdown(); 它的来源：com.mysql.cj.jdbc 名字直译过来：断开连接，清理线程。 它的源码中无任何注释，也没找到官方API，本人没法深究。 ...
[JDK工具-8] jstack java堆栈跟踪工具
最新发布
心流时间的博客
05-27 1089
java jdk工具 jstack java堆栈跟踪工具
关闭Tomcat报错appears to have started a thread named [Abandoned connection-cleanup] but has failed to st
chenzhiyuan09的专栏
05-27 1万+
关闭Tomcat报错The web application [ROOT] appears to have started a thread named [Abandoned connection cleanup thread] but has failed to stop it. This is very likely to create a memory leak.
问题“Web应用程序[ROOT]似乎启动了一个名为[mysql-cj-abandoned-connection-cleanup]的线程，但未能停止它。这很可能会造成内存泄漏”的解决
陈广智的专栏
03-14 2760
给出了警告信息“警告 [main] org.apache.catalina.loader.WebappClassLoaderBase.clearReferencesThreads Web应用程序[ROOT]似乎启动了一个名为[mysql-cj-abandoned-connection-cleanup]的线程，但未能停止它。这很可能会造成内存泄漏”等的解决方法。
解决：IDEA 重新部署 Tomcat 服务报异常
qq_40498276的博客
08-07 1729
使用tomcat版本：apache-tomcat-8.5.91。​​ 对象中并没有，close()方法。查看 阿里 Druid 源代码，发现其。​​ 是有 close() 方法的。是可以进行 close() 方法。解决办法：①在项目中新建一个名为。解决思路：进行连接池的关闭操作。得出dataSource的。​​这个注解相当于在。
java 线程 dump 分析工具 2.3.3
09-11
java 线程Dump 分析工具： Java的TDA线程转储分析器是一个用于分析Sun Java VM生成的线程转储和堆信息的小型Swing GUI(目前用1.4测试)。它从提供的日志文件中解析线程转储和类直方图。它提供关于发现的线程转储的...
Java thread dump analyzer (tda)
04-28
Java线程分析工具(TDA)是一款专为Java开发者设计的强大工具，用于解析和理解Java应用程序的线程转储(thread dump)。线程转储是Java虚拟机(JVM)在特定时刻生成的一种快照，其中包含了应用程序中所有活动线程的状态...
Java线程Dump分析工具jstack解析及使用场景
10-18
Java线程Dump分析工具jstack是Java开发人员和运维人员常用的诊断工具，它能够帮助我们了解Java应用程序中线程的状态，以及线程的执行轨迹。本文将深入解析jstack的使用方法及其在不同场景下的应用。 jstack命令的...
java线程分析工具TDA
06-21
TDA（Thread Dump Analyzer）是一款强大的Java线程分析工具，它能够帮助开发者深入理解应用在运行时的线程状态，包括线程的阻塞情况、等待资源、死锁等问题。下面将详细介绍TDA的使用方法、功能以及它如何帮助我们...
Jstack分析工具——IBM Thread and Monitor Dump Analyzer for Java
08-16
需要本地安装JDK并配置JAVA环境变量。 之后使用java -jar jca469.jar即可打开工具。 直接将dump出来的堆栈信息，打开，便可分析。
Java线程状态分析
JIESA的专栏
07-05 1484
Java线程的生命周期中，存在几种状态。在Thread类里有一个枚举类型State，定义了线程的几种状态，分别有： NEW: 线程创建之后，但是还没有启动(not yet started)。这时候它的状态就是NEWRUNNABLE: 正在Java虚拟机下跑任务的线程的状态。在RUNNABLE状态下的线程可能会处于等待状态， 因为它正在等待一些系统资源的释放，比如IOBLOCKED: 阻塞状态
关闭tomcat时，出现内存泄露警告
【小喵】的博客
01-13 2943
关闭tomcat时出现了下面警告：appears to have started a thread named [mysql-cj-abandoned-connection-cleanup] but has failed to stop it. This is very likely to create a memory leak. 具体信息如下： 原因是在spring的配置文件里，引用了一个未使用的连接，在关闭tomcat时，无法close这个连接，所以就会有内在泄露的风险，就有了这个警告。把没用的那个
[mysql-cj-abandoned-connection-cleanup] org.apache.catalina.loader.WebappClassLoaderBase.checkStateF
lebencat的博客
10-16 5872
可能是jar包没有添加到war上 有的话就点开，挨个fix
java.lang.ClassNotFoundException: com.mysql.cj.jdbc.AbandonedConnectionCleanupThread
高山仰止，景行行止
08-28 5694
在停止tomcat的时候在localhost.2019-08-28.log 报错： 27-Aug-2019 21:23:50.410 SEVERE [localhost-startStop-2] org.apache.catalina.core.StandardContext.listenerStop Exception sending context destroyed event to lis...
com.mysql.jdbc.AbandonedConnectionCleanupThread.run(AbandonedConnectionCleanupThread.java:43)
青山师
05-08 1万+
在IDEA中部署web项目到tomcat测试后， 关闭tomcat时可能遇到以下警告信息： com.mysql.jdbc.AbandonedConnectionCleanupThread.run(AbandonedConnectionCleanupThread.java:43) 完整信息如下： 警告 [localhost-startStop-1] org.apache.catalina.loader.WebappClassLoaderBase.clearReferencesJdbc The web app
TIMED_WAITING (on object monitor)分析
u013593306的专栏
04-23 1万+
背景:采用mina和外部进行通信，在发送数据的方法上出现。 tracestack： "" prio=10 tid=0x00007f1c7c1e0000 nid=0x3e31 in Object.wait() [0x00007f1cb48bf000]    java.lang.Thread.State: TIMED_WAITING (on object monitor)     at jav
三个实例演示 Java Thread Dump 日志分析
05-26
好的，下面给出三个简单的 Java Thread Dump 日志分析实例： 1. 查看占用 CPU 最高的线程 通过查看 Thread Dump 日志中的 CPU 占用时间，可以快速定位占用 CPU 最高的线程。例如： ``` "pool-1-thread-3" #9 prio...
评论
添加红包

请填写红包祝福语或标题

个

红包个数最小为10个

元

红包金额最低5元

当前余额3.43元 前往充值 >
需支付：10.00元
成就一亿技术人!
领取后你会自动成为博主和红包主的粉丝 规则
hope_wisdom
发出的红包
实付元
使用余额支付
点击重新获取
扫码支付
钱包余额 0

抵扣说明：

1.余额是钱包充值的虚拟货币，按照1:1的比例进行支付金额的抵扣。
2.余额无法直接购买下载，可以购买VIP、付费专栏及课程。

余额充值