#1107328 bluez-obexd: obex.service often hangs poweroff for some time

Package:
bluez-obexd
Source:
bluez-obexd
Description:
bluez obex daemon
Submitter:
Chris Bainbridge
Date:
2025-06-05 17:27:01 UTC
Severity:
normal
#1107328#5
Date:
2025-06-05 17:24:39 UTC
From:
To:
Dear Maintainer,

After running `poweroff`, this laptop normally powers off within 3
seconds. But after updating to trixie, poweroff often takes much longer,
because shutdown blocks (for around 30 seconds) until obexd is stopped.

To reproduce:

  - boot
  - login to XFCE
  - run `sudo poweroff`

(I thought perhaps this was XFCE-related, but it appears it can also be
reproduced by ctrl-alt-f2 at gdm login screen to switch to virtual
terminal, login to virtual terminal, `systemctl --user start obex`, and
then `poweroff`.)

An abbreviated (grep -P 'now!|bluez|obex|xdg-desktop') log shows 30
seconds passing between the initial poweroff command, and obex.service
becoming stopped:

Jun 05 15:54:32 debian systemd-logind[1514]: The system will power off now!
Jun 05 15:54:32 debian systemd[2842]: xdg-desktop-portal-gtk.service: Main process exited, code=exited, status=1/FAILURE
Jun 05 15:54:32 debian systemd[2842]: xdg-desktop-portal-gtk.service: Failed with result 'exit-code'.
Jun 05 15:54:32 debian dbus-daemon[1491]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.80" (uid=1000 pid=2869 comm="/usr/bin/wireplumber") interface="(unset)" member="(unset)" error name="org.bluez.MediaEndpoint1.Error.NotImplemented" requested_reply="0" destination=":1.3" (uid=0 pid=1488 comm="/usr/libexec/bluetooth/bluetoothd")
Jun 05 15:54:32 debian dbus-daemon[1491]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.80" (uid=1000 pid=2869 comm="/usr/bin/wireplumber") interface="(unset)" member="(unset)" error name="org.bluez.MediaEndpoint1.Error.NotImplemented" requested_reply="0" destination=":1.3" (uid=0 pid=1488 comm="/usr/libexec/bluetooth/bluetoothd")
Jun 05 15:54:32 debian dbus-daemon[1491]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.80" (uid=1000 pid=2869 comm="/usr/bin/wireplumber") interface="(unset)" member="(unset)" error name="org.bluez.MediaEndpoint1.Error.NotImplemented" requested_reply="0" destination=":1.3" (uid=0 pid=1488 comm="/usr/libexec/bluetooth/bluetoothd")
Jun 05 15:54:32 debian dbus-daemon[1491]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.80" (uid=1000 pid=2869 comm="/usr/bin/wireplumber") interface="(unset)" member="(unset)" error name="org.bluez.MediaEndpoint1.Error.NotImplemented" requested_reply="0" destination=":1.3" (uid=0 pid=1488 comm="/usr/libexec/bluetooth/bluetoothd")
Jun 05 15:54:32 debian dbus-daemon[1491]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.80" (uid=1000 pid=2869 comm="/usr/bin/wireplumber") interface="(unset)" member="(unset)" error name="org.bluez.MediaEndpoint1.Error.NotImplemented" requested_reply="0" destination=":1.3" (uid=0 pid=1488 comm="/usr/libexec/bluetooth/bluetoothd")
Jun 05 15:54:32 debian dbus-daemon[1491]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.80" (uid=1000 pid=2869 comm="/usr/bin/wireplumber") interface="(unset)" member="(unset)" error name="org.bluez.MediaEndpoint1.Error.NotImplemented" requested_reply="0" destination=":1.3" (uid=0 pid=1488 comm="/usr/libexec/bluetooth/bluetoothd")
Jun 05 15:54:32 debian dbus-daemon[1491]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.80" (uid=1000 pid=2869 comm="/usr/bin/wireplumber") interface="(unset)" member="(unset)" error name="org.bluez.MediaEndpoint1.Error.NotImplemented" requested_reply="0" destination=":1.3" (uid=0 pid=1488 comm="/usr/libexec/bluetooth/bluetoothd")
Jun 05 15:54:32 debian dbus-daemon[1491]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.80" (uid=1000 pid=2869 comm="/usr/bin/wireplumber") interface="(unset)" member="(unset)" error name="org.bluez.MediaEndpoint1.Error.NotImplemented" requested_reply="0" destination=":1.3" (uid=0 pid=1488 comm="/usr/libexec/bluetooth/bluetoothd")
Jun 05 15:54:32 debian dbus-daemon[1491]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.80" (uid=1000 pid=2869 comm="/usr/bin/wireplumber") interface="(unset)" member="(unset)" error name="org.bluez.MediaEndpoint1.Error.NotImplemented" requested_reply="0" destination=":1.3" (uid=0 pid=1488 comm="/usr/libexec/bluetooth/bluetoothd")
Jun 05 15:54:32 debian dbus-daemon[1491]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.80" (uid=1000 pid=2869 comm="/usr/bin/wireplumber") interface="(unset)" member="(unset)" error name="org.bluez.MediaEndpoint1.Error.NotImplemented" requested_reply="0" destination=":1.3" (uid=0 pid=1488 comm="/usr/libexec/bluetooth/bluetoothd")
Jun 05 15:54:32 debian dbus-daemon[1491]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.80" (uid=1000 pid=2869 comm="/usr/bin/wireplumber") interface="(unset)" member="(unset)" error name="org.bluez.MediaEndpoint1.Error.NotImplemented" requested_reply="0" destination=":1.3" (uid=0 pid=1488 comm="/usr/libexec/bluetooth/bluetoothd")
Jun 05 15:54:32 debian dbus-daemon[1491]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.80" (uid=1000 pid=2869 comm="/usr/bin/wireplumber") interface="(unset)" member="(unset)" error name="org.bluez.MediaEndpoint1.Error.NotImplemented" requested_reply="0" destination=":1.3" (uid=0 pid=1488 comm="/usr/libexec/bluetooth/bluetoothd")
Jun 05 15:54:32 debian dbus-daemon[1491]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.80" (uid=1000 pid=2869 comm="/usr/bin/wireplumber") interface="(unset)" member="(unset)" error name="org.bluez.MediaEndpoint1.Error.NotImplemented" requested_reply="0" destination=":1.3" (uid=0 pid=1488 comm="/usr/libexec/bluetooth/bluetoothd")
Jun 05 15:54:32 debian dbus-daemon[1491]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.80" (uid=1000 pid=2869 comm="/usr/bin/wireplumber") interface="(unset)" member="(unset)" error name="org.bluez.MediaEndpoint1.Error.NotImplemented" requested_reply="0" destination=":1.3" (uid=0 pid=1488 comm="/usr/libexec/bluetooth/bluetoothd")
Jun 05 15:54:32 debian dbus-daemon[1491]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.80" (uid=1000 pid=2869 comm="/usr/bin/wireplumber") interface="(unset)" member="(unset)" error name="org.bluez.MediaEndpoint1.Error.NotImplemented" requested_reply="0" destination=":1.3" (uid=0 pid=1488 comm="/usr/libexec/bluetooth/bluetoothd")
Jun 05 15:54:32 debian dbus-daemon[1491]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.80" (uid=1000 pid=2869 comm="/usr/bin/wireplumber") interface="(unset)" member="(unset)" error name="org.bluez.MediaEndpoint1.Error.NotImplemented" requested_reply="0" destination=":1.3" (uid=0 pid=1488 comm="/usr/libexec/bluetooth/bluetoothd")
Jun 05 15:54:32 debian dbus-daemon[1491]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.80" (uid=1000 pid=2869 comm="/usr/bin/wireplumber") interface="(unset)" member="(unset)" error name="org.bluez.MediaEndpoint1.Error.NotImplemented" requested_reply="0" destination=":1.3" (uid=0 pid=1488 comm="/usr/libexec/bluetooth/bluetoothd")
Jun 05 15:54:32 debian dbus-daemon[1491]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.80" (uid=1000 pid=2869 comm="/usr/bin/wireplumber") interface="(unset)" member="(unset)" error name="org.bluez.MediaEndpoint1.Error.NotImplemented" requested_reply="0" destination=":1.3" (uid=0 pid=1488 comm="/usr/libexec/bluetooth/bluetoothd")
Jun 05 15:54:32 debian dbus-daemon[1491]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.80" (uid=1000 pid=2869 comm="/usr/bin/wireplumber") interface="(unset)" member="(unset)" error name="org.bluez.MediaEndpoint1.Error.NotImplemented" requested_reply="0" destination=":1.3" (uid=0 pid=1488 comm="/usr/libexec/bluetooth/bluetoothd")
Jun 05 15:54:32 debian dbus-daemon[1491]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.80" (uid=1000 pid=2869 comm="/usr/bin/wireplumber") interface="(unset)" member="(unset)" error name="org.bluez.Profile1.Error.NotImplemented" requested_reply="0" destination=":1.3" (uid=0 pid=1488 comm="/usr/libexec/bluetooth/bluetoothd")
Jun 05 15:54:32 debian dbus-daemon[1491]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.80" (uid=1000 pid=2869 comm="/usr/bin/wireplumber") interface="(unset)" member="(unset)" error name="org.bluez.Profile1.Error.NotImplemented" requested_reply="0" destination=":1.3" (uid=0 pid=1488 comm="/usr/libexec/bluetooth/bluetoothd")
Jun 05 15:54:32 debian dbus-daemon[1491]: [system] Rejected send message, 1 matched rules; type="method_call", sender=":1.3" (uid=0 pid=1488 comm="/usr/libexec/bluetooth/bluetoothd") interface="org.bluez.GattProfile1" member="Release" error name="(unset)" requested_reply="0" destination=":1.81" (uid=1000 pid=2869 comm="/usr/bin/wireplumber")
Jun 05 15:54:32 debian dbus-daemon[1491]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.80' (uid=1000 pid=2869 comm="/usr/bin/wireplumber")
Jun 05 15:54:32 debian dbus-daemon[1491]: [system] Activation via systemd failed for unit 'dbus-org.bluez.service': Refusing activation, D-Bus is shutting down.
Jun 05 15:54:32 debian dbus-daemon[1491]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.80' (uid=1000 pid=2869 comm="/usr/bin/wireplumber")
Jun 05 15:54:32 debian dbus-daemon[1491]: [system] Activation via systemd failed for unit 'dbus-org.bluez.service': Refusing activation, D-Bus is shutting down.
Jun 05 15:54:34 debian systemd[2842]: Stopping obex.service - Bluetooth OBEX service...
Jun 05 15:54:34 debian systemd[2842]: Stopping xdg-desktop-portal.service - Portal service...
Jun 05 15:54:34 debian mpris-proxy[2873]: org.bluez appeared
Jun 05 15:54:34 debian mpris-proxy[2873]: Bluetooth Adapter /org/bluez/hci0 found
Jun 05 15:54:34 debian mpris-proxy[2873]: org.bluez.obex appeared
Jun 05 15:54:34 debian mpris-proxy[2873]: Bluetooth Adapter /org/bluez/hci0 removed
Jun 05 15:54:34 debian mpris-proxy[2873]: org.bluez disappeared
Jun 05 15:54:34 debian systemd[2842]: Stopped xdg-desktop-portal.service - Portal service.
Jun 05 15:55:02 debian obexd[3441]: Terminating
Jun 05 15:55:02 debian systemd[2842]: obex.service: Main process exited, code=exited, status=1/FAILURE
Jun 05 15:55:02 debian systemd[2842]: obex.service: Failed with result 'exit-code'.
Jun 05 15:55:02 debian systemd[2842]: Stopped obex.service - Bluetooth OBEX service.