Jun 02 11:21:00 living-room volumio[1167]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jun 02 11:21:00 living-room volumio[1167]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jun 02 11:21:00 living-room volumio[1167]: info: Streaming services startup Jun 02 11:21:00 living-room volumio[1167]: info: Starting Streaming Daemon Jun 02 11:21:00 living-room sudo[1602]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 02 11:21:00 living-room sudo[1602]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 11:21:00 living-room volumio[1167]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jun 02 11:21:00 living-room sudo[1602]: pam_unix(sudo:session): session closed for user root Jun 02 11:21:01 living-room volumio[1167]: info: Initializing connection to go-librespot Websocket Jun 02 11:21:01 living-room volumio[1167]: info: AutoStart - Check #5/60 - VOLUMIO_SYSTEM_STATUS = starting Jun 02 11:21:01 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 02 11:21:01 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 11:21:01 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 02 11:21:01 living-room volumio[1167]: error: Cannot start Volumio Streaming Daemon Jun 02 11:21:01 living-room volumio[1167]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 02 11:21:01 living-room volumio[1167]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 02 11:21:02 living-room go-librespot[1518]: time="2026-06-02T11:21:02+02:00" level=debug msg="new websocket client" Jun 02 11:21:02 living-room volumio[1167]: info: CoreCommandRouter::volumioGetState Jun 02 11:21:02 living-room volumio[1167]: info: CorePlayQueue::getTrack 0 Jun 02 11:21:02 living-room volumio[1167]: info: Connection to go-librespot Websocket established Jun 02 11:21:02 living-room volumio[1167]: info: CoreCommandRouter::volumioGetState Jun 02 11:21:02 living-room volumio[1167]: info: CorePlayQueue::getTrack 0 Jun 02 11:21:02 living-room volumio[1167]: error: MyVolumio Custom Token format not valid, refreshing it Jun 02 11:21:02 living-room volumio[1167]: error: updateQueue error: null Jun 02 11:21:03 living-room volumio[1167]: info: Listing playlists Jun 02 11:21:03 living-room volumio[1167]: info: Listing playlists Jun 02 11:21:03 living-room volumio[1167]: info: Listing playlists Jun 02 11:21:03 living-room volumio[1167]: info: Listing playlists Jun 02 11:21:04 living-room volumio-remote-updater[694]: Test mode disabled Jun 02 11:21:04 living-room volumio-remote-updater[694]: Alpha mode disabled Jun 02 11:21:04 living-room volumio-remote-updater[694]: Alpha legacy test mode disabled Jun 02 11:21:04 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jun 02 11:21:04 living-room volumio[1167]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jun 02 11:21:04 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jun 02 11:21:04 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 02 11:21:04 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 02 11:21:04 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 02 11:21:04 living-room volumio[1167]: info: Received Get System Info Jun 02 11:21:04 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 11:21:04 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 11:21:04 living-room volumio[1167]: info: Discovery: Getting this device information Jun 02 11:21:04 living-room volumio[1167]: info: CoreCommandRouter::volumioGetState Jun 02 11:21:05 living-room volumio[1167]: info: CorePlayQueue::getTrack 0 Jun 02 11:21:05 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 11:21:05 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 02 11:21:05 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 02 11:21:05 living-room volumio5-onboarding[1463]: time=2026-06-02T11:21:05.552+02:00 level=INFO msg="enabling local network discovery" Jun 02 11:21:05 living-room volumio5-onboarding[1463]: time=2026-06-02T11:21:05.600+02:00 level=INFO msg="enabling BLE discovery" Jun 02 11:21:05 living-room volumio[1167]: info: Getting Spotify volume Jun 02 11:21:06 living-room volumio[1167]: info: MyVolumio login type: Token Jun 02 11:21:06 living-room volumio[1167]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Jun 02 11:21:06 living-room volumio[1167]: info: AutoStart - Check #6/60 - VOLUMIO_SYSTEM_STATUS = starting Jun 02 11:21:06 living-room volumio5-onboarding[1463]: time=2026-06-02T11:21:06.721+02:00 level=INFO msg="service successfully established" component=discovery/localnet Jun 02 11:21:06 living-room volumio5-onboarding[1463]: time=2026-06-02T11:21:06.997+02:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.2.37:56422 Jun 02 11:21:07 living-room volumio[1167]: info: CoreCommandRouter::volumioGetState Jun 02 11:21:07 living-room volumio[1167]: info: CorePlayQueue::getTrack 0 Jun 02 11:21:08 living-room volumio[1167]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jun 02 11:21:09 living-room volumio[1167]: info: MyVolumio token set successfully Jun 02 11:21:09 living-room volumio[1167]: info: MYVOLUMIO: Adding device Jun 02 11:21:09 living-room volumio[1167]: info: MYVOLUMIO: Evaluating Server Jun 02 11:21:11 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 02 11:21:11 living-room volumio[1167]: info: MyVolumio Plan changed: premium Jun 02 11:21:11 living-room volumio[1167]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Jun 02 11:21:11 living-room volumio[1167]: info: Removing browser output: myVolumio user plan is not superstar Jun 02 11:21:11 living-room volumio[1167]: info: Removing audio output: Jun 02 11:21:11 living-room volumio[1167]: info: MYVOLUMIO: Adding device Jun 02 11:21:11 living-room volumio[1167]: info: MYVOLUMIO: Evaluating Server Jun 02 11:21:12 living-room volumio[1167]: info: Setting Geolocation for MyVolumio to eu2 Jun 02 11:21:12 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 11:21:12 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 11:21:12 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 11:21:12 living-room volumio[1167]: info: AutoStart - Check #7/60 - VOLUMIO_SYSTEM_STATUS = starting Jun 02 11:21:14 living-room volumio[1167]: info: Updating MyVolumio device info Jun 02 11:21:14 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 11:21:14 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 11:21:14 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 11:21:14 living-room volumio[1167]: info: CoreCommandRouter::volumioGetState Jun 02 11:21:14 living-room volumio[1167]: info: CorePlayQueue::getTrack 0 Jun 02 11:21:14 living-room volumio[1167]: info: Successfully Added MyVolumio device Jun 02 11:21:15 living-room volumio[1167]: info: Setting Geolocation for MyVolumio to eu2 Jun 02 11:21:15 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 11:21:15 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 11:21:15 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 11:21:15 living-room volumio[1167]: info: Remote config written successfully Jun 02 11:21:15 living-room volumio[1167]: info: Starting Tunnel 1 Jun 02 11:21:15 living-room volumio[1167]: info: Starting Tunnel Connection Checker Jun 02 11:21:15 living-room volumio[1167]: info: Completed starting MyVolumio Plugin Jun 02 11:21:15 living-room volumio[1167]: info: CoreCommandRouter::volumioGetState Jun 02 11:21:15 living-room volumio[1167]: info: CorePlayQueue::getTrack 0 Jun 02 11:21:15 living-room volumio[1167]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Jun 02 11:21:15 living-room volumio[1167]: info: MYVolumio Device enabled Jun 02 11:21:15 living-room volumio[1167]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Jun 02 11:21:15 living-room volumio[1167]: info: MyVolumio status changed Jun 02 11:21:15 living-room volumio[1167]: info: Streaming services startup Jun 02 11:21:15 living-room volumio[1167]: info: Starting Streaming Daemon Jun 02 11:21:16 living-room sudo[1674]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 02 11:21:16 living-room sudo[1674]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 11:21:16 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 11:21:16 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 11:21:16 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jun 02 11:21:16 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 02 11:21:16 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jun 02 11:21:16 living-room volumio[1167]: info: CoreCommandRouter::volumioGetBrowseSources Jun 02 11:21:16 living-room sudo[1674]: pam_unix(sudo:session): session closed for user root Jun 02 11:21:16 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 02 11:21:16 living-room volumio[1167]: info: Updating MyVolumio device info Jun 02 11:21:16 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 11:21:16 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 11:21:16 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 11:21:17 living-room volumio[1167]: info: Successfully Updated MyVolumio device Jun 02 11:21:18 living-room volumio[1167]: error: Cannot start Volumio Streaming Daemon Jun 02 11:21:18 living-room volumio[1167]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 02 11:21:18 living-room volumio[1167]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 02 11:21:18 living-room volumio[1167]: info: AutoStart - Check #8/60 - VOLUMIO_SYSTEM_STATUS = starting Jun 02 11:21:18 living-room volumio[1167]: info: Successfully Added MyVolumio device Jun 02 11:21:18 living-room volumio[1167]: info: Successfully Updated MyVolumio device Jun 02 11:21:18 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Jun 02 11:21:18 living-room volumio[1167]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Jun 02 11:21:22 living-room volumio[1167]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin bluetooth Jun 02 11:21:22 living-room volumio[1167]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin bluetooth Jun 02 11:21:22 living-room volumio[1167]: ------------------------------------ BT MESSAGE: [FUNC] onVolumioStart Jun 02 11:21:22 living-room volumio[1167]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Jun 02 11:21:45 living-room volumio[1167]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Jun 02 11:21:46 living-room sudo[1721]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Jun 02 11:21:46 living-room sudo[1721]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 11:21:46 living-room sudo[1721]: pam_unix(sudo:session): session closed for user root Jun 02 11:21:47 living-room volumio[1167]: info: MRS: MultiRoom plugin initialized Jun 02 11:21:47 living-room volumio[1167]: info: MRS: STOPPING SNAPCLIENT Jun 02 11:21:47 living-room volumio[1167]: info: MRS: Snap server stop Jun 02 11:21:47 living-room volumio[1167]: info: MRS: STOPPING volumioStreaming Jun 02 11:21:47 living-room volumio[1167]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Jun 02 11:21:47 living-room sudo[1738]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Jun 02 11:21:47 living-room sudo[1738]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 11:21:47 living-room sudo[1740]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Jun 02 11:21:48 living-room sudo[1742]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Jun 02 11:21:48 living-room sudo[1740]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 11:21:48 living-room sudo[1742]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 11:21:48 living-room sudo[1744]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Jun 02 11:21:48 living-room sudo[1738]: pam_unix(sudo:session): session closed for user root Jun 02 11:21:48 living-room sudo[1744]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 11:21:48 living-room sudo[1744]: pam_unix(sudo:session): session closed for user root Jun 02 11:21:48 living-room volumio[1167]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Jun 02 11:21:48 living-room sudo[1740]: pam_unix(sudo:session): session closed for user root Jun 02 11:21:48 living-room sudo[1742]: pam_unix(sudo:session): session closed for user root Jun 02 11:21:48 living-room volumio[1167]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Jun 02 11:21:49 living-room volumio[1167]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Jun 02 11:21:49 living-room volumio[1167]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Jun 02 11:21:49 living-room volumio[1167]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Jun 02 11:21:49 living-room volumio[1167]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Jun 02 11:21:49 living-room volumio[1167]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Jun 02 11:21:50 living-room volumio[1167]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Jun 02 11:21:50 living-room volumio[1167]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... Jun 02 11:21:50 living-room volumio[1167]: info: Preparing to generate the ALSA configuration file Jun 02 11:21:52 living-room dbus-daemon[679]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30007ms) Jun 02 11:21:52 living-room volumio[1167]: info: AutoStart - Check #9/60 - VOLUMIO_SYSTEM_STATUS = starting Jun 02 11:21:52 living-room volumio[1167]: error: MyVolumio Plugins failed to start in a timely fashion Jun 02 11:21:52 living-room volumio[1167]: error: Plugin audio_interface bluetooth failed to complete 'onStart' in a timely fashion Jun 02 11:21:52 living-room volumio[1167]: error: Plugin audio_interface multiroom failed to complete 'onStart' in a timely fashion Jun 02 11:21:52 living-room volumio[1167]: error: Plugin music_service cd_controller failed to complete 'onStart' in a timely fashion Jun 02 11:21:52 living-room volumio[1167]: error: Plugin music_service tidalconnect failed to complete 'onStart' in a timely fashion Jun 02 11:21:52 living-room volumio[1167]: error: Plugin music_service qobuzconnect failed to complete 'onStart' in a timely fashion Jun 02 11:21:52 living-room volumio[1167]: [Metrics] CommandRouter: 120s 614.94ms Jun 02 11:21:52 living-room volumio[1167]: info: CoreCommandRouter::volumiosetStartupVolume Jun 02 11:21:52 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 11:21:52 living-room volumio[1167]: info: VolumeController:: Setting startup Volume 25 Jun 02 11:21:52 living-room volumio[1167]: info: VolumeController::SetAlsaVolume25 Jun 02 11:21:52 living-room volumio[1167]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 11:21:52 living-room volumio[1167]: info: CoreCommandRouter::Close All Modals sent Jun 02 11:21:52 living-room volumio[1167]: info: CoreCommandRouter::Close All Modals sent Jun 02 11:21:52 living-room volumio[1167]: info: CoreStateMachine::pushState Jun 02 11:21:52 living-room volumio[1167]: info: CorePlayQueue::getTrack 0 Jun 02 11:21:52 living-room volumio[1167]: info: CoreCommandRouter::volumioPushState Jun 02 11:21:53 living-room volumio[1167]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 02 11:21:53 living-room volumio[1167]: info: Reading ALSA contributions from plugins. Jun 02 11:21:54 living-room volumio[1167]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 11:21:54 living-room volumio[1167]: Error: write EPIPE Jun 02 11:21:54 living-room volumio[1167]: at afterWriteDispatched (node:internal/stream_base_commons:160:15) Jun 02 11:21:54 living-room volumio[1167]: at writeGeneric (node:internal/stream_base_commons:151:3) Jun 02 11:21:54 living-room volumio[1167]: at Socket._writeGeneric (node:net:952:11) Jun 02 11:21:54 living-room volumio[1167]: at Socket._write (node:net:964:8) Jun 02 11:21:54 living-room volumio[1167]: at writeOrBuffer (node:internal/streams/writable:399:12) Jun 02 11:21:54 living-room volumio[1167]: at _write (node:internal/streams/writable:340:10) Jun 02 11:21:54 living-room volumio[1167]: at Writable.write (node:internal/streams/writable:344:10) Jun 02 11:21:54 living-room volumio[1167]: at auth (/myvolumio/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/handshake.js:67:10) Jun 02 11:21:54 living-room volumio[1167]: at Socket. (/myvolumio/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/connection.js:137:32) Jun 02 11:21:54 living-room volumio[1167]: at Object.onceWrapper (node:events:628:28) Jun 02 11:21:54 living-room volumio[1167]: at Socket.emit (node:events:514:28) Jun 02 11:21:54 living-room volumio[1167]: at PipeConnectWrap.afterConnect [as oncomplete] (node:net:1580:10) { Jun 02 11:21:54 living-room volumio[1167]: errno: -32, Jun 02 11:21:54 living-room volumio[1167]: code: 'EPIPE', Jun 02 11:21:54 living-room volumio[1167]: syscall: 'write' Jun 02 11:21:54 living-room volumio[1167]: } Jun 02 11:21:54 living-room volumio[1167]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 11:22:08 living-room sudo[1801]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-06-02 11:21' Jun 02 11:22:08 living-room sudo[1801]: 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"