(10)系统慢,CPU100%,Full GC过多排查思路(1)

导出jstack内存信息重启系统,尽快保证可用性。

主要原因(可导致不可用):

    (1)读数据量较大内存耗尽Full GC多,慢; (2)耗CPU操作,CPU过高,慢;

原因(只慢,还可用):

    (3)阻塞,耗时,出现随机;(4)线程WAITING,整体不可用,但无法复现;(5)多个线程死锁

这种要查看系统日志,查CPU和系统内存,看不出具体问题,阻塞性操作,CPU和系统内存使用都不高。

一. Full GC次数过多

 两个特征:CPU超过100%,jstack命令看,主要是垃圾回收线程

                    jstat命令看监控GC情况,Full GC不断增加。

操作概要:看CPU,看进程(线程),看内存日志(哪些对象多),内存占用不高,Full GC多,System.gc()禁用

1、输入 “top”  看CPU高示例:

2、来查看哪些线程CPU高top -Hp 9

进程9中各个线程CPU占用情况,jstack命令看10线程为什么耗费CPU最高。jsatck中线程id都转换成十六进制查看转换结果:root@a39de7e7934b:/# printf "%x\n" 10a (结果说明在jstack中的展现形式为0xa),jstack命令:

nid=0xa,nid是系统线程。VM Thread是垃圾回收线程。GC停顿时间长,慢。GC情况:

3、Full GC数量高达6793,不断增长。dump内存日志(看是否是内存溢出),通过eclipse的mat看,展示对象树结构:

PrintStream最多,消耗量只有12.2%。不足导致大量Full GC,显示System.gc()调用导致GC次数过多,解决:添加-XX:+DisableExplicitGC禁用

    Shallow Size:对象本身占内存大小,不包含引用对象。1)对象(非数组)Shallow Size由其成员变量数量和类型来定,2)数组ShallowSize由数组类型和长度决定,为数组元素大小总和

    Retained Size=当前对象+直/间接引用到对象大小总和。(A->B->C,C间接引用) ,排除被GC Roots直/间接引用对象。就是当前对象被GC后,Heap释放掉的总内存

二、CPU过高

jstack得到线程信息,类似VM Thread线程(上面),如代码耗时计算,得到线程堆栈信息:定位UserController34行

三、接口不定期耗时

消耗CPU和内存都不多,jstack命令信息没法判断

思路:压测接口,复现堆栈日志:阻塞在18行

四、 线程WAITING

罕见情况,“不可复现性”,用CountDownLatch时,并行任务完成,唤醒主线程。一个连接一直等待服务器响应。其余WAITING

问题线程与其他一样,思路:grep在jstack日志,找所有TIMED_WAITING线程,导出到a1.log:

10s后,再对jstack日志grep,导出到a2.log:

重复2,导出3~4文件对比,几个文件一直存在的用户线程,是问题线程。正常线程不会20~30s后还等待。通过线程名,排除框架线程

看堆栈信息,哪个代码导致:Thread-0是线程,SyncTask8行导致

五、 死锁

jstack检查死锁,日志中打印:

死锁线程堆栈信息

六. 小结

(1)top看CPU情况,top -Hp <pid>看线程,将线程id转换为十六进制,jstack日志:

    1、VM Thread,jstat -gcutil <pid> <period> <times>监控GC状,jmap dump:format=b,file=<filepath> <pid>内存数据。放到eclipse的mat工具分析

    2、正常线程,堆栈信息看哪处代码消耗CPU;

(2)CPU、内存都不高:

压测,jstack看堆栈信息;

无法复现,多次导出jstack日志,找出问题线程。

jstack看死锁

https://my.oschina.net/zhangxufeng/blog/3017521

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