如何统计启动Activity所用的时间

如何统计Activity启动所用的时间？<wbr style="line-height:25px"><div style="line-height:25px">可以通过分析Log得到（这个就是DDMS的那个Log）。</div> <div style="line-height:25px">当我们点击触摸时会了类似以下的Log<span style="line-height:25px"><span style="color:#993300; line-height:25px">A</span></span>：</div> <div style="line-height:25px"> <div style="line-height:25px"> <div style="line-height:22px"> <span style="color:#0000ff; line-height:22px">03-06 03:36:47.865: VERBOSE/InputDevice(2486): ID[0]=0(0)</span><span style="color:#ff9900; line-height:22px">Dn</span><span style="color:#0000ff; line-height:22px">(0=&gt;1)</span> </div> <div style="line-height:22px"><span style="color:#3366ff; line-height:25px">03-06 03:36:47.865: INFO/PowerManagerService(2486): Ulight 3-&gt;7|0</span></div> <div style="line-height:22px"><span style="color:#3366ff; line-height:25px">03-06 03:36:47.933: INFO/(2486): PRODUCT_SHIP = false</span></div> <div style="line-height:22px"> <span style="color:#0000ff; line-height:22px">03-06 03:36:47.933: VERBOSE/InputDevice(2486): ID[0]=0(0)</span><span style="color:#ff9900; line-height:22px">Up</span><span style="color:#0000ff; line-height:22px">(1=&gt;0)</span> </div> </div> </div> <div style="line-height:25px">当系统收到一个启动Activity的Intent时会有类似以下的Log<span style="color:#993300; line-height:25px">B</span>：</div> <div style="line-height:25px"> <span style="color:#3366ff; line-height:25px">03-06 03:36:47.954:</span><span style="color:#0000ff; line-height:25px">INFO/ActivityManager(2486): Starting activity</span><span style="color:#3366ff; line-height:25px">: Intent { act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] flg=0x10200000 cmp=com.teleca/.ContextMenuActivity }</span> </div> <div style="line-height:25px">当系统完成Activity进程启动时会有类似以下的Log<span style="line-height:22px">C</span>：</div> <div style="line-height:25px"> <span style="color:#3366ff; line-height:25px">03-06 03:36:48.068:</span><span style="color:#0000ff; line-height:25px">INFO/ActivityManager(2486): Start proc</span><span style="color:#3366ff; line-height:25px">com.teleca for activity com.teleca/.ContextMenuActivity: pid=2933 uid=10089 gids={}</span> </div> <div style="line-height:25px">当系统完成显示一个Activity时会有类似以下的Log<span style="line-height:25px">D</span>：</div> <div style="line-height:25px"> <span style="color:#3366ff; line-height:25px">03-06 03:36:48.302:</span><span style="color:#0000ff; line-height:25px">INFO/ActivityManager(2486): Displayed activity com.teleca/.ContextMenuActivity: 240 ms (total 41289 ms)</span> </div> <div style="line-height:25px">那么启动Activity所用的<span style="color:#000080; line-height:25px">所有时间</span>=<span style="color:#000080; line-height:25px">LogD</span><span style="line-height:22px">那刻</span><span style="line-height:22px">时间</span><span style="color:#ff9900; line-height:25px"><span style="line-height:25px">减去</span></span><span style="color:#000080; line-height:25px">Log</span><span style="line-height:22px"><span style="color:#000080; line-height:25px">A</span><span style="line-height:25px"></span></span><span style="line-height:22px">那刻</span><span style="line-height:22px">时间。</span> </div> <div style="line-height:25px"> <span style="line-height:22px">即：</span><span style="line-height:25px">03:36:48.302</span><span style="color:#0000ff; line-height:25px">减去</span><span style="line-height:25px"></span><span style="line-height:22px">03:36:47.933，简化即为：</span><span style="line-height:25px"><span style="line-height:22px"><span style="line-height:22px">48.302</span></span></span><span style="color:#ff6600; line-height:25px">减去</span><span style="line-height:22px">47.933=<span style="color:#339966; line-height:25px">369ms</span><span style="line-height:25px">.</span></span> </div> <div style="line-height:25px">注1：<span style="color:#000080; line-height:25px">从</span><span style="color:#339966; line-height:25px">Log<span style="line-height:22px">A</span></span><span style="line-height:22px; color:rgb(0,0,128)">到</span><span style="color:#008000; line-height:25px">Log<span style="line-height:22px">B</span></span><span style="line-height:22px; color:rgb(0,0,128)">为系统所用时间。:</span> </div> <div style="line-height:25px"> <span style="line-height:22px">注2：</span><span style="line-height:22px"><span style="color:#000080; line-height:25px">从</span><span style="color:#99cc00; line-height:25px">Log<span style="line-height:22px">B</span></span><span style="line-height:22px; color:rgb(0,0,128)">到</span><span style="color:#808000; line-height:25px">Log</span><span style="color:#808000; line-height:25px">D</span><span style="color:#0000ff; line-height:25px">主要</span><span style="color:#000080; line-height:25px">是</span></span><span style="line-height:22px"><span style="color:#993300; line-height:25px">activity</span></span><span style="line-height:22px; color:rgb(0,0,128)">本身创建所用的时间（on create(),onresume(),onDraw()等）</span><span style="color:#000080; line-height:25px">。</span><span style="line-height:22px"><span style="line-height:25px; color:rgb(0,0,128)">48.302</span><span style="color:#ff6600; line-height:25px">减去</span></span><span style="line-height:22px"><span style="color:#000080; line-height:25px">47.954=</span><span style="line-height:22px"><span style="color:#339966; line-height:25px">348ms</span><strong>.</strong></span><span style="line-height:22px; color:rgb(0,0,128)">有时也包括了</span></span><span style="line-height:22px; color:rgb(0,0,128)"><span style="line-height:22px">系统为</span></span><span style="color:#000080; line-height:25px">创建</span><span style="line-height:22px"><span style="color:#993300; line-height:25px">activity</span><span style="color:#000080; line-height:25px">所在应用程序（APK）</span></span><span style="line-height:22px; color:rgb(0,0,128)">进程所用的时间</span><span style="line-height:25px; color:rgb(0,0,128)">。</span> </div> <div style="line-height:25px">注3：<span style="color:#339966; line-height:25px">Log D</span><span style="line-height:22px"></span><span style="line-height:22px">的</span><span style="line-height:22px">“</span>240 ms<span style="line-height:22px">”</span><span style="line-height:22px">和</span><span style="line-height:22px">“</span>(total 41289 ms)<span style="line-height:22px">”</span><span style="line-height:22px">的意义还不清楚。只是”240ms“和</span><span style="color:#99cc00; line-height:25px">Log C</span><span style="line-height:22px">到</span><span style="color:#808000; line-height:25px">Log D</span>的时间很接近<span style="line-height:25px">。</span> </div> <div style="line-height:25px"><span style="line-height:25px">附件1：</span></div> <div style="line-height:25px">一个启动<span style="line-height:22px">activity的Log:</span> </div> <div style="line-height:25px"> <div style="line-height:25px"> <div style="line-height:25px"><span style="color:#0000FF; line-height:25px">03-06 03:36:47.865: VERBOSE/InputDevice(2486): ID[0]=0(0) Dn(0=&gt;1)</span></div> <div style="line-height:25px">03-06 03:36:47.865: INFO/PowerManagerService(2486): Ulight 3-&gt;7|0</div> <div style="line-height:25px">03-06 03:36:47.933: INFO/(2486): PRODUCT_SHIP = false</div> <div style="line-height:25px"><span style="color:#0000FF; line-height:25px">03-06 03:36:47.933: VERBOSE/InputDevice(2486): ID[0]=0(0) Up(1=&gt;0)</span></div> <div style="line-height:25px">03-06 03:36:47.935: VERBOSE/WindowManager(2486): Dsptch 1 x82.0 y592.0 &gt; Window{485bd6c0 com.sec.android.app.twlauncher/com.sec.android.app.twlauncher.Launcher paused=false}</div> <div style="line-height:25px"><span style="color:#0000FF; line-height:25px">03-06 03:36:47.954: INFO/ActivityManager(2486): Starting activity: Intent { act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] flg=0x10200000 cmp=com.teleca/.ContextMenuActivity }</span></div> <div style="line-height:25px">03-06 03:36:48.029: INFO/Launcher(2570): onPause()</div> <div style="line-height:25px">03-06 03:36:48.044: DEBUG/AudioHardwareALSA(2377): ALSA OPEN mode 0,device 2</div> <div style="line-height:25px">03-06 03:36:48.044: INFO/AudioHardwareALSA(2377): Try to open ALSA PLAYBACK device AndroidPlayback_Speaker_normal</div> <div style="line-height:25px">03-06 03:36:48.048: WARN/Launcher(2570): WallpaperManager setVisibility visible true</div> <div style="line-height:25px"><span style="color:#0000FF; line-height:25px">03-06 03:36:48.068: INFO/ActivityManager(2486): Start proc com.teleca for activity com.teleca/.ContextMenuActivity: pid=2933 uid=10089 gids={}</span></div> <div style="line-height:25px">03-06 03:36:48.099: INFO/AudioHardwareALSA(2377): Initialized ALSA PLAYBACK device AndroidPlayback_Speaker_normal</div> <div style="line-height:25px">03-06 03:36:48.099: DEBUG/AudioHardwareALSA(2377): Set PLAYBACK PCM format to S16_LE (Signed 16 bit Little Endian)</div> <div style="line-height:25px">03-06 03:36:48.099: DEBUG/AudioHardwareALSA(2377): Using 2 channels for PLAYBACK.</div> <div style="line-height:25px">03-06 03:36:48.099: DEBUG/AudioHardwareALSA(2377): Set PLAYBACK sample rate to 44100 HZ</div> <div style="line-height:25px">03-06 03:36:48.099: DEBUG/AudioHardwareALSA(2377): Buffer size: 2048</div> <div style="line-height:25px">03-06 03:36:48.099: DEBUG/AudioHardwareALSA(2377): Latency: 46439</div> <div style="line-height:25px">03-06 03:36:48.134: INFO/WindowManager(2486): Setting rotation to 1, animFlags=1</div> <div style="line-height:25px">03-06 03:36:48.154: INFO/ActivityManager(2486): Config changed: { scale=1.0 imsi=0/0 loc=en_CA touch=3 keys=1/1/2 nav=1/1 orien=2 layout=34 uiMode=17 seq=3 FlipFont=0}</div> <div style="line-height:25px">03-06 03:36:48.189: INFO/Launcher(2570): onWindowFocusChanged(false)</div> <div style="line-height:25px"><span style="color:#0000FF; line-height:25px">03-06 03:36:48.302: INFO/ActivityManager(2486): Displayed activity com.teleca/.ContextMenuActivity: 240 ms (total 41289 ms)</span></div> <div><span style="color:#0000FF; line-height:25px"><br></span></div> </div> </div> </wbr>