May 31 15:58:04 volumio volumio[1234]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 May 31 15:58:04 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 15:58:04 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 15:58:04 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam May 31 15:58:04 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam May 31 15:58:04 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 31 15:58:04 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject May 31 15:58:04 volumio volumio[1234]: info: CoreCommandRouter::volumioGetBrowseSources May 31 15:58:04 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 31 15:58:06 volumio volumio-remote-updater[831]: Test mode disabled May 31 15:58:06 volumio volumio-remote-updater[831]: Alpha mode disabled May 31 15:58:06 volumio volumio-remote-updater[831]: Alpha legacy test mode disabled May 31 15:58:06 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled May 31 15:58:06 volumio volumio[1234]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN May 31 15:58:08 volumio volumio[1234]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} May 31 15:58:08 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 31 15:58:10 volumio volumio[1234]: error: MyVolumio Plugin failed to authenticate in a timely fashion May 31 15:58:10 volumio volumio[1234]: info: Completed starting MyVolumio Plugin May 31 15:58:10 volumio volumio[1234]: [Metrics] CommandRouter: 86s 963.15ms May 31 15:58:10 volumio volumio[1234]: info: CoreCommandRouter::volumiosetStartupVolume May 31 15:58:10 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 15:58:10 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 15:58:10 volumio volumio[1234]: info: CoreCommandRouter::Close All Modals sent May 31 15:58:10 volumio volumio[1234]: info: CoreCommandRouter::Close All Modals sent May 31 15:58:14 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable May 31 15:58:14 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 31 15:58:14 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect May 31 15:58:18 volumio volumio[1234]: info: BOOT COMPLETED May 31 15:58:19 volumio volumio[1234]: info: MyVolumio token set successfully May 31 15:58:20 volumio volumio[1234]: info: MYVOLUMIO: Adding device May 31 15:58:20 volumio volumio[1234]: info: MYVOLUMIO: Evaluating Server May 31 15:58:25 volumio volumio[1234]: info: MyVolumio Plan changed: premium May 31 15:58:25 volumio volumio[1234]: info: [MyVolumio PluginManager] Subscribed plan changed to premium May 31 15:58:25 volumio volumio[1234]: info: Removing browser output: myVolumio user plan is not superstar May 31 15:58:25 volumio volumio[1234]: info: Removing audio output: May 31 15:58:25 volumio volumio[1234]: info: MYVOLUMIO: Adding device May 31 15:58:25 volumio volumio[1234]: info: MYVOLUMIO: Evaluating Server May 31 15:58:25 volumio volumio[1234]: info: CoreCommandRouter::volumioGetState May 31 15:58:25 volumio volumio[1234]: info: CorePlayQueue::getTrack 0 May 31 15:58:30 volumio volumio[1234]: info: Setting Geolocation for MyVolumio to eu3 May 31 15:58:30 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 15:58:30 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 15:58:30 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 15:58:33 volumio volumio[1234]: info: Setting Geolocation for MyVolumio to eu3 May 31 15:58:33 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 15:58:33 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 15:58:33 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 15:58:33 volumio volumio[1234]: info: Updating MyVolumio device info May 31 15:58:33 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 15:58:33 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 15:58:33 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 15:58:35 volumio volumio[1234]: info: Successfully Added MyVolumio device May 31 15:58:35 volumio volumio[1234]: info: Updating MyVolumio device info May 31 15:58:35 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 15:58:35 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 15:58:35 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 15:58:39 volumio volumio[1234]: info: Remote config written successfully May 31 15:58:39 volumio volumio[1234]: info: Starting Tunnel 1 May 31 15:58:39 volumio volumio[1234]: info: Starting Tunnel Connection Checker May 31 15:58:42 volumio volumio[1234]: info: Successfully Updated MyVolumio device May 31 15:58:42 volumio volumio[1234]: info: MYVolumio Device enabled May 31 15:58:42 volumio volumio[1234]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... May 31 15:58:42 volumio volumio[1234]: info: MyVolumio status changed May 31 15:58:42 volumio volumio[1234]: info: Streaming services startup May 31 15:58:42 volumio volumio[1234]: info: Starting Streaming Daemon May 31 15:58:42 volumio sudo[1984]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 31 15:58:42 volumio sudo[1984]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 15:58:42 volumio sudo[1984]: pam_unix(sudo:session): session closed for user root May 31 15:58:47 volumio volumio[1234]: info: Successfully Added MyVolumio device May 31 15:58:47 volumio volumio[1234]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 May 31 15:58:47 volumio volumio[1234]: error: Cannot start Volumio Streaming Daemon May 31 15:58:47 volumio volumio[1234]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 31 15:58:47 volumio volumio[1234]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 31 15:58:57 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid May 31 15:58:57 volumio volumio[1234]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... May 31 15:58:59 volumio volumio[1234]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin bluetooth May 31 15:58:59 volumio volumio[1234]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin bluetooth May 31 15:58:59 volumio volumio[1234]: ------------------------------------ BT MESSAGE: [FUNC] onVolumioStart May 31 15:58:59 volumio volumio[1234]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... May 31 15:59:05 volumio volumio[1234]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom May 31 15:59:06 volumio sudo[2039]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom May 31 15:59:06 volumio sudo[2039]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 15:59:06 volumio sudo[2039]: pam_unix(sudo:session): session closed for user root May 31 15:59:06 volumio volumio[1234]: info: MRS: MultiRoom plugin initialized May 31 15:59:06 volumio volumio[1234]: info: MRS: STOPPING SNAPCLIENT May 31 15:59:06 volumio volumio[1234]: info: MRS: Snap server stop May 31 15:59:07 volumio volumio[1234]: info: MRS: STOPPING volumioStreaming May 31 15:59:07 volumio sudo[2056]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient May 31 15:59:07 volumio sudo[2056]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 15:59:07 volumio volumio[1234]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... May 31 15:59:07 volumio sudo[2060]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming May 31 15:59:07 volumio sudo[2058]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver May 31 15:59:07 volumio sudo[2058]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 15:59:07 volumio sudo[2060]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 15:59:07 volumio sudo[2056]: pam_unix(sudo:session): session closed for user root May 31 15:59:07 volumio volumio[1234]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... May 31 15:59:07 volumio sudo[2063]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* May 31 15:59:07 volumio volumio[1234]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... May 31 15:59:07 volumio sudo[2063]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 15:59:07 volumio sudo[2063]: pam_unix(sudo:session): session closed for user root May 31 15:59:07 volumio volumio[1234]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... May 31 15:59:07 volumio volumio[1234]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... May 31 15:59:07 volumio sudo[2060]: pam_unix(sudo:session): session closed for user root May 31 15:59:07 volumio sudo[2058]: pam_unix(sudo:session): session closed for user root May 31 15:59:07 volumio volumio[1234]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio May 31 15:59:08 volumio volumio[1234]: info: [MyVolumio PluginManager] Loading plugin "tidal"... May 31 15:59:08 volumio volumio[1234]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... May 31 15:59:08 volumio volumio[1234]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... May 31 15:59:08 volumio volumio[1234]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... May 31 15:59:08 volumio volumio[1234]: info: Preparing to generate the ALSA configuration file May 31 15:59:08 volumio volumio[1234]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf May 31 15:59:08 volumio volumio[1234]: info: Reading ALSA contributions from plugins. May 31 15:59:08 volumio volumio[1234]: info: Successfully Updated MyVolumio device May 31 15:59:14 volumio volumio[1234]: info: MRS: Removed streaming files May 31 15:59:14 volumio volumio[1234]: info: MRS: volumioStreaming STOPPED May 31 15:59:14 volumio volumio[1234]: info: MRS: SNAPSERVER STOPPED May 31 15:59:14 volumio volumio[1234]: info: MRS: SNAPCLIENT STOPPED May 31 15:59:14 volumio sudo[2069]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service May 31 15:59:14 volumio sudo[2069]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 15:59:14 volumio 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. May 31 15:59:14 volumio 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. May 31 15:59:14 volumio systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. May 31 15:59:14 volumio sudo[2069]: pam_unix(sudo:session): session closed for user root May 31 15:59:14 volumio autossh[2072]: port set to 0, monitoring disabled May 31 15:59:14 volumio autossh[2072]: starting ssh (count 1) May 31 15:59:14 volumio autossh[2072]: ssh child pid is 2075 May 31 15:59:15 volumio volumiossh-tunnel[2075]: Warning: Permanently added '[eu3.myvolumio.org]:2222' (RSA) to the list of known hosts. May 31 15:59:26 volumio volumio5-onboarding[1754]: time=2026-05-31T15:59:26.441+01:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.1.190:51549 May 31 15:59:29 volumio dbus-daemon[800]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30009ms) May 31 15:59:40 volumio volumio[1234]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 31 15:59:41 volumio volumio[1234]: Error: write EPIPE May 31 15:59:41 volumio volumio[1234]: at afterWriteDispatched (node:internal/stream_base_commons:160:15) May 31 15:59:41 volumio volumio[1234]: at writeGeneric (node:internal/stream_base_commons:151:3) May 31 15:59:41 volumio volumio[1234]: at Socket._writeGeneric (node:net:952:11) May 31 15:59:41 volumio volumio[1234]: at Socket._write (node:net:964:8) May 31 15:59:41 volumio volumio[1234]: at writeOrBuffer (node:internal/streams/writable:399:12) May 31 15:59:41 volumio volumio[1234]: at _write (node:internal/streams/writable:340:10) May 31 15:59:41 volumio volumio[1234]: at Writable.write (node:internal/streams/writable:344:10) May 31 15:59:41 volumio volumio[1234]: at /myvolumio/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/handshake.js:89:18 May 31 15:59:41 volumio volumio[1234]: at Socket.readable (/myvolumio/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/readline.js:12:11) May 31 15:59:41 volumio volumio[1234]: at Socket.emit (node:events:514:28) May 31 15:59:41 volumio volumio[1234]: at emitReadable_ (node:internal/streams/readable:609:12) May 31 15:59:41 volumio volumio[1234]: at process.processTicksAndRejections (node:internal/process/task_queues:81:21) { May 31 15:59:41 volumio volumio[1234]: errno: -32, May 31 15:59:41 volumio volumio[1234]: code: 'EPIPE', May 31 15:59:41 volumio volumio[1234]: syscall: 'write' May 31 15:59:41 volumio volumio[1234]: } May 31 15:59:41 volumio volumio[1234]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 31 15:59:48 volumio sudo[2153]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-05-31 15:58' May 31 15:59:48 volumio sudo[2153]: 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"