Jan 26 12:29:04 volumiochurch volumio[1269]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Jan 26 12:29:04 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Jan 26 12:29:04 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:29:04 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:29:04 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:29:04 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:29:04 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:29:04 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:29:04 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:29:04 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:29:04 volumiochurch sudo[2377]: volumio : unable to resolve host volumiochurch: System error Jan 26 12:29:04 volumiochurch sudo[2377]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 26 12:29:04 volumiochurch sudo[2377]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 26 12:29:04 volumiochurch sudo[2377]: pam_unix(sudo:session): session closed for user root Jan 26 12:29:04 volumiochurch sudo[2379]: volumio : unable to resolve host volumiochurch: System error Jan 26 12:29:04 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 12:29:04 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:29:04 volumiochurch sudo[2379]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 26 12:29:04 volumiochurch sudo[2379]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 26 12:29:04 volumiochurch volumio[1269]: info: MPD Permissions set Jan 26 12:29:04 volumiochurch systemd[1]: Stopping mpd.service - Music Player Daemon... Jan 26 12:29:04 volumiochurch systemd[1]: mpd.service: Deactivated successfully. Jan 26 12:29:04 volumiochurch systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 26 12:29:04 volumiochurch systemd[1]: mpd.socket: Deactivated successfully. Jan 26 12:29:04 volumiochurch systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 26 12:29:04 volumiochurch systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 26 12:29:04 volumiochurch systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 26 12:29:04 volumiochurch systemd[1]: Starting mpd.service - Music Player Daemon... Jan 26 12:29:04 volumiochurch sudo[2388]: root : unable to resolve host volumiochurch: System error Jan 26 12:29:04 volumiochurch sudo[2388]: sudo: unable to resolve host volumiochurch: System error Jan 26 12:29:04 volumiochurch sudo[2388]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 26 12:29:04 volumiochurch sudo[2388]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 26 12:29:04 volumiochurch sudo[2388]: pam_unix(sudo:session): session closed for user root Jan 26 12:29:05 volumiochurch mpd[2390]: 2026-01-26T12:29:05 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 26 12:29:05 volumiochurch systemd[1]: Started mpd.service - Music Player Daemon. Jan 26 12:29:05 volumiochurch sudo[2379]: pam_unix(sudo:session): session closed for user root Jan 26 12:29:05 volumiochurch volumio[1269]: error: updateQueue error: null Jan 26 12:29:06 volumiochurch systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 19. Jan 26 12:29:06 volumiochurch systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Jan 26 12:29:06 volumiochurch systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Jan 26 12:29:06 volumiochurch upmpdcli[2394]: Could not open config: /tmp/upmpdcli.conf Jan 26 12:29:06 volumiochurch systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Jan 26 12:29:06 volumiochurch systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Jan 26 12:29:21 volumiochurch systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 20. Jan 26 12:29:21 volumiochurch systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Jan 26 12:29:21 volumiochurch systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Jan 26 12:29:21 volumiochurch upmpdcli[2423]: Could not open config: /tmp/upmpdcli.conf Jan 26 12:29:21 volumiochurch systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Jan 26 12:29:21 volumiochurch systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Jan 26 12:29:26 volumiochurch go-librespot[1538]: time="2026-01-26T12:29:26-06:00" level=trace msg="sent dealer ping" Jan 26 12:29:26 volumiochurch go-librespot[1538]: time="2026-01-26T12:29:26-06:00" level=trace msg="received dealer pong" Jan 26 12:29:37 volumiochurch systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 21. Jan 26 12:29:37 volumiochurch systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Jan 26 12:29:37 volumiochurch systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Jan 26 12:29:37 volumiochurch upmpdcli[2440]: Could not open config: /tmp/upmpdcli.conf Jan 26 12:29:37 volumiochurch systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Jan 26 12:29:37 volumiochurch systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Jan 26 12:29:48 volumiochurch volumio[1269]: info: MRS: Updating multiroomSync output Jan 26 12:29:48 volumiochurch volumio[1269]: info: MRS: Updating multiroomSync output Jan 26 12:29:49 volumiochurch volumio[1269]: info: MRS: Updating multiroomSync output Jan 26 12:29:52 volumiochurch systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 22. Jan 26 12:29:52 volumiochurch systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Jan 26 12:29:52 volumiochurch systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Jan 26 12:29:52 volumiochurch upmpdcli[2470]: Could not open config: /tmp/upmpdcli.conf Jan 26 12:29:52 volumiochurch systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Jan 26 12:29:52 volumiochurch systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Jan 26 12:29:56 volumiochurch go-librespot[1538]: time="2026-01-26T12:29:56-06:00" level=trace msg="sent dealer ping" Jan 26 12:29:56 volumiochurch go-librespot[1538]: time="2026-01-26T12:29:56-06:00" level=trace msg="received dealer pong" Jan 26 12:29:58 volumiochurch volumio[1269]: info: MRS: Updating multiroomSync output Jan 26 12:29:58 volumiochurch volumio[1269]: info: MRS: Updating multiroomSync output Jan 26 12:29:58 volumiochurch volumio[1269]: info: MRS: Updating multiroomSync output Jan 26 12:30:05 volumiochurch volumio[1269]: info: CALLMETHOD: audio_interface alsa_controller saveResamplingOpts [object Object] Jan 26 12:30:05 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveResamplingOpts Jan 26 12:30:05 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: mpd , saveResampleOptions Jan 26 12:30:05 volumiochurch sudo[2487]: volumio : unable to resolve host volumiochurch: System error Jan 26 12:30:05 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:30:05 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:30:05 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:30:05 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:30:05 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:30:05 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:30:05 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:30:05 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:30:05 volumiochurch sudo[2489]: volumio : unable to resolve host volumiochurch: System error Jan 26 12:30:05 volumiochurch sudo[2487]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 26 12:30:05 volumiochurch sudo[2487]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 26 12:30:05 volumiochurch sudo[2487]: pam_unix(sudo:session): session closed for user root Jan 26 12:30:05 volumiochurch sudo[2489]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 26 12:30:05 volumiochurch sudo[2489]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 26 12:30:05 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 12:30:05 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:30:05 volumiochurch volumio[1269]: info: MPD Permissions set Jan 26 12:30:05 volumiochurch systemd[1]: Stopping mpd.service - Music Player Daemon... Jan 26 12:30:05 volumiochurch systemd[1]: mpd.service: Deactivated successfully. Jan 26 12:30:05 volumiochurch systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 26 12:30:05 volumiochurch systemd[1]: mpd.socket: Deactivated successfully. Jan 26 12:30:05 volumiochurch systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 26 12:30:05 volumiochurch systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 26 12:30:05 volumiochurch systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 26 12:30:05 volumiochurch systemd[1]: Starting mpd.service - Music Player Daemon... Jan 26 12:30:05 volumiochurch sudo[2500]: root : unable to resolve host volumiochurch: System error Jan 26 12:30:05 volumiochurch sudo[2500]: sudo: unable to resolve host volumiochurch: System error Jan 26 12:30:05 volumiochurch sudo[2500]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 26 12:30:05 volumiochurch sudo[2500]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 26 12:30:05 volumiochurch sudo[2500]: pam_unix(sudo:session): session closed for user root Jan 26 12:30:06 volumiochurch mpd[2502]: 2026-01-26T12:30:06 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 26 12:30:06 volumiochurch systemd[1]: Started mpd.service - Music Player Daemon. Jan 26 12:30:06 volumiochurch sudo[2489]: pam_unix(sudo:session): session closed for user root Jan 26 12:30:06 volumiochurch volumio[1269]: error: updateQueue error: null Jan 26 12:30:07 volumiochurch systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 23. Jan 26 12:30:07 volumiochurch systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Jan 26 12:30:07 volumiochurch systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Jan 26 12:30:07 volumiochurch upmpdcli[2505]: Could not open config: /tmp/upmpdcli.conf Jan 26 12:30:07 volumiochurch systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Jan 26 12:30:07 volumiochurch systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Jan 26 12:30:18 volumiochurch volumio[1269]: info: CALLMETHOD: audio_interface alsa_controller saveResamplingOpts [object Object] Jan 26 12:30:18 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveResamplingOpts Jan 26 12:30:18 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: mpd , saveResampleOptions Jan 26 12:30:18 volumiochurch sudo[2522]: volumio : unable to resolve host volumiochurch: System error Jan 26 12:30:18 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:30:18 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:30:18 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:30:18 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:30:18 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:30:18 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:30:18 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:30:18 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:30:18 volumiochurch sudo[2524]: volumio : unable to resolve host volumiochurch: System error Jan 26 12:30:18 volumiochurch sudo[2522]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 26 12:30:18 volumiochurch sudo[2524]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 26 12:30:18 volumiochurch sudo[2524]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 26 12:30:18 volumiochurch sudo[2522]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 26 12:30:18 volumiochurch sudo[2522]: pam_unix(sudo:session): session closed for user root Jan 26 12:30:18 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 12:30:18 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:30:18 volumiochurch volumio[1269]: info: MPD Permissions set Jan 26 12:30:18 volumiochurch systemd[1]: Stopping mpd.service - Music Player Daemon... Jan 26 12:30:18 volumiochurch systemd[1]: mpd.service: Deactivated successfully. Jan 26 12:30:18 volumiochurch systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 26 12:30:18 volumiochurch systemd[1]: mpd.socket: Deactivated successfully. Jan 26 12:30:18 volumiochurch systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 26 12:30:18 volumiochurch systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 26 12:30:18 volumiochurch systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 26 12:30:18 volumiochurch systemd[1]: Starting mpd.service - Music Player Daemon... Jan 26 12:30:18 volumiochurch sudo[2533]: root : unable to resolve host volumiochurch: System error Jan 26 12:30:18 volumiochurch sudo[2533]: sudo: unable to resolve host volumiochurch: System error Jan 26 12:30:18 volumiochurch sudo[2533]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 26 12:30:18 volumiochurch sudo[2533]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 26 12:30:18 volumiochurch sudo[2533]: pam_unix(sudo:session): session closed for user root Jan 26 12:30:19 volumiochurch mpd[2535]: 2026-01-26T12:30:19 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 26 12:30:19 volumiochurch systemd[1]: Started mpd.service - Music Player Daemon. Jan 26 12:30:19 volumiochurch sudo[2524]: pam_unix(sudo:session): session closed for user root Jan 26 12:30:19 volumiochurch volumio[1269]: error: updateQueue error: null Jan 26 12:30:22 volumiochurch systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 24. Jan 26 12:30:22 volumiochurch systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Jan 26 12:30:22 volumiochurch systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Jan 26 12:30:22 volumiochurch upmpdcli[2552]: Could not open config: /tmp/upmpdcli.conf Jan 26 12:30:22 volumiochurch systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Jan 26 12:30:22 volumiochurch systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Jan 26 12:30:24 volumiochurch volumio[1269]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 12:30:24 volumiochurch volumio[1269]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 12:30:24 volumiochurch volumio[1269]: info: Retrieving Cloud Streaming UI Jan 26 12:30:24 volumiochurch volumio[1269]: info: Getting Tidal Cloud Configuration Jan 26 12:30:24 volumiochurch volumio[1269]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 12:30:24 volumiochurch volumio[1269]: info: Getting Qobuz Cloud Configuration Jan 26 12:30:24 volumiochurch volumio[1269]: info: Asking plugin for UI Config Jan 26 12:30:24 volumiochurch volumio[1269]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 12:30:24 volumiochurch volumio[1269]: info: Getting Spotify Cloud Configuration Jan 26 12:30:24 volumiochurch volumio[1269]: info: Asking plugin for UI Config Jan 26 12:30:24 volumiochurch volumio[1269]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 12:30:24 volumiochurch volumio[1269]: info: Saving Spotify Acccount Jan 26 12:30:24 volumiochurch volumio[1269]: info: Got it Jan 26 12:30:24 volumiochurch volumio[1269]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jan 26 12:30:24 volumiochurch volumio[1269]: info: Got Tidal Cloud Configuration Jan 26 12:30:24 volumiochurch volumio[1269]: info: Got it Jan 26 12:30:24 volumiochurch volumio[1269]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 12:30:24 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 26 12:30:24 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 26 12:30:24 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 26 12:30:24 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 26 12:30:24 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 12:30:24 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 12:30:24 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 12:30:24 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 12:30:24 volumiochurch volumio[1269]: info: CoreCommandRouter::volumioGetBrowseSources Jan 26 12:30:24 volumiochurch volumio[1269]: info: CoreCommandRouter::volumioGetBrowseSources Jan 26 12:30:24 volumiochurch volumio[1269]: info: CoreCommandRouter::volumioGetBrowseSources Jan 26 12:30:24 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 12:30:24 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jan 26 12:30:25 volumiochurch go-librespot[1538]: time="2026-01-26T12:30:25-06:00" level=trace msg="received accesspoint ping" Jan 26 12:30:25 volumiochurch go-librespot[1538]: time="2026-01-26T12:30:25-06:00" level=trace msg="received accesspoint pong ack" Jan 26 12:30:26 volumiochurch go-librespot[1538]: time="2026-01-26T12:30:26-06:00" level=trace msg="sent dealer ping" Jan 26 12:30:26 volumiochurch go-librespot[1538]: time="2026-01-26T12:30:26-06:00" level=trace msg="received dealer pong" Jan 26 12:30:26 volumiochurch volumio[1269]: info: Disabling MyMusic plugin bluetooth Jan 26 12:30:26 volumiochurch volumio[1269]: info: [MyVolumio PluginManager] Disabling and stopping plugin audio_interface bluetooth Jan 26 12:30:26 volumiochurch volumio[1269]: ------------------------------------ BT MESSAGE: [FUNC] onStop Jan 26 12:30:26 volumiochurch volumio[1269]: ------------------------------------ BT MESSAGE: [FUNC] btAudioOutput Jan 26 12:30:26 volumiochurch volumio[1269]: ------------------------------------ BT MESSAGE: [dbus-next] Disabling Bluetooth Audio Output Jan 26 12:30:26 volumiochurch volumio[1269]: ------------------------------------ BT MESSAGE: Bluetooth audio output stopped Jan 26 12:30:26 volumiochurch volumio[1269]: ------------------------------------ BT MESSAGE: [FUNC] stopBTStack Jan 26 12:30:26 volumiochurch sudo[2555]: volumio : unable to resolve host volumiochurch: System error Jan 26 12:30:26 volumiochurch sudo[2555]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumiobt.service Jan 26 12:30:26 volumiochurch sudo[2555]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 26 12:30:26 volumiochurch systemd[1]: Stopping volumiobt.service - Volumio Bluetooth Module... Jan 26 12:30:26 volumiochurch volumiobt[2558]: INFO [BTSTART] Disconnecting all Bluetooth devices... Jan 26 12:30:26 volumiochurch bluetoothd[939]: Path / reserved for Adv Monitor app :1.27 Jan 26 12:30:26 volumiochurch bluetoothd[939]: Adv Monitor app :1.27 disconnected from D-Bus Jan 26 12:30:26 volumiochurch volumiobt[2563]: INFO [BTSTART] Unregistering Bluetooth agent... Jan 26 12:30:26 volumiochurch volumiobt[2564]: No agent is registered Jan 26 12:30:26 volumiochurch volumiobt[2564]: [NEW] Media /org/bluez/hci0 Jan 26 12:30:26 volumiochurch volumiobt[2564]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb Jan 26 12:30:26 volumiochurch volumiobt[2564]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb Jan 26 12:30:26 volumiochurch volumiobt[2564]: SupportedUUIDs: 0000FDF0-0000-1000-8000-00805f9b34fb Jan 26 12:30:26 volumiochurch bluetoothd[939]: Adv Monitor app :1.28 disconnected from D-Bus Jan 26 12:30:26 volumiochurch volumiobt[2565]: INFO [BTSTART] Stopping bluealsa-aplay (if any)... Jan 26 12:30:26 volumiochurch volumiobt[2567]: INFO [BTSTART] Stopping A2DP agent (a2dp-agent)... Jan 26 12:30:26 volumiochurch systemd[1]: volumiobt.service: Deactivated successfully. Jan 26 12:30:26 volumiochurch systemd[1]: Stopped volumiobt.service - Volumio Bluetooth Module. Jan 26 12:30:26 volumiochurch sudo[2555]: pam_unix(sudo:session): session closed for user root Jan 26 12:30:26 volumiochurch volumio[1269]: ------------------------------------ BT MESSAGE: volumiobt.service stopped successfully Jan 26 12:30:26 volumiochurch volumio[1269]: ------------------------------------ BT MESSAGE: volumiobt.service stopped Jan 26 12:30:26 volumiochurch volumio[1269]: verbose: UNSET VOLATILE: Service: undefined Jan 26 12:30:26 volumiochurch volumio[1269]: ------------------------------------ BT MESSAGE: [FUNC] detachBluetooth Jan 26 12:30:26 volumiochurch volumio[1269]: ------------------------------------ BT MESSAGE: [FUNC] btAudioOutput Jan 26 12:30:26 volumiochurch volumio[1269]: ------------------------------------ BT MESSAGE: [dbus-next] Disabling Bluetooth Audio Output Jan 26 12:30:26 volumiochurch volumio[1269]: ------------------------------------ BT MESSAGE: Bluetooth audio output disabled. Jan 26 12:30:26 volumiochurch volumio[1269]: info: CoreStateMachine::resetVolumioState Jan 26 12:30:26 volumiochurch volumio[1269]: info: CoreStateMachine::getcurrentVolume Jan 26 12:30:26 volumiochurch volumio[1269]: info: CoreCommandRouter::volumioRetrievevolume Jan 26 12:30:26 volumiochurch volumio[1269]: info: CoreStateMachine::resetVolumioState Jan 26 12:30:26 volumiochurch volumio[1269]: info: CoreStateMachine::getcurrentVolume Jan 26 12:30:26 volumiochurch volumio[1269]: info: CoreCommandRouter::volumioRetrievevolume Jan 26 12:30:26 volumiochurch volumio[1269]: info: CoreStateMachine::pushState Jan 26 12:30:26 volumiochurch volumio[1269]: info: CorePlayQueue::getTrack 0 Jan 26 12:30:26 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 12:30:26 volumiochurch volumio[1269]: info: CoreCommandRouter::volumioPushState Jan 26 12:30:26 volumiochurch volumio[1269]: info: MRS: Pushing multiroomSync output update for this device Jan 26 12:30:26 volumiochurch volumio[1269]: info: MRS: Pushing multiroomSync output Jan 26 12:30:26 volumiochurch volumio[1269]: info: CoreCommandRouter::volumioGetState Jan 26 12:30:26 volumiochurch volumio[1269]: info: CorePlayQueue::getTrack 0 Jan 26 12:30:26 volumiochurch volumio[1269]: ------------------------------------ BT MESSAGE: Volumio state reset after Bluetooth stop Jan 26 12:30:26 volumiochurch volumio[1269]: info: CoreCommandRouter::volumioStop Jan 26 12:30:26 volumiochurch volumio[1269]: info: CoreStateMachine::stop Jan 26 12:30:26 volumiochurch volumio[1269]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 26 12:30:26 volumiochurch volumio[1269]: info: CoreStateMachine::pushState Jan 26 12:30:26 volumiochurch volumio[1269]: info: CorePlayQueue::getTrack 0 Jan 26 12:30:26 volumiochurch volumio[1269]: info: CoreCommandRouter::volumioPushState Jan 26 12:30:26 volumiochurch volumio[1269]: info: MRS: Pushing multiroomSync output update for this device Jan 26 12:30:26 volumiochurch volumio[1269]: info: MRS: Pushing multiroomSync output Jan 26 12:30:26 volumiochurch volumio[1269]: info: CoreCommandRouter::volumioGetState Jan 26 12:30:26 volumiochurch volumio[1269]: info: CorePlayQueue::getTrack 0 Jan 26 12:30:26 volumiochurch volumio[1269]: info: CoreCommandRouter::volumioStop Jan 26 12:30:26 volumiochurch volumio[1269]: info: CoreStateMachine::stop Jan 26 12:30:26 volumiochurch volumio[1269]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 26 12:30:26 volumiochurch bluetoothd[939]: Path / reserved for Adv Monitor app :1.29 Jan 26 12:30:26 volumiochurch bluetoothd[939]: Adv Monitor app :1.29 disconnected from D-Bus Jan 26 12:30:26 volumiochurch volumio[1269]: ------------------------------------ BT MESSAGE: Bluetooth adapter powered off Jan 26 12:30:26 volumiochurch volumio[1269]: info: Disabling plugin bluetooth Jan 26 12:30:28 volumiochurch volumio[1269]: info: Disabling MyMusic plugin multiroom Jan 26 12:30:28 volumiochurch volumio[1269]: info: [MyVolumio PluginManager] Disabling and stopping plugin audio_interface multiroom Jan 26 12:30:28 volumiochurch volumio[1269]: info: Disabling plugin multiroom Jan 26 12:30:28 volumiochurch volumio[1269]: info: Preparing to generate the ALSA configuration file Jan 26 12:30:28 volumiochurch volumio[1269]: info: Asound.conf file written Jan 26 12:30:28 volumiochurch sudo[2574]: volumio : unable to resolve host volumiochurch: System error Jan 26 12:30:28 volumiochurch sudo[2574]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jan 26 12:30:28 volumiochurch sudo[2574]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 26 12:30:28 volumiochurch sudo[2574]: pam_unix(sudo:session): session closed for user root Jan 26 12:30:28 volumiochurch volumio[1269]: sudo: unable to resolve host volumiochurch: System error Jan 26 12:30:28 volumiochurch volumio[1269]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Jan 26 12:30:28 volumiochurch volumio[1269]: info: Output device has changed, restarting MPD Jan 26 12:30:28 volumiochurch volumio[1269]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 26 12:30:28 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:30:28 volumiochurch sudo[2583]: volumio : unable to resolve host volumiochurch: System error Jan 26 12:30:28 volumiochurch volumio[1269]: info: QobuzConnect: setDeactiveState invoked Jan 26 12:30:28 volumiochurch volumio[1269]: info: CoreCommandRouter::volumioGetState Jan 26 12:30:28 volumiochurch volumio[1269]: info: CorePlayQueue::getTrack 0 Jan 26 12:30:28 volumiochurch sudo[2583]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 26 12:30:28 volumiochurch sudo[2583]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 26 12:30:28 volumiochurch vtcs[1913]: [2026-01-26 12:30:28.386] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Jan 26 12:30:28 volumiochurch sudo[2583]: pam_unix(sudo:session): session closed for user root Jan 26 12:30:28 volumiochurch vtcs[1913]: [2026-01-26 12:30:28.389] [tisoc] [error] [SpkconServer.cpp:380] recv error. client fd=8 errorno=104 error=Connection reset by peer Jan 26 12:30:28 volumiochurch vtcs[1913]: [2026-01-26 12:30:28.389] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Jan 26 12:30:28 volumiochurch sudo[2586]: volumio : unable to resolve host volumiochurch: System error Jan 26 12:30:28 volumiochurch sudo[2586]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 26 12:30:28 volumiochurch sudo[2586]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 26 12:30:28 volumiochurch sudo[2590]: volumio : unable to resolve host volumiochurch: System error Jan 26 12:30:28 volumiochurch sudo[2590]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 26 12:30:28 volumiochurch sudo[2590]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 26 12:30:28 volumiochurch sudo[2593]: volumio : unable to resolve host volumiochurch: System error Jan 26 12:30:28 volumiochurch sudo[2593]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 26 12:30:28 volumiochurch sudo[2593]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 26 12:30:28 volumiochurch volumio[1269]: info: MPD Permissions set Jan 26 12:30:28 volumiochurch sudo[2601]: volumio : unable to resolve host volumiochurch: System error Jan 26 12:30:28 volumiochurch systemd[1]: Stopping mpd.service - Music Player Daemon... Jan 26 12:30:28 volumiochurch sudo[2601]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 26 12:30:28 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:30:28 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:30:28 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:30:28 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:30:28 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:30:28 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:30:28 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:30:28 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:30:28 volumiochurch systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Jan 26 12:30:28 volumiochurch sudo[2601]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 26 12:30:28 volumiochurch systemd[1]: vtcs.service: Deactivated successfully. Jan 26 12:30:28 volumiochurch systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Jan 26 12:30:28 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 12:30:28 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 12:30:28 volumiochurch sudo[2593]: pam_unix(sudo:session): session closed for user root Jan 26 12:30:28 volumiochurch systemd[1]: mpd.service: Deactivated successfully. Jan 26 12:30:28 volumiochurch systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 26 12:30:28 volumiochurch sudo[2590]: pam_unix(sudo:session): session closed for user root Jan 26 12:30:28 volumiochurch systemd[1]: mpd.socket: Deactivated successfully. Jan 26 12:30:28 volumiochurch systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 26 12:30:28 volumiochurch systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 26 12:30:28 volumiochurch sudo[2601]: pam_unix(sudo:session): session closed for user root Jan 26 12:30:28 volumiochurch sudo[2610]: volumio : unable to resolve host volumiochurch: System error Jan 26 12:30:28 volumiochurch sudo[2610]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 26 12:30:28 volumiochurch sudo[2610]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 26 12:30:28 volumiochurch systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 26 12:30:28 volumiochurch systemd[1]: Starting mpd.service - Music Player Daemon... Jan 26 12:30:28 volumiochurch systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Jan 26 12:30:28 volumiochurch qobuz-connect[1895]: 20260126 12:30:28.513 [1895.1895] INFO SampleApp: Stopping Local configuration server Jan 26 12:30:28 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 12:30:28 volumiochurch sudo[2614]: root : unable to resolve host volumiochurch: System error Jan 26 12:30:28 volumiochurch sudo[2614]: sudo: unable to resolve host volumiochurch: System error Jan 26 12:30:28 volumiochurch sudo[2614]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 26 12:30:28 volumiochurch sudo[2614]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 26 12:30:28 volumiochurch sudo[2614]: pam_unix(sudo:session): session closed for user root Jan 26 12:30:29 volumiochurch mpd[2616]: 2026-01-26T12:30:29 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 26 12:30:29 volumiochurch systemd[1]: Started mpd.service - Music Player Daemon. Jan 26 12:30:29 volumiochurch sudo[2586]: pam_unix(sudo:session): session closed for user root Jan 26 12:30:29 volumiochurch volumio[1269]: error: updateQueue error: null Jan 26 12:30:29 volumiochurch volumio[1269]: info: Disabling MyMusic plugin cd_controller Jan 26 12:30:29 volumiochurch volumio[1269]: info: [MyVolumio PluginManager] Disabling and stopping plugin music_service cd_controller Jan 26 12:30:29 volumiochurch volumio[1269]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesAudio CD Jan 26 12:30:29 volumiochurch volumio[1269]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 26 12:30:29 volumiochurch volumio[1269]: Cannot find translation for source Dante USB I/O Module Jan 26 12:30:29 volumiochurch volumio[1269]: Cannot find translation for source TIDAL Jan 26 12:30:29 volumiochurch volumio[1269]: info: Stopping UDEV Watcher for CD Jan 26 12:30:29 volumiochurch volumio[1269]: info: Disabling plugin cd_controller Jan 26 12:30:29 volumiochurch volumio[1269]: info: Disabling MyMusic plugin qobuzconnect Jan 26 12:30:29 volumiochurch volumio[1269]: info: [MyVolumio PluginManager] Disabling and stopping plugin music_service qobuzconnect Jan 26 12:30:29 volumiochurch volumio[1269]: info: QobuzConnect: setDeactiveState invoked Jan 26 12:30:29 volumiochurch volumio[1269]: info: CoreCommandRouter::volumioGetState Jan 26 12:30:29 volumiochurch volumio[1269]: info: CorePlayQueue::getTrack 0 Jan 26 12:30:29 volumiochurch sudo[2621]: volumio : unable to resolve host volumiochurch: System error Jan 26 12:30:29 volumiochurch sudo[2621]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop qobuz-connect Jan 26 12:30:29 volumiochurch sudo[2621]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 26 12:30:29 volumiochurch sudo[2610]: pam_unix(sudo:session): session closed for user root Jan 26 12:30:29 volumiochurch volumio[1269]: error: QobuzConnect: could not execute /bin/systemctl to restart qobuz connect process. Reason: sudo: unable to resolve host volumiochurch: System error Jan 26 12:30:29 volumiochurch volumio[1269]: sudo: unable to resolve host volumiochurch: System error Jan 26 12:30:29 volumiochurch volumio[1269]: Job for qobuz-connect.service canceled. Jan 26 12:30:29 volumiochurch volumio[1269]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 26 12:30:29 volumiochurch volumio[1269]: [UnhandledPromiseRejection: This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). The promise rejected with the reason "undefined".] { Jan 26 12:30:29 volumiochurch volumio[1269]: code: 'ERR_UNHANDLED_REJECTION' Jan 26 12:30:29 volumiochurch volumio[1269]: } Jan 26 12:30:29 volumiochurch volumio[1269]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 26 12:30:30 volumiochurch sudo[2637]: volumio : unable to resolve host volumiochurch: System error Jan 26 12:30:30 volumiochurch sudo[2637]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-26 12:29' Jan 26 12:30:30 volumiochurch sudo[2637]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"