Same here. In fact, it happened today.
My uprecords show that I never get beyond 25 days of uptime since Linux 4.19.248. After that period, Alien Dalvik refuses to start.
Maybe the issue isn’t related to uptime, but to the number of service restarts.
Additional information: I use Situations to stop AD service during the night.
My gut feeling is that it’s not service restart dependent… I hadn’t restarted android app support in this time, so that would be the stop-start for me after the last device reboot.
But could he number of +/- 25 days of uptime be some pattern?
OT: I made similar experiences, but not with Android support but with network services. Resetting network with SFOS utilities didn’t help, but a full reboot did. There seems something to be unstable in the whole SFOS.
I tried to start Android app support again, this time there are a lot of crashes:
Another service start-stuck-stop
-- Logs begin at Sun 2023-03-05 22:23:05 EET. --
16:21:38 kernel: binder: release 27486:27601 transaction 64604622 out, still active
16:21:38 alien-post-startup.sh[28638]: lxc-attach: aliendalvik: af_unix.c: lxc_abstract_unix_recv_fds_iov: 318 Invalid argument - Received no file descriptors
16:21:38 alien-post-startup.sh[28638]: lxc-attach: aliendalvik: commands.c: lxc_cmd_rsp_recv_fds: 129 Failed to receive file descriptors
16:21:39 alien-post-startup.sh[28638]: cmd: Can't find service: settings
16:21:39 alien-post-startup.sh[28638]: cmd: Can't find service: settings
16:21:39 alien-post-startup.sh[28638]: cmd: Can't find service: settings
16:21:39 alien-post-startup.sh[28638]: cmd: Can't find service: settings
16:21:39 alien-post-startup.sh[28638]: cmd: Can't find service: package
16:21:39 alien-post-startup.sh[28638]: cmd: Can't find service: device_config
16:21:39 systemd[1]: aliendalvik.service: Control process exited, code=exited status=20
16:21:39 kernel: binder_thread_write: 5 callbacks suppressed
16:21:39 kernel: binder: 27273:27273 BC_DEAD_BINDER_DONE 0000000000000000 not found
16:21:39 alienaudioservice[27273]: [gbinder] WARNING: Service manager /dev/vndpuddlejumper has died
16:21:39 alienaudioservice[27273]: [AlienAudioService] service: Service manager has died.
16:21:39 kernel: binder: release 27379:27379 transaction 64600269 out, still active
16:21:39 kernel: binder: undelivered TRANSACTION_COMPLETE
16:21:39 kernel: binder: 27312:27312 BC_CLEAR_DEATH_NOTIFICATION invalid ref 5
16:21:39 alienkeyboardservice[27294]: [gbinder] WARNING: Service manager /dev/puddlejumper has died
16:21:39 kernel: binder: 27294:27294 BC_DEAD_BINDER_DONE 0000000000000000 not found
16:21:39 kernel: binder: 27312:27312 BC_DEAD_BINDER_DONE 0000000000000000 not found
16:21:39 kernel: binder: 27273:27273 BC_DEAD_BINDER_DONE 0000000000000000 not found
16:21:39 alienaudioservice[27273]: [gbinder] WARNING: Service manager /dev/puddlejumper has died
16:21:39 kernel: binder: 27312:27312 BC_DEAD_BINDER_DONE 0000000000000000 not found
16:21:39 kernel: binder: 27273:27273 BC_DEAD_BINDER_DONE 0000000000000000 not found
16:21:39 alienaudioservice[27273]: [gbinder] WARNING: Service manager /dev/hwpuddlejumper has died
16:21:39 ofonod[3388]: [gbinder] WARNING! Service manager /dev/hwpuddlejumper has died
16:21:39 kernel: binder: release 27388:27464 transaction 64600269 in, still active
16:21:39 kernel: binder: send failed reply for transaction 64600269, target dead
16:21:39 kernel: binder: undelivered death notification, b400007a6ffe9140
16:21:39 stop-aliendalvik.sh[28676]: lxc-attach: aliendalvik: af_unix.c: lxc_abstract_unix_recv_fds_iov: 318 Invalid argument - Received no file descriptors
16:21:39 stop-aliendalvik.sh[28676]: lxc-attach: aliendalvik: commands.c: lxc_cmd_rsp_recv_fds: 129 Failed to receive file descriptors
16:21:39 kernel: binder: 27273:27273 transaction failed 29189/-22, size 0-0 line 3103
16:21:39 stop-aliendalvik.sh[28676]: Done
16:21:39 kernel: binder: 27294:27294 transaction failed 29189/-22, size 0-0 line 3103
16:21:39 kernel: binder: 27312:27312 transaction failed 29189/-22, size 0-0 line 3103
16:21:39 kernel: binder: 27273:27273 transaction failed 29189/-22, size 0-0 line 3103
16:21:39 kernel: binder: 27273:27273 transaction failed 29189/-22, size 32-0 line 3103
16:21:39 kernel: binder: 27312:27312 transaction failed 29189/-22, size 32-0 line 3103
16:21:39 stop-aliendalvik.sh[28676]: Waiting for container to exit.
16:21:39 kernel: Core dump to |/usr/sbin/rich-core-dumper --pid=1 --signal=11 --name=init disabled
16:21:39 kernel: binder: 27273:27273 transaction failed 29189/-22, size 0-0 line 3103
16:21:39 kernel: binder: 27294:27294 transaction failed 29189/-22, size 0-0 line 3103
16:21:39 kernel: binder: 27312:27312 transaction failed 29189/-22, size 0-0 line 3103
16:21:39 toeterm[26475]: [D] unknown:0 - unknown special key: 67108864
16:21:40 systemd[1]: aliendalvik.service: Failed with result 'exit-code'.
16:21:40 systemd[1]: Stopped Alien Dalvik.
16:21:40 systemd[1]: Stopping Alien Dalvik prepare...
16:21:40 systemd[6379]: Stopping Alien Audio Service...
16:21:40 systemd[6379]: Stopped Alien Audio Service.
16:21:40 systemd[6379]: Stopping Alien Keyboard Service...
16:21:40 systemd[6379]: Stopped Alien Keyboard Service.
16:21:40 systemd[6379]: Stopping Bridge native data to Alien Dalvik...
16:21:40 /usr/libexec/mapplauncherd/booster-qt5[6416]: warning: terminating: booster:26124 invoker:27311 socket:13
16:21:40 /usr/libexec/mapplauncherd/booster-qt5[6416]: warning: Daemon: sending exit(1) to invoker(27311)
16:21:40 /usr/libexec/mapplauncherd/booster-qt5[6416]: warning: sending SIGTERM to booster (pid=26124)
16:21:40 systemd[6379]: Stopped Bridge native data to Alien Dalvik.
16:21:40 booster-qt5[6416]: *** signal=17 pid=6416
16:21:40 systemd[6379]: Stopping Bridge native data to Alien Dalvik...
16:21:40 /usr/libexec/mapplauncherd/booster-qt5[6416]: warning: terminating: booster:27312 invoker:27339 socket:19
16:21:40 /usr/libexec/mapplauncherd/booster-qt5[6416]: warning: Daemon: sending exit(1) to invoker(27339)
16:21:40 /usr/libexec/mapplauncherd/booster-qt5[6416]: warning: sending SIGTERM to booster (pid=27312)
16:21:40 systemd[6379]: Stopped Bridge native data to Alien Dalvik.
16:21:40 kernel: binder: release 27312:27459 transaction 64604622 in, still active
16:21:40 kernel: binder: send failed reply for transaction 64604622, target dead
16:21:40 sensorfwd[3315]: [SocketHandler]: Socket error: QLocalSocket::PeerClosedError
16:21:40 sensorfwd[3315]: [SocketHandler]: Noticed lost session: 96
16:21:40 sensorfwd[3315]: [SocketHandler]: Socket error: QLocalSocket::PeerClosedError
16:21:40 sensorfwd[3315]: [SocketHandler]: Noticed lost session: 98
16:21:40 sensorfwd[3315]: [SocketHandler]: Socket error: QLocalSocket::PeerClosedError
16:21:40 booster-qt5[6416]: *** signal=17 pid=6416
16:21:40 sensorfwd[3315]: [SocketHandler]: Noticed lost session: 100
16:21:40 sensorfwd[3315]: [SocketHandler]: Socket error: QLocalSocket::PeerClosedError
16:21:40 sensorfwd[3315]: [SocketHandler]: Noticed lost session: 97
16:21:40 sensorfwd[3315]: [SocketHandler]: Socket error: QLocalSocket::PeerClosedError
16:21:40 sensorfwd[3315]: [SocketHandler]: Noticed lost session: 101
16:21:40 sensorfwd[3315]: [SocketHandler]: Socket error: QLocalSocket::PeerClosedError
16:21:40 sensorfwd[3315]: [SocketHandler]: Noticed lost session: 99
16:21:40 systemd[1]: Stopped Alien Dalvik prepare.
16:21:42 mce[2052]: tklock.c: tklock_datapipe_uiexception_type_cb(): uiexception_type = notif -> none
16:21:44 kernel: rpmh_rsc_send_data: 77 callbacks suppressed
16:21:44 kernel: binder_transaction: 23 callbacks suppressed
16:21:46 sudo[28792]: defaultuser : TTY=pts/1 ; PWD=/home/defaultuser ; USER=root ; COMMAND=/usr/bin/journalctl --follow --since -1min
16:21:46 sudo[28792]: pam_systemd(sudo:session): Using 600s D-Bus method call timeout
16:21:46 sudo[28792]: pam_systemd(sudo:session): Cannot create session: Already running in a session
16:21:46 sudo[28792]: pam_unix(sudo:session): session opened for user root by (uid=100000)
16:21:47 mce[2052]: modules/proximity.c: mp_datapipe_set_proximity_sensor_actual(): state: OPEN -> UNDEF
16:21:51 kernel: rpmh_rsc_send_data: 29 callbacks suppressed
16:21:58 mce[2052]: tklock.c: tklock_dbus_notification_beg_cb(): notification begin from name=:1.73 owner=:1.73 pid=6598 uid=100000 gid=996 priv=1 cmd=/usr/bin/lipstick -plugin evdevtouch -plugin evdevmouse -plugin
16:21:58 mce[2052]: tklock.c: tklock_datapipe_uiexception_type_cb(): uiexception_type = none -> notif
16:21:58 kernel: [aw882xx_smartpa]aw882xx_startup: capture enter
16:21:58 kernel: [aw882xx_smartpa]aw882xx_set_fmt: fmt=0x4001
16:21:58 kernel: msm_mi2s_snd_startup: set sysclk failed, err:-524
16:21:58 kernel: __afe_port_start: port id: 0x1001
16:21:58 kernel: afe_find_cal_topo_id_by_port: port id: 0x1001, dev_acdb_id: -22
16:21:58 kernel: afe_find_cal_topo_id_by_port: top_id:1000ff02 acdb_id:102 afe_port:0x1001
16:21:58 kernel: afe_get_cal_topology_id: port_id = 0x1001 acdb_id = 102 topology_id = 0x1000ff02 cal_type_index=8 ret=0
16:21:58 kernel: afe_send_port_topology_id: AFE set topology id 0x1000ff02 enable for port 0x1001 ret 0
16:21:58 kernel: send_afe_cal_type: cal_index is 1
16:21:58 kernel: send_afe_cal_type: dev_acdb_id[41] is -22
16:21:58 kernel: send_afe_cal_type: Sending cal_index cal 1
16:21:58 kernel: afe_send_hw_delay: port_id 0x1001 rate 48000 delay_usec 578 status 0
16:21:58 kernel: [aw882xx_smartpa]aw882xx_mute: mute state=0
16:21:58 kernel: [aw882xx_smartpa]aw882xx_startup: playback enter
16:21:58 kernel: __afe_port_start: port id: 0x1000
16:21:58 kernel: afe_find_cal_topo_id_by_port: port id: 0x1000, dev_acdb_id: 124
16:21:58 kernel: afe_find_cal_topo_id_by_port: top_id:1001025f acdb_id:124 afe_port_id:0x1000
16:21:58 kernel: afe_get_cal_topology_id: port_id = 0x1000 acdb_id = 124 topology_id = 0x1001025f cal_type_index=8 ret=0
16:21:58 kernel: afe_send_port_topology_id: AFE set topology id 0x1001025f enable for port 0x1000 ret 0
16:21:58 kernel: send_afe_cal_type: cal_index is 0
16:21:58 kernel: send_afe_cal_type: dev_acdb_id[40] is 124
16:21:58 kernel: afe_find_cal: cal_index 0 port_id 0x1000 port_index 40
16:21:58 kernel: afe_find_cal: acdb_id 124 dev_acdb_id 124 sample_rate 48000 afe_sample_rates 48000
16:21:58 kernel: afe_find_cal: cal block is a match, size is 868
16:21:58 kernel: send_afe_cal_type: Sending cal_index cal 0
16:21:58 kernel: afe_send_hw_delay: port_id 0x1000 rate 48000 delay_usec 474 status 0
16:21:58 kernel: [aw882xx_smartpa]aw882xx_mute: mute state=0
16:21:58 kernel: [aw882xx_smartpa]aw882xx_smartpa_cfg: flag = 1, power status = 0
16:21:58 kernel: [aw882xx_smartpa]aw882xx_clear_sysint: get_sysint=0x4395
16:21:58 kernel: [aw882xx_smartpa]aw882xx_clear_sysint: get_sysint=0x0000
16:21:58 kernel: afe_callback: cmd = 0x100fa returned error = 0x1
16:21:58 kernel: afe_apr_send_pkt: DSP returned error[ADSP_EFAILED]
16:21:58 kernel: [aw882xx_smartpa]aw882xx_set_cali_re_to_dsp : set cali re to dsp failed
16:21:58 kernel: [aw882xx_smartpa]aw882xx_monitor_start: enter
16:21:58 kernel: [aw882xx_smartpa]aw882xx_monitor_get_data: vol: ipeak = 0x8, gain = 0x0, vmax = 0x0
16:21:58 kernel: [aw882xx_smartpa]aw882xx_monitor_get_data: temp: ipeak = 0x8, gain = 0x0, vmax = 0x0
16:21:58 kernel: [aw882xx_smartpa]aw882xx_monitor_set_ipeak: ipeak = 0x8, no change
16:21:58 kernel: [aw882xx_smartpa]aw882xx_monitor_set_gain: set db = 0.0 dB, no change
16:21:58 kernel: afe_callback: cmd = 0x100fa returned error = 0x1
16:21:58 kernel: afe_apr_send_pkt: DSP returned error[ADSP_EFAILED]
16:21:58 kernel: [aw882xx_smartpa]aw882xx_monitor_set_vmax: dsp_msg_write error
16:21:58 kernel: [aw882xx_smartpa]aw882xx_monitor_set_vmax: set vmax = 0x0
16:21:59 mce[2052]: modules/proximity.c: mp_datapipe_set_proximity_sensor_actual(): state: UNDEF -> OPEN
16:22:01 kernel: rpmh_rsc_send_data: 118 callbacks suppressed
16:22:02 kernel: [aw882xx_smartpa]aw882xx_mute: mute state=1
16:22:02 kernel: [aw882xx_smartpa]aw882xx_smartpa_cfg: flag = 0, power status = 2
16:22:02 kernel: [aw882xx_smartpa]aw882xx_monitor_stop: enter
16:22:02 kernel: [aw882xx_smartpa]aw882xx_stop: get_sysint=0x0000
16:22:02 kernel: afe_close: port_id = 0x1000
16:22:02 kernel: [aw882xx_smartpa]aw882xx_mute: mute state=1
16:22:02 kernel: afe_close: port_id = 0x1001
16:22:05 mce[2052]: tklock.c: tklock_datapipe_uiexception_type_cb(): uiexception_type = notif -> none
16:22:07 kernel: rpmh_rsc_send_data: 130 callbacks suppressed
16:22:10 mce[2052]: modules/proximity.c: mp_datapipe_set_proximity_sensor_actual(): state: OPEN -> UNDEF
16:22:17 kernel: rpmh_rsc_send_data: 168 callbacks suppressed
16:22:22 kernel: rpmh_rsc_send_data: 32 callbacks suppressed
16:22:28 kernel: rpmh_rsc_send_data: 20 callbacks suppressed
16:22:28 toeterm[26475]: [D] unknown:0 - unknown special key: 67108864
16:22:28 sudo[28792]: pam_unix(sudo:session): session closed for user root
16:22:33 sudo[28937]: defaultuser : TTY=pts/1 ; PWD=/home/defaultuser ; USER=root ; COMMAND=/usr/bin/systemctl stop aliendalvik.service
16:22:33 sudo[28937]: pam_systemd(sudo:session): Using 600s D-Bus method call timeout
16:22:33 sudo[28937]: pam_systemd(sudo:session): Cannot create session: Already running in a session
16:22:33 sudo[28937]: pam_unix(sudo:session): session opened for user root by (uid=100000)
16:22:33 sudo[28937]: pam_unix(sudo:session): session closed for user root
16:22:33 kernel: rpmh_rsc_send_data: 6 callbacks suppressed
16:22:38 sudo[28944]: defaultuser : TTY=pts/1 ; PWD=/home/defaultuser ; USER=root ; COMMAND=/usr/bin/journalctl --follow --since -1min
16:22:38 sudo[28944]: pam_systemd(sudo:session): Using 600s D-Bus method call timeout
16:22:38 sudo[28944]: pam_systemd(sudo:session): Cannot create session: Already running in a session
16:22:38 sudo[28944]: pam_unix(sudo:session): session opened for user root by (uid=100000)
16:22:39 kernel: rpmh_rsc_send_data: 45 callbacks suppressed
16:22:41 invoker[7297]: WARNING: An inactive plugin is misbehaving - tried to show a window!
16:22:41 invoker[7297]: WARNING: requestActivate() called for QQuickView(0x3b630370) which has Qt::WindowDoesNotAcceptFocus set.
16:22:44 kernel: rpmh_rsc_send_data: 14 callbacks suppressed
16:22:47 dbus-daemon[6405]: dbus-daemon[6405]: [session uid=100000 pid=6405] Activating service name='com.jolla.settings' requested by ':1.4859' (uid=100000 pid=28982 comm="/usr/libexec/mliteremoteaction com.jolla.settings " label="u:r:kernel:s0")
16:22:47 dbus-daemon[6405]: dbus-daemon[6405]: [session uid=100000 pid=6405] Successfully activated service 'com.jolla.settings'
16:22:48 invoker[7297]: WARNING: An inactive plugin is misbehaving - tried to show a window!
16:22:48 invoker[7297]: WARNING: requestActivate() called for QQuickView(0x3b630370) which has Qt::WindowDoesNotAcceptFocus set.
16:22:48 dbus-daemon[6405]: QInotifyFileSystemWatcherEngine::addPaths: inotify_add_watch failed: Tiedostoa tai hakemistoa ei ole
16:22:48 booster-silica-qt5[28986]: [D] unknown:0 - Using Wayland-EGL
16:22:48 dbus-daemon[6405]: QInotifyFileSystemWatcherEngine::addPaths: inotify_add_watch failed: Tiedostoa tai hakemistoa ei ole
16:22:50 systemd[1]: selinux: Unknown permission status for class system
16:22:50 systemd[1]: selinux: Unknown permission status for class system
16:22:51 kernel: rpmh_rsc_send_data: 46 callbacks suppressed
16:22:51 systemd[1]: Starting Alien Dalvik prepare...
16:22:52 prepare-aliendalvik.sh[29006]: Failed to read 'ANDROID_DATA_ROOT' from environment variables for template 'env:ANDROID_DATA_ROOT'
16:22:52 prepare-aliendalvik.sh[29006]: Failed to read 'WAYLAND_SOCKET_PATH' from environment variables for template 'env:WAYLAND_SOCKET_PATH'
16:22:52 prepare-aliendalvik.sh[29006]: Failed to read 'WAYLAND_SOCKET' from environment variables for template 'env:WAYLAND_SOCKET'
16:22:52 prepare-aliendalvik.sh[29006]: Failed to read 'WAYLAND_SOCKET_PATH' from environment variables for template 'env:WAYLAND_SOCKET_PATH'
16:22:52 prepare-aliendalvik.sh[29006]: Failed to read 'BINDER_DEV' from environment variables for template 'env:BINDER_DEV'
16:22:52 prepare-aliendalvik.sh[29006]: Failed to read 'HWBINDER_DEV' from environment variables for template 'env:HWBINDER_DEV'
16:22:52 prepare-aliendalvik.sh[29006]: Failed to read 'VNDBINDER_DEV' from environment variables for template 'env:VNDBINDER_DEV'
16:22:52 prepare-aliendalvik.sh[29006]: Failed to read 'persist.multisim.config' from properties for template 'prop:persist.multisim.config'
16:22:52 prepare-aliendalvik.sh[29006]: Failed to read 'ro.hybris.battery.capacity' from properties for template 'prop:ro.hybris.battery.capacity'
16:22:52 prepare-aliendalvik.sh[29006]: Failed to read 'ro.vendor.product.manufacturer' from properties for template 'prop:ro.vendor.product.manufacturer'
16:22:52 prepare-aliendalvik.sh[29006]: Failed to read 'ro.vendor.product.model' from properties for template 'prop:ro.vendor.product.model'
16:22:52 prepare-aliendalvik.sh[29006]: Failed to read 'ro.vendor.product.brand' from properties for template 'prop:ro.vendor.product.brand'
16:22:52 prepare-aliendalvik.sh[29006]: Failed to read 'ro.vendor.product.name' from properties for template 'prop:ro.vendor.product.name'
16:22:52 prepare-aliendalvik.sh[29006]: Failed to read 'ro.vendor.product.device' from properties for template 'prop:ro.vendor.product.device'
16:22:52 prepare-aliendalvik.sh[29006]: Failed to read 'ANDROID_DATA_ROOT' from environment variables for template 'env:ANDROID_DATA_ROOT'
16:22:52 prepare-aliendalvik.sh[29006]: Failed to read 'ANDROID_DATA_ROOT' from environment variables for template 'env:ANDROID_DATA_ROOT'
16:22:52 prepare-aliendalvik.sh[29006]: Failed to read 'WAYLAND_SOCKET_PATH' from environment variables for template 'env:WAYLAND_SOCKET_PATH'
16:22:52 prepare-aliendalvik.sh[29006]: Failed to read 'WAYLAND_SOCKET' from environment variables for template 'env:WAYLAND_SOCKET'
16:22:52 prepare-aliendalvik.sh[29006]: Failed to read 'WAYLAND_SOCKET_PATH' from environment variables for template 'env:WAYLAND_SOCKET_PATH'
16:22:52 prepare-aliendalvik.sh[29006]: Failed to read 'WIDTH' from environment variables for template 'env:WIDTH'
16:22:52 prepare-aliendalvik.sh[29006]: Failed to read 'HEIGHT' from environment variables for template 'env:HEIGHT'
16:22:52 prepare-aliendalvik.sh[29006]: Failed to read 'DEPTH' from environment variables for template 'env:DEPTH'
16:22:52 prepare-aliendalvik.sh[29006]: Failed to read 'DPI_X' from environment variables for template 'env:DPI_X'
16:22:52 prepare-aliendalvik.sh[29006]: Failed to read 'DPI_Y' from environment variables for template 'env:DPI_Y'
16:22:52 systemd[1]: Started Alien Dalvik prepare.
16:22:52 systemd[1]: Starting Alien Dalvik...
16:22:52 start-aliendalvik.sh[29133]: lxc-start: aliendalvik: utils.c: lxc_can_use_pidfd: 1772 Kernel does not support pidfds
16:22:52 start-aliendalvik.sh[29133]: lxc-attach: aliendalvik: af_unix.c: lxc_abstract_unix_recv_fds_iov: 318 Invalid argument - Received no file descriptors
16:22:52 start-aliendalvik.sh[29133]: lxc-attach: aliendalvik: commands.c: lxc_cmd_rsp_recv_fds: 129 Failed to receive file descriptors
16:22:52 start-aliendalvik.sh[29133]: lxc-attach: aliendalvik: attach.c: lxc_attach_run_command: 1808 No such file or directory - Failed to exec "/system/bin/getprop"
16:22:52 start-aliendalvik.sh[29133]: Supplementary services waiting for hwservicemanager...
16:22:52 kernel: new mount options do not match the existing superblock, will be ignored
16:22:53 kernel: binder: 29197:29197 transaction failed 29189/-22, size 0-0 line 3103
16:22:53 start-aliendalvik.sh[29133]: lxc-attach: aliendalvik: af_unix.c: lxc_abstract_unix_recv_fds_iov: 318 Invalid argument - Received no file descriptors
16:22:53 start-aliendalvik.sh[29133]: lxc-attach: aliendalvik: commands.c: lxc_cmd_rsp_recv_fds: 129 Failed to receive file descriptors
16:22:53 systemd[6379]: Started Alien Audio Service.
16:22:53 ofonod[3388]: [gbinder] Service manager /dev/hwpuddlejumper has appeared
16:22:53 systemd[6379]: Started Alien Keyboard Service.
16:22:54 systemd[6379]: Starting Bridge native data to Alien Dalvik...
16:22:54 invoker[29271]: Failed to read 'ANDROID_DATA_ROOT' from environment variables for template 'env:ANDROID_DATA_ROOT'
16:22:54 invoker[29271]: Failed to read 'BINDER_DEV' from environment variables for template 'env:BINDER_DEV'
16:22:54 invoker[29271]: Failed to read 'HWBINDER_DEV' from environment variables for template 'env:HWBINDER_DEV'
16:22:54 invoker[29271]: Failed to read 'APKD_PACKAGE_BLACKLIST_PATH' from environment variables for template 'env:APKD_PACKAGE_BLACKLIST_PATH'
16:22:54 invoker[29271]: Failed to read 'APKD_NOTIF_BLACKLIST_PATH' from environment variables for template 'env:APKD_NOTIF_BLACKLIST_PATH'
16:22:54 systemd[1]: selinux: Unknown permission status for class system
16:22:54 systemd[6379]: Started Bridge native data to Alien Dalvik.
16:22:54 systemd[6379]: Started Bridge native data to Alien Dalvik.
16:22:55 invoker[29294]: Failed to read 'ANDROID_DATA_ROOT' from environment variables for template 'env:ANDROID_DATA_ROOT'
16:22:55 invoker[29294]: Failed to read 'BINDER_DEV' from environment variables for template 'env:BINDER_DEV'
16:22:55 invoker[29294]: Failed to read 'HWBINDER_DEV' from environment variables for template 'env:HWBINDER_DEV'
16:22:55 invoker[29294]: Failed to read 'APKD_PACKAGE_BLACKLIST_PATH' from environment variables for template 'env:APKD_PACKAGE_BLACKLIST_PATH'
16:22:55 invoker[29294]: Failed to read 'APKD_NOTIF_BLACKLIST_PATH' from environment variables for template 'env:APKD_NOTIF_BLACKLIST_PATH'
16:22:55 kernel: Core dump to |/usr/sbin/rich-core-dumper --pid=44 --signal=6 --name=android.hardwar disabled
16:22:55 systemd[1]: selinux: Unknown permission status for class system
16:22:55 invoker[29294]: Starting AlienMediaBrowserService
16:22:55 invoker[29294]: Failed to read 'ANDROID_DATA_ROOT' from environment variables for template 'env:ANDROID_DATA_ROOT'
16:22:55 invoker[29294]: Failed to read 'BINDER_DEV' from environment variables for template 'env:BINDER_DEV'
16:22:55 invoker[29294]: Failed to read 'HWBINDER_DEV' from environment variables for template 'env:HWBINDER_DEV'
16:22:55 invoker[29294]: Failed to read 'APKD_PACKAGE_BLACKLIST_PATH' from environment variables for template 'env:APKD_PACKAGE_BLACKLIST_PATH'
16:22:55 invoker[29294]: Failed to read 'APKD_NOTIF_BLACKLIST_PATH' from environment variables for template 'env:APKD_NOTIF_BLACKLIST_PATH'
16:22:55 [29272]: [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
16:22:55 [29272]: [D] unknown:0 - Starting bridge for "default" ("android.hardware.power@1.0::IPower") on /dev/hwpuddlejumper from /dev/hwbinder
16:22:55 [29272]: [D] unknown:0 - Starting bridge for "legacy/0" ("android.hardware.camera.provider@2.4::ICameraProvider") on /dev/hwpuddlejumper from /dev/hwbinder
16:22:55 droid-hal-init: Control message: Could not find 'android.hardware.graphics.allocator@2.0::IAllocator/default' for ctl.interface_start from pid: 3253 (/system/bin/hwservicemanager)
16:22:55 kernel: Core dump to |/usr/sbin/rich-core-dumper --pid=42 --signal=6 --name=android.hardwar disabled
16:22:55 kernel: Core dump to |/usr/sbin/rich-core-dumper --pid=63 --signal=6 --name=android.hardwar disabled
16:22:58 invoker[7297]: WARNING: An inactive plugin is misbehaving - tried to show a window!
16:22:58 invoker[7297]: WARNING: requestActivate() called for QQuickView(0x3b630370) which has Qt::WindowDoesNotAcceptFocus set.
16:22:59 kernel: Core dump to |/usr/sbin/rich-core-dumper --pid=166 --signal=6 --name=android.hardwar disabled
16:22:59 kernel: Core dump to |/usr/sbin/rich-core-dumper --pid=167 --signal=6 --name=android.hardwar disabled
16:22:59 kernel: binder: undelivered death notification, b400006e5cde0530
16:22:59 kernel: Core dump to |/usr/sbin/rich-core-dumper --pid=178 --signal=6 --name=android.hardwar disabled
16:22:59 kernel: binder: undelivered death notification, b400007079395fb0
16:22:59 kernel: Core dump to |/usr/sbin/rich-core-dumper --pid=208 --signal=6 --name=android.hardwar disabled
16:23:03 kernel: rpmh_rsc_send_data: 56 callbacks suppressed
16:23:04 kernel: Core dump to |/usr/sbin/rich-core-dumper --pid=276 --signal=6 --name=android.hardwar disabled
16:23:04 kernel: Core dump to |/usr/sbin/rich-core-dumper --pid=280 --signal=6 --name=android.hardwar disabled
16:23:04 kernel: binder: 29627:29627 transaction failed 29189/-22, size 32-0 line 3103
16:23:04 kernel: Core dump to |/usr/sbin/rich-core-dumper --pid=295 --signal=6 --name=android.hardwar disabled
16:23:08 kernel: rpmh_rsc_send_data: 90 callbacks suppressed
16:23:09 kernel: Core dump to |/usr/sbin/rich-core-dumper --pid=333 --signal=6 --name=android.hardwar disabled
16:23:09 kernel: Core dump to |/usr/sbin/rich-core-dumper --pid=336 --signal=6 --name=android.hardwar disabled
16:23:09 kernel: binder: undelivered death notification, b40000772e00bf30
16:23:09 kernel: Core dump to |/usr/sbin/rich-core-dumper --pid=345 --signal=6 --name=android.hardwar disabled
16:23:09 kernel: Core dump to |/usr/sbin/rich-core-dumper --pid=355 --signal=6 --name=android.hardwar disabled
16:23:12 ofonod[3388]: imsradio0 > 4 registrationChanged
16:23:12 ofonod[3388]: 0000: 76 65 6e 64 6f 72 2e 71 74 69 2e 68 61 72 64 77 vendor.q ti.hardw
16:23:12 ofonod[3388]: 0010: 61 72 65 2e 72 61 64 69 6f 2e 69 6d 73 40 31 2e are.radi o.ims@1.
16:23:12 ofonod[3388]: 0020: 30 3a 3a 49 49 6d 73 52 61 64 69 6f 49 6e 64 69 0::IImsR adioIndi [REDACTED]
16:23:13 kernel: rpmh_rsc_send_data: 35 callbacks suppressed
16:23:14 kernel: Core dump to |/usr/sbin/rich-core-dumper --pid=369 --signal=6 --name=android.hardwar disabled
16:23:14 kernel: Core dump to |/usr/sbin/rich-core-dumper --pid=372 --signal=6 --name=android.hardwar disabled
16:23:14 kernel: binder: undelivered death notification, b4000075a460c2d0
16:23:14 kernel: Core dump to |/usr/sbin/rich-core-dumper --pid=381 --signal=6 --name=android.hardwar disabled
16:23:14 kernel: Core dump to |/usr/sbin/rich-core-dumper --pid=382 --signal=6 --name=android.hardwar disabled
16:23:18 kernel: rpmh_rsc_send_data: 69 callbacks suppressed
16:23:19 kernel: Core dump to |/usr/sbin/rich-core-dumper --pid=405 --signal=6 --name=android.hardwar disabled
16:23:19 kernel: Core dump to |/usr/sbin/rich-core-dumper --pid=408 --signal=6 --name=android.hardwar disabled
16:23:19 kernel: binder: undelivered death notification, b4000070378b3b90
16:23:19 kernel: Core dump to |/usr/sbin/rich-core-dumper --pid=409 --signal=6 --name=android.hardwar disabled
16:23:19 kernel: Core dump to |/usr/sbin/rich-core-dumper --pid=422 --signal=6 --name=android.hardwar disabled
16:23:19 kernel: binder: undelivered death notification, b400006efd232bc0
Note that there are lots of aw882xx_smartpa lines, that’s likely because I received a Whisperfish message during logging. Also the dominating qcom_rpmh, selinux and binder: 3388:3388 lines were cut - and its still quite long.
Thanks for @mal for hinting me about tombstones and reminding me about logcat. Here’s my log dump which consists of logcat output, journalctl output and /home/.android/tombstones/* crash dump files, feel free to have a look.
We’re quite far from my comfort zone, but I think this is linked to X10III losing audio which 1) did happen to me before I stopped and started app support, and 2) /system/bin/hw/android.hardware.audio.service shows up a lot in the tombstones.
I tested yesterday and Bluetooth audio works, as well as ringtone plays and even call audio works. I did multiple pulseaudio restarts in the initial process, however.
Hei
In another case in here it was mentioned, when having the GPS active it will cause the no sound.
I Have tried to not have the GPS on and for me it seems the issue will not occur in this state.
Yesterday I put the GPS on and this morning I did not have any sound.
If this is the issue (seems strange for me if it is) I do not know, but it could be.
Maybe anyone could try to test this this.
Hi, I observed the same. Therefor I start and stop android-support every day new (per systemd):
`
[root@Xperia10III defaultuser]# vi /usr/local/bin/phone-wake-up
#!/bin/bash
#Datei /usr/local/bin/phone-wake-up
#start Android App Support
dbus-send --system --dest=com.jolla.apkd.control --print-reply /com/jolla/apkd com.jolla.apkd.control.controlService boolean:true
`
(Disabling in the evening analog.)
Restarting App support is what I do, too, but my script calls systemctl start/stop aliendalvik.service.
Is your method more stable? Doesn’t it do the same internally?
I can’t tell that. The line above I was told in another issue.
Right, the clock is ticking for me to restart my phone because I’ll be needing the banking apps soon. I guess I have at least until the end of the week.
Has anyone found anything interesting in the logs? (I didn’t, other than what I already wrote.) Is there something else I could provide logs about? I’d like to know if this is because of the sound issue, for example…
I had to finally reboot my phone to re-enable Android support, so I can’t provide any logs any more (until it happens again).
My plan is to restart Android app support once per week or so to see if that helps keeping it in working order. I’m also interested to test if the audio-dies-and-video-freezes bug affects this.
The issue happened again today, and guess what: 24 days of uptime.
If there is anything I can do to investigate: let me know.
Otherwise I will have to reboot soon.
All I could find was the following:
[root@Xperia home]# systemctl status lxc@multi-user.service
● lxc@multi-user.service - LXC Container: multi-user
Loaded: loaded (/usr/lib/systemd/system/lxc@.service; disabled; vendor preset: enabled)
Active: failed (Result: exit-code) since Thu 2023-11-02 10:03:06 CET; 5s ago
Docs: man:lxc-start
man:lxc
Process: 8162 ExecStart=/usr/bin/lxc-start -F -n multi-user (code=exited, status=1/FAILURE)
Main PID: 8162 (code=exited, status=1/FAILURE)
Nov 02 10:03:06 Xperia systemd[1]: Started LXC Container: multi-user.
Nov 02 10:03:06 Xperia lxc-start[8162]: lxc-start: multi-user: tools/lxc_start.c: main: 268 No container config specified
Nov 02 10:03:06 Xperia systemd[1]: lxc@multi-user.service: Main process exited, code=exited, status=1/FAILURE
Nov 02 10:03:06 Xperia systemd[1]: lxc@multi-user.service: Failed with result 'exit-code'.
1 Like
I’m currently at 15 days and I have restarted Android app support every 3-4 days or so. So far so good.
Have you had the sound dies bug during that time?
No, that bug didn’t occur this time.
To me the “No container config specified” error message seems to indicate that some config files disapperated. Could it be that some mount isn’t available anymore?
To be honest, I don’t know where to look…
After 25 days - pretty much on the dot - sound stopped working. I grabbed logs but I’ve not gone through them yet. After restarting pulseaudio a few times and testing sound, restarting Android app support doesn’t work anymore. This time the AAS had “uptime” of about 5 days, I’ve been restarting it every once in a while.
It does look like they are linked, according to today. I did have a long-ish Bluetooth headset music listening session before I noticed that, but so I have had many times before.
Also, GPS was not used during the 25 days, it remained disabled the whole time.
5 Likes
Today I had the exact same thing with uptime 25 or 29 days - not sure exactly. I had Phone app stuck and I restarted Home Screen from Settings → Utilities. Android apps weren’t starting after that, and android support showed that it failed to restart.
Xperia 10 iii , build 4.5.0.24
@direc85 I too have sound problems too some times, I do a
systemctl --user restart pulseaudio from times to times, sound starts working again without android support restart
Android app support not able to start after a long uptime on Xperia XA2 Plus also.
Again, after 25 days of uptime Android app support refuses to start.
# Uptime | System Boot up
----------------------------+---------------------------------------------------
1 32 days, 16:12:59 | Linux 4.19.188 Tue Dec 27 19:35:05 2022
2 25 days, 16:18:35 | Linux 4.19.248 Wed Jul 12 14:47:01 2023
3 25 days, 15:25:44 | Linux 4.19.248 Tue Sep 12 17:24:32 2023
-> 4 25 days, 08:52:21 | Linux 4.19.248 Thu Nov 2 11:02:32 2023
5 25 days, 03:11:28 | Linux 4.19.248 Sun Oct 8 08:50:43 2023
6 25 days, 00:35:38 | Linux 4.19.248 Fri Jun 2 06:50:42 2023
7 24 days, 23:32:13 | Linux 4.19.248 Mon May 8 07:18:02 2023
8 24 days, 22:46:56 | Linux 4.19.248 Thu Apr 13 08:30:38 2023
9 23 days, 03:53:04 | Linux 4.19.248 Sat Feb 25 10:35:06 2023
10 12 days, 16:09:11 | Linux 4.19.248 Fri Mar 31 16:21:00 2023
----------------------------+---------------------------------------------------
1up in 0 days, 06:33:24 | at Tue Nov 28 02:28:17 2023
no1 in 7 days, 07:20:39 | at Tue Dec 5 03:15:32 2023
up 336 days, 18:20:53 | since Sun Dec 25 17:03:50 2022
down 0 days, 08:30:10 | since Sun Dec 25 17:03:50 2022
%up 99.895 | since Sun Dec 25 17:03:50 2022