lovegaoshi / azusa-player-mobile

移动端的抽象b站音乐播放器
https://azusa-player-mobile.vercel.app/
GNU Affero General Public License v3.0
646 stars 22 forks source link

[bug] app killed investigations #554

Closed lovegaoshi closed 1 week ago

lovegaoshi commented 2 months ago

occasionally app gets shutdown by the OS without an error thrown. happens when in background and another app is ran (eg. cpu intensive web browsing, android auto) suspected to be oom/low ram issue? APM does use ~200-400MB ram, and S21 is at 6GB/8GB RAM. debug msg is added https://github.com/lovegaoshi/azusa-player-mobile/commit/35b17c935843456cc91c728c97ed9eb583e8d1ae to help narrowing the causes.

lovegaoshi commented 1 month ago

seems to be battery optimization related, as I could not reproduce when device is charged.

however battery usage is already set to unrestricted so i dont see a way to resolve this.

lovegaoshi commented 1 month ago

try turning off charging via adb, use battery until 15%/turn on battery saver, monitor adb.

lovegaoshi commented 2 weeks ago

seems good after the media3 migration

lovegaoshi commented 1 week ago

now i believe its a RAM issue

10-31 09:24:00.068 11106 11106 D APMRAMTrim: trim memory level 15 emitted.
10-31 09:24:00.068 11106 11106 D APMRAM  : APM RAM usage: 183MB (65)
10-31 09:24:00.068  9124  9124 I AppBase : AppBase.onTrimMemory():461 onTrimMemory(): 15
10-31 09:24:00.068 11106 11230 I ReactNativeJNI: Memory warning (pressure level: TRIM_MEMORY_RUNNING_CRITICAL) received by JS VM, running a GC
10-31 09:24:00.069 27445 27445 I Edge.CocktailBarUiController: onTrimMemory is ignored
10-31 09:24:00.070  9124  9124 I GoogleInputMethodService: GoogleInputMethodService.onTrimMemory():4487 onTrimMemory(): 15
10-31 09:24:00.073 30479 30479 D SystemUIService: SYSUI_RAM_OPTIMIZATION onTrimMemory=15
10-31 09:24:00.073 30479 30479 D CentralSurfaces: SYSUI_RAM_OPTIMIZATION onTrimMemory=15
10-31 09:24:00.073 30479 30479 D SystemUIService: onTrimMemory : 15
10-31 09:24:00.073 30479 30479 D MemoryMonitor: Starting getMemoryInfo in MemoryInfoReporter thread. Delay Time: 0
10-31 09:24:00.076  1525  1525 I Telecom:SamsungTelecomSystem: onTrimMemory : 15
10-31 09:24:00.082 10991 10991 I [AUTHFW][PASS]AuthFwApp: otlv15
10-31 09:24:00.114 10639 10639 I [-0700]oneconnect[1.8.17.22_01][CORE]: QcApplication.PLog@onTrimMemory - Total   65.700 MB, Increased 6.272 MB
10-31 09:24:00.114 10639 10639 I [-0700]oneconnect[1.8.17.22_01][CORE]: QcApplication.onTrimMemory - ************** lvl=15 elapsed=1ms
10-31 09:24:00.132  1525  5657 I ActivityManager: Process com.samsung.android.scs (pid 29574) has died: cch+35 CEM (1177,1608)
10-31 09:24:00.133  1525  1959 I libprocessgroup: Successfully killed process cgroup uid 10100 pid 29574 in 0ms
10-31 09:24:00.134  1525  1847 D DisplayManagerService: Drop pending events for gone uid 10100
10-31 09:24:00.135  5499  5499 D HidDeviceService: handleMessage(): msg.what=8
10-31 09:24:00.135  1071  1071 I Zygote  : Process 29574 exited due to signal 9 (Killed)
10-31 09:24:00.167  1525  8793 I ActivityManager: Process com.samsung.android.samsungpass (pid 20918) has died: svcb SVC (1198,1608)
10-31 09:24:00.167  1525  1959 I libprocessgroup: Successfully killed process cgroup uid 10112 pid 20918 in 0ms
10-31 09:24:00.169  1525  8793 W ActivityManager: Scheduling restart of crashed service com.samsung.android.samsungpass/.passservice.PassService in 1000ms for connection
10-31 09:24:00.169  1525  8793 W ActivityManager: Scheduling restart of crashed service com.samsung.android.samsungpass/.main.TaskRemovalMonitorService in 40999ms for start-requested
10-31 09:24:00.171  1525  1847 D DisplayManagerService: Drop pending events for gone uid 10112
10-31 09:24:00.172  5499  5499 D HidDeviceService: handleMessage(): msg.what=8
10-31 09:24:00.172  1071  1071 I Zygote  : Process 20918 exited due to signal 9 (Killed)
10-31 09:24:00.173 10991 10991 I [PASS][SDK]o: onServiceDisconnected
10-31 09:24:00.183  1525  8793 I ActivityManager: Process com.google.process.gservices (pid 31884) has died: cch+25 CEM (1197,1608)
10-31 09:24:00.183  1525  1959 I libprocessgroup: Successfully killed process cgroup uid 10232 pid 31884 in 0ms
10-31 09:24:00.184  1071  1071 I Zygote  : Process 31884 exited due to signal 9 (Killed)
10-31 09:24:00.195  1525  5453 I ActivityManager: Process android.process.acore (pid 10679) has died: picked CEM (1199,1608)
10-31 09:24:00.195  1525  8191 D InputMethodManagerService: removeClient
10-31 09:24:00.196  1525  1847 D DisplayManagerService: Drop pending events for gone uid 10046
10-31 09:24:00.196  1525  1959 I libprocessgroup: Successfully killed process cgroup uid 10046 pid 10679 in 0ms
10-31 09:24:00.197  1071  1071 I Zygote  : Process 10679 exited due to signal 9 (Killed)
10-31 09:24:00.197  5499  5499 D HidDeviceService: handleMessage(): msg.what=8
10-31 09:24:00.207  1525  3840 I ActivityManager: Process com.samsung.android.privacydashboard (pid 31952) has died: cch+15 CEM (1201,1608)
10-31 09:24:00.207  1071  1071 I Zygote  : Process 31952 exited due to signal 9 (Killed)
10-31 09:24:00.207  1525  1959 I libprocessgroup: Successfully killed process cgroup uid 10089 pid 31952 in 0ms
10-31 09:24:00.208  1525  1847 D DisplayManagerService: Drop pending events for gone uid 10089
10-31 09:24:00.210  5499  5499 D HidDeviceService: handleMessage(): msg.what=8
10-31 09:24:00.215   800   800 D io_stats: !@   8,0 r 305017588 8717947436 w 42037450 488032844 d 8044887 388918760 f 0 0 iot 111584740 0 th 0 0 0 pt 0 inp 0 0 1558648.793
10-31 09:24:00.215   800   800 D io_stats: !@ Read_top(KB): ogle.android.as(27161) 4920 ng.android.spay(9135) 2780 xplay.noxplayer(11106) 1436
10-31 09:24:00.215   800   800 D io_stats: !@ Write_top(KB): kworker/u16:4(20430) 896 sait.sohservice(31355) 16 xplay.noxplayer(11106) 4
10-31 09:24:00.266  1525  3840 I ActivityManager: Process com.samsung.android.authfw (pid 10991) has died: cch+5 CEM (1182,1607)
10-31 09:24:00.267  1071  1071 I Zygote  : Process 10991 exited due to signal 9 (Killed)
10-31 09:24:00.268  1525  1847 D DisplayManagerService: Drop pending events for gone uid 5278
10-31 09:24:00.269  5499  5499 D HidDeviceService: handleMessage(): msg.what=8
10-31 09:24:00.270  1525  1959 I libprocessgroup: Successfully killed process cgroup uid 5278 pid 10991 in 0ms
10-31 09:24:00.328  1525  3840 I ActivityManager: Process com.verizon.mips.services:remote (pid 18989) has died: svcb SVC (1187,1606)
10-31 09:24:00.328  1071  1071 I Zygote  : Process 18989 exited due to signal 9 (Killed)
10-31 09:24:00.328  1525  1959 I libprocessgroup: Successfully killed process cgroup uid 10261 pid 18989 in 0ms
10-31 09:24:00.330  1525  3840 W ActivityManager: Scheduling restart of crashed service com.verizon.mips.services/com.vzw.apnservice.VZWAPNServiceNew in 80839ms for start-requested
10-31 09:24:00.332  1525  1847 D DisplayManagerService: Drop pending events for gone uid 10261
10-31 09:24:00.333  5499  5499 D HidDeviceService: handleMessage(): msg.what=8
10-31 09:24:00.345  1525  3840 I ActivityManager: Process com.samsung.klmsagent (pid 20800) has died: svcb SVC (1188,1605)
10-31 09:24:00.345  1071  1071 I Zygote  : Process 20800 exited due to signal 9 (Killed)
10-31 09:24:00.346  1525  3840 W ActivityManager: Scheduling restart of crashed service com.samsung.klmsagent/.service.KLMDebugService in 120823ms for start-requested
10-31 09:24:00.347  1525  1847 D DisplayManagerService: Drop pending events for gone uid 10073
10-31 09:24:00.349  5499  5499 D HidDeviceService: handleMessage(): msg.what=8
10-31 09:24:00.351  1525  1959 I libprocessgroup: Successfully killed process cgroup uid 10073 pid 20800 in 0ms
10-31 09:24:00.439  1525  3840 I ActivityManager: Process com.samsung.sait.sohservice (pid 31355) has died: svcb SVC (1202,1604)
10-31 09:24:00.439  1525  1959 I libprocessgroup: Successfully killed process cgroup uid 1000 pid 31355 in 0ms
10-31 09:24:00.439  1071  1071 I Zygote  : Process 31355 exited due to signal 9 (Killed)
10-31 09:24:00.440  1525  3840 W ActivityManager: Scheduling restart of crashed service com.samsung.sait.sohservice/.service.BatteryService in 160728ms for start-requested
10-31 09:24:00.444  5359  5359 I SDHMS:LOAD: type: LoadsFreqs, value: 0:0:0:881664:2688000:844800:804095:2419200:710400:315:315:315
10-31 09:24:00.476  1525  3840 I ActivityManager: Process android:drmService (pid 20581) has died: svcb SVC (1217,1603)
10-31 09:24:00.477  1071  1071 I Zygote  : Process 20581 exited due to signal 9 (Killed)
10-31 09:24:00.477  1525  1959 I libprocessgroup: Successfully killed process cgroup uid 1000 pid 20581 in 0ms
10-31 09:24:00.479  1525  3840 W ActivityManager: Scheduling restart of crashed service android/com.android.server.DrmEventService in 0ms for persistent
10-31 09:24:00.484  1658  7439 I ResourceManagerService: ResourceManagerService::Client::DeathNotifier::binderDied called
10-31 09:24:00.487  1658  7439 E mediaserver: unlinkToDeath: removed reference to death recipient but unlink failed: DEAD_OBJECT
10-31 09:24:00.487  1525  1913 I ActivityManager: android is exempt from freezer
10-31 09:24:00.487  1658  7439 I ResourceManagerService: Client(0xe9d09cd0) destructor - (PID : 20581)
10-31 09:24:00.487  1525  1913 D CompatibilityChangeReporter: Compat change id reported: 135634846; UID 1000; state: DISABLED
10-31 09:24:00.487  1525  1913 D CompatibilityChangeReporter: Compat change id reported: 177438394; UID 1000; state: DISABLED
10-31 09:24:00.487  1525  1913 D CompatibilityChangeReporter: Compat change id reported: 135772972; UID 1000; state: DISABLED
10-31 09:24:00.487  1525  1913 D CompatibilityChangeReporter: Compat change id reported: 135754954; UID 1000; state: ENABLED
10-31 09:24:00.487  1658  7439 E IPCThreadState: attemptIncStrongHandle(5): Not supported
10-31 09:24:00.500  1071  1071 D Zygote  : Forked child process 31983
10-31 09:24:00.501  1525  1915 I ActivityManager: Start proc 31983:android:drmService/1000 for service {android/com.android.server.DrmEventService}
10-31 09:24:00.519  1071  1071 I Zygote  : Process 29613 exited due to signal 9 (Killed)
10-31 09:24:00.519  1525  3840 I ActivityManager: Process com.samsung.android.smartsuggestions:core (pid 29613) has died: prev LAST(1223,1602)
10-31 09:24:00.521  1525  1959 I libprocessgroup: Successfully killed process cgroup uid 10107 pid 29613 in 0ms
10-31 09:24:00.524 31983 31983 I android:drmServ: Using CollectorTypeCC GC.
10-31 09:24:00.527 31983 31983 E android:drmServ: Not starting debugger since process cannot load the jdwp agent.
10-31 09:24:00.530 31983 31983 D nativeloader: Load libframework-connectivity-tiramisu-jni.so using APEX ns com_android_tethering for caller /apex/com.android.tethering/javalib/framework-connectivity-t.jar: ok
10-31 09:24:00.533 31983 31983 D ActivityThread: setConscryptValidator
10-31 09:24:00.533 31983 31983 D ActivityThread: setConscryptValidator - put
10-31 09:24:00.536  1525  3840 D CompatibilityChangeReporter: Compat change id reported: 168419799; UID 1000; state: DISABLED
10-31 09:24:00.537  1525  3840 D CompatibilityChangeReporter: Compat change id reported: 273564678; UID 1000; state: DISABLED
10-31 09:24:00.547 31983 31983 D CompatibilityChangeReporter: Compat change id reported: 171979766; UID 1000; state: ENABLED
10-31 09:24:00.547 31983 31983 D CompatibilityChangeReporter: Compat change id reported: 242716250; UID 1000; state: ENABLED
10-31 09:24:00.568  1525  3840 I ActivityManager: Process com.samsung.euicc (pid 31779) has died: svcb SVC (1250,1601)
10-31 09:24:00.568  1525  1959 I libprocessgroup: Successfully killed process cgroup uid 1000 pid 31779 in 0ms
10-31 09:24:00.570  1071  1071 I Zygote  : Process 31779 exited due to signal 9 (Killed)
10-31 09:24:00.575 31983 31983 D nativeloader: Load libframework-connectivity-jni.so using APEX ns com_android_tethering for caller /apex/com.android.tethering/javalib/framework-connectivity.jar: ok
10-31 09:24:00.583 31983 31983 V GraphicsEnvironment: Currently set values for:
10-31 09:24:00.584 31983 31983 V GraphicsEnvironment:   angle_gl_driver_selection_pkgs=[]
10-31 09:24:00.584 31983 31983 V GraphicsEnvironment:   angle_gl_driver_selection_values=[]
10-31 09:24:00.585 31983 31983 V GraphicsEnvironment: ANGLE GameManagerService for android: false
10-31 09:24:00.585 31983 31983 V GraphicsEnvironment: android is not listed in per-application setting
10-31 09:24:00.605  1525  7842 I ActivityManager: Flag disabled. Ignoring finishAttachApplication from uid: 1000. pid: 31983
10-31 09:24:00.611  1525  7842 I ActivityManager: Process com.xiaomi.wearable (pid 11147) has died: svc SVC (1263,1601)
10-31 09:24:00.612  1525  1959 I libprocessgroup: Successfully killed process cgroup uid 10481 pid 11147 in 0ms
10-31 09:24:00.612  1525  7842 W ActivityManager: Scheduling restart of crashed service com.xiaomi.wearable/com.google.android.libraries.wear.companion.esim.service.EsimProfileHandlingService in 200556ms for start-requested
10-31 09:24:00.613  1071  1071 I Zygote  : Process 11147 exited due to signal 9 (Killed)
10-31 09:24:00.627 31983 31983 D nativeloader: Load libdrmframework_jni.so using system ns (caller=/system/framework/framework.jar): ok
10-31 09:24:00.630  1525  5657 D NotificationManagerService$NotificationListeners: Removing active service ComponentInfo{com.xiaomi.wearable/com.xiaomi.wearable.home.devices.ble.sync.NotifySyncService}
10-31 09:24:00.630  1525  7842 I ActivityManager: Process com.xiaomi.wearable:device (pid 11161) has died: fg  BFGS(1363,1601)
10-31 09:24:00.630  1525  1525 V NotificationManagerService$NotificationListeners: 0 notification listener connection lost: ComponentInfo{com.xiaomi.wearable/com.xiaomi.wearable.home.devices.ble.sync.NotifySyncService}
10-31 09:24:00.632  1525  7842 W ActivityManager: Scheduling restart of crashed service com.xiaomi.wearable/.home.devices.ble.sync.NotifySyncService in 240536ms for start-requested
10-31 09:24:00.633  1525  7842 W ActivityManager: Scheduling restart of crashed service com.xiaomi.wearable/com.xiaomi.xms.wearable.WearableXmsService in 280536ms for start-requested
10-31 09:24:00.633  1525  7842 W ActivityManager: Scheduling restart of crashed service com.xiaomi.wearable/com.xiaomi.fitness.keep_alive.KeepAliveService in 320535ms for start-requested
10-31 09:24:00.634  1525  7842 I ActivityManager: Changes in 10481 5 to 19, 56 to 0
10-31 09:24:00.635  1525  1959 I libprocessgroup: Successfully killed process cgroup uid 10481 pid 11161 in 0ms
10-31 09:24:00.635  1525  2423 D CompatibilityChangeReporter: Compat change id reported: 265195908; UID 10481; state: ENABLED
10-31 09:24:00.635  5499  5499 D HidDeviceService: handleMessage(): msg.what=8
10-31 09:24:00.636  1525  1847 D DisplayManagerService: Drop pending events for gone uid 10481
10-31 09:24:00.637  5499  5499 D HidDeviceService: handleMessage(): msg.what=8
10-31 09:24:00.643  1071  1071 I Zygote  : Process 11161 exited due to signal 9 (Killed)
10-31 09:24:00.644 31983 31983 E DrmManagerClient: saveDevID : Checking 
10-31 09:24:00.659 31983 31998 I DrmEventService: action event :START_RESOURCE_HELPER
10-31 09:24:00.663 31983 31998 I DrmMediaResourceHelper: createMediaResourceHelper
10-31 09:24:00.671 31983 31998 D nativeloader: Load libmediaresourcehelper.so using system ns (caller=/system/framework/framework.jar!classes5.dex): ok
10-31 09:24:00.671 31983 31998 V ResourceManagerHelper-JNI: JNI_OnLoad
10-31 09:24:00.672 31983 31998 V ResourceManagerHelper-JNI: JNI_OnLoad out
10-31 09:24:00.673 31983 31998 V ResourceManagerHelper-JNI: JNIMediaResourceHelper constructor
10-31 09:24:00.673 31983 31998 V ResourceManagerHelper-JNI: create ResourceManagerObserverClient
10-31 09:24:00.673 31983 31998 V ResourceManagerHelper-JNI: JNIMediaResourceHelper getMediaResourceHelper_l
10-31 09:24:00.675  1658  7439 I ResourceManagerService: Client(0xe9d09550) constructor - (PID : 31983)
10-31 09:24:00.677 31983 31998 I SemMediaResourceHelper: SemMediaResourceHelper() resourceType : 2, ownResourceEventExcluded : false, myPid : 31983
10-31 09:24:00.677 31983 31998 V ResourceManagerHelper-JNI: enableObserver enable : 1
10-31 09:24:00.678 31983 31998 V ResourceManagerHelper-JNI: enableObserver enable : 1
10-31 09:24:00.719  1221  2025 I QC2CompStore: Deleting component(c2.qti.hevc.decoder) id(3851)
10-31 09:24:00.731  1221  2025 I QC2V4l2Driver: [hevcD_3851] Closed device driver with fd: 92
10-31 09:24:00.733  1221  2025 I QC2Comp : [hevcD_3851] Deallocated component c2.qti.hevc.decoder [id=3851]
10-31 09:24:00.785  1525  7842 D InputMethodManagerService: removeClient
10-31 09:24:00.785  1525  7835 I WindowManager: WIN DEATH: Window{3a06583 u0 com.noxplay.noxplayer/com.noxplay.noxplayer.MainActivity}
10-31 09:24:00.785  1525  7842 D InputTransport: Input channel destroyed: 'ClientS', fd=979
10-31 09:24:00.786  1525  3091 I ActivityManager: Process com.noxplay.noxplayer (pid 11106) has died: prcp FGS (1611,1580)
10-31 09:24:00.786  1658  7439 E mediaserver: unlinkToDeath: removed reference to death recipient but unlink failed: DEAD_OBJECT
10-31 09:24:00.786  1658  7439 I ResourceManagerService: removeResourceInfo pid 11106, removed 1728000 (width 900 height 1920), isLowPriority 0, remained hw codec count 1
10-31 09:24:00.786  1525  7835 D InputTransport: Input channel destroyed: '3a06583', fd=962
10-31 09:24:00.786  1525  3010 I MediaSessionStack: removeSession | record: com.noxplay.noxplayer/androidx.media3.session.id. (userId=0)

i dunno. probably should get a better phone at this point.

lovegaoshi commented 1 week ago

nothing can be done really other than optimize my app. which i wont do, pffft