Jun 01 19:17:02 volumioms volumio[1215]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jun 01 19:17:02 volumioms volumio[1215]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jun 01 19:17:02 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 19:17:02 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 19:17:02 volumioms volumio[1215]: info: Starting MyVolumio Remote Streaming Endpoints Jun 01 19:17:02 volumioms volumio[1215]: info: MyVolumio login type: Token Jun 01 19:17:02 volumioms volumio[1215]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jun 01 19:17:02 volumioms volumio[1215]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jun 01 19:17:06 volumioms go-librespot[1563]: time="2026-06-01T19:17:06+02:00" level=trace msg="sent dealer ping" Jun 01 19:17:06 volumioms go-librespot[1563]: time="2026-06-01T19:17:06+02:00" level=trace msg="received dealer pong" Jun 01 19:17:10 volumioms volumio[1215]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jun 01 19:17:10 volumioms volumio[1215]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jun 01 19:17:10 volumioms volumio[1215]: info: Streaming services startup Jun 01 19:17:10 volumioms volumio[1215]: info: Starting Streaming Daemon Jun 01 19:17:10 volumioms volumio[1215]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jun 01 19:17:11 volumioms sudo[1912]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 01 19:17:11 volumioms sudo[1912]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 01 19:17:11 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 01 19:17:11 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 19:17:11 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 01 19:17:11 volumioms sudo[1912]: pam_unix(sudo:session): session closed for user root Jun 01 19:17:11 volumioms volumio[1215]: error: Cannot start Volumio Streaming Daemon Jun 01 19:17:11 volumioms volumio[1215]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 01 19:17:11 volumioms volumio[1215]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 01 19:17:12 volumioms volumio[1215]: error: MyVolumio Custom Token format not valid, refreshing it Jun 01 19:17:14 volumioms volumio-remote-updater[692]: Test mode disabled Jun 01 19:17:14 volumioms volumio-remote-updater[692]: Alpha mode disabled Jun 01 19:17:14 volumioms volumio-remote-updater[692]: Alpha legacy test mode disabled Jun 01 19:17:14 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jun 01 19:17:14 volumioms volumio[1215]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jun 01 19:17:14 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jun 01 19:17:15 volumioms volumio[1215]: info: MyVolumio login type: Token Jun 01 19:17:17 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 01 19:17:18 volumioms volumio[1215]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jun 01 19:17:18 volumioms volumio[1215]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jun 01 19:17:20 volumioms volumio[1215]: info: MyVolumio token set successfully Jun 01 19:17:20 volumioms volumio[1215]: info: MYVOLUMIO: Adding device Jun 01 19:17:20 volumioms volumio[1215]: info: MYVOLUMIO: Evaluating Server Jun 01 19:17:20 volumioms volumio[1215]: info: CoreCommandRouter::volumioGetState Jun 01 19:17:20 volumioms volumio[1215]: info: CorePlayQueue::getTrack 0 Jun 01 19:17:22 volumioms volumio[1215]: info: MyVolumio Plan changed: premium Jun 01 19:17:22 volumioms volumio[1215]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Jun 01 19:17:22 volumioms volumio[1215]: info: Removing browser output: myVolumio user plan is not superstar Jun 01 19:17:22 volumioms volumio[1215]: info: Removing audio output: Jun 01 19:17:22 volumioms volumio[1215]: info: MYVOLUMIO: Adding device Jun 01 19:17:22 volumioms volumio[1215]: info: MYVOLUMIO: Evaluating Server Jun 01 19:17:22 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 01 19:17:22 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 01 19:17:22 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jun 01 19:17:22 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jun 01 19:17:22 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 01 19:17:22 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jun 01 19:17:22 volumioms volumio[1215]: info: CoreCommandRouter::volumioGetBrowseSources Jun 01 19:17:22 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 01 19:17:25 volumioms volumio[1215]: info: Setting Geolocation for MyVolumio to eu2 Jun 01 19:17:25 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 19:17:25 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 19:17:25 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 19:17:25 volumioms volumio[1215]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/147.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jun 01 19:17:25 volumioms volumio[1215]: info: Setting Geolocation for MyVolumio to eu4 Jun 01 19:17:25 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 19:17:25 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 19:17:25 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 19:17:26 volumioms volumio[1215]: info: Updating MyVolumio device info Jun 01 19:17:26 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 19:17:26 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 19:17:26 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 19:17:26 volumioms volumio[1215]: info: Remote config written successfully Jun 01 19:17:26 volumioms volumio[1215]: info: Starting Tunnel 1 Jun 01 19:17:26 volumioms volumio[1215]: info: Starting Tunnel Connection Checker Jun 01 19:17:26 volumioms volumio[1215]: info: Completed starting MyVolumio Plugin Jun 01 19:17:26 volumioms volumio[1215]: info: Successfully Added MyVolumio device Jun 01 19:17:26 volumioms volumio[1215]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/147.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jun 01 19:17:26 volumioms volumio[1215]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/147.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Jun 01 19:17:26 volumioms volumio[1215]: info: MYVolumio Device enabled Jun 01 19:17:26 volumioms volumio[1215]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Jun 01 19:17:26 volumioms volumio[1215]: info: MyVolumio status changed Jun 01 19:17:26 volumioms volumio[1215]: info: Streaming services startup Jun 01 19:17:26 volumioms volumio[1215]: info: Starting Streaming Daemon Jun 01 19:17:27 volumioms volumio[1215]: info: Updating MyVolumio device info Jun 01 19:17:27 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 19:17:27 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 19:17:27 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 19:17:27 volumioms volumio[1215]: info: Successfully Updated MyVolumio device Jun 01 19:17:27 volumioms sudo[1981]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 01 19:17:27 volumioms sudo[1981]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 01 19:17:28 volumioms sudo[1981]: pam_unix(sudo:session): session closed for user root Jun 01 19:17:28 volumioms volumio[1215]: info: Successfully Updated MyVolumio device Jun 01 19:17:28 volumioms volumio[1215]: info: Successfully Added MyVolumio device Jun 01 19:17:28 volumioms volumio[1215]: error: Cannot start Volumio Streaming Daemon Jun 01 19:17:28 volumioms volumio[1215]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 01 19:17:28 volumioms volumio[1215]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 01 19:17:28 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Jun 01 19:17:29 volumioms volumio[1215]: error: [MyVolumio PluginManager] Cache data is invalid! Jun 01 19:17:29 volumioms volumio[1215]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/147.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Jun 01 19:17:30 volumioms volumio[1215]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Jun 01 19:17:33 volumioms volumio[1215]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin bluetooth Jun 01 19:17:33 volumioms volumio[1215]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin bluetooth Jun 01 19:17:33 volumioms volumio[1215]: ------------------------------------ BT MESSAGE: [FUNC] onVolumioStart Jun 01 19:17:33 volumioms volumio[1215]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Jun 01 19:17:36 volumioms go-librespot[1563]: time="2026-06-01T19:17:36+02:00" level=trace msg="sent dealer ping" Jun 01 19:17:36 volumioms go-librespot[1563]: time="2026-06-01T19:17:36+02:00" level=trace msg="received dealer pong" Jun 01 19:17:59 volumioms volumio[1215]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Jun 01 19:18:00 volumioms sudo[2032]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Jun 01 19:18:00 volumioms sudo[2032]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 01 19:18:00 volumioms sudo[2032]: pam_unix(sudo:session): session closed for user root Jun 01 19:18:01 volumioms volumio[1215]: info: MRS: MultiRoom plugin initialized Jun 01 19:18:01 volumioms volumio[1215]: info: MRS: STOPPING SNAPCLIENT Jun 01 19:18:02 volumioms volumio[1215]: info: MRS: Snap server stop Jun 01 19:18:02 volumioms volumio[1215]: info: MRS: STOPPING volumioStreaming Jun 01 19:18:02 volumioms sudo[2057]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Jun 01 19:18:02 volumioms volumio[1215]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Jun 01 19:18:02 volumioms sudo[2057]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 01 19:18:02 volumioms sudo[2058]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Jun 01 19:18:02 volumioms sudo[2058]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 01 19:18:02 volumioms sudo[2060]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Jun 01 19:18:02 volumioms sudo[2060]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 01 19:18:02 volumioms sudo[2063]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Jun 01 19:18:02 volumioms sudo[2063]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 01 19:18:02 volumioms sudo[2063]: pam_unix(sudo:session): session closed for user root Jun 01 19:18:03 volumioms sudo[2057]: pam_unix(sudo:session): session closed for user root Jun 01 19:18:03 volumioms sudo[2060]: pam_unix(sudo:session): session closed for user root Jun 01 19:18:03 volumioms sudo[2058]: pam_unix(sudo:session): session closed for user root Jun 01 19:18:03 volumioms dbus-daemon[672]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30004ms) Jun 01 19:18:06 volumioms go-librespot[1563]: time="2026-06-01T19:18:06+02:00" level=trace msg="sent dealer ping" Jun 01 19:18:06 volumioms go-librespot[1563]: time="2026-06-01T19:18:06+02:00" level=trace msg="received dealer pong" Jun 01 19:18:06 volumioms upmpdcli[2135]: writing RSA key Jun 01 19:18:08 volumioms volumio[1215]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Jun 01 19:18:08 volumioms volumio[1215]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Jun 01 19:18:08 volumioms volumio[1215]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Jun 01 19:18:08 volumioms volumio[1215]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Jun 01 19:18:08 volumioms volumio[1215]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Jun 01 19:18:08 volumioms volumio[1215]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Jun 01 19:18:09 volumioms volumio[1215]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Jun 01 19:18:09 volumioms volumio[1215]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Jun 01 19:18:09 volumioms volumio[1215]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... Jun 01 19:18:09 volumioms volumio[1215]: info: Preparing to generate the ALSA configuration file Jun 01 19:18:09 volumioms volumio[1215]: error: MyVolumio Plugins failed to start in a timely fashion Jun 01 19:18:09 volumioms volumio[1215]: [Metrics] CommandRouter: 127s 828.05ms Jun 01 19:18:09 volumioms volumio[1215]: info: CoreCommandRouter::volumiosetStartupVolume Jun 01 19:18:09 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 01 19:18:09 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 19:18:09 volumioms volumio[1215]: info: CoreCommandRouter::Close All Modals sent Jun 01 19:18:10 volumioms volumio[1215]: info: CoreCommandRouter::Close All Modals sent Jun 01 19:18:10 volumioms volumio[1215]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Jun 01 19:18:10 volumioms volumio[1215]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jun 01 19:18:10 volumioms volumio[1215]: info: Reading ALSA contributions from plugins. Jun 01 19:18:10 volumioms volumio[1215]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 01 19:18:11 volumioms volumio[1215]: Error: write EPIPE Jun 01 19:18:11 volumioms volumio[1215]: at afterWriteDispatched (node:internal/stream_base_commons:160:15) Jun 01 19:18:11 volumioms volumio[1215]: at writeGeneric (node:internal/stream_base_commons:151:3) Jun 01 19:18:11 volumioms volumio[1215]: at Socket._writeGeneric (node:net:952:11) Jun 01 19:18:11 volumioms volumio[1215]: at Socket._write (node:net:964:8) Jun 01 19:18:11 volumioms volumio[1215]: at writeOrBuffer (node:internal/streams/writable:399:12) Jun 01 19:18:11 volumioms volumio[1215]: at _write (node:internal/streams/writable:340:10) Jun 01 19:18:11 volumioms volumio[1215]: at Writable.write (node:internal/streams/writable:344:10) Jun 01 19:18:11 volumioms volumio[1215]: at auth (/myvolumio/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/handshake.js:67:10) Jun 01 19:18:11 volumioms volumio[1215]: at Socket. (/myvolumio/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/connection.js:137:32) Jun 01 19:18:11 volumioms volumio[1215]: at Object.onceWrapper (node:events:628:28) Jun 01 19:18:11 volumioms volumio[1215]: at Socket.emit (node:events:514:28) Jun 01 19:18:11 volumioms volumio[1215]: at PipeConnectWrap.afterConnect [as oncomplete] (node:net:1580:10) { Jun 01 19:18:11 volumioms volumio[1215]: errno: -32, Jun 01 19:18:11 volumioms volumio[1215]: code: 'EPIPE', Jun 01 19:18:11 volumioms volumio[1215]: syscall: 'write' Jun 01 19:18:11 volumioms volumio[1215]: } Jun 01 19:18:11 volumioms volumio[1215]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 01 19:18:24 volumioms sudo[2201]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-06-01 19:17' Jun 01 19:18:24 volumioms sudo[2201]: 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"