Java 定位導(dǎo)致CPU飆升的代碼過程

線上的一個日志實時輸出的程序曾經(jīng)出過這樣一個問題,剛開始上線java程序占用的CPU的資源很少,但是到了整點的時候,CPU直線飆高吉嫩,直接到達(dá)100%根本沒有要下降的趨勢价认,唯一的方法只能殺掉它了,后面在借助jstacktop排查到線程然后定位到某行代碼出的問題自娩。

排查演示

  1. 使用jps找到程序的pid
[root@logs bin]# ./jps -l -m | grep logdir2
22169 galaxy-log-online-0.1-SNAPSHOT-all.jar 3002 /logdir2
  1. 找到22169進(jìn)程ID
  2. 找到CPU過高的線程
top -H -p 22169

top - 19:03:22 up 156 days,  5:57,  4 users,  load average: 1.00, 2.84, 4.25
Threads:  15 total,   0 running,  15 sleeping,   0 stopped,   0 zombie
%Cpu(s): 99.4 us, 12.6 sy,  0.0 ni, 62.6 id,  4.8 wa,  0.0 hi,  2.6 si,  0.0 st
KiB Mem :  8010456 total,   206760 free,  1079668 used,  6724028 buff/cache
KiB Swap:        0 total,        0 free,        0 used.  6561460 avail Mem

  PID USER      PR  NI    VIRT    RES    SHR S %CPU %MEM     TIME+ COMMAND
22184 root      20   0 4543356  74148  12960 S  80.0  40.9   0:19.96 java
22169 root      20   0 4543356  74148  12960 S  0.0  0.9   0:00.00 java
22170 root      20   0 4543356  74148  12960 S  0.0  0.9   0:00.35 java
22171 root      20   0 4543356  74148  12960 S  0.0  0.9   0:00.08 java
22172 root      20   0 4543356  74148  12960 S  0.0  0.9   0:00.09 java
...
  1. 將線程轉(zhuǎn)為16進(jìn)制
[root@logs bin]# printf "%x" 22184
56a8
  1. 使用jstack定位到線程
[root@logs bin]# ./jstack 22169 | grep 56a8
"Thread-1" #9 prio=5 os_prio=0 tid=0x00007fe428230800 nid=0x56a8 waiting on condition [0x00007fe4121a5000]
  1. 使用3D肉眼來查看線程運行的代碼了
"Thread-1" #9 prio=5 os_prio=0 tid=0x00007fe428230800 nid=0x56a8 waiting on condition [0x00007fe4121a5000]
   java.lang.Thread.State: TIMED_WAITING (sleeping)
    at java.lang.Thread.sleep(Native Method)
    at java.lang.Thread.sleep(Unknown Source)
    at java.util.concurrent.TimeUnit.sleep(Unknown Source)
    at com.dounine.tool.http.sql.LogsRequest$4.run(LogsRequest.java:152)
    at java.lang.Thread.run(Unknown Source)

然后開始從LogsRequest.java152行開始找起用踩,發(fā)現(xiàn)里面有一個死循環(huán)...

FIX 它

然后開開心心下班

