search

BimmerGestalt / AAIdrive

Implementations of some Android Auto features as unofficial IDrive apps
MIT License
551 stars 90 forks source link

new app builds crash from time to time #366

Closed unlive74 closed 3 years ago

unlive74 commented 3 years ago

Hi Walter! I always try to run the latest build of the aaid app and it seems like there is a new problem - the app started to crash periodically

look 00: 18: 37: 268 - 00: 18: 51: 029 logcat_08-24-2021_00-23-33.zip

and 00:49 logcat_08-24-2021_00-49-31.zip

hufman commented 3 years ago

Thank you so much for the detailed logs! I of course don't want any crashes at all. When looking through the logs, I don't see any UI crashes, but instead I only saw some exceptions that were logged when the car connection went down. At the same time, I found (in both files) log lines indicating that Android had killed the MyBMW app, for example:

[08-24 00:18:37.032 3304:3304 I/lmkd]
Reclaim Mem 'de.bmw.connected.mobile20.row' (25311), uid 10770, oom_adj 906, state 9 to free 207840kB
[08-24 00:18:37.032 3304:3304 I/lmkd]
Killing to reclaim 7244kB, reclaimed 207840kB at oom_adj 900
[08-24 00:18:37.244 3852:5388 I/ActivityManager]
Process de.bmw.connected.mobile20.row (pid 25311) has died: cch+6SVC (314,826)
[08-24 00:18:37.245 3852:5388 I/am_proc_died]
[0,25311,de.bmw.connected.mobile20.row,906,9,314,826]
[08-24 00:18:37.245 3852:3889 W/libprocessgroup]
kill(-25311, 9) failed: No such process
[08-24 00:18:37.245 3852:3889 I/libprocessgroup]
Successfully killed process cgroup uid 10770 pid 25311 in 0ms
[08-24 00:18:37.246 3852:5388 W/ActivityManager]
Scheduling restart of crashed service de.bmw.connected.mobile20.row/com.bmwgroup.connected.core.services.accessory.BtService in 1000ms
[08-24 00:18:37.246 3852:5388 I/am_schedule_service_restart]
[0,de.bmw.connected.mobile20.row/com.bmwgroup.connected.core.services.accessory.BtService,1000]
[08-24 00:18:37.246 3852:5388 W/ActivityManager]
Scheduling restart of crashed service de.bmw.connected.mobile20.row/com.bmwgroup.connected.coex.CoexService in 11000ms
[08-24 00:18:37.246 3852:5388 I/am_schedule_service_restart]
[0,de.bmw.connected.mobile20.row/com.bmwgroup.connected.coex.CoexService,11000]
[08-24 00:18:37.246 3469:3469 I/Zygote]
Process 25311 exited due to signal (9)

[08-24 00:18:37.268 25125:25542 E/PhoneNotifications]
Error while hiding notification popup: org.apache.etch.util.TimeoutException: timeout waiting for de.bmw.idrive.BMWRemoting._result_rhmi_triggerEvent(288419370)
[08-24 00:18:37.276 25125:25543 I/CarThread]
Shutting down thread Music due to RuntimeException: org.apache.etch.util.TimeoutException: timeout waiting for de.bmw.idrive.BMWRemoting._result_rhmi_setData(-1822907036)
org.apache.etch.util.TimeoutException: timeout waiting for de.bmw.idrive.BMWRemoting._result_rhmi_setData(-1822907036)
[08-24 00:18:40.157 25125:29706 W/CarProber]
Exception while pinging car
java.lang.RuntimeException: unexpected exception sending message
[08-24 00:18:40.157 25125:29706 I/CarProber]
Previously-connected car has disconnected

[08-24 00:18:49.909 25125:25125 I/IDriveConnectionListen]
Received car announcement: com.bmwgroup.connected.accessory.ACTION_CAR_ACCESSORY_ATTACHED bmw 14@127.0.0.1:4007

[08-24 00:18:52.138 25125:18678 I/MainService]
Starting to discover car capabilities

Does it not continue to reconnect after the MyBMW app quits and reconnects? The car connection might be in a strange state and so it might take 30 seconds for the watchdog timer to close the bad connection and try again.

unlive74 commented 3 years ago

Yes, I think you're right, the problem was with the MyBMW app. I rebooted my smartphone and the MyBMW application asked for authorization on the server. It seems to me that everything is working fine now. I am using MyBMW 1.4.3, later builds sometimes lose connection with my car.