#### 15.1.4 响应速度优化和ANR日志分析
响应速度优化的核心思想是避免在主线程中做耗时操作,但是有时候的确有很多耗时操作,怎么办呢?可以将这些耗时操作放在线程中去执行,即采用异步的方式执行耗时操作。响应速度过慢更多地体现在Activity的启动速度上面,如果在主线程中做太多事情,会导致Activity启动时出现黑屏现象,甚至出现ANR。Android规定,Activity如果5秒钟之内无法响应屏幕触摸事件或者键盘输入事件就会出现ANR,而BroadcastReceiver如果10秒钟之内还未执行完操作也会出现ANR。在实际开发中,ANR是很难从代码上发现的,如果在开发过程中遇到了ANR,那么怎么定位问题呢?其实当一个进程发生ANR了以后,系统会在/data/anr目录下创建一个文件traces.txt,通过分析这个文件就能定位出ANR的原因,下面模拟一个ANR的场景。下面的代码在Activity的onCreate中休眠30s,程序运行后持续点击屏幕,应用一定会出现ANR:
protected void onCreate(Bundle savedInstanceState) {
super.onCreate(savedInstanceState);
setContentView(R.layout.activity_main);
SystemClock.sleep(30 * 1000);
}
这里先假定我们无法从代码中看出ANR,为了分析ANR的原因,可以到处traces文件,如下所示,其中.表示当前目录:
adb pull /data/anr/traces.txt .
traces文件一般是非常长的,下面是traces文件的部分内容:
----- pid 29395 at 2015-05-31 16:14:36-----
Cmd line: com.ryg.chapter_15
DALVIK THREADS:
(mutexes: tll=0 tsl=0 tscl=0 ghl=0)
"main" prio=5 tid=1 TIMED_WAIT
| group="main" sCount=1 dsCount=0 obj=0x4185b700 self=0x4012d0b0
| sysTid=29395 nice=0 sched=0/0 cgrp=apps handle=1073954608
| schedstat=( 0 0 0 ) utm=3 stm=2 core=2
at java.lang.VMThread.sleep(Native Method)
at java.lang.Thread.sleep(Thread.java:1031)
at java.lang.Thread.sleep(Thread.java:1013)
at android.os.SystemClock.sleep(SystemClock.java:114)
at com.ryg.chapter_15.MainActivity.onCreate(MainActivity.java:42)
at android.app.Activity.performCreate(Activity.java:5086)
at android.app.Instrumentation.callActivityOnCreate(Instrumentation.
java:1079)
at android.app.ActivityThread.performLaunchActivity(ActivityThread.
java:2056)
at android.app.ActivityThread.handleLaunchActivity(ActivityThread.
java:2117)
at android.app.ActivityThread.access$600(ActivityThread.java:140)
at android.app.ActivityThread$H.handleMessage(ActivityThread.java:1213)
at android.os.Handler.dispatchMessage(Handler.java:99)
at android.os.Looper.loop(Looper.java:137)
at android.app.ActivityThread.main(ActivityThread.java:4914)
at java.lang.reflect.Method.invokeNative(Native Method)
at java.lang.reflect.Method.invoke(Method.java:511)
at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run
(ZygoteInit.java:808)
at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:575)
at dalvik.system.NativeStart.main(Native Method)
"Binder_2" prio=5 tid=10 NATIVE
| group="main" sCount=1 dsCount=0 obj=0x42296d80 self=0x69068848
| sysTid=29407 nice=0 sched=0/0 cgrp=apps handle=1750664088
| schedstat=( 0 0 0 ) utm=0 stm=0 core=1
#00 pc 0000cc50 /system/lib/libc.so (__ioctl+8)
#01 pc 0002816d /system/lib/libc.so (ioctl+16)
#02 pc 00016f9d /system/lib/libbinder.so (android::IPCThreadState::
talkWithDriver(bool)+124)
#03 pc 0001768f /system/lib/libbinder.so (android::IPCThreadState::
joinThreadPool(bool)+154)
#04 pc 0001b4e9 /system/lib/libbinder.so
#05 pc 00010f7f /system/lib/libutils.so (android::Thread::_threadLoop
(void*)+114)
#06 pc 00048ba5 /system/lib/libandroid_runtime.so (android::Android-
Runtime::javaThreadShell(void*)+44)
#07 pc 00010ae5 /system/lib/libutils.so
#08 pc 00012ff0 /system/lib/libc.so (__thread_entry+48)
#09 pc 00012748 /system/lib/libc.so (pthread_create+172)
at dalvik.system.NativeStart.run(Native Method)
从traces的内容可以看出,主线程直接sleep了,而原因就是MainActivity的42行。第42行刚好就是SystemClock.sleep(30 * 1000),这样一来就可以定位问题了。当然这个例子太直接了,下面再模拟一个稍微复杂点的ANR的例子。
下面的代码也会导致ANR,原因是这样的,在Activity的onCreate中开启了一个线程,在线程中执行testANR(),而testANR()和initView()都被加了同一个锁,为了百分之百让testANR()先获得锁,特意在执行initView()之前让主线程休眠了10ms,这样一来initView()肯定会因为等待testANR()所持有的锁而被同步住,这样就产生了一个稍微复杂些的ANR。这个ANR是很参考意义的,这样的代码很容易在实际开发中出现,尤其是当调用关系比较复杂时,这个时候分析ANR日志就显得异常重要了。下面的代码中虽然已经将耗时操作放在线程中了,按道理就不会出现ANR了,但是仍然要注意子线程和主线程抢占同步锁的情况。
protected void onCreate(Bundle savedInstanceState) {
super.onCreate(savedInstanceState);
setContentView(R.layout.activity_main);
new Thread(new Runnable() {
@Override
public void run() {
testANR();
}
}).start();
SystemClock.sleep(10);
initView();
}
private synchronized void testANR() {
SystemClock.sleep(30 * 1000);
}
private synchronized void initView() {
}
为了分析问题,需要从traces文件着手,如下所示。
----- pid 32662 at 2015-05-31 16:40:21-----
Cmd line: com.ryg.chapter_15
DALVIK THREADS:
(mutexes: tll=0 tsl=0 tscl=0 ghl=0)
"main" prio=5 tid=1 MONITOR
| group="main" sCount=1 dsCount=0 obj=0x4185b700 self=0x4012d0b0
| sysTid=32662 nice=0 sched=0/0 cgrp=apps handle=1073954608
| schedstat=( 0 0 0 ) utm=0 stm=4 core=0
at com.ryg.chapter_15.MainActivity.initView(MainActivity.java:~62)
- waiting to lock <0x422a0120> (a com.ryg.chapter_15.MainActivity) held
by tid=11 (Thread-13248)
at com.ryg.chapter_15.MainActivity.onCreate(MainActivity.java:53)
at android.app.Activity.performCreate(Activity.java:5086)
at android.app.Instrumentation.callActivityOnCreate(Instrumentation.
java:1079)
at android.app.ActivityThread.performLaunchActivity(ActivityThread.
java:2056)
at android.app.ActivityThread.handleLaunchActivity(ActivityThread.
java:2117)
at android.app.ActivityThread.access$600(ActivityThread.java:140)
at android.app.ActivityThread$H.handleMessage(ActivityThread.java:1213)
at android.os.Handler.dispatchMessage(Handler.java:99)
at android.os.Looper.loop(Looper.java:137)
at android.app.ActivityThread.main(ActivityThread.java:4914)
at java.lang.reflect.Method.invokeNative(Native Method)
at java.lang.reflect.Method.invoke(Method.java:511)
at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run
(ZygoteInit.java:808)
at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:575)
at dalvik.system.NativeStart.main(Native Method)
"Thread-13248" prio=5 tid=11 TIMED_WAIT
| group="main" sCount=1 dsCount=0 obj=0x422b0ed8 self=0x683d20c0
| sysTid=32687 nice=0 sched=0/0 cgrp=apps handle=1751804288
| schedstat=( 0 0 0 ) utm=0 stm=0 core=0
at java.lang.VMThread.sleep(Native Method)
at java.lang.Thread.sleep(Thread.java:1031)
at java.lang.Thread.sleep(Thread.java:1013)
at android.os.SystemClock.sleep(SystemClock.java:114)
at com.ryg.chapter_15.MainActivity.testANR(MainActivity.java:57)
at com.ryg.chapter_15.MainActivity.access$0(MainActivity.java:56)
at com.ryg.chapter_15.MainActivity$1.run(MainActivity.java:49)
at java.lang.Thread.run(Thread.java:856)
上面的情况稍微复杂一些,需要逐步分析。首先看主线程,如下所示。可以看得出主线程在initView方法中正在等待一个锁<0x422a0120>,这个锁的类型是一个MainActivity对象,并且这个锁已经被线程id为11(即tid=11)的线程持有了,因此需要再看一下线程11的情况。
at com.ryg.chapter_15.MainActivity.initView(MainActivity.java:~62)
- waiting to lock <0x422a0120> (a com.ryg.chapter_15.MainActivity) held
by tid=11 (Thread-13248)
tid是11的线程就是“Thread-13248”,就是它持有了主线程所需的锁,可以看出“Thread-13248”正在sleep, sleep的原因是MainActivity的57行,即testANR方法。这个时候可以发现testANR方法和主线程的initView方法都加了synchronized关键字,表明它们在竞争同一个锁,即当前Activity的对象锁,这样一来ANR的原因就明确了,接着就可以修改代码了。
上面分析了两个ANR的实例,尤其是第二个ANR在实际开发中很容易出现,我们首先要有意识地避免出现ANR,其次出现ANR了也不要着急,通过分析traces文件即可定位问题。
- 前言
- 第1章 Activity的生命周期和启动模式
- 1.1 Activity的生命周期全面分析
- 1.1.1 典型情况下的生命周期分析
- 1.1.2 异常情况下的生命周期分析
- 1.2 Activity的启动模式
- 1.2.1 Activity的LaunchMode
- 1.2.2 Activity的Flags
- 1.3 IntentFilter的匹配规则
- 第2章 IPC机制
- 2.1 Android IPC简介
- 2.2 Android中的多进程模式
- 2.2.1 开启多进程模式
- 2.2.2 多进程模式的运行机制
- 2.3 IPC基础概念介绍
- 2.3.1 Serializable接口
- 2.3.2 Parcelable接口
- 2.3.3 Binder
- 2.4 Android中的IPC方式
- 2.4.1 使用Bundle
- 2.4.2 使用文件共享
- 2.4.3 使用Messenger
- 2.4.4 使用AIDL
- 2.4.5 使用ContentProvider
- 2.4.6 使用Socket
- 2.5 Binder连接池
- 2.6 选用合适的IPC方式
- 第3章 View的事件体系
- 3.1 View基础知识
- 3.1.1 什么是View
- 3.1.2 View的位置参数
- 3.1.3 MotionEvent和TouchSlop
- 3.1.4 VelocityTracker、GestureDetector和Scroller
- 3.2 View的滑动
- 3.2.1 使用scrollTo/scrollBy
- 3.2.2 使用动画
- 3.2.3 改变布局参数
- 3.2.4 各种滑动方式的对比
- 3.3 弹性滑动
- 3.3.1 使用Scroller7
- 3.3.2 通过动画
- 3.3.3 使用延时策略
- 3.4 View的事件分发机制
- 3.4.1 点击事件的传递规则
- 3.4.2 事件分发的源码解析
- 3.5 View的滑动冲突
- 3.5.1 常见的滑动冲突场景
- 3.5.2 滑动冲突的处理规则
- 3.5.3 滑动冲突的解决方式
- 第4章 View的工作原理
- 4.1 初识ViewRoot和DecorView
- 4.2 理解MeasureSpec
- 4.2.1 MeasureSpec
- 4.2.2 MeasureSpec和LayoutParams的对应关系
- 4.3 View的工作流程
- 4.3.1 measure过程
- 4.3.2 layout过程
- 4.3.3 draw过程
- 4.4 自定义View
- 4.4.1 自定义View的分类
- 4.4.2 自定义View须知
- 4.4.3 自定义View示例
- 4.4.4 自定义View的思想
- 第5章 理解RemoteViews
- 5.1 RemoteViews的应用
- 5.1.1 RemoteViews在通知栏上的应用
- 5.1.2 RemoteViews在桌面小部件上的应用
- 5.1.3 PendingIntent概述
- 5.2 RemoteViews的内部机制
- 5.3 RemoteViews的意义
- 第6章 Android的Drawable
- 6.1 Drawable简介
- 6.2 Drawable的分类
- 6.2.1 BitmapDrawable2
- 6.2.2 ShapeDrawable
- 6.2.3 LayerDrawable
- 6.2.4 StateListDrawable
- 6.2.5 LevelListDrawable
- 6.2.6 TransitionDrawable
- 6.2.7 InsetDrawable
- 6.2.8 ScaleDrawable
- 6.2.9 ClipDrawable
- 6.3 自定义Drawable
- 第7章 Android动画深入分析
- 7.1 View动画
- 7.1.1 View动画的种类
- 7.1.2 自定义View动画
- 7.1.3 帧动画
- 7.2 View动画的特殊使用场景
- 7.2.1 LayoutAnimation
- 7.2.2 Activity的切换效果
- 7.3 属性动画
- 7.3.1 使用属性动画
- 7.3.2 理解插值器和估值器 /
- 7.3.3 属性动画的监听器
- 7.3.4 对任意属性做动画
- 7.3.5 属性动画的工作原理
- 7.4 使用动画的注意事项
- 第8章 理解Window和WindowManager
- 8.1 Window和WindowManager
- 8.2 Window的内部机制
- 8.2.1 Window的添加过程
- 8.2.2 Window的删除过程
- 8.2.3 Window的更新过程
- 8.3 Window的创建过程
- 8.3.1 Activity的Window创建过程
- 8.3.2 Dialog的Window创建过程
- 8.3.3 Toast的Window创建过程
- 第9章 四大组件的工作过程
- 9.1 四大组件的运行状态
- 9.2 Activity的工作过程
- 9.3 Service的工作过程
- 9.3.1 Service的启动过程
- 9.3.2 Service的绑定过程
- 9.4 BroadcastReceiver的工作过程
- 9.4.1 广播的注册过程
- 9.4.2 广播的发送和接收过程
- 9.5 ContentProvider的工作过程
- 第10章 Android的消息机制
- 10.1 Android的消息机制概述
- 10.2 Android的消息机制分析
- 10.2.1 ThreadLocal的工作原理
- 10.2.2 消息队列的工作原理
- 10.2.3 Looper的工作原理
- 10.2.4 Handler的工作原理
- 10.3 主线程的消息循环
- 第11章 Android的线程和线程池
- 11.1 主线程和子线程
- 11.2 Android中的线程形态
- 11.2.1 AsyncTask
- 11.2.2 AsyncTask的工作原理
- 11.2.3 HandlerThread
- 11.2.4 IntentService
- 11.3 Android中的线程池
- 11.3.1 ThreadPoolExecutor
- 11.3.2 线程池的分类
- 第12章 Bitmap的加载和Cache
- 12.1 Bitmap的高效加载
- 12.2 Android中的缓存策略
- 12.2.1 LruCache
- 12.2.2 DiskLruCache
- 12.2.3 ImageLoader的实现446
- 12.3 ImageLoader的使用
- 12.3.1 照片墙效果
- 12.3.2 优化列表的卡顿现象
- 第13章 综合技术
- 13.1 使用CrashHandler来获取应用的crash信息
- 13.2 使用multidex来解决方法数越界
- 13.3 Android的动态加载技术
- 13.4 反编译初步
- 13.4.1 使用dex2jar和jd-gui反编译apk
- 13.4.2 使用apktool对apk进行二次打包
- 第14章 JNI和NDK编程
- 14.1 JNI的开发流程
- 14.2 NDK的开发流程
- 14.3 JNI的数据类型和类型签名
- 14.4 JNI调用Java方法的流程
- 第15章 Android性能优化
- 15.1 Android的性能优化方法
- 15.1.1 布局优化
- 15.1.2 绘制优化
- 15.1.3 内存泄露优化
- 15.1.4 响应速度优化和ANR日志分析
- 15.1.5 ListView和Bitmap优化
- 15.1.6 线程优化
- 15.1.7 一些性能优化建议
- 15.2 内存泄露分析之MAT工具
- 15.3 提高程序的可维护性