1、原因。原因可能是cpu被占用,導(dǎo)致當(dāng)前任務(wù)分配不到時(shí)間片;也可能是內(nèi)存不足,導(dǎo)致程序運(yùn)行緩慢;還有可能是當(dāng)前的程序不太合理,如邏輯不合理導(dǎo)致執(zhí)行時(shí)間太長、鎖的不當(dāng)使用導(dǎo)致互相等待等。
2、分析步驟。先看cpu和內(nèi)存。如果是應(yīng)用的cpu占用很高,肯定是應(yīng)用的問題,如果是系統(tǒng)模塊占用cpu高,需要再分析。logcat中搜a(bǔ)nr in,看下面cpu的占用率和reason。trace文件中主要看當(dāng)前進(jìn)程的主線程堆棧和相關(guān)線程的堆棧,一般主線程處于等待狀態(tài),當(dāng)時(shí)的堆棧上調(diào)用的函數(shù)很可能就是有問題的。如果還不太明確,可以結(jié)合看看logcat中的ActivityManager的日志,如果是輸入引起的問題可以看下input相關(guān)的日志。
3、如何分析trace文件。它的輸出格式如下:
DALVIK THREADS:
(mutexes: tll=0 tsl=0 tscl=0 ghl=0 hwl=0 hwll=0)
"main" prio=5 tid=1 NATIVE
| group="main" sCount=1 dsCount=0 obj=0x400246a0 self=0x12770
| sysTid=503 nice=0 sched=0/0 cgrp=default handle=-1342909272
| schedstat=( 15165039025 12197235258 23068 ) utm=182 stm=1334 core=0
at android.os.MessageQueue.nativePollOnce(Native Method)
at android.os.MessageQueue.next(MessageQueue.java:119)
at android.os.Looper.loop(Looper.java:122)
at android.app.ActivityThread.main(ActivityThread.java:4134)
at java.lang.reflect.Method.invokeNative(Native Method)
at java.lang.reflect.Method.invoke(Method.java:491)
at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:841)
at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:599)
at dalvik.system.NativeStart.main(Native Method)
第一行 固定的頭, 指明下面的都是當(dāng)前運(yùn)行的dvm thread:“DALVIK THREADS:”
第二行 輸出的是該 進(jìn)程里各種線程互斥量的值。
第三行 輸出分別是 線程的名字(“main”),線程優(yōu)先級(jí)(“prio=5”,這個(gè)不用看,都是5),線程id(“tid=1”,如果有等待鎖的,可以看下是哪個(gè)tid持鎖) 以及線程的狀態(tài)(當(dāng)前是“NATIVE”,說明是native線程,如果是java線程,將會(huì)標(biāo)明是waiting,blocked,runnable狀態(tài))
第四行 分別是線程所述的線程組 (“main”),線程被正常掛起的次處(“sCount=1”),線程因調(diào)試而掛起次數(shù)(”dsCount=0“),當(dāng)前線程所關(guān)聯(lián)的java線程對(duì)象(”obj=0x400246a0“)以及該線程本身的地址(“self=0x12770”)。
第五行 顯示線程調(diào)度信息。 分別是該線程在linux系統(tǒng)下得本地線程id (“ sysTid=503”),線程的調(diào)度有優(yōu)先級(jí)(“nice=0”),調(diào)度策略(sched=0/0),優(yōu)先組屬(“cgrp=default”)以及 處理函數(shù)地址(“handle=-1342909272”)
第六行 顯示更多該線程當(dāng)前上下文,分別是 調(diào)度狀態(tài)(從 /proc/[pid]/task/[tid]/schedstat讀出)(“schedstat=( 15165039025 12197235258 23068 )”),以及該線程運(yùn)行信息 ,它們是 線程用戶態(tài)下使用的時(shí)間值(單位是jiffies)? (“utm=182”), 內(nèi)核態(tài)下得調(diào)度時(shí)間值(“stm=1334”),以及最后運(yùn)行線程所在cpu核心號(hào)(“core=0”);
第七行 后面幾行輸出 該線程 調(diào)用棧。