top+jstack查找线上CPU占用最高的线程

1 场景

通过linux的top命令jdk的jstack命令来排查当前系统CPU占用最多的线程。

2 步骤

主要步骤如下图:


1621513211543.png

2.1 测试代码

SpringBoot中写一个死循环

// package com.sa.jvm.admin.controller;
/**
 * 死循环测试
 */
@Controller
@RequestMapping("/infiniteLoop")
public class PowerController {
    @RequestMapping("test")
    public String test() {
        while (1 == 1) {
            System.out.println(new Random().nextInt(1000));
        }
    }   
}

当前访问此请求路径(/infiniteLoop/test)时,CPU将飙升。

发起请求后,控制台将无限输出1000以内的随机数,如下:

http://192.168.0.11:8080/infiniteLoop/test

2.2 排查问题

(1)查找CPU占用最高的进程

linux系统中输入如下命令,查看CPU占用最高的进程

top -c
1621426435098.png

如图所示,PIP为3147的java进程的CPU占比最高。此处已经定位到有问题的进程PID为3147。

top -c含义:

每隔5秒显式进程的资源占用情况,并显示进程的命令行参数(默认只有进程名)

另外TOP模式下,常用交互命令如下:

命令 说明
P 以 CPU 占用率大小的顺序排列进程列表
M 以内存占用率大小的顺序排列进程列表

(2)查看进程中CPU占比最高的线程

已经找到CPU占比最高的进程,ID为3147,继续查找此进程对应的线程信息

linux系统中输入如下命令,查找指定进程中,CPU占用最高的线程

top -H -p 3147
1621426952921.png

如图所示,该进程中CPU占比最高的进程的PID为:3168此处已经定位到有问题的线程PID为3168。

linux中通过如下命令,将线程的PID转为小写16进制。

printf '%x\n' 3168

得到16进制的线程ID为:c60

(3)导出进程堆栈信息

此处我们得到有问题的进程为3147,有问题的线程ID的16进制为c60

先使用jdk的jstack命令根据线程PID导出对应的线程栈信息。

jstack 3147

此命令会输出此java进程中的所有的线程栈信息,我们通过有问题的线程的16进制PID查找问题线程对应的栈信息。

可以使用如下命令进行线程栈信息过滤

jstack 3147 | grep c60 -A 50

或j将线程栈信息重定向到文件中,再进行查询:

jstack 3147 > jstack.log

得到查询结果如下:

1621427894361.png

如图所示,此CPU占用主要为输出打印内容导致的CPU占用,有问题的代码为:

at com.sa.jvm.admin.controller.PowerController.test(PowerController.java:18)

我们查看源码,进行问题定位:

有问题的代码第18行如下,此时已经定位到问题的代码,和我们模拟的死循环代码一致:

1621428181489.png

3 服务器CPU使用率高的情况

服务器CPU使用率高的情况,除了以上的业务代码外。此处对可能出现的原因进行分析。

3.1 CAS

使用AtomicIntegerCountdownLatch基于CAS的相关类时或者自己实现CAS时,当值修改失败时,会一直高速循环

解决方案:

(1)限制重试次数

(2)间隔一段时间后重试

3.2 程序死循环

如本文的案例,当业务代码出现死循环无法跳出的情况时,会长时间大量占用CPU。

解决方案:

在代码级别进行控制,保证代码质量和健壮性,流程代码需有退出循环的条件

3.3 tomcat并发量太高

tomcat默认线程池数量200,一般不会更改为太高,大多数的请求都是快速响应

并发请求数暴增,超过tomcat的负载能力后,web容器中会堆积大量的请求,会占用过多的CPU资源导致响应慢和卡顿。

解决方案:

(1)限流、进行请求数量的控制

(2)负载均衡

(3)处理相应慢的请求业务代码......

3.4 服务器被攻击

当前服务器的端口被攻击后(如redis的6379端口)。

如何排查:

查看服务器网路的带宽情况和非法程序

解决方案:

(1)更改程序的通用端口为其他端口,防止被攻击

(2)运行环境,尽量使用同一的局域网,只对外部暴露可供访问的程序端口。如使用阿里云等环境,需尽量使用同一的云环境,环境中的服务可通过局域网的方式访问。

3.5 java虚拟机GC频繁

当java虚拟机频繁GC时,根据本文的方法,查找到的CPU占用高的线程是JVM的GC线程,没有对应的业务代码,无法定位业务代码

解决方案:

