WaitHoldingLocks异常引发ANR求助：JobServiceEngine关联问题排查

主线程因WaitHoldingLocks异常触发ANR，核心原因是等待Binder事务完成，从堆栈来看，卡主点在调用IJobCallback$Stub$Proxy.acknowledgeStartMessage的Binder跨进程调用环节。以下是具体排查方向：

• 检查JobService执行逻辑

  • 确认onStartJob是否在主线程执行耗时操作（如IO、网络请求、CPU密集计算），JobService默认运行在主线程，这类操作会阻塞主线程，导致Binder事务响应超时。
  • 排查acknowledgeStartMessage调用时是否持有锁，若主线程持有锁的同时发起Binder调用，可能与系统侧的锁等待形成死锁，触发WaitHoldingLocks异常。

• 分析系统侧Binder事务阻塞原因

  • 查看system_server进程状态，通过ANR日志中的system_server堆栈或抓取系统trace，确认是否存在系统进程负载过高、死锁或其他异常，导致无法及时处理JobService的回调请求。
  • 检查Binder事务队列状态，使用dumpsys binder查看事务统计，确认是否存在事务队列满、事务超时的情况；同时用dumpsys activity service jobscheduler查看JobScheduler的运行状态，是否有大量积压的Job任务。

• 排查JobScheduler调度异常

  • 检查应用中Job的创建与调度策略，是否存在重复调度、触发条件不合理（如频繁触发）的情况，导致系统Job处理能力过载。
  • 确认JobService是否及时调用jobFinished，若未在任务完成后调用该方法，会导致JobScheduler持续等待回调，占用系统资源并影响后续事务处理。

• 补充日志与调试

  • 在JobService的关键节点（onStartJob前后、ackStartMessage调用前后）添加详细日志，记录线程ID、锁持有情况，便于复现问题时追踪执行流程。
  • 使用Android Studio Profiler或simpleperf工具，在复现问题时抓取主线程的调用栈和锁信息，定位是否存在其他锁与Binder事务等待的冲突场景。

原始ANR堆栈 #

"main" tid=1 Native
  #00  pc 0x0000000000099ccc  /apex/com.android.runtime/lib64/bionic/libc.so (syscall+28)
  #01  pc 0x000000000023247c  /apex/com.android.art/lib64/libart.so (art::ConditionVariable::WaitHoldingLocks+140)
  #02  pc 0x000000000045b218  /apex/com.android.art/lib64/libart.so (artJniMethodEnd+336)
  #03  pc 0x00000000005bf0fc  /apex/com.android.art/lib64/libart.so (art_jni_method_end+12)
  at android.os.BinderProxy.transactNative (Native method)
  at android.os.BinderProxy.transact (BinderProxy.java:685)
  at android.app.job.IJobCallback$Stub$Proxy.acknowledgeStartMessage (IJobCallback.java:434)
  at android.app.job.JobServiceEngine$JobHandler.ackStartMessage (JobServiceEngine.java:384)
  at android.app.job.JobServiceEngine$JobHandler.handleMessage (JobServiceEngine.java:196)
  at android.os.Handler.dispatchMessage (Handler.java:106)
  at android.os.Looper.loopOnce (Looper.java:257)
  at android.os.Looper.loop (Looper.java:368)
  at android.app.ActivityThread.main (ActivityThread.java:8839)
  at java.lang.reflect.Method.invoke (Native method)
  at com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run (RuntimeInit.java:572)
  at com.android.internal.os.ZygoteInit.main (ZygoteInit.java:1049)

内容的提问来源于stack exchange，提问作者z.g.y