Mar 27 20:17:05 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 27 20:17:05 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 27 20:17:05 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 27 20:17:06 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 27 20:17:06 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 7. Mar 27 20:17:06 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 27 20:17:06 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 27 20:17:06 volumio upmpdcli[1905]: Could not open config: /tmp/upmpdcli.conf Mar 27 20:17:06 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 27 20:17:06 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 27 20:17:08 volumio volumio-remote-updater[793]: Test mode disabled Mar 27 20:17:08 volumio volumio-remote-updater[793]: Alpha mode disabled Mar 27 20:17:08 volumio volumio-remote-updater[793]: Alpha legacy test mode disabled Mar 27 20:17:08 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Mar 27 20:17:08 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 27 20:17:08 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 27 20:17:08 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 27 20:17:08 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 27 20:17:08 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 27 20:17:08 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 27 20:17:08 volumio volumio[1660]: info: CoreCommandRouter::volumioGetBrowseSources Mar 27 20:17:08 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 27 20:17:09 volumio volumio[1660]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

NEW ADDITIONS

","title":"Update v4.119","updateavailable":true} Mar 27 20:17:10 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 27 20:17:12 volumio volumio[1660]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Mar 27 20:17:13 volumio volumio[1660]: error: MyVolumio Plugin failed to authenticate in a timely fashion Mar 27 20:17:13 volumio volumio[1660]: info: Completed starting MyVolumio Plugin Mar 27 20:17:13 volumio volumio[1660]: [Metrics] CommandRouter: 55s 104.02ms Mar 27 20:17:13 volumio volumio[1660]: info: CoreCommandRouter::volumiosetStartupVolume Mar 27 20:17:13 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 27 20:17:13 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 27 20:17:13 volumio volumio[1660]: info: CoreCommandRouter::Close All Modals sent Mar 27 20:17:13 volumio volumio[1660]: info: CoreCommandRouter::Close All Modals sent Mar 27 20:17:13 volumio kernel: bcm2835-i2s fe203000.i2s: I2S SYNC error! Mar 27 20:17:16 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 27 20:17:16 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 27 20:17:16 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 27 20:17:20 volumio volumio[1660]: info: MyVolumio login type: Token Mar 27 20:17:22 volumio volumio[1660]: info: BOOT COMPLETED Mar 27 20:17:22 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 8. Mar 27 20:17:22 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 27 20:17:22 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 27 20:17:22 volumio upmpdcli[1938]: Could not open config: /tmp/upmpdcli.conf Mar 27 20:17:22 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 27 20:17:22 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 27 20:17:23 volumio volumio[1660]: info: CoreCommandRouter::volumioGetState Mar 27 20:17:23 volumio volumio[1660]: info: CorePlayQueue::getTrack 0 Mar 27 20:17:37 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 9. Mar 27 20:17:37 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 27 20:17:37 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 27 20:17:37 volumio upmpdcli[1954]: Could not open config: /tmp/upmpdcli.conf Mar 27 20:17:37 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 27 20:17:37 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 27 20:17:42 volumio volumio[1660]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Mar 27 20:17:52 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 10. Mar 27 20:17:52 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 27 20:17:53 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 27 20:17:53 volumio upmpdcli[1986]: Could not open config: /tmp/upmpdcli.conf Mar 27 20:17:53 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 27 20:17:53 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 27 20:17:56 volumio volumio[1660]: info: MyVolumio token set successfully Mar 27 20:17:56 volumio volumio[1660]: info: MYVOLUMIO: Adding device Mar 27 20:17:56 volumio volumio[1660]: info: MYVOLUMIO: Evaluating Server Mar 27 20:18:00 volumio volumio[1660]: info: MyVolumio Plan changed: premium Mar 27 20:18:00 volumio volumio[1660]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Mar 27 20:18:00 volumio volumio[1660]: info: Removing browser output: myVolumio user plan is not superstar Mar 27 20:18:00 volumio volumio[1660]: info: Removing audio output: Mar 27 20:18:00 volumio volumio[1660]: info: MYVOLUMIO: Adding device Mar 27 20:18:00 volumio volumio[1660]: info: MYVOLUMIO: Evaluating Server Mar 27 20:18:05 volumio volumio[1660]: info: Setting Geolocation for MyVolumio to eu6 Mar 27 20:18:05 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 27 20:18:05 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 27 20:18:05 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 27 20:18:08 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 11. Mar 27 20:18:08 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 27 20:18:08 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 27 20:18:08 volumio upmpdcli[2037]: Could not open config: /tmp/upmpdcli.conf Mar 27 20:18:08 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 27 20:18:08 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 27 20:18:08 volumio volumio[1660]: info: Setting Geolocation for MyVolumio to eu6 Mar 27 20:18:08 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 27 20:18:08 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 27 20:18:08 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 27 20:18:09 volumio volumio[1660]: info: Updating MyVolumio device info Mar 27 20:18:09 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 27 20:18:09 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 27 20:18:09 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 27 20:18:10 volumio volumio[1660]: info: Updating MyVolumio device info Mar 27 20:18:10 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 27 20:18:10 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 27 20:18:10 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 27 20:18:12 volumio volumio[1660]: info: Remote config written successfully Mar 27 20:18:12 volumio volumio[1660]: info: Starting Tunnel 1 Mar 27 20:18:12 volumio volumio[1660]: info: Starting Tunnel Connection Checker Mar 27 20:18:16 volumio volumio[1660]: info: MYVolumio Device enabled Mar 27 20:18:16 volumio volumio[1660]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Mar 27 20:18:16 volumio volumio[1660]: info: MyVolumio status changed Mar 27 20:18:16 volumio volumio[1660]: info: Streaming services startup Mar 27 20:18:16 volumio volumio[1660]: info: Starting Streaming Daemon Mar 27 20:18:16 volumio sudo[2054]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 27 20:18:16 volumio sudo[2054]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 27 20:18:16 volumio sudo[2054]: pam_unix(sudo:session): session closed for user root Mar 27 20:18:16 volumio volumio[1660]: info: Successfully Added MyVolumio device Mar 27 20:18:19 volumio volumio[1660]: info: Successfully Added MyVolumio device Mar 27 20:18:19 volumio volumio[1660]: error: Cannot start Volumio Streaming Daemon Mar 27 20:18:19 volumio volumio[1660]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 27 20:18:19 volumio volumio[1660]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 27 20:18:23 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 12. Mar 27 20:18:23 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 27 20:18:23 volumio volumio[1660]: info: Successfully Updated MyVolumio device Mar 27 20:18:23 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 27 20:18:23 volumio upmpdcli[2073]: Could not open config: /tmp/upmpdcli.conf Mar 27 20:18:23 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 27 20:18:23 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 27 20:18:25 volumio volumio[1660]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Mar 27 20:18:25 volumio volumio[1660]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Mar 27 20:18:25 volumio volumio[1660]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin bluetooth Mar 27 20:18:25 volumio volumio[1660]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin bluetooth Mar 27 20:18:25 volumio volumio[1660]: ------------------------------------ BT MESSAGE: [FUNC] onVolumioStart Mar 27 20:18:25 volumio volumio[1660]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Mar 27 20:18:30 volumio volumio[1660]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Mar 27 20:18:30 volumio sudo[2077]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Mar 27 20:18:30 volumio sudo[2077]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 27 20:18:30 volumio sudo[2077]: pam_unix(sudo:session): session closed for user root Mar 27 20:18:30 volumio volumio[1660]: info: MRS: MultiRoom plugin initialized Mar 27 20:18:30 volumio volumio[1660]: info: MRS: STOPPING SNAPCLIENT Mar 27 20:18:30 volumio volumio[1660]: info: MRS: Snap server stop Mar 27 20:18:31 volumio volumio[1660]: info: MRS: STOPPING volumioStreaming Mar 27 20:18:31 volumio volumio[1660]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Mar 27 20:18:31 volumio sudo[2094]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Mar 27 20:18:31 volumio sudo[2096]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Mar 27 20:18:31 volumio sudo[2098]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Mar 27 20:18:31 volumio sudo[2098]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 27 20:18:31 volumio sudo[2094]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 27 20:18:31 volumio sudo[2096]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 27 20:18:31 volumio sudo[2101]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Mar 27 20:18:31 volumio sudo[2101]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 27 20:18:31 volumio volumio[1660]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Mar 27 20:18:31 volumio sudo[2101]: pam_unix(sudo:session): session closed for user root Mar 27 20:18:31 volumio sudo[2098]: pam_unix(sudo:session): session closed for user root Mar 27 20:18:31 volumio sudo[2096]: pam_unix(sudo:session): session closed for user root Mar 27 20:18:31 volumio sudo[2094]: pam_unix(sudo:session): session closed for user root Mar 27 20:18:31 volumio volumio[1660]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Mar 27 20:18:31 volumio volumio[1660]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Mar 27 20:18:31 volumio volumio[1660]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Mar 27 20:18:31 volumio volumio[1660]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Mar 27 20:18:31 volumio volumio[1660]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Mar 27 20:18:31 volumio volumio[1660]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Mar 27 20:18:31 volumio volumio[1660]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Mar 27 20:18:31 volumio volumio[1660]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... Mar 27 20:18:31 volumio volumio[1660]: info: Preparing to generate the ALSA configuration file Mar 27 20:18:31 volumio volumio[1660]: info: Successfully Updated MyVolumio device Mar 27 20:18:31 volumio volumio[1660]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Mar 27 20:18:31 volumio volumio[1660]: info: Reading ALSA contributions from plugins. Mar 27 20:18:33 volumio volumio[1660]: info: MRS: Removed streaming files Mar 27 20:18:33 volumio volumio[1660]: info: MRS: volumioStreaming STOPPED Mar 27 20:18:33 volumio volumio[1660]: info: MRS: SNAPSERVER STOPPED Mar 27 20:18:33 volumio volumio[1660]: info: MRS: SNAPCLIENT STOPPED Mar 27 20:18:38 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 13. Mar 27 20:18:38 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 27 20:18:38 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 27 20:18:38 volumio upmpdcli[2126]: Could not open config: /tmp/upmpdcli.conf Mar 27 20:18:38 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 27 20:18:38 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 27 20:18:54 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 14. Mar 27 20:18:54 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 27 20:18:54 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 27 20:18:54 volumio upmpdcli[2156]: Could not open config: /tmp/upmpdcli.conf Mar 27 20:18:54 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 27 20:18:54 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 27 20:18:55 volumio dbus-daemon[767]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30000ms) Mar 27 20:18:56 volumio volumio[1660]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 27 20:18:56 volumio volumio[1660]: Error: write EPIPE Mar 27 20:18:56 volumio volumio[1660]: at afterWriteDispatched (node:internal/stream_base_commons:160:15) Mar 27 20:18:56 volumio volumio[1660]: at writeGeneric (node:internal/stream_base_commons:151:3) Mar 27 20:18:56 volumio volumio[1660]: at Socket._writeGeneric (node:net:952:11) Mar 27 20:18:56 volumio volumio[1660]: at Socket._write (node:net:964:8) Mar 27 20:18:56 volumio volumio[1660]: at writeOrBuffer (node:internal/streams/writable:399:12) Mar 27 20:18:56 volumio volumio[1660]: at _write (node:internal/streams/writable:340:10) Mar 27 20:18:56 volumio volumio[1660]: at Writable.write (node:internal/streams/writable:344:10) Mar 27 20:18:56 volumio volumio[1660]: at /myvolumio/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/handshake.js:89:18 Mar 27 20:18:56 volumio volumio[1660]: at Socket.readable (/myvolumio/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/readline.js:12:11) Mar 27 20:18:56 volumio volumio[1660]: at Socket.emit (node:events:514:28) { Mar 27 20:18:56 volumio volumio[1660]: errno: -32, Mar 27 20:18:56 volumio volumio[1660]: code: 'EPIPE', Mar 27 20:18:56 volumio volumio[1660]: syscall: 'write' Mar 27 20:18:56 volumio volumio[1660]: } Mar 27 20:18:56 volumio volumio[1660]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 27 20:19:00 volumio sudo[2172]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-27 20:17' Mar 27 20:19:00 volumio sudo[2172]: 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="dc61260dec5515dafd2b634881860b4c46c919ff" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Mar 6 16:46:58 UTC 2026" VOLUMIO_VERSION="4.103" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="aa741395b8bfc648ff5d04e312f53d2c"