?著作權(quán)歸作者所有,轉(zhuǎn)載或內(nèi)容合作請聯(lián)系作者
  • 序言:七十年代末,一起剝皮案震驚了整個濱河市忙迁,隨后出現(xiàn)的幾起案子脐彩,更是在濱河造成了極大的恐慌,老刑警劉巖姊扔,帶你破解...
    沈念sama閱讀 216,591評論 6 501
  • 序言:濱河連續(xù)發(fā)生了三起死亡事件惠奸,死亡現(xiàn)場離奇詭異,居然都是意外死亡恰梢,警方通過查閱死者的電腦和手機佛南,發(fā)現(xiàn)死者居然都...
    沈念sama閱讀 92,448評論 3 392
  • 文/潘曉璐 我一進(jìn)店門,熙熙樓的掌柜王于貴愁眉苦臉地迎上來嵌言,“玉大人嗅回,你說我怎么就攤上這事〈蒈睿” “怎么了绵载?”我有些...
    開封第一講書人閱讀 162,823評論 0 353
  • 文/不壞的土叔 我叫張陵,是天一觀的道長蓬蝶。 經(jīng)常有香客問我,道長猜惋,這世上最難降的妖魔是什么丸氛? 我笑而不...
    開封第一講書人閱讀 58,204評論 1 292
  • 正文 為了忘掉前任,我火速辦了婚禮著摔,結(jié)果婚禮上缓窜,老公的妹妹穿的比我還像新娘。我一直安慰自己谍咆,他們只是感情好禾锤,可當(dāng)我...
    茶點故事閱讀 67,228評論 6 388
  • 文/花漫 我一把揭開白布。 她就那樣靜靜地躺著摹察,像睡著了一般恩掷。 火紅的嫁衣襯著肌膚如雪。 梳的紋絲不亂的頭發(fā)上供嚎,一...
    開封第一講書人閱讀 51,190評論 1 299
  • 那天黄娘,我揣著相機與錄音峭状,去河邊找鬼。 笑死逼争,一個胖子當(dāng)著我的面吹牛优床,可吹牛的內(nèi)容都是我干的。 我是一名探鬼主播誓焦,決...
    沈念sama閱讀 40,078評論 3 418
  • 文/蒼蘭香墨 我猛地睜開眼胆敞,長吁一口氣:“原來是場噩夢啊……” “哼!你這毒婦竟也來了杂伟?” 一聲冷哼從身側(cè)響起移层,我...
    開封第一講書人閱讀 38,923評論 0 274
  • 序言:老撾萬榮一對情侶失蹤,失蹤者是張志新(化名)和其女友劉穎稿壁,沒想到半個月后幽钢,有當(dāng)?shù)厝嗽跇淞掷锇l(fā)現(xiàn)了一具尸體,經(jīng)...
    沈念sama閱讀 45,334評論 1 310
  • 正文 獨居荒郊野嶺守林人離奇死亡傅是,尸身上長有42處帶血的膿包…… 初始之章·張勛 以下內(nèi)容為張勛視角 年9月15日...
    茶點故事閱讀 37,550評論 2 333
  • 正文 我和宋清朗相戀三年匪燕,在試婚紗的時候發(fā)現(xiàn)自己被綠了。 大學(xué)時的朋友給我發(fā)了我未婚夫和他白月光在一起吃飯的照片喧笔。...
    茶點故事閱讀 39,727評論 1 348
  • 序言:一個原本活蹦亂跳的男人離奇死亡帽驯,死狀恐怖,靈堂內(nèi)的尸體忽然破棺而出书闸,到底是詐尸還是另有隱情尼变,我是刑警寧澤,帶...
    沈念sama閱讀 35,428評論 5 343
  • 正文 年R本政府宣布浆劲,位于F島的核電站嫌术,受9級特大地震影響,放射性物質(zhì)發(fā)生泄漏牌借。R本人自食惡果不足惜度气,卻給世界環(huán)境...
    茶點故事閱讀 41,022評論 3 326
  • 文/蒙蒙 一、第九天 我趴在偏房一處隱蔽的房頂上張望膨报。 院中可真熱鬧磷籍,春花似錦、人聲如沸现柠。這莊子的主人今日做“春日...
    開封第一講書人閱讀 31,672評論 0 22
  • 文/蒼蘭香墨 我抬頭看了看天上的太陽够吩。三九已至比然,卻和暖如春,著一層夾襖步出監(jiān)牢的瞬間周循,已是汗流浹背谈秫。 一陣腳步聲響...
    開封第一講書人閱讀 32,826評論 1 269
  • 我被黑心中介騙來泰國打工扒寄, 沒想到剛下飛機就差點兒被人妖公主榨干…… 1. 我叫王不留,地道東北人拟烫。 一個月前我還...
    沈念sama閱讀 47,734評論 2 368
  • 正文 我出身青樓该编,卻偏偏與公主長得像,于是被迫代替她去往敵國和親硕淑。 傳聞我的和親對象是個殘疾皇子课竣,可洞房花燭夜當(dāng)晚...
    茶點故事閱讀 44,619評論 2 354

推薦閱讀更多精彩內(nèi)容