(1)加大堆内存(临时解决

(2)生成堆dump,通过MAT或jprofile排查大对象产生的代码。一般生产环境,不会允许进行堆dump,此种情况,可以考虑使用本文的方法,查找仅CPU占用率前几的线程栈信息或者CPU执行时间前几的线程栈信息

最后编辑于
©著作权归作者所有,转载或内容合作请联系作者
禁止转载,如需转载请通过简信或评论联系作者。
  • 序言:七十年代末,一起剥皮案震惊了整个滨河市,随后出现的几起案子,更是在滨河造成了极大的恐慌,老刑警刘岩,带你破解...
    沈念sama阅读 204,590评论 6 478
  • 序言:滨河连续发生了三起死亡事件,死亡现场离奇诡异,居然都是意外死亡,警方通过查阅死者的电脑和手机,发现死者居然都...
    沈念sama阅读 86,808评论 2 381
  • 文/潘晓璐 我一进店门,熙熙楼的掌柜王于贵愁眉苦脸地迎上来,“玉大人,你说我怎么就摊上这事。” “怎么了?”我有些...
    开封第一讲书人阅读 151,151评论 0 337
  • 文/不坏的土叔 我叫张陵,是天一观的道长。 经常有香客问我,道长,这世上最难降的妖魔是什么? 我笑而不...
    开封第一讲书人阅读 54,779评论 1 277
  • 正文 为了忘掉前任,我火速办了婚礼,结果婚礼上,老公的妹妹穿的比我还像新娘。我一直安慰自己,他们只是感情好,可当我...
    茶点故事阅读 63,773评论 5 367
  • 文/花漫 我一把揭开白布。 她就那样静静地躺着,像睡着了一般。 火红的嫁衣衬着肌肤如雪。 梳的纹丝不乱的头发上,一...
    开封第一讲书人阅读 48,656评论 1 281
  • 那天,我揣着相机与录音,去河边找鬼。 笑死,一个胖子当着我的面吹牛,可吹牛的内容都是我干的。 我是一名探鬼主播,决...
    沈念sama阅读 38,022评论 3 398
  • 文/苍兰香墨 我猛地睁开眼,长吁一口气:“原来是场噩梦啊……” “哼!你这毒妇竟也来了?” 一声冷哼从身侧响起,我...
    开封第一讲书人阅读 36,678评论 0 258
  • 序言:老挝万荣一对情侣失踪,失踪者是张志新(化名)和其女友刘颖,没想到半个月后,有当地人在树林里发现了一具尸体,经...
    沈念sama阅读 41,038评论 1 299
  • 正文 独居荒郊野岭守林人离奇死亡,尸身上长有42处带血的脓包…… 初始之章·张勋 以下内容为张勋视角 年9月15日...
    茶点故事阅读 35,659评论 2 321
  • 正文 我和宋清朗相恋三年,在试婚纱的时候发现自己被绿了。 大学时的朋友给我发了我未婚夫和他白月光在一起吃饭的照片。...
    茶点故事阅读 37,756评论 1 330
  • 序言:一个原本活蹦乱跳的男人离奇死亡,死状恐怖,灵堂内的尸体忽然破棺而出,到底是诈尸还是另有隐情,我是刑警宁泽,带...
    沈念sama阅读 33,411评论 4 321
  • 正文 年R本政府宣布,位于F岛的核电站,受9级特大地震影响,放射性物质发生泄漏。R本人自食恶果不足惜,却给世界环境...
    茶点故事阅读 39,005评论 3 307
  • 文/蒙蒙 一、第九天 我趴在偏房一处隐蔽的房顶上张望。 院中可真热闹,春花似锦、人声如沸。这庄子的主人今日做“春日...
    开封第一讲书人阅读 29,973评论 0 19
  • 文/苍兰香墨 我抬头看了看天上的太阳。三九已至,却和暖如春,着一层夹袄步出监牢的瞬间,已是汗流浃背。 一阵脚步声响...
    开封第一讲书人阅读 31,203评论 1 260
  • 我被黑心中介骗来泰国打工, 没想到刚下飞机就差点儿被人妖公主榨干…… 1. 我叫王不留,地道东北人。 一个月前我还...
    沈念sama阅读 45,053评论 2 350
  • 正文 我出身青楼,却偏偏与公主长得像,于是被迫代替她去往敌国和亲。 传闻我的和亲对象是个残疾皇子,可洞房花烛夜当晚...
    茶点故事阅读 42,495评论 2 343

推荐阅读更多精彩内容