REPRODUCIBILITY: always
OS VERSION: 5.0.0.68
HARDWARE: Sony Xperia 10 V
UI LANGUAGE: en_GB
REGRESSION: yes
DESCRIPTION:
Android App Support no longer starts/crashes and then keeps crashing in a loop as it tries to restart itself (thus also draining the battery). I have happily used AAS in the past months on my 10 V.
PRECONDITIONS:
I think I installed three extra apps at some point recently and then rebooted my phone this morning, just because it has been a while. Afterwards, this problem occurs.
STEPS TO REPRODUCE:
-
Reboot the device
-
Start AAS from Settings, if it was not set to boot at start
EXPECTED RESULT:
Android App Support starts normally.
ACTUAL RESULT:
Android App support crashes.
MODIFICATIONS:
Installing some apps via the Aurora app store.
ADDITIONAL INFORMATION:
An excerpt from the systemd journal:
Sep 15 21:41:12 impulse systemd[1]: Created slice system-appsupport\x2dprepare.slice.
Sep 15 21:41:12 impulse systemd[1]: Starting AppSupport prepareâŠ
Sep 15 21:41:12 impulse systemd[1]: Created slice system-appsupport.slice.
[âŠ]
Sep 15 21:41:13 impulse appsupport-init[5612]: export APPSUPPORT_API=â/opt/appsupport/init/appsupport-commonâ
Sep 15 21:41:13 impulse appsupport-init[5612]: export APPSUPPORT_DATA_ROOT=â/home/.appsupportâ
Sep 15 21:41:13 impulse appsupport-init[5612]: export INSTANCE_NAME=âdefaultuserâ
Sep 15 21:41:13 impulse appsupport-init[5612]: export CONFIG_INSTANCE=ââinstance defaultuserâ
Sep 15 21:41:13 impulse appsupport-init[5612]: export APPSUPPORT_GENERATE_CONFIG=â/usr/libexec/appsupport/appsupport-generate-config --config /tmp/appsupport/defaultuser/config.dâ
Sep 15 21:41:13 impulse appsupport-init[5612]: export APPSUPPORT_PARSE_CONFIG=â/usr/libexec/appsupport/appsupport-parse-config --config /tmp/appsupport/defaultuser/config.dâ
Sep 15 21:41:13 impulse appsupport-init[5612]: export PASSWD_HELPER=â/opt/appsupport/libexec/passwd_helperâ
Sep 15 21:41:13 impulse appsupport-init[5612]: export BASE_INSTALL_PATH=â/opt/appsupportâ
Sep 15 21:41:13 impulse appsupport-init[5612]: export BASE_CONFIG_PATH=â/opt/appsupport/etcâ
Sep 15 21:41:13 impulse appsupport-init[5612]: export LXC_CONFIG_PATH=â/tmp/appsupportâ
Sep 15 21:41:13 impulse appsupport-init[5612]: export CONTAINER_CONFIG_PATH=â/tmp/appsupport/defaultuserâ
Sep 15 21:41:13 impulse appsupport-init[5612]: export APPSUPPORT_USER=âdefaultuserâ
Sep 15 21:41:13 impulse appsupport-init[5612]: export PRIVILEGED=0
Sep 15 21:41:13 impulse appsupport-init[5612]: export APPSUPPORT_BASE_UID=500000
Sep 15 21:41:13 impulse appsupport-init[5612]: export APPSUPPORT_USER_UID=100000
Sep 15 21:41:13 impulse appsupport-init[5612]: export APPSUPPORT_USER_HOME=â/home/defaultuserâ
Sep 15 21:41:13 impulse appsupport-init[5612]: export ANDROID_DATA_ROOT=â/home/.appsupport/instance/defaultuserâ
Sep 15 21:41:13 impulse appsupport-init[5612]: export ANDROID_DATA=/home/.appsupport/instance/defaultuser/data
Sep 15 21:41:13 impulse appsupport-init[5612]: export CONTROL_FILE_PATH=â/tmp/appsupport/defaultuser/controlâ
Sep 15 21:41:13 impulse appsupport-init[5612]: export ROOTFS_PATH=â/opt/appsupport/rootfsâ
Sep 15 21:41:13 impulse appsupport-init[5612]: export SYSTEM_IMAGE_PATH=â/opt/appsupport/system.imgâ
Sep 15 21:41:13 impulse appsupport-init[5612]: export PRODUCT_IMAGE_PATH=â/opt/appsupport/product.imgâ
Sep 15 21:41:13 impulse appsupport-init[5612]: Running hooks from prepare-hook.dâŠ
Sep 15 21:41:13 impulse appsupport-init[5612]: Running 01-binderfs-setup.sh
Sep 15 21:41:13 impulse ofonod[4920]: [gbinder] ERROR! Canât open /dev/hwpuddlejumper: Permission denied
Sep 15 21:41:13 impulse kernel: binder: 4920:4920 transaction failed 29189/-22, size 0-0 line 2785
Sep 15 21:41:13 impulse appsupport-init[5612]: Running 02-data-root.sh
Sep 15 21:41:13 impulse appsupport-init[5612]: Running 05-create-storage-directory.sh
Sep 15 21:41:13 impulse appsupport-init[5612]: Running 10-graphics.sh
Sep 15 21:41:13 impulse appsupport-init[5612]: Running 10-start-lxc-net.sh
[âŠ.]
Sep 15 21:41:13 impulse systemd[1]: Started LXC network bridge setup.
Sep 15 21:41:13 impulse appsupport-init[5612]: Running 20-clear-caches.sh
Sep 15 21:41:13 impulse appsupport-init[5612]: Running 20-create-appsupport-root-home.sh
Sep 15 21:41:13 impulse appsupport-init[5612]: Running 20-mount-rootfs.sh
Sep 15 21:41:14 impulse appsupport-init[5612]: Running 30-privilege-migration.sh
Sep 15 21:41:14 impulse appsupport-init[5612]: Running 30-set-container-node-permissions.sh
Sep 15 21:41:14 impulse kernel: binder: 4920:4920 transaction failed 29189/-22, size 0-0 line 2785
Sep 15 21:41:14 impulse appsupport-init[5612]: Running 35-storage-migration.sh
Sep 15 21:41:14 impulse appsupport-init[5612]: Running 60-generate-bsp-config.sh
Sep 15 21:41:14 impulse appsupport-init[5612]: Running 70-generate-properties.sh
Sep 15 21:41:14 impulse appsupport-init[5612]: Running 70-generate-rootfs-config.sh
Sep 15 21:41:14 impulse appsupport-init[5612]: Running 75-generate-privilege-config.sh
Sep 15 21:41:14 impulse appsupport-init[5612]: Running 90-setup.sh
Sep 15 21:41:14 impulse appsupport-init[5612]: Running 98-anr-and-logger.sh
Sep 15 21:41:14 impulse kernel: binder: 4920:4920 transaction failed 29189/-22, size 0-0 line 2785
Sep 15 21:41:14 impulse systemd[1]: Started AppSupport prepare.
Sep 15 21:41:14 impulse systemd[1]: Starting AppSupportâŠ
[âŠ]
Sep 15 21:41:16 impulse appsupport-init[5612]: Start --user apkd-bridge.service
Sep 15 21:41:16 impulse systemd[3263]: Starting Bridge native privileged data to AppSupportâŠ
Sep 15 21:41:16 impulse systemd[3263]: Started Bridge native privileged data to AppSupport.
Sep 15 21:41:16 impulse appsupport-init[5612]: Start --user apkd-bridge-hw.service
Sep 15 21:41:16 impulse systemd[3263]: Starting Bridge native data to AppSupportâŠ
Sep 15 21:41:16 impulse apkd-bridge-hw[6178]: [W] unknown:0 - Sensor not supported ( QAmbientLightSensor )
Sep 15 21:41:16 impulse apkd-bridge-hw[6178]: [W] unknown:0 - Sensor not supported ( QCompass )
Sep 15 21:41:16 impulse apkd-bridge-hw[6178]: [W] unknown:0 - Sensor not supported ( QRotationSensor )
Sep 15 21:41:16 impulse apkd-bridge-hw[6178]: [D] unknown:0 - Starting bridge for âdefaultâ (âandroid.hardware.graphics.allocator@4.0::IAllocatorâ, âandroid.hardware.graphics.allocator@3.0::IAllocatorâ, âandroid.hardware.graphics.allocator@2.0::IAllocatorâ) on /dev/hwpuddlejumper from /dev/hwbinder
Sep 15 21:41:16 impulse apkd-bridge-hw[6178]: [D] unknown:0 - Starting bridge for âdefaultâ (âandroid.hardware.power@1.3::IPowerâ, âandroid.hardware.power@1.2::IPowerâ, âandroid.hardware.power@1.1::IPowerâ, âandroid.hardware.power@1.0::IPowerâ) on /dev/hwpuddlejumper from /dev/hwbinder
Sep 15 21:41:16 impulse droid-hal-init: Control message: Could not find âandroid.hardware.graphics.allocator@2.0::IAllocator/defaultâ for ctl.interface_start from pid: 1199 (/system/system_ext/bin/hwservicemanager)
Sep 15 21:41:16 impulse droid-hal-init: Control message: Could not find âandroid.hardware.graphics.allocator@2.0::IAllocator/defaultâ for ctl.interface_start from pid: 1199 (/system/system_ext/bin/hwservicemanager)
Sep 15 21:41:16 impulse apkd-bridge-hw[6178]: [D] unknown:0 - Starting bridge for âlegacy/0â (âandroid.hardware.camera.provider@2.4::ICameraProviderâ) on /dev/hwpuddlejumper from /dev/hwbinder
Sep 15 21:41:16 impulse droid-hal-init: Control message: Could not find âandroid.hardware.camera.provider@2.4::ICameraProvider/legacy/0â for ctl.interface_start from pid: 1199 (/system/system_ext/bin/hwservicemanager)
Sep 15 21:41:16 impulse droid-hal-init: Control message: Could not find âandroid.hardware.camera.provider@2.4::ICameraProvider/legacy/0â for ctl.interface_start from pid: 1199 (/system/system_ext/bin/hwservicemanager)
Sep 15 21:41:16 impulse systemd[3263]: Started Bridge native data to AppSupport.
[âŠ.]
Sep 15 21:41:24 impulse appsupport-init[6970]: Running hooks from start-post-hook.dâŠ
Sep 15 21:41:24 impulse appsupport-init[6970]: Running 50-setup.sh
[âŠ]
Sep 15 21:41:24 impulse systemd[1]: Started AppSupport.
Sep 15 21:41:24 impulse d-bridge[4236]: [W] unknown:0 - Discarding parcel with 4 bytes unread.
Sep 15 21:41:24 impulse d-bridge[4236]: [W] unknown:0 - Discarding parcel with 4 bytes unread.
Sep 15 21:41:24 impulse d-bridge[4236]: [W] unknown:0 - Discarding parcel with 36 bytes unread.
Sep 15 21:41:24 impulse d-bridge[4236]: [W] unknown:0 - Successfully notified AppSupport contacts service of current contacts.
[âŠ]
Sep 15 21:41:27 impulse apkd-bridge-hw[6178]: [W] unknown:0 - âGNSS Remote died, cleaning up!â
Sep 15 21:41:27 impulse kernel: binder: send failed reply for transaction 77817 to 7172:7202
Sep 15 21:41:27 impulse kernel: binder: send failed reply for transaction 77818 to 7172:7234
Sep 15 21:41:27 impulse kernel: binder: send failed reply for transaction 77819 to 7172:7172
Sep 15 21:41:27 impulse kernel: binder: 6178:6178 BC_DEAD_BINDER_DONE 0000000000000001 not found
Sep 15 21:41:27 impulse apkd-bridge-hw[6178]: [W] unknown:0 - alien.connectivity died! Trying to reconnect.
Sep 15 21:41:27 impulse d-bridge[4236]: [W] unknown:0 - alien died! Trying to reconnect.
Sep 15 21:41:27 impulse kernel: binder: 4236:4236 BC_DEAD_BINDER_DONE 0000000000000005 not found
Sep 15 21:41:27 impulse d-bridge[4236]: [W] unknown:0 - appsupport.inputattachservice died! Trying to reconnect.
[âŠ]
Sep 15 21:41:30 impulse d-bridge[4236]: [W] unknown:0 - appsupport.contacts died! Trying to reconnect.
Sep 15 21:41:30 impulse d-bridge[4236]: [W] unknown:0 - appsupport.media.control died! Trying to reconnect.
Sep 15 21:41:30 impulse d-bridge[4236]: [W] unknown:0 - appsupport.audio.control died! Trying to reconnect.
Sep 15 21:41:30 impulse d-bridge[4236]: [W] unknown:0 - appsupport.intent.resolver died! Trying to reconnect.
Sep 15 21:41:30 impulse d-bridge[4236]: [W] unknown:0 - appsupport.media.file_observer died! Trying to reconnect.
Sep 15 21:41:31 impulse systemd[1]: appsupport@defaultuser.service: Main process exited, code=exited, status=1/FAILURE
Sep 15 21:41:31 impulse systemd[1]: appsupport@defaultuser.service: Failed with result âexit-codeâ.
( I removed most selinux and other kernel messages to make the logs more clear, let me know if anyone wants to see the full journal.)