Aug 25 21:22:00 volumio volumio[1184]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Aug 25 21:22:00 volumio volumio[1184]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Aug 25 21:22:00 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 21:22:00 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 21:22:00 volumio volumio[1184]: info: Starting MyVolumio Remote Streaming Endpoints Aug 25 21:22:00 volumio volumio[1184]: info: MyVolumio login type: Token Aug 25 21:22:00 volumio volumio[1184]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Aug 25 21:22:00 volumio volumio[1184]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Aug 25 21:22:08 volumio volumio[1184]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Aug 25 21:22:08 volumio volumio[1184]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Aug 25 21:22:08 volumio volumio[1184]: info: Streaming services startup Aug 25 21:22:08 volumio volumio[1184]: info: Starting Streaming Daemon Aug 25 21:22:08 volumio sudo[1697]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 25 21:22:08 volumio sudo[1697]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 21:22:08 volumio volumio[1184]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Aug 25 21:22:09 volumio sudo[1697]: pam_unix(sudo:session): session closed for user root Aug 25 21:22:09 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 25 21:22:09 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 21:22:09 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 25 21:22:09 volumio volumio[1184]: error: Cannot start Volumio Streaming Daemon Aug 25 21:22:09 volumio volumio[1184]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 25 21:22:09 volumio volumio[1184]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Aug 25 21:22:10 volumio volumio[1184]: error: MyVolumio Custom Token format not valid, refreshing it Aug 25 21:22:12 volumio volumio-remote-updater[695]: Test mode disabled Aug 25 21:22:12 volumio volumio-remote-updater[695]: Alpha mode disabled Aug 25 21:22:12 volumio volumio-remote-updater[695]: Alpha legacy test mode disabled Aug 25 21:22:12 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Aug 25 21:22:13 volumio volumio[1184]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Aug 25 21:22:13 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Aug 25 21:22:14 volumio volumio[1184]: info: MyVolumio login type: Token Aug 25 21:22:15 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 25 21:22:15 volumio volumio[1184]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Aug 25 21:22:16 volumio volumio[1184]: info: CoreCommandRouter::volumioGetState Aug 25 21:22:16 volumio volumio[1184]: info: CorePlayQueue::getTrack 0 Aug 25 21:22:17 volumio volumio[1184]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Aug 25 21:22:18 volumio volumio[1184]: info: MyVolumio token set successfully Aug 25 21:22:18 volumio volumio[1184]: info: MYVOLUMIO: Adding device Aug 25 21:22:18 volumio volumio[1184]: info: MYVOLUMIO: Evaluating Server Aug 25 21:22:20 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 21:22:20 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 21:22:20 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Aug 25 21:22:20 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Aug 25 21:22:20 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 25 21:22:20 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Aug 25 21:22:20 volumio volumio[1184]: info: CoreCommandRouter::volumioGetBrowseSources Aug 25 21:22:20 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 25 21:22:20 volumio volumio[1184]: info: MyVolumio Plan changed: premium Aug 25 21:22:20 volumio volumio[1184]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Aug 25 21:22:20 volumio volumio[1184]: info: Removing browser output: myVolumio user plan is not superstar Aug 25 21:22:20 volumio volumio[1184]: info: Removing audio output: Aug 25 21:22:20 volumio volumio[1184]: info: MYVOLUMIO: Adding device Aug 25 21:22:20 volumio volumio[1184]: info: MYVOLUMIO: Evaluating Server Aug 25 21:22:22 volumio volumio[1184]: info: Setting Geolocation for MyVolumio to as1 Aug 25 21:22:22 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 21:22:22 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 21:22:22 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 21:22:23 volumio volumio[1184]: info: Setting Geolocation for MyVolumio to as1 Aug 25 21:22:23 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 21:22:23 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 21:22:23 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 21:22:23 volumio volumio[1184]: info: Successfully Added MyVolumio device Aug 25 21:22:23 volumio volumio[1184]: info: Remote config written successfully Aug 25 21:22:23 volumio volumio[1184]: info: Starting Tunnel 1 Aug 25 21:22:23 volumio volumio[1184]: info: Starting Tunnel Connection Checker Aug 25 21:22:24 volumio volumio[1184]: info: Completed starting MyVolumio Plugin Aug 25 21:22:24 volumio volumio[1184]: info: Updating MyVolumio device info Aug 25 21:22:24 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 21:22:24 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 21:22:24 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 21:22:24 volumio volumio[1184]: info: MYVolumio Device enabled Aug 25 21:22:24 volumio volumio[1184]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Aug 25 21:22:24 volumio volumio[1184]: info: MyVolumio status changed Aug 25 21:22:24 volumio volumio[1184]: info: Streaming services startup Aug 25 21:22:24 volumio volumio[1184]: info: Starting Streaming Daemon Aug 25 21:22:24 volumio volumio[1184]: info: Successfully Added MyVolumio device Aug 25 21:22:24 volumio sudo[1780]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 25 21:22:24 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Aug 25 21:22:24 volumio sudo[1780]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 21:22:24 volumio volumio[1184]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Aug 25 21:22:25 volumio sudo[1780]: pam_unix(sudo:session): session closed for user root Aug 25 21:22:28 volumio volumio[1184]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin bluetooth Aug 25 21:22:28 volumio volumio[1184]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin bluetooth Aug 25 21:22:28 volumio volumio[1184]: ------------------------------------ BT MESSAGE: [FUNC] onVolumioStart Aug 25 21:22:28 volumio volumio[1184]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Aug 25 21:22:52 volumio volumio[1184]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Aug 25 21:22:53 volumio sudo[1827]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Aug 25 21:22:53 volumio sudo[1827]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 21:22:53 volumio sudo[1827]: pam_unix(sudo:session): session closed for user root Aug 25 21:22:54 volumio volumio[1184]: info: MRS: MultiRoom plugin initialized Aug 25 21:22:54 volumio volumio[1184]: info: MRS: STOPPING SNAPCLIENT Aug 25 21:22:54 volumio volumio[1184]: info: MRS: Snap server stop Aug 25 21:22:54 volumio volumio[1184]: info: MRS: STOPPING volumioStreaming Aug 25 21:22:54 volumio sudo[1844]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Aug 25 21:22:54 volumio volumio[1184]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Aug 25 21:22:54 volumio sudo[1844]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 21:22:54 volumio sudo[1846]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Aug 25 21:22:54 volumio sudo[1846]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 21:22:54 volumio sudo[1848]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Aug 25 21:22:54 volumio sudo[1848]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 21:22:55 volumio sudo[1844]: pam_unix(sudo:session): session closed for user root Aug 25 21:22:55 volumio volumio[1184]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Aug 25 21:22:55 volumio sudo[1851]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Aug 25 21:22:55 volumio sudo[1851]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 21:22:55 volumio sudo[1851]: pam_unix(sudo:session): session closed for user root Aug 25 21:22:55 volumio sudo[1848]: pam_unix(sudo:session): session closed for user root Aug 25 21:22:55 volumio sudo[1846]: pam_unix(sudo:session): session closed for user root Aug 25 21:22:55 volumio volumio[1184]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Aug 25 21:22:55 volumio volumio[1184]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Aug 25 21:22:56 volumio volumio[1184]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Aug 25 21:22:56 volumio volumio[1184]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Aug 25 21:22:56 volumio volumio[1184]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Aug 25 21:22:56 volumio volumio[1184]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Aug 25 21:22:57 volumio volumio[1184]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Aug 25 21:22:57 volumio volumio[1184]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... Aug 25 21:22:58 volumio volumio[1184]: info: Preparing to generate the ALSA configuration file Aug 25 21:22:58 volumio dbus-daemon[684]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30002ms) Aug 25 21:22:58 volumio volumio[1184]: info: Updating MyVolumio device info Aug 25 21:22:58 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 21:22:58 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 21:22:58 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 21:22:58 volumio volumio[1184]: error: MyVolumio Plugins failed to start in a timely fashion Aug 25 21:22:58 volumio volumio[1184]: [Metrics] CommandRouter: 120s 406.96ms Aug 25 21:22:58 volumio volumio[1184]: info: CoreCommandRouter::volumiosetStartupVolume Aug 25 21:22:58 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 21:22:58 volumio volumio[1184]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 21:22:58 volumio volumio[1184]: info: CoreCommandRouter::Close All Modals sent Aug 25 21:22:58 volumio volumio[1184]: info: CoreCommandRouter::Close All Modals sent Aug 25 21:22:58 volumio volumio[1184]: error: Failed to update MyVolumio device: undefined Aug 25 21:22:59 volumio volumio[1184]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Aug 25 21:22:59 volumio volumio[1184]: info: Reading ALSA contributions from plugins. Aug 25 21:22:59 volumio volumio[1184]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 21:22:59 volumio volumio[1184]: Error: write EPIPE Aug 25 21:22:59 volumio volumio[1184]: at afterWriteDispatched (node:internal/stream_base_commons:160:15) Aug 25 21:22:59 volumio volumio[1184]: at writeGeneric (node:internal/stream_base_commons:151:3) Aug 25 21:22:59 volumio volumio[1184]: at Socket._writeGeneric (node:net:952:11) Aug 25 21:22:59 volumio volumio[1184]: at Socket._write (node:net:964:8) Aug 25 21:22:59 volumio volumio[1184]: at writeOrBuffer (node:internal/streams/writable:399:12) Aug 25 21:22:59 volumio volumio[1184]: at _write (node:internal/streams/writable:340:10) Aug 25 21:22:59 volumio volumio[1184]: at Writable.write (node:internal/streams/writable:344:10) Aug 25 21:22:59 volumio volumio[1184]: at auth (/myvolumio/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/handshake.js:67:10) Aug 25 21:22:59 volumio volumio[1184]: at Socket. (/myvolumio/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/connection.js:137:32) Aug 25 21:22:59 volumio volumio[1184]: at Object.onceWrapper (node:events:628:28) Aug 25 21:22:59 volumio volumio[1184]: at Socket.emit (node:events:514:28) Aug 25 21:22:59 volumio volumio[1184]: at PipeConnectWrap.afterConnect [as oncomplete] (node:net:1580:10) { Aug 25 21:22:59 volumio volumio[1184]: errno: -32, Aug 25 21:22:59 volumio volumio[1184]: code: 'EPIPE', Aug 25 21:22:59 volumio volumio[1184]: syscall: 'write' Aug 25 21:22:59 volumio volumio[1184]: } Aug 25 21:22:59 volumio volumio[1184]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 21:23:05 volumio kernel: hwmon hwmon1: Voltage normalised Aug 25 21:23:09 volumio sudo[1886]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-25 21:22' Aug 25 21:23:09 volumio sudo[1886]: 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"