Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: warn: [cd-plugin] cdspeedctl: device or media not ready Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Adding inputs REST Endpoints Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Scanning Audio Inputs Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Checking against Known Cards name Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Checking against Known Cards name Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: [1772054880152] CoreMusicLibrary::Adding element Loopback Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: Cannot find translation for source Randomizer Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: Cannot find translation for source FM/DAB Radio Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: Cannot find translation for source Loopback Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Checking against Known Cards name Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Checking against Known Cards name Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Checking against Known Cards name Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Checking against Known Cards name Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Checking against Known Cards name Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Checking against Known Cards name Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Adding Server instance for streaming Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: error: Hi Res Audio Failed Login: Missing Login Data Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Adding HIGHRESAUDIO REST API Endpoints Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Refreshing TIDAL token Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Refreshing QOBUZ token Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuzconnect Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect Feb 25 22:28:00 hp-800-g1-dm sudo[2175]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 25 22:28:00 hp-800-g1-dm sudo[2175]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: QobuzConnect: Starting Qobuz Connect socket and service Feb 25 22:28:00 hp-800-g1-dm sudo[2182]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 25 22:28:00 hp-800-g1-dm sudo[2182]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:00 hp-800-g1-dm sudo[2175]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections Feb 25 22:28:00 hp-800-g1-dm sudo[2182]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Updating MyVolumio device info Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Updating MyVolumio device info Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: MRS: Getting audio outputs on start Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: MRS: Requesting all other devices output Feb 25 22:28:00 hp-800-g1-dm sudo[2185]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 25 22:28:00 hp-800-g1-dm sudo[2185]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Discovery: Connecting to remote: 192.168.211.1 Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Discovery: Connecting to remote: 169.254.52.164 Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: MRS: Adding multiroomSync output Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Adding audio output: Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: MRS: Pushing multiroomSync output Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::volumioGetState Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CorePlayQueue::getTrack 0 Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 25 22:28:00 hp-800-g1-dm volumio-remote-updater[777]: Test mode enabled Feb 25 22:28:00 hp-800-g1-dm volumio-remote-updater[777]: Alpha mode disabled Feb 25 22:28:00 hp-800-g1-dm volumio-remote-updater[777]: Alpha legacy test mode disabled Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Successfully Added MyVolumio device Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 25 22:28:00 hp-800-g1-dm systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: ------------------------------------ BT MESSAGE: Failed to power on adapter: Feb 25 22:28:00 hp-800-g1-dm sudo[2185]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: MPD Permissions set Feb 25 22:28:00 hp-800-g1-dm sudo[2191]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Feb 25 22:28:00 hp-800-g1-dm sudo[2191]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:00 hp-800-g1-dm systemd[1]: Started volumiobt.service - Volumio Bluetooth Module. Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: error: updateQueue error: null Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 22:28:00 hp-800-g1-dm sudo[2191]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:00 hp-800-g1-dm volumiobt[2201]: INFO [BTSTART] Ensuring Bluetooth directory exists... Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 22:28:00 hp-800-g1-dm sudo[2203]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /var/lib/bluetooth Feb 25 22:28:00 hp-800-g1-dm sudo[2203]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:00 hp-800-g1-dm sudo[2203]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: ------------------------------------ BT MESSAGE: volumiobt.service started successfully Feb 25 22:28:00 hp-800-g1-dm sudo[2212]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: ------------------------------------ BT MESSAGE: [FUNC] dbusStart Feb 25 22:28:00 hp-800-g1-dm sudo[2212]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:00 hp-800-g1-dm sudo[2212]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 25 22:28:00 hp-800-g1-dm volumiobt[2215]: INFO [BTSTART] Powering on Bluetooth if needed... Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Starting Shairport Sync Feb 25 22:28:00 hp-800-g1-dm sudo[2220]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Feb 25 22:28:00 hp-800-g1-dm sudo[2220]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:00 hp-800-g1-dm volumiobt[2222]: No default controller available Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Executing endpoint qc_getconfig Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 25 22:28:00 hp-800-g1-dm sudo[2224]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 25 22:28:00 hp-800-g1-dm sudo[2224]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:00 hp-800-g1-dm systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 25 22:28:00 hp-800-g1-dm systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 25 22:28:00 hp-800-g1-dm qobuz-connect[2188]: 20260225 22:28:00.329 [2188.2188] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: QobuzConnect: QOBUZ Connect daemon connected Feb 25 22:28:00 hp-800-g1-dm systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Feb 25 22:28:00 hp-800-g1-dm sudo[2220]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Remote SSH Started Feb 25 22:28:00 hp-800-g1-dm systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 25 22:28:00 hp-800-g1-dm systemd[1]: shairport-sync.service: Deactivated successfully. Feb 25 22:28:00 hp-800-g1-dm systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 25 22:28:00 hp-800-g1-dm systemd[1]: shairport-sync.service: Consumed 1.606s CPU time. Feb 25 22:28:00 hp-800-g1-dm systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 25 22:28:00 hp-800-g1-dm sudo[2224]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:00 hp-800-g1-dm autossh[2232]: port set to 0, monitoring disabled Feb 25 22:28:00 hp-800-g1-dm autossh[2232]: starting ssh (count 1) Feb 25 22:28:00 hp-800-g1-dm autossh[2232]: ssh child pid is 2236 Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Shairport-Sync Started Feb 25 22:28:00 hp-800-g1-dm qobuz-connect[2188]: 20260225 22:28:00.391 [2188.2188] INFO VolumeManager: [0x5650f3bf0300]: Setting new playback volume: 75 Feb 25 22:28:00 hp-800-g1-dm qobuz-connect[2188]: 20260225 22:28:00.392 [2188.2188] INFO VolumeManager: [0x5650f3bf0300]: Setting new mute state: 0 Feb 25 22:28:00 hp-800-g1-dm qobuz-connect[2188]: 20260225 22:28:00.392 [2188.2188] INFO QobuzConnect: [0x5650f3bf1520]: Client initialized! Feb 25 22:28:00 hp-800-g1-dm qobuz-connect[2188]: 20260225 22:28:00.392 [2188.2188] INFO SampleApp: Starting Avahi advertising, name: HP-800-G1-DM, service name: _qobuz-connect._tcp Feb 25 22:28:00 hp-800-g1-dm qobuz-connect[2188]: 20260225 22:28:00.399 [2188.2188] INFO LocalConfigManager: [0x5650f3bef5f0]: Starting Local Configuration server Feb 25 22:28:00 hp-800-g1-dm qobuz-connect[2188]: 20260225 22:28:00.400 [2188.2188] INFO SampleApp: Starting Local configuration server Feb 25 22:28:00 hp-800-g1-dm qobuz-connect[2188]: 20260225 22:28:00.400 [2188.2188] INFO SampleApp: Connected to UNIX socket client 0x5650f3bc5bb0 Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: Successfully Updated MyVolumio device Feb 25 22:28:00 hp-800-g1-dm qobuz-connect[2188]: 20260225 22:28:00.479 [2188.2188] INFO SampleApp: Playback volume changed: 75 Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::volumioGetState Feb 25 22:28:00 hp-800-g1-dm volumio[1061]: info: CorePlayQueue::getTrack 0 Feb 25 22:28:00 hp-800-g1-dm volumiossh-tunnel[2236]: Warning: Permanently added '[eu9.myvolumio.org]:2222' (RSA) to the list of known hosts. Feb 25 22:28:01 hp-800-g1-dm volumiobt[2254]: INFO [BTSTART] Making Bluetooth discoverable and pairable... Feb 25 22:28:01 hp-800-g1-dm volumiobt[2255]: [83B blob data] Feb 25 22:28:01 hp-800-g1-dm volumiobt[2255]: No default controller available Feb 25 22:28:01 hp-800-g1-dm volumiobt[2255]: [bluetoothctl]> pairable on Feb 25 22:28:01 hp-800-g1-dm volumiobt[2255]: No default controller available Feb 25 22:28:01 hp-800-g1-dm volumiobt[2255]: [113B blob data] Feb 25 22:28:01 hp-800-g1-dm volumiobt[2255]: [bluetoothctl]> Feb 25 22:28:01 hp-800-g1-dm volumiobt[2256]: INFO [BTSTART] Registering Bluetooth agent... Feb 25 22:28:01 hp-800-g1-dm volumiobt[2258]: No agent is registered Feb 25 22:28:01 hp-800-g1-dm volumiobt[2259]: INFO [BTSTART] Agent registered successfully. Feb 25 22:28:01 hp-800-g1-dm volumiobt[2260]: INFO [BTSTART] Starting A2DP agent (a2dp-agent)... Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: 2026-02-25 22:28:01 a2dp-agent [INFO] Connecting to system D-Bus Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: 2026-02-25 22:28:01 a2dp-agent [INFO] Connected to system D-Bus Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: 2026-02-25 22:28:01 a2dp-agent [ERROR] No Bluetooth adapter found: Bluetooth adapter not found Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: 2026-02-25 22:28:01 a2dp-agent [ERROR] Agent crashed: Bluetooth adapter not found Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: Traceback (most recent call last): Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: File "/bin/bt/a2dp-agent", line 225, in main Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: asyncio.run(_run()) Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: File "/usr/lib/python3.11/asyncio/runners.py", line 190, in run Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: return runner.run(main) Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: ^^^^^^^^^^^^^^^^ Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: File "/usr/lib/python3.11/asyncio/runners.py", line 118, in run Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: return self._loop.run_until_complete(task) Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: File "/usr/lib/python3.11/asyncio/base_events.py", line 653, in run_until_complete Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: return future.result() Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: ^^^^^^^^^^^^^^^ Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: File "/bin/bt/a2dp-agent", line 175, in _run Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: adapter_path = await find_adapter(bus) Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: ^^^^^^^^^^^^^^^^^^^^^^^ Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: File "/usr/bin/bt/bluezutils.py", line 73, in find_adapter Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: raise Exception("Bluetooth adapter not found") Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: Exception: Bluetooth adapter not found Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: Traceback (most recent call last): Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: File "/bin/bt/a2dp-agent", line 234, in Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: main() Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: File "/bin/bt/a2dp-agent", line 225, in main Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: asyncio.run(_run()) Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: File "/usr/lib/python3.11/asyncio/runners.py", line 190, in run Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: return runner.run(main) Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: ^^^^^^^^^^^^^^^^ Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: File "/usr/lib/python3.11/asyncio/runners.py", line 118, in run Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: return self._loop.run_until_complete(task) Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: File "/usr/lib/python3.11/asyncio/base_events.py", line 653, in run_until_complete Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: return future.result() Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: ^^^^^^^^^^^^^^^ Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: File "/bin/bt/a2dp-agent", line 175, in _run Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: adapter_path = await find_adapter(bus) Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: ^^^^^^^^^^^^^^^^^^^^^^^ Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: File "/usr/bin/bt/bluezutils.py", line 73, in find_adapter Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: raise Exception("Bluetooth adapter not found") Feb 25 22:28:01 hp-800-g1-dm volumiobt[2261]: Exception: Bluetooth adapter not found Feb 25 22:28:01 hp-800-g1-dm systemd[1]: volumiobt.service: Main process exited, code=exited, status=1/FAILURE Feb 25 22:28:01 hp-800-g1-dm systemd[1]: volumiobt.service: Failed with result 'exit-code'. Feb 25 22:28:01 hp-800-g1-dm systemd[1]: volumiobt.service: Scheduled restart job, restart counter is at 1. Feb 25 22:28:01 hp-800-g1-dm systemd[1]: Stopped volumiobt.service - Volumio Bluetooth Module. Feb 25 22:28:01 hp-800-g1-dm systemd[1]: Started volumiobt.service - Volumio Bluetooth Module. Feb 25 22:28:01 hp-800-g1-dm volumiobt[2264]: INFO [BTSTART] Ensuring Bluetooth directory exists... Feb 25 22:28:01 hp-800-g1-dm sudo[2265]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /var/lib/bluetooth Feb 25 22:28:01 hp-800-g1-dm sudo[2265]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:01 hp-800-g1-dm sudo[2265]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:01 hp-800-g1-dm sudo[2267]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth Feb 25 22:28:01 hp-800-g1-dm sudo[2267]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:01 hp-800-g1-dm sudo[2267]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:01 hp-800-g1-dm volumiobt[2269]: INFO [BTSTART] Powering on Bluetooth if needed... Feb 25 22:28:01 hp-800-g1-dm volumiobt[2272]: No default controller available Feb 25 22:28:01 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 25 22:28:01 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 25 22:28:02 hp-800-g1-dm volumio[1061]: info: Executing endpoint metavolumio Feb 25 22:28:02 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 25 22:28:02 hp-800-g1-dm volumio[1061]: info: Executing endpoint metavolumio Feb 25 22:28:02 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 25 22:28:02 hp-800-g1-dm volumio[1061]: info: Executing endpoint metavolumio Feb 25 22:28:02 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 25 22:28:02 hp-800-g1-dm volumio[1061]: info: Discovery: Connecting to remote: 192.168.211.1 Feb 25 22:28:02 hp-800-g1-dm volumiobt[2289]: INFO [BTSTART] Making Bluetooth discoverable and pairable... Feb 25 22:28:02 hp-800-g1-dm volumiobt[2290]: [83B blob data] Feb 25 22:28:02 hp-800-g1-dm volumiobt[2290]: No default controller available Feb 25 22:28:02 hp-800-g1-dm volumiobt[2290]: [bluetoothctl]> pairable on Feb 25 22:28:02 hp-800-g1-dm volumiobt[2290]: No default controller available Feb 25 22:28:02 hp-800-g1-dm volumiobt[2290]: [bluetoothctl]> Feb 25 22:28:02 hp-800-g1-dm volumiobt[2291]: INFO [BTSTART] Registering Bluetooth agent... Feb 25 22:28:02 hp-800-g1-dm volumiobt[2293]: No agent is registered Feb 25 22:28:02 hp-800-g1-dm volumiobt[2294]: INFO [BTSTART] Agent registered successfully. Feb 25 22:28:02 hp-800-g1-dm volumiobt[2295]: INFO [BTSTART] Starting A2DP agent (a2dp-agent)... Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: 2026-02-25 22:28:02 a2dp-agent [INFO] Connecting to system D-Bus Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: 2026-02-25 22:28:02 a2dp-agent [INFO] Connected to system D-Bus Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: 2026-02-25 22:28:02 a2dp-agent [ERROR] No Bluetooth adapter found: Bluetooth adapter not found Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: 2026-02-25 22:28:02 a2dp-agent [ERROR] Agent crashed: Bluetooth adapter not found Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: Traceback (most recent call last): Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: File "/bin/bt/a2dp-agent", line 225, in main Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: asyncio.run(_run()) Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: File "/usr/lib/python3.11/asyncio/runners.py", line 190, in run Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: return runner.run(main) Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: ^^^^^^^^^^^^^^^^ Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: File "/usr/lib/python3.11/asyncio/runners.py", line 118, in run Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: return self._loop.run_until_complete(task) Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: File "/usr/lib/python3.11/asyncio/base_events.py", line 653, in run_until_complete Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: return future.result() Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: ^^^^^^^^^^^^^^^ Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: File "/bin/bt/a2dp-agent", line 175, in _run Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: adapter_path = await find_adapter(bus) Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: ^^^^^^^^^^^^^^^^^^^^^^^ Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: File "/usr/bin/bt/bluezutils.py", line 73, in find_adapter Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: raise Exception("Bluetooth adapter not found") Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: Exception: Bluetooth adapter not found Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: Traceback (most recent call last): Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: File "/bin/bt/a2dp-agent", line 234, in Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: main() Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: File "/bin/bt/a2dp-agent", line 225, in main Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: asyncio.run(_run()) Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: File "/usr/lib/python3.11/asyncio/runners.py", line 190, in run Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: return runner.run(main) Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: ^^^^^^^^^^^^^^^^ Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: File "/usr/lib/python3.11/asyncio/runners.py", line 118, in run Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: return self._loop.run_until_complete(task) Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: File "/usr/lib/python3.11/asyncio/base_events.py", line 653, in run_until_complete Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: return future.result() Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: ^^^^^^^^^^^^^^^ Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: File "/bin/bt/a2dp-agent", line 175, in _run Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: adapter_path = await find_adapter(bus) Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: ^^^^^^^^^^^^^^^^^^^^^^^ Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: File "/usr/bin/bt/bluezutils.py", line 73, in find_adapter Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: raise Exception("Bluetooth adapter not found") Feb 25 22:28:02 hp-800-g1-dm volumiobt[2296]: Exception: Bluetooth adapter not found Feb 25 22:28:02 hp-800-g1-dm systemd[1]: volumiobt.service: Main process exited, code=exited, status=1/FAILURE Feb 25 22:28:02 hp-800-g1-dm systemd[1]: volumiobt.service: Failed with result 'exit-code'. Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: Discovery: Connecting to remote: 169.254.52.164 Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: TidalConnect service stoped! Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 25 22:28:03 hp-800-g1-dm sudo[2306]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 25 22:28:03 hp-800-g1-dm sudo[2306]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:03 hp-800-g1-dm systemd[1]: volumiobt.service: Scheduled restart job, restart counter is at 2. Feb 25 22:28:03 hp-800-g1-dm systemd[1]: Stopped volumiobt.service - Volumio Bluetooth Module. Feb 25 22:28:03 hp-800-g1-dm systemd[1]: Started volumiobt.service - Volumio Bluetooth Module. Feb 25 22:28:03 hp-800-g1-dm systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Feb 25 22:28:03 hp-800-g1-dm sudo[2306]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:03 hp-800-g1-dm volumiobt[2310]: INFO [BTSTART] Ensuring Bluetooth directory exists... Feb 25 22:28:03 hp-800-g1-dm sudo[2311]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /var/lib/bluetooth Feb 25 22:28:03 hp-800-g1-dm sudo[2311]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:03 hp-800-g1-dm sudo[2311]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:03 hp-800-g1-dm sudo[2315]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth Feb 25 22:28:03 hp-800-g1-dm sudo[2315]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:03 hp-800-g1-dm sudo[2315]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:03 hp-800-g1-dm volumiobt[2317]: INFO [BTSTART] Powering on Bluetooth if needed... Feb 25 22:28:03 hp-800-g1-dm volumiobt[2320]: No default controller available Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: Executing endpoint tc_getconfig Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Feb 25 22:28:03 hp-800-g1-dm vtcs[2312]: STARTING TidalConnect services, version: 1.6.1 Feb 25 22:28:03 hp-800-g1-dm vtcs[2312]: STARTED TidalConnect services. Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: Executing endpoint tc_connect Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: Connecting to TidalConnect Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::servicePushState Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: CoreStateMachine::pushState Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: CorePlayQueue::getTrack 0 Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::volumioPushState Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: MRS: Pushing multiroomSync output update for this device Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: MRS: Pushing multiroomSync output Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::volumioGetState Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: CorePlayQueue::getTrack 0 Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: CorePlayQueue::getTrack 0 Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current rtlsdr_radio Received tidalconnect Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::servicePushState Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: CoreStateMachine::pushState Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: CorePlayQueue::getTrack 0 Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::volumioPushState Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: MRS: Pushing multiroomSync output update for this device Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: MRS: Pushing multiroomSync output Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::volumioGetState Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: CorePlayQueue::getTrack 0 Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: CorePlayQueue::getTrack 0 Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current rtlsdr_radio Received tidalconnect Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: SPOTIFY: RECEIVED VOLUMIO VOLUME 52 Feb 25 22:28:03 hp-800-g1-dm volumio[1061]: SPOTIFY: RECEIVED VOLUMIO VOLUME 52 Feb 25 22:28:04 hp-800-g1-dm volumiobt[2337]: INFO [BTSTART] Making Bluetooth discoverable and pairable... Feb 25 22:28:04 hp-800-g1-dm volumiobt[2338]: [83B blob data] Feb 25 22:28:04 hp-800-g1-dm volumiobt[2338]: No default controller available Feb 25 22:28:04 hp-800-g1-dm volumiobt[2338]: [bluetoothctl]> pairable on Feb 25 22:28:04 hp-800-g1-dm volumiobt[2338]: No default controller available Feb 25 22:28:04 hp-800-g1-dm volumiobt[2338]: [113B blob data] Feb 25 22:28:04 hp-800-g1-dm volumiobt[2338]: [bluetoothctl]> Feb 25 22:28:04 hp-800-g1-dm volumiobt[2339]: INFO [BTSTART] Registering Bluetooth agent... Feb 25 22:28:04 hp-800-g1-dm volumiobt[2341]: No agent is registered Feb 25 22:28:04 hp-800-g1-dm volumiobt[2342]: INFO [BTSTART] Agent registered successfully. Feb 25 22:28:04 hp-800-g1-dm volumiobt[2343]: INFO [BTSTART] Starting A2DP agent (a2dp-agent)... Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: 2026-02-25 22:28:04 a2dp-agent [INFO] Connecting to system D-Bus Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: 2026-02-25 22:28:04 a2dp-agent [INFO] Connected to system D-Bus Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: 2026-02-25 22:28:04 a2dp-agent [ERROR] No Bluetooth adapter found: Bluetooth adapter not found Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: 2026-02-25 22:28:04 a2dp-agent [ERROR] Agent crashed: Bluetooth adapter not found Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: Traceback (most recent call last): Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: File "/bin/bt/a2dp-agent", line 225, in main Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: asyncio.run(_run()) Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: File "/usr/lib/python3.11/asyncio/runners.py", line 190, in run Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: return runner.run(main) Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: ^^^^^^^^^^^^^^^^ Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: File "/usr/lib/python3.11/asyncio/runners.py", line 118, in run Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: return self._loop.run_until_complete(task) Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: File "/usr/lib/python3.11/asyncio/base_events.py", line 653, in run_until_complete Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: return future.result() Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: ^^^^^^^^^^^^^^^ Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: File "/bin/bt/a2dp-agent", line 175, in _run Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: adapter_path = await find_adapter(bus) Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: ^^^^^^^^^^^^^^^^^^^^^^^ Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: File "/usr/bin/bt/bluezutils.py", line 73, in find_adapter Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: raise Exception("Bluetooth adapter not found") Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: Exception: Bluetooth adapter not found Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: Traceback (most recent call last): Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: File "/bin/bt/a2dp-agent", line 234, in Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: main() Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: File "/bin/bt/a2dp-agent", line 225, in main Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: asyncio.run(_run()) Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: File "/usr/lib/python3.11/asyncio/runners.py", line 190, in run Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: return runner.run(main) Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: ^^^^^^^^^^^^^^^^ Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: File "/usr/lib/python3.11/asyncio/runners.py", line 118, in run Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: return self._loop.run_until_complete(task) Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: File "/usr/lib/python3.11/asyncio/base_events.py", line 653, in run_until_complete Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: return future.result() Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: ^^^^^^^^^^^^^^^ Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: File "/bin/bt/a2dp-agent", line 175, in _run Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: adapter_path = await find_adapter(bus) Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: ^^^^^^^^^^^^^^^^^^^^^^^ Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: File "/usr/bin/bt/bluezutils.py", line 73, in find_adapter Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: raise Exception("Bluetooth adapter not found") Feb 25 22:28:04 hp-800-g1-dm volumiobt[2344]: Exception: Bluetooth adapter not found Feb 25 22:28:04 hp-800-g1-dm systemd[1]: volumiobt.service: Main process exited, code=exited, status=1/FAILURE Feb 25 22:28:04 hp-800-g1-dm systemd[1]: volumiobt.service: Failed with result 'exit-code'. Feb 25 22:28:04 hp-800-g1-dm systemd[1]: volumiobt.service: Scheduled restart job, restart counter is at 3. Feb 25 22:28:04 hp-800-g1-dm systemd[1]: Stopped volumiobt.service - Volumio Bluetooth Module. Feb 25 22:28:04 hp-800-g1-dm systemd[1]: Started volumiobt.service - Volumio Bluetooth Module. Feb 25 22:28:04 hp-800-g1-dm volumiobt[2346]: INFO [BTSTART] Ensuring Bluetooth directory exists... Feb 25 22:28:04 hp-800-g1-dm sudo[2347]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /var/lib/bluetooth Feb 25 22:28:04 hp-800-g1-dm sudo[2347]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:04 hp-800-g1-dm sudo[2347]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:04 hp-800-g1-dm sudo[2349]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth Feb 25 22:28:04 hp-800-g1-dm sudo[2349]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:04 hp-800-g1-dm sudo[2349]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:04 hp-800-g1-dm volumiobt[2351]: INFO [BTSTART] Powering on Bluetooth if needed... Feb 25 22:28:04 hp-800-g1-dm volumiobt[2354]: No default controller available Feb 25 22:28:05 hp-800-g1-dm systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Feb 25 22:28:05 hp-800-g1-dm volumiobt[2373]: INFO [BTSTART] Making Bluetooth discoverable and pairable... Feb 25 22:28:05 hp-800-g1-dm volumiobt[2374]: [83B blob data] Feb 25 22:28:05 hp-800-g1-dm volumiobt[2374]: No default controller available Feb 25 22:28:05 hp-800-g1-dm volumiobt[2374]: [bluetoothctl]> pairable on Feb 25 22:28:05 hp-800-g1-dm volumiobt[2374]: No default controller available Feb 25 22:28:05 hp-800-g1-dm volumiobt[2374]: [bluetoothctl]> Feb 25 22:28:05 hp-800-g1-dm volumiobt[2375]: INFO [BTSTART] Registering Bluetooth agent... Feb 25 22:28:05 hp-800-g1-dm volumiobt[2377]: No agent is registered Feb 25 22:28:05 hp-800-g1-dm volumiobt[2378]: INFO [BTSTART] Agent registered successfully. Feb 25 22:28:05 hp-800-g1-dm volumiobt[2379]: INFO [BTSTART] Starting A2DP agent (a2dp-agent)... Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: 2026-02-25 22:28:05 a2dp-agent [INFO] Connecting to system D-Bus Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: 2026-02-25 22:28:05 a2dp-agent [INFO] Connected to system D-Bus Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: 2026-02-25 22:28:05 a2dp-agent [ERROR] No Bluetooth adapter found: Bluetooth adapter not found Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: 2026-02-25 22:28:05 a2dp-agent [ERROR] Agent crashed: Bluetooth adapter not found Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: Traceback (most recent call last): Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: File "/bin/bt/a2dp-agent", line 225, in main Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: asyncio.run(_run()) Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: File "/usr/lib/python3.11/asyncio/runners.py", line 190, in run Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: return runner.run(main) Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: ^^^^^^^^^^^^^^^^ Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: File "/usr/lib/python3.11/asyncio/runners.py", line 118, in run Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: return self._loop.run_until_complete(task) Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: File "/usr/lib/python3.11/asyncio/base_events.py", line 653, in run_until_complete Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: return future.result() Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: ^^^^^^^^^^^^^^^ Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: File "/bin/bt/a2dp-agent", line 175, in _run Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: adapter_path = await find_adapter(bus) Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: ^^^^^^^^^^^^^^^^^^^^^^^ Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: File "/usr/bin/bt/bluezutils.py", line 73, in find_adapter Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: raise Exception("Bluetooth adapter not found") Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: Exception: Bluetooth adapter not found Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: Traceback (most recent call last): Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: File "/bin/bt/a2dp-agent", line 234, in Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: main() Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: File "/bin/bt/a2dp-agent", line 225, in main Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: asyncio.run(_run()) Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: File "/usr/lib/python3.11/asyncio/runners.py", line 190, in run Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: return runner.run(main) Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: ^^^^^^^^^^^^^^^^ Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: File "/usr/lib/python3.11/asyncio/runners.py", line 118, in run Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: return self._loop.run_until_complete(task) Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: File "/usr/lib/python3.11/asyncio/base_events.py", line 653, in run_until_complete Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: return future.result() Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: ^^^^^^^^^^^^^^^ Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: File "/bin/bt/a2dp-agent", line 175, in _run Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: adapter_path = await find_adapter(bus) Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: ^^^^^^^^^^^^^^^^^^^^^^^ Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: File "/usr/bin/bt/bluezutils.py", line 73, in find_adapter Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: raise Exception("Bluetooth adapter not found") Feb 25 22:28:05 hp-800-g1-dm volumiobt[2380]: Exception: Bluetooth adapter not found Feb 25 22:28:05 hp-800-g1-dm systemd[1]: volumiobt.service: Main process exited, code=exited, status=1/FAILURE Feb 25 22:28:05 hp-800-g1-dm systemd[1]: volumiobt.service: Failed with result 'exit-code'. Feb 25 22:28:06 hp-800-g1-dm systemd[1]: volumiobt.service: Scheduled restart job, restart counter is at 4. Feb 25 22:28:06 hp-800-g1-dm systemd[1]: Stopped volumiobt.service - Volumio Bluetooth Module. Feb 25 22:28:06 hp-800-g1-dm systemd[1]: Started volumiobt.service - Volumio Bluetooth Module. Feb 25 22:28:06 hp-800-g1-dm volumiobt[2383]: INFO [BTSTART] Ensuring Bluetooth directory exists... Feb 25 22:28:06 hp-800-g1-dm sudo[2384]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /var/lib/bluetooth Feb 25 22:28:06 hp-800-g1-dm sudo[2384]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:06 hp-800-g1-dm sudo[2384]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:06 hp-800-g1-dm sudo[2386]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth Feb 25 22:28:06 hp-800-g1-dm sudo[2386]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:06 hp-800-g1-dm sudo[2386]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:06 hp-800-g1-dm volumiobt[2388]: INFO [BTSTART] Powering on Bluetooth if needed... Feb 25 22:28:06 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 25 22:28:06 hp-800-g1-dm volumio[1061]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 25 22:28:06 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 25 22:28:06 hp-800-g1-dm volumio[1061]: info: Received Get System Version Feb 25 22:28:06 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 25 22:28:06 hp-800-g1-dm volumio[1061]: info: Received Get System Info Feb 25 22:28:06 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 22:28:06 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 22:28:06 hp-800-g1-dm volumio[1061]: info: Discovery: Getting this device information Feb 25 22:28:06 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::volumioGetState Feb 25 22:28:06 hp-800-g1-dm volumio[1061]: info: CorePlayQueue::getTrack 0 Feb 25 22:28:06 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 22:28:06 hp-800-g1-dm volumiobt[2391]: No default controller available Feb 25 22:28:06 hp-800-g1-dm volumio[1061]: info: TidalConnect service started! Feb 25 22:28:06 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 25 22:28:06 hp-800-g1-dm volumio[1061]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 25 22:28:06 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 25 22:28:06 hp-800-g1-dm volumio[1061]: info: Received Get System Version Feb 25 22:28:06 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 25 22:28:06 hp-800-g1-dm volumio[1061]: info: Received Get System Info Feb 25 22:28:06 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 22:28:06 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 22:28:06 hp-800-g1-dm volumio[1061]: info: Discovery: Getting this device information Feb 25 22:28:06 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::volumioGetState Feb 25 22:28:06 hp-800-g1-dm volumio[1061]: info: CorePlayQueue::getTrack 0 Feb 25 22:28:06 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 22:28:07 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 25 22:28:07 hp-800-g1-dm volumiobt[2394]: INFO [BTSTART] Making Bluetooth discoverable and pairable... Feb 25 22:28:07 hp-800-g1-dm volumiobt[2395]: [165B blob data] Feb 25 22:28:07 hp-800-g1-dm volumiobt[2395]: [bluetoothctl]> discoverable on Feb 25 22:28:07 hp-800-g1-dm volumiobt[2395]: No default controller available Feb 25 22:28:07 hp-800-g1-dm volumiobt[2395]: [bluetoothctl]> pairable on Feb 25 22:28:07 hp-800-g1-dm volumiobt[2395]: No default controller available Feb 25 22:28:07 hp-800-g1-dm volumiobt[2395]: [bluetoothctl]> Feb 25 22:28:07 hp-800-g1-dm volumiobt[2396]: INFO [BTSTART] Registering Bluetooth agent... Feb 25 22:28:07 hp-800-g1-dm volumiobt[2398]: No agent is registered Feb 25 22:28:07 hp-800-g1-dm volumiobt[2399]: INFO [BTSTART] Agent registered successfully. Feb 25 22:28:07 hp-800-g1-dm volumiobt[2400]: INFO [BTSTART] Starting A2DP agent (a2dp-agent)... Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: 2026-02-25 22:28:07 a2dp-agent [INFO] Connecting to system D-Bus Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: 2026-02-25 22:28:07 a2dp-agent [INFO] Connected to system D-Bus Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: 2026-02-25 22:28:07 a2dp-agent [ERROR] No Bluetooth adapter found: Bluetooth adapter not found Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: 2026-02-25 22:28:07 a2dp-agent [ERROR] Agent crashed: Bluetooth adapter not found Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: Traceback (most recent call last): Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: File "/bin/bt/a2dp-agent", line 225, in main Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: asyncio.run(_run()) Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: File "/usr/lib/python3.11/asyncio/runners.py", line 190, in run Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: return runner.run(main) Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: ^^^^^^^^^^^^^^^^ Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: File "/usr/lib/python3.11/asyncio/runners.py", line 118, in run Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: return self._loop.run_until_complete(task) Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: File "/usr/lib/python3.11/asyncio/base_events.py", line 653, in run_until_complete Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: return future.result() Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: ^^^^^^^^^^^^^^^ Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: File "/bin/bt/a2dp-agent", line 175, in _run Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: adapter_path = await find_adapter(bus) Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: ^^^^^^^^^^^^^^^^^^^^^^^ Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: File "/usr/bin/bt/bluezutils.py", line 73, in find_adapter Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: raise Exception("Bluetooth adapter not found") Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: Exception: Bluetooth adapter not found Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: Traceback (most recent call last): Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: File "/bin/bt/a2dp-agent", line 234, in Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: main() Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: File "/bin/bt/a2dp-agent", line 225, in main Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: asyncio.run(_run()) Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: File "/usr/lib/python3.11/asyncio/runners.py", line 190, in run Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: return runner.run(main) Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: ^^^^^^^^^^^^^^^^ Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: File "/usr/lib/python3.11/asyncio/runners.py", line 118, in run Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: return self._loop.run_until_complete(task) Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: File "/usr/lib/python3.11/asyncio/base_events.py", line 653, in run_until_complete Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: return future.result() Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: ^^^^^^^^^^^^^^^ Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: File "/bin/bt/a2dp-agent", line 175, in _run Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: adapter_path = await find_adapter(bus) Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: ^^^^^^^^^^^^^^^^^^^^^^^ Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: File "/usr/bin/bt/bluezutils.py", line 73, in find_adapter Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: raise Exception("Bluetooth adapter not found") Feb 25 22:28:07 hp-800-g1-dm volumiobt[2401]: Exception: Bluetooth adapter not found Feb 25 22:28:07 hp-800-g1-dm systemd[1]: volumiobt.service: Main process exited, code=exited, status=1/FAILURE Feb 25 22:28:07 hp-800-g1-dm systemd[1]: volumiobt.service: Failed with result 'exit-code'. Feb 25 22:28:07 hp-800-g1-dm systemd[1]: volumiobt.service: Scheduled restart job, restart counter is at 5. Feb 25 22:28:07 hp-800-g1-dm systemd[1]: Stopped volumiobt.service - Volumio Bluetooth Module. Feb 25 22:28:07 hp-800-g1-dm systemd[1]: volumiobt.service: Start request repeated too quickly. Feb 25 22:28:07 hp-800-g1-dm systemd[1]: volumiobt.service: Failed with result 'exit-code'. Feb 25 22:28:07 hp-800-g1-dm systemd[1]: Failed to start volumiobt.service - Volumio Bluetooth Module. Feb 25 22:28:07 hp-800-g1-dm systemd[1]: setdatetime-helper.service: Deactivated successfully. Feb 25 22:28:07 hp-800-g1-dm systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: Starting Uninstall of plugin music_service - rtlsdr_radio Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: Uninstalling plugin rtlsdr_radio Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: [RTL-SDR Radio] onStop - force terminating all processes Feb 25 22:28:08 hp-800-g1-dm sudo[2414]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/pkill -9 -f fn-rtl_fm Feb 25 22:28:08 hp-800-g1-dm sudo[2414]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: [RTL-SDR Radio] onStop - processes terminated Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesFM/DAB Radio Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: Cannot find translation for source Randomizer Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: Cannot find translation for source Loopback Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: [RTL-SDR Radio] Management server stopped Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: [RTL-SDR Radio] Plugin stopped Feb 25 22:28:08 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:28:08.040+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: Disabling plugin rtlsdr_radio Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: Preparing to generate the ALSA configuration file Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: Reading ALSA contributions from plugins. Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: Asound.conf file unchanged, so no further update is needed Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: Output device has changed, restarting MPD Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: Output device has changed, restarting Shairport Sync Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 22:28:08 hp-800-g1-dm sudo[2417]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 25 22:28:08 hp-800-g1-dm sudo[2417]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:08 hp-800-g1-dm sudo[2417]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:08 hp-800-g1-dm sudo[2420]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 25 22:28:08 hp-800-g1-dm sudo[2420]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: QobuzConnect: setDeactiveState invoked Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::volumioGetState Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CorePlayQueue::getTrack 0 Feb 25 22:28:08 hp-800-g1-dm systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 25 22:28:08 hp-800-g1-dm vtcs[2312]: [2026-02-25 22:28:08.066] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected Feb 25 22:28:08 hp-800-g1-dm vtcs[2312]: [2026-02-25 22:28:08.066] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Feb 25 22:28:08 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:28:08.072+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: Checking if uninstall.sh is present Feb 25 22:28:08 hp-800-g1-dm sudo[2429]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 25 22:28:08 hp-800-g1-dm sudo[2429]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:08 hp-800-g1-dm sudo[2432]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 25 22:28:08 hp-800-g1-dm sudo[2432]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 22:28:08 hp-800-g1-dm systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Feb 25 22:28:08 hp-800-g1-dm systemd[1]: vtcs.service: Deactivated successfully. Feb 25 22:28:08 hp-800-g1-dm systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: Executing uninstall.sh Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: MPD Permissions set Feb 25 22:28:08 hp-800-g1-dm sudo[2429]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:08 hp-800-g1-dm sudo[2439]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 25 22:28:08 hp-800-g1-dm sudo[2439]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 25 22:28:08 hp-800-g1-dm sudo[2432]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:08 hp-800-g1-dm systemd[1]: mpd.service: Deactivated successfully. Feb 25 22:28:08 hp-800-g1-dm systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 25 22:28:08 hp-800-g1-dm systemd[1]: mpd.socket: Deactivated successfully. Feb 25 22:28:08 hp-800-g1-dm systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 25 22:28:08 hp-800-g1-dm systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 25 22:28:08 hp-800-g1-dm sudo[2439]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 22:28:08 hp-800-g1-dm sudo[2456]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 25 22:28:08 hp-800-g1-dm sudo[2456]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:08 hp-800-g1-dm sudo[2443]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/music_service/rtlsdr_radio/uninstall.sh Feb 25 22:28:08 hp-800-g1-dm sudo[2443]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: Starting Shairport Sync Feb 25 22:28:08 hp-800-g1-dm sudo[2461]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 25 22:28:08 hp-800-g1-dm sudo[2461]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:08 hp-800-g1-dm systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 25 22:28:08 hp-800-g1-dm systemd[1]: Starting mpd.service - Music Player Daemon... Feb 25 22:28:08 hp-800-g1-dm systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Feb 25 22:28:08 hp-800-g1-dm qobuz-connect[2188]: 20260225 22:28:08.153 [2188.2188] INFO SampleApp: Stopping Local configuration server Feb 25 22:28:08 hp-800-g1-dm systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 25 22:28:08 hp-800-g1-dm systemd[1]: shairport-sync.service: Deactivated successfully. Feb 25 22:28:08 hp-800-g1-dm systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 25 22:28:08 hp-800-g1-dm systemd[1]: shairport-sync.service: Consumed 1.555s CPU time. Feb 25 22:28:08 hp-800-g1-dm systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 25 22:28:08 hp-800-g1-dm sudo[2461]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: Shairport-Sync Started Feb 25 22:28:08 hp-800-g1-dm sudo[2463]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 25 22:28:08 hp-800-g1-dm sudo[2463]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 25 22:28:08 hp-800-g1-dm sudo[2463]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 26 Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: Access Token successfully retrieved Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: [1772054888328] CoreMusicLibrary::Adding element QOBUZ Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: Cannot find translation for source Randomizer Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: Cannot find translation for source Loopback Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: Cannot find translation for source QOBUZ Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: Stopping AccessToken refresher cron for QOBUZ Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: AccessToken refresher cron started for QOBUZ Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: Adding QOBUZ REST API Endpoints Feb 25 22:28:08 hp-800-g1-dm qobuz-connect[2188]: 20260225 22:28:08.408 [2188.2188] INFO SampleApp: shat down connection on UNIX socket Feb 25 22:28:08 hp-800-g1-dm systemd[1]: qobuz-connect.service: Deactivated successfully. Feb 25 22:28:08 hp-800-g1-dm systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 27 Feb 25 22:28:08 hp-800-g1-dm systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Feb 25 22:28:08 hp-800-g1-dm sudo[2456]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: QobuzConnect: setDeactiveState invoked Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::volumioGetState Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CorePlayQueue::getTrack 0 Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: Executing endpoint qc_getconfig Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Feb 25 22:28:08 hp-800-g1-dm qobuz-connect[2499]: 20260225 22:28:08.525 [2499.2499] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Feb 25 22:28:08 hp-800-g1-dm qobuz-connect[2499]: 20260225 22:28:08.527 [2499.2499] INFO VolumeManager: [0x561dd5fe3300]: Setting new playback volume: 75 Feb 25 22:28:08 hp-800-g1-dm qobuz-connect[2499]: 20260225 22:28:08.527 [2499.2499] INFO VolumeManager: [0x561dd5fe3300]: Setting new mute state: 0 Feb 25 22:28:08 hp-800-g1-dm qobuz-connect[2499]: 20260225 22:28:08.527 [2499.2499] INFO QobuzConnect: [0x561dd5fe4520]: Client initialized! Feb 25 22:28:08 hp-800-g1-dm qobuz-connect[2499]: 20260225 22:28:08.527 [2499.2499] INFO SampleApp: Starting Avahi advertising, name: HP-800-G1-DM, service name: _qobuz-connect._tcp Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: QobuzConnect: QOBUZ Connect daemon connected Feb 25 22:28:08 hp-800-g1-dm qobuz-connect[2499]: 20260225 22:28:08.531 [2499.2499] INFO LocalConfigManager: [0x561dd5fe25f0]: Starting Local Configuration server Feb 25 22:28:08 hp-800-g1-dm qobuz-connect[2499]: 20260225 22:28:08.531 [2499.2499] INFO SampleApp: Starting Local configuration server Feb 25 22:28:08 hp-800-g1-dm qobuz-connect[2499]: 20260225 22:28:08.531 [2499.2499] INFO SampleApp: Connected to UNIX socket client 0x561dd5fb8bb0 Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::volumioGetState Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CorePlayQueue::getTrack 0 Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: Successfully Updated MyVolumio device Feb 25 22:28:08 hp-800-g1-dm mpd[2481]: 2026-02-25T22:28:08 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.5CvWEqrMC5R8R7GzBFAP50Q8G0t1.028f5adc9ad74c71eb876b0fa4e2bd26.state.track' Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::volumioGetState Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CorePlayQueue::getTrack 0 Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: Access Token successfully retrieved Feb 25 22:28:08 hp-800-g1-dm qobuz-connect[2499]: 20260225 22:28:08.675 [2499.2499] INFO SampleApp: Playback volume changed: 75 Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::volumioGetState Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: CorePlayQueue::getTrack 0 Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: info: Successfully retrieved User Session From TIDAL Feb 25 22:28:08 hp-800-g1-dm systemd[1]: Started mpd.service - Music Player Daemon. Feb 25 22:28:08 hp-800-g1-dm sudo[2420]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:08 hp-800-g1-dm volumio[1061]: error: updateQueue error: null Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: info: Successfully retrieved User Subscription From TIDAL Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: info: Adding TIDAL to Browse Sources Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: info: [1772054889186] CoreMusicLibrary::Adding element TIDAL Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: Cannot find translation for source Randomizer Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: Cannot find translation for source Loopback Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: Cannot find translation for source QOBUZ Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: Cannot find translation for source TIDAL Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: info: Adding TIDAL REST API Endpoints Feb 25 22:28:09 hp-800-g1-dm sudo[2443]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: info: Uninstall script completed Feb 25 22:28:09 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:28:09.722+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: info: Removing plugin rtlsdr_radio from configuration Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: info: Successfully removed rtlsdr_radio configuration files Feb 25 22:28:09 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:28:09.758+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:28:09 hp-800-g1-dm systemd-logind[770]: Watching system buttons on /dev/input/event1 (Power Button) Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: info: Plugin folders cleanup Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: info: Scanning into folder /volumio/app/plugins/ Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: info: Scanning category audio_interface Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: info: Scanning category miscellanea Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: info: Scanning category music_service Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: info: Scanning category plugins.json Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: info: Scanning category system_controller Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: info: Scanning category user_interface Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: info: Scanning into folder /data/plugins/ Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: info: Scanning category music_service Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: info: Cleaning folder for rtlsdr_radio Feb 25 22:28:09 hp-800-g1-dm systemd-logind[770]: Watching system buttons on /dev/input/event0 (Power Button) Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: info: Scanning category user_interface Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: info: Plugin folders cleanup completed Feb 25 22:28:09 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:28:09.974+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: info: [{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.3.0","icon":"fa-spotify","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"System information","name":"Systeminfo","category":"user_interface","version":"3.0.15","icon":"fa-info-circle","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Randomizer","name":"randomizer","category":"user_interface","version":"4.1.2","icon":"fa-random","isManuallyInstalled":false,"enabled":true,"active":true}] Feb 25 22:28:09 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: TidalConnect service stoped! Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: TidalConnect service stoped! Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 25 22:28:11 hp-800-g1-dm sudo[2600]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 25 22:28:11 hp-800-g1-dm sudo[2600]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:11 hp-800-g1-dm systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Feb 25 22:28:11 hp-800-g1-dm sudo[2600]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: Executing endpoint tc_getconfig Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Feb 25 22:28:11 hp-800-g1-dm vtcs[2603]: STARTING TidalConnect services, version: 1.6.1 Feb 25 22:28:11 hp-800-g1-dm vtcs[2603]: STARTED TidalConnect services. Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: Executing endpoint tc_connect Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: Connecting to TidalConnect Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::servicePushState Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: CoreStateMachine::pushState Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: CorePlayQueue::getTrack 0 Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::volumioPushState Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: MRS: Pushing multiroomSync output update for this device Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: MRS: Pushing multiroomSync output Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::volumioGetState Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: CorePlayQueue::getTrack 0 Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: CorePlayQueue::getTrack 0 Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current rtlsdr_radio Received tidalconnect Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::servicePushState Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: CoreStateMachine::pushState Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: CorePlayQueue::getTrack 0 Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::volumioPushState Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: MRS: Pushing multiroomSync output update for this device Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: MRS: Pushing multiroomSync output Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::volumioGetState Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: CorePlayQueue::getTrack 0 Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: CorePlayQueue::getTrack 0 Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current rtlsdr_radio Received tidalconnect Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: SPOTIFY: RECEIVED VOLUMIO VOLUME 52 Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: SPOTIFY: RECEIVED VOLUMIO VOLUME 52 Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.5CvWEqrMC5R8R7GzBFAP50Q8G0t1.028f5adc9ad74c71eb876b0fa4e2bd26.state.track' Feb 25 22:28:11 hp-800-g1-dm volumio[1061]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.5CvWEqrMC5R8R7GzBFAP50Q8G0t1.028f5adc9ad74c71eb876b0fa4e2bd26.state.track' Feb 25 22:28:12 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 22:28:12 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 22:28:12 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Feb 25 22:28:12 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 25 22:28:12 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 25 22:28:12 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::volumioGetBrowseSources Feb 25 22:28:12 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 25 22:28:14 hp-800-g1-dm volumio[1061]: info: TidalConnect service started! Feb 25 22:28:15 hp-800-g1-dm volumio[1061]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/80s80s/volumio/bookworm/amd64 Feb 25 22:28:15 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:28:15.921+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:28:17 hp-800-g1-dm volumio[1061]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/80s80s/volumio/bookworm/amd64 Feb 25 22:28:17 hp-800-g1-dm volumio[1061]: info: Folder /tmp/plugins removed Feb 25 22:28:17 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:28:17.469+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:28:17 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:28:17.525+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:28:17 hp-800-g1-dm volumio[1061]: info: Check plugin dependencies Feb 25 22:28:17 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 25 22:28:17 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:28:17.543+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:28:17 hp-800-g1-dm volumio[1061]: info: Checking if plugin already exists Feb 25 22:28:17 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:28:17.545+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:28:17 hp-800-g1-dm volumio[1061]: info: Rename folder Feb 25 22:28:17 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:28:17.552+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:28:17 hp-800-g1-dm volumio[1061]: info: Move to category Feb 25 22:28:17 hp-800-g1-dm volumio[1061]: info: Folder /tmp/downloaded_plugin.zip removed Feb 25 22:28:17 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:28:17.632+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:28:17 hp-800-g1-dm volumio[1061]: info: Checking if install.sh is present Feb 25 22:28:17 hp-800-g1-dm volumio[1061]: info: Executing install.sh Feb 25 22:28:17 hp-800-g1-dm sudo[2657]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/music_service/80s80s/install.sh Feb 25 22:28:17 hp-800-g1-dm sudo[2657]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:17 hp-800-g1-dm sudo[2657]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:17 hp-800-g1-dm volumio[1061]: info: Installing 80s80s radio Dependencies Feb 25 22:28:17 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:28:17.653+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:28:17 hp-800-g1-dm volumio[1061]: Plugin install end detected on script Feb 25 22:28:17 hp-800-g1-dm volumio[1061]: info: Install script completed Feb 25 22:28:17 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:28:17.658+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:28:17 hp-800-g1-dm volumio[1061]: info: Adding reference to registry Feb 25 22:28:17 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:28:17.661+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:28:17 hp-800-g1-dm volumio[1061]: info: Done installing plugin. Feb 25 22:28:17 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 25 22:28:17 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 25 22:28:17 hp-800-g1-dm volumio[1061]: info: Folder /tmp/plugins removed Feb 25 22:28:17 hp-800-g1-dm volumio[1061]: info: Folder /tmp/downloaded_plugin.zip removed Feb 25 22:28:17 hp-800-g1-dm volumio[1061]: info: Folder /data/temp removed Feb 25 22:28:18 hp-800-g1-dm volumio[1061]: info: Enabling plugin 80s80s Feb 25 22:28:18 hp-800-g1-dm volumio[1061]: info: Loading plugin "80s80s"... Feb 25 22:28:18 hp-800-g1-dm volumio[1061]: info: [1772054898950] [80s80s] API delay: 30 Feb 25 22:28:18 hp-800-g1-dm volumio[1061]: info: PLUGIN START: 80s80s Feb 25 22:28:18 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 25 22:28:18 hp-800-g1-dm volumio[1061]: info: [1772054898952] CoreMusicLibrary::Adding element 80s80s Radio Feb 25 22:28:18 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 22:28:18 hp-800-g1-dm volumio[1061]: Cannot find translation for source Randomizer Feb 25 22:28:18 hp-800-g1-dm volumio[1061]: Cannot find translation for source Loopback Feb 25 22:28:18 hp-800-g1-dm volumio[1061]: Cannot find translation for source QOBUZ Feb 25 22:28:18 hp-800-g1-dm volumio[1061]: Cannot find translation for source TIDAL Feb 25 22:28:18 hp-800-g1-dm volumio[1061]: Cannot find translation for source 80s80s Radio Feb 25 22:28:18 hp-800-g1-dm volumio[1061]: info: Done. Feb 25 22:28:35 hp-800-g1-dm volumio[1061]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/radio_paradise/volumio/bookworm/amd64 Feb 25 22:28:35 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:28:35.378+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:28:37 hp-800-g1-dm volumio[1061]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/radio_paradise/volumio/bookworm/amd64 Feb 25 22:28:37 hp-800-g1-dm volumio[1061]: info: Folder /tmp/plugins removed Feb 25 22:28:37 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:28:37.007+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:28:37 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:28:37.030+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:28:37 hp-800-g1-dm volumio[1061]: info: Check plugin dependencies Feb 25 22:28:37 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 25 22:28:37 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:28:37.039+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:28:37 hp-800-g1-dm volumio[1061]: info: Checking if plugin already exists Feb 25 22:28:37 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:28:37.039+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:28:37 hp-800-g1-dm volumio[1061]: info: Rename folder Feb 25 22:28:37 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:28:37.047+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:28:37 hp-800-g1-dm volumio[1061]: info: Move to category Feb 25 22:28:37 hp-800-g1-dm volumio[1061]: info: Folder /tmp/downloaded_plugin.zip removed Feb 25 22:28:37 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:28:37.532+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:28:37 hp-800-g1-dm volumio[1061]: info: Checking if install.sh is present Feb 25 22:28:37 hp-800-g1-dm volumio[1061]: info: Executing install.sh Feb 25 22:28:37 hp-800-g1-dm sudo[2765]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/music_service/radio_paradise/install.sh Feb 25 22:28:37 hp-800-g1-dm sudo[2765]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:28:37 hp-800-g1-dm sudo[2765]: pam_unix(sudo:session): session closed for user root Feb 25 22:28:37 hp-800-g1-dm volumio[1061]: info: Installing radio paradise Dependencies Feb 25 22:28:37 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:28:37.552+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:28:37 hp-800-g1-dm volumio[1061]: Plugin install end detected on script Feb 25 22:28:37 hp-800-g1-dm volumio[1061]: info: Install script completed Feb 25 22:28:37 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:28:37.556+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:28:37 hp-800-g1-dm volumio[1061]: info: Adding reference to registry Feb 25 22:28:37 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:28:37.558+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:28:37 hp-800-g1-dm volumio[1061]: info: Done installing plugin. Feb 25 22:28:37 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 25 22:28:37 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 25 22:28:37 hp-800-g1-dm volumio[1061]: info: Folder /tmp/plugins removed Feb 25 22:28:37 hp-800-g1-dm volumio[1061]: info: Folder /tmp/downloaded_plugin.zip removed Feb 25 22:28:37 hp-800-g1-dm volumio[1061]: info: Folder /data/temp removed Feb 25 22:28:40 hp-800-g1-dm volumio[1061]: info: Enabling plugin radio_paradise Feb 25 22:28:40 hp-800-g1-dm volumio[1061]: info: Loading plugin "radio_paradise"... Feb 25 22:28:40 hp-800-g1-dm volumio[1061]: info: [1772054920431] [RadioParadise] API delay: 5 Feb 25 22:28:40 hp-800-g1-dm volumio[1061]: info: PLUGIN START: radio_paradise Feb 25 22:28:40 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 25 22:28:40 hp-800-g1-dm volumio[1061]: info: [1772054920432] CoreMusicLibrary::Adding element Radio Paradise Feb 25 22:28:40 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 22:28:40 hp-800-g1-dm volumio[1061]: Cannot find translation for source Randomizer Feb 25 22:28:40 hp-800-g1-dm volumio[1061]: Cannot find translation for source Loopback Feb 25 22:28:40 hp-800-g1-dm volumio[1061]: Cannot find translation for source QOBUZ Feb 25 22:28:40 hp-800-g1-dm volumio[1061]: Cannot find translation for source TIDAL Feb 25 22:28:40 hp-800-g1-dm volumio[1061]: Cannot find translation for source 80s80s Radio Feb 25 22:28:40 hp-800-g1-dm volumio[1061]: Cannot find translation for source Radio Paradise Feb 25 22:28:40 hp-800-g1-dm volumio[1061]: info: Done. Feb 25 22:28:54 hp-800-g1-dm volumio[1061]: info: MRS: Updating multiroomSync output Feb 25 22:28:56 hp-800-g1-dm volumio[1061]: info: MRS: Updating multiroomSync output Feb 25 22:28:56 hp-800-g1-dm volumio[1061]: info: MRS: Updating multiroomSync output Feb 25 22:29:00 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 25 22:29:14 hp-800-g1-dm volumio[1061]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/download/spop/4.4.0/volumio/bookworm/amd64 Feb 25 22:29:14 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:29:14.595+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:29:16 hp-800-g1-dm volumio[1061]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/download/spop/4.4.0/volumio/bookworm/amd64 Feb 25 22:29:16 hp-800-g1-dm volumio[1061]: info: Folder /tmp/plugins removed Feb 25 22:29:16 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:29:16.156+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:29:16 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:29:16.279+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:29:16 hp-800-g1-dm volumio[1061]: info: Check plugin dependencies Feb 25 22:29:16 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 25 22:29:16 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:29:16.291+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:29:16 hp-800-g1-dm volumio[1061]: info: Checking if plugin already exists Feb 25 22:29:16 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:29:16.294+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:29:16 hp-800-g1-dm volumio[1061]: info: An error occurred installing the plugin. Rolling back config Feb 25 22:29:16 hp-800-g1-dm volumio[1061]: info: Plugin folders cleanup Feb 25 22:29:16 hp-800-g1-dm volumio[1061]: info: Scanning into folder /volumio/app/plugins/ Feb 25 22:29:16 hp-800-g1-dm volumio[1061]: info: Scanning category audio_interface Feb 25 22:29:16 hp-800-g1-dm volumio[1061]: info: Scanning category miscellanea Feb 25 22:29:16 hp-800-g1-dm volumio[1061]: info: Scanning category music_service Feb 25 22:29:16 hp-800-g1-dm volumio[1061]: info: Scanning category plugins.json Feb 25 22:29:16 hp-800-g1-dm volumio[1061]: info: Scanning category system_controller Feb 25 22:29:16 hp-800-g1-dm volumio[1061]: info: Scanning category user_interface Feb 25 22:29:16 hp-800-g1-dm volumio[1061]: info: Scanning into folder /data/plugins/ Feb 25 22:29:16 hp-800-g1-dm volumio[1061]: info: Scanning category music_service Feb 25 22:29:16 hp-800-g1-dm volumio[1061]: info: Scanning category user_interface Feb 25 22:29:16 hp-800-g1-dm volumio[1061]: info: Plugin folders cleanup completed Feb 25 22:29:16 hp-800-g1-dm volumio[1061]: info: Error: Error Feb 25 22:29:16 hp-800-g1-dm volumio[1061]: info: Folder /tmp/plugins removed Feb 25 22:29:16 hp-800-g1-dm volumio[1061]: info: Folder /tmp/downloaded_plugin.zip removed Feb 25 22:29:16 hp-800-g1-dm volumio[1061]: info: Folder /tmp/downloaded_plugin.zip removed Feb 25 22:29:16 hp-800-g1-dm volumio[1061]: info: Folder /data/temp removed Feb 25 22:29:21 hp-800-g1-dm volumio[1061]: info: Starting Uninstall of plugin music_service - spop Feb 25 22:29:21 hp-800-g1-dm volumio[1061]: info: Uninstalling plugin spop Feb 25 22:29:21 hp-800-g1-dm go-librespot[1918]: time="2026-02-25T22:29:21+01:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF" Feb 25 22:29:21 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify Feb 25 22:29:21 hp-800-g1-dm volumio[1061]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 22:29:21 hp-800-g1-dm volumio[1061]: Cannot find translation for source Randomizer Feb 25 22:29:21 hp-800-g1-dm volumio[1061]: Cannot find translation for source Loopback Feb 25 22:29:21 hp-800-g1-dm volumio[1061]: Cannot find translation for source QOBUZ Feb 25 22:29:21 hp-800-g1-dm volumio[1061]: Cannot find translation for source TIDAL Feb 25 22:29:21 hp-800-g1-dm volumio[1061]: Cannot find translation for source 80s80s Radio Feb 25 22:29:21 hp-800-g1-dm volumio[1061]: Cannot find translation for source Radio Paradise Feb 25 22:29:21 hp-800-g1-dm sudo[2892]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop go-librespot-daemon.service Feb 25 22:29:21 hp-800-g1-dm sudo[2892]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:29:21 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:29:21.032+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:29:21 hp-800-g1-dm volumio[1061]: info: Disabling plugin spop Feb 25 22:29:21 hp-800-g1-dm volumio5-onboarding[1596]: time=2026-02-25T22:29:21.035+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 22:29:21 hp-800-g1-dm volumio[1061]: info: Checking if uninstall.sh is present Feb 25 22:29:21 hp-800-g1-dm systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Feb 25 22:29:21 hp-800-g1-dm volumio[1061]: info: Connection to go-librespot Websocket closed Feb 25 22:29:21 hp-800-g1-dm systemd[1]: go-librespot-daemon.service: Deactivated successfully. Feb 25 22:29:21 hp-800-g1-dm systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 22:29:21 hp-800-g1-dm volumio[1061]: info: Executing uninstall.sh Feb 25 22:29:21 hp-800-g1-dm systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 25 22:29:21 hp-800-g1-dm systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 25 22:29:21 hp-800-g1-dm systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 25 22:29:21 hp-800-g1-dm systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 25 22:29:21 hp-800-g1-dm systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 25 22:29:21 hp-800-g1-dm systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 25 22:29:21 hp-800-g1-dm sudo[2892]: pam_unix(sudo:session): session closed for user root Feb 25 22:29:21 hp-800-g1-dm volumio[1061]: error: Failed to send command to Spotify local API: /player/volume: Error: socket hang up Feb 25 22:29:21 hp-800-g1-dm volumio[1061]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 25 22:29:21 hp-800-g1-dm volumio[1061]: Error: socket hang up Feb 25 22:29:21 hp-800-g1-dm volumio[1061]: at connResetException (node:internal/errors:720:14) Feb 25 22:29:21 hp-800-g1-dm volumio[1061]: at Socket.socketOnEnd (node:_http_client:519:23) Feb 25 22:29:21 hp-800-g1-dm volumio[1061]: at Socket.emit (node:events:526:35) Feb 25 22:29:21 hp-800-g1-dm volumio[1061]: at endReadableNT (node:internal/streams/readable:1376:12) Feb 25 22:29:21 hp-800-g1-dm volumio[1061]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Feb 25 22:29:21 hp-800-g1-dm volumio[1061]: code: 'ECONNRESET', Feb 25 22:29:21 hp-800-g1-dm volumio[1061]: response: undefined Feb 25 22:29:21 hp-800-g1-dm volumio[1061]: } Feb 25 22:29:21 hp-800-g1-dm volumio[1061]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 25 22:29:21 hp-800-g1-dm sudo[2896]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/music_service/spop/uninstall.sh Feb 25 22:29:21 hp-800-g1-dm sudo[2896]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 22:29:21 hp-800-g1-dm sudo[2896]: pam_unix(sudo:session): session closed for user root Feb 25 22:29:21 hp-800-g1-dm sudo[2916]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-25 22:28' Feb 25 22:29:21 hp-800-g1-dm sudo[2916]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="f8b25437696d030ba01136ff33a129a42b97a4aa" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Feb 10 18:22:41 UTC 2026" VOLUMIO_VERSION="4.097" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="d7204c63afb7bf3420048db04b050c1c"