在研究设备的低功耗突然唤醒时,看到了对应的唤醒源:
[ 75.813476] suspend ns: 75813465022\x09suspend cycles: 1548322670 [ 75.813465] resume cycles: 2105086036 ## 注意到这一行,唤醒源。 [ 75.813658] pm_system_irq_wakeup: 197 triggered pm8xxx_rtc_alarm [ 75.814549] Enabling non-boot CPUs ... [ 75.816121] Detected VIPT I-cache on CPU1 [ 75.816267] arch_timer: CPU1: Trapping CNTVCT access [ 75.816333] CPU1: Booted secondary processor 0x0000000001 [0x51af8014] [ 75.822557] CPU1 is up [ 75.825359] Detected VIPT I-cache on CPU2 [ 75.825524] arch_timer: CPU2: Trapping CNTVCT access [ 75.825598] CPU2: Booted secondary processor 0x0000000002 [0x51af8014] [ 75.832122] CPU2 is up [ 75.834884] Detected VIPT I-cache on CPU3 [ 75.835055] arch_timer: CPU3: Trapping CNTVCT access [ 75.835129] CPU3: Booted secondary processor 0x0000000003 [0x51af8014] [ 75.842262] CPU3 is up [ 75.844905] Detected VIPT I-cache on CPU4 [ 75.845065] arch_timer: CPU4: Trapping CNTVCT access [ 75.845142] CPU4: Booted secondary processor 0x0000000100 [0x51af8002] [ 75.851134] CPU4 is up [ 75.852917] Detected VIPT I-cache on CPU5 [ 75.853039] arch_timer: CPU5: Trapping CNTVCT access [ 75.853095] CPU5: Booted secondary processor 0x0000000101 [0x51af8002] [ 75.858917] CPU5 is up [ 75.860717] Detected VIPT I-cache on CPU6 [ 75.860846] arch_timer: CPU6: Trapping CNTVCT access [ 75.860903] CPU6: Booted secondary processor 0x0000000102 [0x51af8002] [ 75.867485] CPU6 is up [ 75.869900] Detected VIPT I-cache on CPU7 [ 75.870034] arch_timer: CPU7: Trapping CNTVCT access [ 75.870094] CPU7: Booted secondary processor 0x0000000103 [0x51af8002] [ 75.877657] CPU7 is up [ 76.035199] enter resume [ 76.035227] enter disable wake up
因此,需要排查alarm
有关的问题。
在安卓adb root进如命令行后(没有root或者root群组的权限执行不了该命令),执行方法:
adb shell "dumpsys alarm"
adb dumpsys alarm
当应用设置ALARM的时候,系统不会将这些ALARM在设置的准确时间内触发,而将用一种批量触发(batches mode)的策略,这样可以最小化地使系统从休眠状态醒来,最低程度地减少电池的消耗,即将一批触发时间接近的闹钟,压缩到某一个时间段内一起触发,而不是一个个触发,这样系统会很难休眠。
Pending alarm batches: 16
表示,有16个ALARM将被触发,dumpsys alarm 输出后,就是现实每一个闹钟的触发详情,如:
Pending alarm batches: 16 Batch{45002a6 num=2 start=1850496 end=2152767 flgs=0x8}: ELAPSED #1: Alarm{9da07d9 type 3 when 1850496 android} tag=*alarm*:com.android.server.action.NETWORK_STATS_POLL type=3 expectedWhenElapsed=+9m18s608ms expectedMaxWhenElapsed=+31m48s608ms whenElapsed=+9m18s608ms maxWhenElapsed=+31m48s608ms when=+9m18s608ms window=+22m30s0ms repeatInterval=1800000 count=0 flags=0x8 operation=PendingIntent{b0fa59e: PendingIntentRecord{53d87f android broadcastIntent}} ELAPSED_WAKEUP #0: Alarm{e4104c type 2 when 1252767 android} tag=*walarm*:WifiConnectivityManager Schedule Watchdog Timer type=2 expectedWhenElapsed=-39s121ms expectedMaxWhenElapsed=+14m20s879ms whenElapsed=-39s121ms maxWhenElapsed=+14m20s879ms when=-39s121ms window=+15m0s0ms repeatInterval=0 count=0 flags=0x8 operation=null listener=android.app.AlarmManager$ListenerWrapper@4da4895 ...
Batch{45002a6 num=2 start=1850496 end=2152767 flgs=0x8}:
45002a6
:批处理模式下的内部ID号
num = 2
:表示在该batch中,有2个闹钟
ELAPSED #1: Alarm{9da07d9 type 3 when 1850496 android} ... ELAPSED_WAKEUP #0: Alarm{e4104c type 2 when 1252767 android} ...
start、end
:表示自系统启动后,流逝的时间,该段时间粗略的表示,该闹钟会在start和end之间的时间触发
对于每一个alrm,都会有这三行解说:
RTC #0: Alarm{4293d358 type 1 com.android.chrome} type=1 whenElapsed=1369361 when=+19s304ms window=-1 repeatInterval=0 count=0 operation=PendingIntent{429e4500: PendingIntentRecord{429dbbc8 com.android.chrome broadcastIntent}} ELAPSED_WAKEUP #1: Alarm{61bf54d type 2 when 21600000 com.android.providers.calendar} tag=*walarm*:com.android.providers.calendar.intent.CalendarProvider2 type=2 expectedWhenElapsed=+5h38m28s112ms expectedMaxWhenElapsed=+10h8m28s112ms whenElapsed=+5h38m28s112ms maxWhenElapsed=+10h8m28s112ms when=+5h38m28s112ms window=+4h30m0s0ms repeatInterval=21600000 count=0 flags=0x0 operation=PendingIntent{5331802: PendingIntentRecord{b9e0513 com.android.providers.calendar broadcastIntent}} ELAPSED #0: Alarm{7862350 type 3 when 14535465 android} tag=*alarm*:LockSettingsPrimaryAuth.nonStrongBiometricIdleTimeoutForUser type=3 expectedWhenElapsed=+3h40m43s577ms expectedMaxWhenElapsed=+6h40m43s576ms whenElapsed=+3h40m43s577ms maxWhenElapsed=+6h40m43s576ms when=+3h40m43s577ms window=+2h59m59s999ms repeatInterval=0 count=0 flags=0x8 operation=null listener=android.app.AlarmManager$ListenerWrapper@2bf9949
ELAPSED_WAKEUP
:表示ALARM的类型type,一般有:RTC_WAKEUP
、RTC
、 ELAPSED_WAKEUP
、ELAPSED
。
详见:https://developer.android.com/reference/android/app/AlarmManager.html#RTC_WAKEUP
#1
:表示在该批量模式中,该ALARM的标号,取值0~n-1,n为该batch中alarm个数
61bf54d
:闹钟的内部编号
type=1
:闹钟的类型,即第一条中提到的几个闹钟类型,相当于type对应的整数值
com.android.providers.calendar
:设置该闹钟的应用包名
whenElapsed=+5h38m28s112ms
:该闹钟会在系统开机后,大概5小时后触发。
when = 21600000
:该闹钟时间戳为21600000
以后触发
window=:
根据该alarm被调度的不同方法,设置不同的值:
repeatInterval=21600000
:闹钟的重复频率,900000ms后重复,0表示不重复
count=:
表示该alarm因为某些原因而被忽略了的次数,0表示没有被忽略过
operation=PendingIntent{...}:
与pendingIntent相关,该intent被实例化后,可以发送广播,启动服务,或者启动Activity, 说白了就是唤醒应用的操作。
Broadcast Ref Count: 0
为了使得系统在醒来后,发送必要的广播帧,并且保证在所有的广播帧没有发送出去之前,系统不要进入睡眠状态,内部定义了一个变量:mBroadcastRefCount
,它的初始值是0,
并且当需要发送的广播在队列配对的时候,该变量的值就会递增,发送一个广播后则递减,当减到0的时候,就会释放它持有的wakelock,而让系统进入休眠状态。
所以,Broadcast Ref Count: 0
表示此时此刻,该时刻并没有广播要发送。
根据应用的唤醒系统的时间排行,取最长时间的前十名,然后按照降序列出,有助于找出第三方app因为编程不规范,而导致极度耗电
Top Alarms: +10s913ms running, 1 wakeups, 1 alarms: u0a113:com.qti.ltebc *walarm*:wake_up_from_boot +10s156ms running, 1 wakeups, 1 alarms: u0a56:com.android.providers.calendar *walarm*:com.android.providers.calendar.intent.CalendarProvider2 +1s333ms running, 0 wakeups, 1 alarms: 1000:android *alarm*:com.android.server.action.NETWORK_STATS_POLL +755ms running, 0 wakeups, 8 alarms: 1000:android *alarm*:TIME_TICK +220ms running, 1 wakeups, 1 alarms: 1000:android *walarm*:EventConditionProvider.EVALUATE +219ms running, 1 wakeups, 1 alarms: 1000:android *walarm*:ScheduleConditionProvider.EVALUATE +202ms running, 0 wakeups, 1 alarms: 1000:android *alarm*:GraphicsStatsService +56ms running, 3 wakeups, 3 alarms: 1000:android *walarm*:WifiConnectivityManager Schedule Periodic Scan Timer +45ms running, 1 wakeups, 1 alarms: 1000:android *walarm*:*job.deadline* +39ms running, 0 wakeups, 1 alarms: 1000:android *alarm*:*CountQuotaTracker.cleanup*
列出所有系统中应用设置alarm的情况,可以排查设置的闹钟是否起作用了。
Alarm Stats: 1000:android +2s413ms running, 7 wakeups: +1s333ms 0 wakes 1 alarms, last -20m41s388ms: *alarm*:com.android.server.action.NETWORK_STATS_POLL +755ms 0 wakes 8 alarms, last -3m8s638ms: *alarm*:TIME_TICK +220ms 1 wakes 1 alarms, last -20m25s368ms: *walarm*:EventConditionProvider.EVALUATE +219ms 1 wakes 1 alarms, last -20m25s368ms: *walarm*:ScheduleConditionProvider.EVALUATE +202ms 0 wakes 1 alarms, last -20m25s368ms: *alarm*:GraphicsStatsService +56ms 3 wakes 3 alarms, last -19m35s130ms: *walarm*:WifiConnectivityManager Schedule Periodic Scan Timer +45ms 1 wakes 1 alarms, last -19m35s130ms: *walarm*:*job.deadline* +39ms 0 wakes 1 alarms, last -9m32s957ms: *alarm*:*CountQuotaTracker.cleanup* +26ms 1 wakes 1 alarms, last -19m55s159ms: *walarm*:WifiHealthMonitor Schedule Post-Boot Detection Timer +23ms 0 wakes 1 alarms, last -19m35s130ms: *alarm*:*job.delay* 1073:com.android.networkstack +8ms running, 2 wakeups: +5ms 1 wakes 1 alarms, last -20m26s669ms: *walarm*:DhcpClient.wlan0.TIMEOUT +3ms 1 wakes 1 alarms, last -20m30s704ms: *walarm*:DhcpClient.wlan0.KICK u0a56:com.android.providers.calendar +10s156ms running, 1 wakeups: +10s156ms 1 wakes 1 alarms, last -20m18s689ms: *walarm*:com.android.providers.calendar.intent.CalendarProvider2 u0a113:com.qti.ltebc +10s913ms running, 1 wakeups: +10s913ms 1 wakes 1 alarms, last -20m19s759ms: *walarm*:wake_up_from_boot
格式如下
com.example.someapp +1s857ms running, 0 wakeups: +1s817ms 0 wakes 83 alarms: cmp={com.example.someapp/com.example.someapp.someservice} +40ms 0 wakes 1 alarms: cmp={com.example.someapp/com.example.someapp.someotherservice}
例如:
1073:com.android.networkstack +8ms running, 2 wakeups: +5ms 1 wakes 1 alarms, last -20m26s669ms: *walarm*:DhcpClient.wlan0.TIMEOUT +3ms 1 wakes 1 alarms, last -20m30s704ms: *walarm*:DhcpClient.wlan0.KICK
com.android.networkstack
:设置alarm的应用包名
+8ms running
:系统总体被该应用所有的alarm
消耗的时间
2 wakeups
:设备被闹钟唤醒的次数,包含了每一次alarm的情况
1073:com.android.networkstack +8ms running, 2 wakeups: +5ms 1 wakes 1 alarms, last -20m26s669ms: *walarm*:DhcpClient.wlan0.TIMEOUT
+5ms
:该alarm消耗的时间
1 wakes
:设备被唤醒的次数
1 alarms
:alarm被触发的次数,重复闹钟,该值大于1
如果触发的是广播,则格式如:
1000:android +2s413ms running, 7 wakeups: +1s333ms 0 wakes 1 alarms, last -20m41s388ms: *alarm*:com.android.server.action.NETWORK_STATS_POLL +755ms 0 wakes 8 alarms, last -3m8s638ms: *alarm*:TIME_TICK +220ms 1 wakes 1 alarms, last -20m25s368ms: *walarm*:EventConditionProvider.EVALUATE +219ms 1 wakes 1 alarms, last -20m25s368ms: *walarm*:ScheduleConditionProvider.EVALUATE +202ms 0 wakes 1 alarms, last -20m25s368ms: *alarm*:GraphicsStatsService +56ms 3 wakes 3 alarms, last -19m35s130ms: *walarm*:WifiConnectivityManager Schedule Periodic Scan Timer +45ms 1 wakes 1 alarms, last -19m35s130ms: *walarm*:*job.deadline* +39ms 0 wakes 1 alarms, last -9m32s957ms: *alarm*:*CountQuotaTracker.cleanup* +26ms 1 wakes 1 alarms, last -19m55s159ms: *walarm*:WifiHealthMonitor Schedule Post-Boot Detection Timer +23ms 0 wakes 1 alarms, last -19m35s130ms: *alarm*:*job.delay* action. 代表:发送广播的名称