General overview of various issues: Sony WH-1000XM3 and UE Megaboom with Bluetooth
Hi, I don't know if this goes down as a specific bug or general issue across many bugs as the implementation in general across gnome, pulseaudio and bluez/bluetooth is terrible and we need to get some scope on the massive array of bugs related to devices, classic codec's and distro's
The objective should e "work out of the box" and have side implementations to address inconsistencies and specific device support. Also some sort of closed loop feedback system. like if a device can't connect and has errors we send that data to some bluetooth database with log traces which could amount to a massive database of various bluetooth devices and there funny implementations.
anyways here's a every day issue i see what both a MEGABOOM bluetooth speaker and Sony headphones I'll add various issues to this ticket and see where we get.
Here's one to start:
Distro: ArchLinux LTS
pulseaudio --version
pulseaudio 13.0
bluetoothctl --version
bluetoothctl: 5.54
uname -a
Linux md1nkv0c-santis 5.4.32-1-lts #1 SMP Mon, 13 Apr 2020 12:21:10 +0000 x86_64 GNU/Linux
Super frustrating
May 25 10:22:15 bluetoothd[1280]: Unable to get Headset Voice gateway SDP record: Device or resource busy
May 25 10:22:15 bluetoothd[1280]: Unable to get Headset Voice gateway SDP record: Device or resource busy
May 25 10:22:15 bluetoothd[1280]: Unable to get Hands-Free Voice gateway SDP record: Device or resource busy
May 25 10:22:15 bluetoothd[1280]: Unable to get Headset Voice gateway SDP record: Device or resource busy
May 25 10:22:15 bluetoothd[1280]: connect error: Device or resource busy (16)
May 25 10:22:15 bluetoothd[1280]: Unable to get Headset unit SDP record: Device or resource busy
May 25 10:22:21 bluetoothd[1280]: SET_CONFIGURATION request rejected: Stream End Point in Use (19)
May 25 10:22:38 lldpd[1460]: interface 2 does not have a name or an address, skip
May 25 10:22:41 lldpd[1460]: interface 2 does not have a name or an address, skip
May 25 10:22:44 bluetoothd[1280]: Unable to get Headset Voice gateway SDP record: Device or resource busy
May 25 10:22:44 bluetoothd[1280]: Unable to get Headset Voice gateway SDP record: Device or resource busy
May 25 10:22:44 bluetoothd[1280]: Unable to get Hands-Free Voice gateway SDP record: Device or resource busy
May 25 10:22:44 bluetoothd[1280]: Unable to get Headset Voice gateway SDP record: Device or resource busy
May 25 10:22:45 bluetoothd[1280]: connect error: Device or resource busy (16)
May 25 10:22:45 bluetoothd[1280]: Unable to get Headset unit SDP record: Device or resource busy
May 25 10:22:50 lldpd[1460]: interface 2 does not have a name or an address, skip
May 25 10:23:05 systemd[1759]: gnome-shell-x11.service: start operation timed out. Terminating.
May 25 10:23:11 systemd[1759]: gnome-shell-x11.service: State 'stop-sigterm' timed out. Killing.
May 25 10:23:11 systemd[1759]: gnome-shell-x11.service: Killing process 3310747 (gnome-shell) with signal SIGKILL.
May 25 10:23:11 systemd[1759]: gnome-shell-x11.service: Killing process 3310752 (dconf worker) with signal SIGKILL.
May 25 10:23:11 systemd[1759]: gnome-shell-x11.service: Main process exited, code=killed, status=9/KILL
May 25 10:23:11 systemd[1759]: gnome-shell-x11.service: Failed with result 'timeout'.
May 25 10:23:11 systemd[1759]: Failed to start GNOME Shell on X11.
May 25 10:23:11 systemd[1759]: gnome-shell-x11.service: Scheduled restart job, restart counter is at 1529.
May 25 10:23:11 systemd[1759]: Stopped GNOME Shell on X11.
May 25 10:23:11 systemd[1759]: Starting GNOME Shell on X11...
May 25 10:23:16 lldpd[1460]: interface 2 does not have a name or an address, skip
May 25 10:23:26 lldpd[1460]: interface 2 does not have a name or an address, skip
May 25 10:23:40 lldpd[1460]: interface 2 does not have a name or an address, skip
May 25 10:23:51 bluetoothd[1280]: Unable to get Hands-Free Voice gateway SDP record: Device or resource busy
May 25 10:23:51 bluetoothd[1280]: connect error: Device or resource busy (16)
May 25 10:23:51 bluetoothd[1280]: a2dp-source profile connect failed for 88:C6:26:F6:14:2C: Device or resource busy
May 25 10:23:53 bluetoothd[1280]: connect error: Device or resource busy (16)
May 25 10:23:58 bluetoothd[1280]: Unable to get Hands-Free Voice gateway SDP record: Device or resource busy
May 25 10:23:58 bluetoothd[1280]: connect error: Device or resource busy (16)
May 25 10:23:58 bluetoothd[1280]: a2dp-source profile connect failed for 88:C6:26:F6:14:2C: Device or resource busy
May 25 10:24:00 bluetoothd[1280]: connect error: Device or resource busy (16)
May 25 10:24:08 bluetoothd[1280]: Unable to connect Headset Voice gateway: connect: Device or resource busy (16)
May 25 10:24:08 bluetoothd[1280]: Connecting Headset Voice gateway failed: Input/output error
May 25 10:24:08 bluetoothd[1280]: Unable to get connect data for Hands-Free Voice gateway: getpeername: Transport endpoint is not connected (107)
May 25 10:24:08 bluetoothd[1280]: Unable to connect Headset Voice gateway: connect: Device or resource busy (16)
May 25 10:24:08 bluetoothd[1280]: Connecting Headset Voice gateway failed: Input/output error
May 25 10:24:09 bluetoothd[1280]: SET_CONFIGURATION request rejected: Stream End Point in Use (19)
May 25 10:24:09 bluetoothd[1280]: Unable to connect Headset unit: connect: Device or resource busy (16)
May 25 10:24:09 bluetoothd[1280]: Connecting Headset unit failed: Input/output error
May 25 10:24:10 lldpd[1460]: interface 2 does not have a name or an address, skip
May 25 10:24:11 pulseaudio[2918661]: E: [pulseaudio] backend-native.c: connect(): Function not implemented
May 25 10:24:14 lldpd[1460]: interface 2 does not have a name or an address, skip
May 25 10:24:15 pulseaudio[2918661]: W: [pulseaudio] module-bluez5-device.c: Refused to switch profile to a2dp_sink_sbc: Not connected
May 25 10:24:18 lldpd[1460]: interface 2 does not have a name or an address, skip
May 25 10:24:18 pulseaudio[2918661]: W: [pulseaudio] module-bluez5-device.c: Refused to switch profile to a2dp_sink_aptx_hd: Not connected
May 25 10:24:20 gnome-control-c[3310898]: gvc_mixer_stream_get_channel_map: assertion 'GVC_IS_MIXER_STREAM (stream)' failed
May 25 10:24:20 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:20 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:20 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:20 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:20 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:20 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:20 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:20 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:20 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:20 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:20 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:20 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:20 clamd[1282]: Mon May 25 10:24:20 2020 -> SelfCheck: Database status OK.
May 25 10:24:23 gnome-control-c[3310898]: gvc_mixer_stream_get_channel_map: assertion 'GVC_IS_MIXER_STREAM (stream)' failed
May 25 10:24:23 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:23 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:23 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:23 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:23 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:23 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:23 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:23 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:23 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:23 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:23 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:23 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:27 lldpd[1460]: interface 2 does not have a name or an address, skip
May 25 10:24:35 gnome-control-c[3310898]: gvc_mixer_stream_get_channel_map: assertion 'GVC_IS_MIXER_STREAM (stream)' failed
May 25 10:24:35 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:35 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:35 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:35 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:35 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:35 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:35 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:35 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:35 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:35 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:35 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:35 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:24:39 pulseaudio[2918661]: W: [pulseaudio] module-bluez5-device.c: Refused to switch profile to a2dp_sink_ldac: Not connected
May 25 10:24:41 systemd[1759]: gnome-shell-x11.service: start operation timed out. Terminating.
May 25 10:24:42 pulseaudio[2918661]: W: [pulseaudio] module-bluez5-device.c: Refused to switch profile to a2dp_sink_sbc: Not connected
May 25 10:24:45 pulseaudio[2918661]: W: [pulseaudio] module-bluez5-device.c: Refused to switch profile to a2dp_sink_aac: Not connected
May 25 10:24:46 systemd[1759]: gnome-shell-x11.service: State 'stop-sigterm' timed out. Killing.
May 25 10:24:46 systemd[1759]: gnome-shell-x11.service: Killing process 3311396 (gnome-shell) with signal SIGKILL.
May 25 10:24:46 systemd[1759]: gnome-shell-x11.service: Killing process 3311401 (dconf worker) with signal SIGKILL.
May 25 10:24:46 systemd[1759]: gnome-shell-x11.service: Main process exited, code=killed, status=9/KILL
May 25 10:24:46 systemd[1759]: gnome-shell-x11.service: Failed with result 'timeout'.
May 25 10:24:46 systemd[1759]: Failed to start GNOME Shell on X11.
May 25 10:24:46 systemd[1759]: gnome-shell-x11.service: Scheduled restart job, restart counter is at 1530.
May 25 10:24:46 systemd[1759]: Stopped GNOME Shell on X11.
May 25 10:24:46 systemd[1759]: Starting GNOME Shell on X11...
May 25 10:24:47 pulseaudio[2918661]: W: [pulseaudio] module-bluez5-device.c: Refused to switch profile to a2dp_sink_aptx: Not connected
May 25 10:24:50 pulseaudio[2918661]: W: [pulseaudio] module-bluez5-device.c: Refused to switch profile to a2dp_sink_aptx_hd: Not connected
May 25 10:24:50 pulseaudio[2918661]: W: [pulseaudio] module-bluez5-device.c: Refused to switch profile to a2dp_sink_ldac: Not connected
May 25 10:24:50 pulseaudio[2918661]: W: [pulseaudio] module-bluez5-device.c: Refused to switch profile to a2dp_sink_aptx_hd: Not connected
May 25 10:24:50 pulseaudio[2918661]: W: [pulseaudio] module-bluez5-device.c: Refused to switch profile to a2dp_sink_aptx: Not connected
May 25 10:24:50 pulseaudio[2918661]: W: [pulseaudio] module-bluez5-device.c: Refused to switch profile to a2dp_sink_aac: Not connected
May 25 10:24:50 pulseaudio[2918661]: W: [pulseaudio] module-bluez5-device.c: Refused to switch profile to a2dp_sink_sbc: Not connected
May 25 10:24:51 pulseaudio[2918661]: E: [pulseaudio] backend-native.c: connect(): Function not implemented
May 25 10:24:53 lldpd[1460]: interface 2 does not have a name or an address, skip
May 25 10:24:56 pulseaudio[2918661]: W: [pulseaudio] module-bluez5-device.c: Refused to switch profile to a2dp_sink_sbc: Not connected
May 25 10:24:56 pulseaudio[2918661]: W: [pulseaudio] module-bluez5-device.c: Refused to switch profile to a2dp_sink_aac: Not connected
May 25 10:24:57 lldpd[1460]: interface 2 does not have a name or an address, skip
May 25 10:25:02 pulseaudio[2918661]: W: [pulseaudio] module-bluez5-device.c: Refused to switch profile to a2dp_sink_sbc: Not connected
May 25 10:25:04 pulseaudio[2918661]: W: [pulseaudio] module-bluez5-device.c: Refused to switch profile to a2dp_sink_aptx_hd: Not connected
May 25 10:25:05 gnome-control-c[3310898]: gvc_mixer_stream_get_channel_map: assertion 'GVC_IS_MIXER_STREAM (stream)' failed
May 25 10:25:05 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:25:05 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:25:05 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:25:05 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:25:05 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:25:05 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:25:05 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:25:05 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:25:05 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:25:05 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:25:05 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:25:05 gnome-control-c[3310898]: gvc_channel_map_has_position: assertion 'GVC_IS_CHANNEL_MAP (map)' failed
May 25 10:25:05 lldpd[1460]: interface 2 does not have a name or an address, skip