Feb 24 06:04:00 volumio volumio[1146]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Feb 24 06:04:00 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Feb 24 06:04:00 volumio volumio[1146]: info: CorePlayQueue::getTrack 0 Feb 24 06:04:00 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 24 06:04:00 volumio volumio[1146]: info: CoreCommandRouter::volumioGetVisibleSources Feb 24 06:04:00 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 24 06:04:00 volumio volumio[1146]: info: Listing playlists Feb 24 06:04:00 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 24 06:04:00 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 24 06:04:00 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 24 06:04:00 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 24 06:04:03 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 24 06:04:03 volumio volumio[1146]: info: Received Get System Info Feb 24 06:04:03 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 24 06:04:03 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 24 06:04:03 volumio volumio[1146]: info: Discovery: Getting this device information Feb 24 06:04:03 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Feb 24 06:04:03 volumio volumio[1146]: info: CorePlayQueue::getTrack 0 Feb 24 06:04:03 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 24 06:04:03 volumio sudo[1848]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 24 06:04:03 volumio sudo[1848]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 24 06:04:03 volumio sudo[1846]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 24 06:04:03 volumio sudo[1846]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 24 06:04:03 volumio sudo[1846]: pam_unix(sudo:session): session closed for user root Feb 24 06:04:03 volumio sudo[1853]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Feb 24 06:04:03 volumio sudo[1853]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 24 06:04:03 volumio sudo[1848]: pam_unix(sudo:session): session closed for user root Feb 24 06:04:03 volumio volumio[1146]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Feb 24 06:04:03 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 1. Feb 24 06:04:03 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Feb 24 06:04:03 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Feb 24 06:04:03 volumio sudo[1853]: pam_unix(sudo:session): session closed for user root Feb 24 06:04:03 volumio volumio[1146]: info: Upmpdcli Daemon Started Feb 24 06:04:05 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 24 06:04:05 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 24 06:04:05 volumio volumio[1146]: info: CoreCommandRouter::volumioGetQueue Feb 24 06:04:05 volumio volumio[1146]: info: CoreStateMachine::getQueue Feb 24 06:04:05 volumio volumio[1146]: info: CorePlayQueue::getQueue Feb 24 06:04:05 volumio volumio[1146]: info: Preload queue cleared Feb 24 06:04:05 volumio volumio[1146]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=x86_amd64&variante=volumio&version=4.096&uuid=facde91daed0f386f2287269505c1baa" http://updates.volumio.org/downloader-v1/track-device Feb 24 06:04:05 volumio volumio[1146]: % Total % Received % Xferd Average Speed Time Time Time Current Feb 24 06:04:05 volumio volumio[1146]: Dload Upload Total Spent Left Speed Feb 24 06:04:05 volumio volumio[1146]: [132B blob data] Feb 24 06:04:05 volumio volumio[1146]: retrying in 5 seconds, trial 0 Feb 24 06:04:05 volumio volumio[1146]: info: Volumio Calling Home Feb 24 06:04:15 volumio volumio[1146]: Searching plugin music_service/webradio Feb 24 06:04:15 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: webradio , search Feb 24 06:04:15 volumio volumio[1146]: info: SHOUTCASTのクエリ中にエラーが発生しました Feb 24 06:04:15 volumio volumio[1146]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=x86_amd64&variante=volumio&version=4.096&uuid=facde91daed0f386f2287269505c1baa" http://updates.volumio.org/downloader-v1/track-device Feb 24 06:04:15 volumio volumio[1146]: % Total % Received % Xferd Average Speed Time Time Time Current Feb 24 06:04:15 volumio volumio[1146]: Dload Upload Total Spent Left Speed Feb 24 06:04:15 volumio volumio[1146]: [132B blob data] Feb 24 06:04:15 volumio volumio[1146]: retrying in 5 seconds, trial 1 Feb 24 06:04:15 volumio volumio[1146]: info: Volumio Calling Home Feb 24 06:04:16 volumio systemd[1]: systemd-fsckd.service: Deactivated successfully. Feb 24 06:04:16 volumio volumio[1146]: Searching plugin music_service/webradio Feb 24 06:04:16 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: webradio , search Feb 24 06:04:16 volumio volumio[1146]: info: SHOUTCASTのクエリ中にエラーが発生しました Feb 24 06:04:17 volumio dhcpcd[874]: timed out Feb 24 06:04:17 volumio sh[860]: timed out Feb 24 06:04:17 volumio dhcpcd[874]: dhcpcd exited Feb 24 06:04:17 volumio sh[783]: ifup: failed to bring up eth0 Feb 24 06:04:17 volumio systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Feb 24 06:04:17 volumio ifplugd(eth0)[1087]: client: command failed: No such device (-19) Feb 24 06:04:17 volumio systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Feb 24 06:04:17 volumio ifplugd(eth0)[1087]: client: sending commands to dhcpcd process Feb 24 06:04:17 volumio dhcpcd[971]: control command: dhcpcd eth0 Feb 24 06:04:17 volumio dhcpcd[971]: control_free: No such file or directory Feb 24 06:04:17 volumio ifplugd(eth0)[1087]: Program executed successfully. Feb 24 06:04:17 volumio ifplugd[1000]: Network Interface Plugging Daemon...start eth0...done. Feb 24 06:04:17 volumio systemd[1]: Started ifplugd.service - LSB: Brings up/down network automatically. Feb 24 06:04:18 volumio volumio[1146]: error: MyVolumio Plugin failed to start in a timely fashion Feb 24 06:04:18 volumio volumio[1146]: [Metrics] CommandRouter: 26s 917.92ms Feb 24 06:04:18 volumio volumio[1146]: info: CoreCommandRouter::volumiosetStartupVolume Feb 24 06:04:18 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 24 06:04:18 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 24 06:04:18 volumio volumio[1146]: info: CoreCommandRouter::Close All Modals sent Feb 24 06:04:18 volumio volumio[1146]: info: CoreCommandRouter::Close All Modals sent Feb 24 06:04:18 volumio volumio[1146]: Searching plugin music_service/webradio Feb 24 06:04:18 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: webradio , search Feb 24 06:04:18 volumio volumio[1146]: info: SHOUTCASTのクエリ中にエラーが発生しました Feb 24 06:04:19 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Feb 24 06:04:19 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 24 06:04:19 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Feb 24 06:04:19 volumio volumio[1146]: Searching plugin music_service/webradio Feb 24 06:04:19 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: webradio , search Feb 24 06:04:19 volumio volumio[1146]: info: SHOUTCASTのクエリ中にエラーが発生しました Feb 24 06:04:21 volumio volumio[1146]: Searching plugin music_service/webradio Feb 24 06:04:21 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: webradio , search Feb 24 06:04:21 volumio volumio[1146]: info: SHOUTCASTのクエリ中にエラーが発生しました Feb 24 06:04:25 volumio volumio[1146]: info: BOOT COMPLETED Feb 24 06:04:25 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 24 06:04:25 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 24 06:04:25 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 24 06:04:25 volumio volumio[1146]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=x86_amd64&variante=volumio&version=4.096&uuid=facde91daed0f386f2287269505c1baa" http://updates.volumio.org/downloader-v1/track-device Feb 24 06:04:25 volumio volumio[1146]: % Total % Received % Xferd Average Speed Time Time Time Current Feb 24 06:04:25 volumio volumio[1146]: Dload Upload Total Spent Left Speed Feb 24 06:04:25 volumio volumio[1146]: [132B blob data] Feb 24 06:04:25 volumio volumio[1146]: retrying in 5 seconds, trial 2 Feb 24 06:04:25 volumio volumio[1146]: info: Volumio Calling Home Feb 24 06:04:26 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Feb 24 06:04:26 volumio systemd[1]: systemd-hostnamed.service: Deactivated successfully. Feb 24 06:04:32 volumio bash[1981]: setdatetime-helper: all HTTPS Date fallbacks failed Feb 24 06:04:32 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Feb 24 06:04:32 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Feb 24 06:05:03 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Feb 24 06:05:03 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Feb 24 06:05:08 volumio dhcpcd[971]: eth0: carrier lost Feb 24 06:05:08 volumio ifplugd(eth0)[1087]: Link beat lost. Feb 24 06:05:08 volumio volumio[1146]: info: Received Get System Info Feb 24 06:05:08 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 24 06:05:08 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 24 06:05:08 volumio volumio[1146]: info: Discovery: Getting this device information Feb 24 06:05:08 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Feb 24 06:05:08 volumio volumio[1146]: info: CorePlayQueue::getTrack 0 Feb 24 06:05:08 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 24 06:05:08 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 24 06:05:08 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 24 06:05:10 volumio dhcpcd[971]: eth0: carrier acquired Feb 24 06:05:10 volumio dhcpcd[971]: eth0: IAID 3b:8c:13:e8 Feb 24 06:05:11 volumio volumio[1146]: info: Received Get System Info Feb 24 06:05:11 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 24 06:05:11 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 24 06:05:11 volumio volumio[1146]: info: Discovery: Getting this device information Feb 24 06:05:11 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Feb 24 06:05:11 volumio volumio[1146]: info: CorePlayQueue::getTrack 0 Feb 24 06:05:11 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 24 06:05:11 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 24 06:05:11 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 24 06:05:11 volumio ifplugd(eth0)[1087]: Link beat detected. Feb 24 06:05:11 volumio dhcpcd[971]: eth0: soliciting a DHCP lease Feb 24 06:05:11 volumio dhcpcd[971]: eth0: probing address 10.248.7.158/24 Feb 24 06:05:11 volumio dhcpcd[971]: eth0: soliciting an IPv6 router Feb 24 06:05:16 volumio dhcpcd[971]: eth0: leased 10.248.7.158 for 3599 seconds Feb 24 06:05:16 volumio avahi-daemon[934]: Joining mDNS multicast group on interface eth0.IPv4 with address 10.248.7.158. Feb 24 06:05:16 volumio dhcpcd[971]: eth0: adding route to 10.248.7.0/24 Feb 24 06:05:16 volumio avahi-daemon[934]: New relevant interface eth0.IPv4 for mDNS. Feb 24 06:05:16 volumio avahi-daemon[934]: Registering new address record for 10.248.7.158 on eth0.IPv4. Feb 24 06:05:16 volumio dhcpcd[971]: eth0: adding default route via 10.248.7.134 Feb 24 06:05:16 volumio systemd[1]: welcome.service: Deactivated successfully. Feb 24 06:05:16 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Feb 24 06:05:16 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Feb 24 06:05:16 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Feb 24 06:05:16 volumio welcome[2177]: Resolved ip:[1] 10.248.7.158 Feb 24 06:05:16 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Feb 24 06:05:16 volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Feb 24 06:05:16 volumio systemd[1]: Started nmbd.service - Samba NMB Daemon. Feb 24 06:05:16 volumio systemd[1]: Starting winbind.service - Samba Winbind Daemon... Feb 24 06:05:16 volumio winbindd[2192]: [2026/02/24 06:05:16.455487, 0] ../../source3/winbindd/winbindd.c:1440(main) Feb 24 06:05:16 volumio winbindd[2192]: winbindd version 4.17.12-Debian started. Feb 24 06:05:16 volumio winbindd[2192]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Feb 24 06:05:16 volumio winbindd[2192]: [2026/02/24 06:05:16.464141, 0] ../../source3/winbindd/winbindd_cache.c:3117(initialize_winbindd_cache) Feb 24 06:05:16 volumio winbindd[2192]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Feb 24 06:05:16 volumio systemd[1]: Started winbind.service - Samba Winbind Daemon. Feb 24 06:05:16 volumio systemd[1]: Starting smbd.service - Samba SMB Daemon... Feb 24 06:05:16 volumio volumio[1146]: info: Received Get System Info Feb 24 06:05:16 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 24 06:05:16 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 24 06:05:16 volumio volumio[1146]: info: Discovery: Getting this device information Feb 24 06:05:16 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Feb 24 06:05:16 volumio volumio[1146]: info: CorePlayQueue::getTrack 0 Feb 24 06:05:16 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 24 06:05:16 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 24 06:05:16 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 24 06:05:16 volumio smbd[2201]: [2026/02/24 06:05:16.734884, 0] ../../source3/smbd/server.c:1741(main) Feb 24 06:05:16 volumio smbd[2201]: smbd version 4.17.12-Debian started. Feb 24 06:05:16 volumio smbd[2201]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Feb 24 06:05:17 volumio systemd[1]: Started smbd.service - Samba SMB Daemon. Feb 24 06:05:17 volumio systemd[1]: Reached target multi-user.target - Multi-User System. Feb 24 06:05:17 volumio systemd[1]: Reached target graphical.target - Graphical Interface. Feb 24 06:05:17 volumio systemd[1]: Starting systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP... Feb 24 06:05:17 volumio systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Feb 24 06:05:17 volumio systemd[1]: Finished systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP. Feb 24 06:05:17 volumio systemd[1]: Startup finished in 11.893s (firmware) + 2.942s (loader) + 20.915s (kernel) + 1min 32.207s (userspace) = 2min 7.959s. Feb 24 06:05:17 volumio volumio[1146]: info: Discovery: this is already registered, 2e8d88df-04af-461c-90da-41fb73e16324 Feb 24 06:05:17 volumio volumio[1146]: info: Discovery: Found device Volumio Feb 24 06:05:17 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Feb 24 06:05:17 volumio volumio[1146]: info: CorePlayQueue::getTrack 0 Feb 24 06:05:17 volumio ntpd[1033]: IO: Listen normally on 3 eth0 10.248.7.158:123 Feb 24 06:05:17 volumio ntpd[1033]: IO: new interface(s) found: waking up resolver Feb 24 06:05:17 volumio ntpd[1033]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Feb 24 06:05:17 volumio ntpd[1033]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Feb 24 06:05:17 volumio ntpd[1033]: DNS: Pool taking: 45.76.211.39 Feb 24 06:05:17 volumio ntpd[1033]: DNS: Pool taking: 157.7.213.62 Feb 24 06:05:17 volumio ntpd[1033]: DNS: Pool taking: 43.167.237.61 Feb 24 06:05:17 volumio ntpd[1033]: DNS: Pool taking: 162.159.200.123 Feb 24 06:05:17 volumio ntpd[1033]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 Feb 24 06:05:18 volumio ntpd[1033]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Feb 24 06:05:18 volumio ntpd[1033]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Feb 24 06:05:18 volumio ntpd[1033]: DNS: Pool taking: 162.159.200.1 Feb 24 06:05:18 volumio ntpd[1033]: DNS: Pool taking: 172.233.91.137 Feb 24 06:05:18 volumio ntpd[1033]: DNS: Pool taking: 129.250.35.251 Feb 24 06:05:18 volumio ntpd[1033]: DNS: Pool taking: 165.140.142.8 Feb 24 06:05:18 volumio ntpd[1033]: DNS: Pool taking: 2001:418:3ff::1:53 Feb 24 06:05:18 volumio ntpd[1033]: DNS: Pool taking: 2a06:a880:3:4915::123 Feb 24 06:05:18 volumio ntpd[1033]: DNS: Pool taking: 2a06:a880:3:bb1e::123 Feb 24 06:05:18 volumio ntpd[1033]: DNS: Pool taking: 240b:4009:272:9c06:def8:1b59:32ba:d5f Feb 24 06:05:18 volumio ntpd[1033]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 Feb 24 06:05:18 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2. Feb 24 06:05:18 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Feb 24 06:05:18 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Feb 24 06:05:19 volumio volumio[1146]: info: Adding plugin bluetooth to MyMusic Plugins Feb 24 06:05:19 volumio volumio[1146]: info: Adding plugin multiroom to MyMusic Plugins Feb 24 06:05:19 volumio volumio[1146]: info: Adding plugin metavolumio to MyMusic Plugins Feb 24 06:05:19 volumio volumio[1146]: info: Adding plugin cd_controller to MyMusic Plugins Feb 24 06:05:19 volumio volumio[1146]: info: Adding plugin qobuzconnect to MyMusic Plugins Feb 24 06:05:19 volumio volumio[1146]: info: Adding plugin smart_inputs to MyMusic Plugins Feb 24 06:05:19 volumio volumio[1146]: info: Adding plugin tidalconnect to MyMusic Plugins Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Feb 24 06:05:19 volumio ntpd[1033]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Feb 24 06:05:19 volumio ntpd[1033]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Feb 24 06:05:19 volumio ntpd[1033]: DNS: Pool taking: 172.105.192.74 Feb 24 06:05:19 volumio ntpd[1033]: DNS: Pool taking: 167.179.119.205 Feb 24 06:05:19 volumio ntpd[1033]: DNS: Pool taking: 172.104.124.149 Feb 24 06:05:19 volumio ntpd[1033]: DNS: Pool taking: 45.88.43.100 Feb 24 06:05:19 volumio ntpd[1033]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Feb 24 06:05:19 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 24 06:05:19 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 24 06:05:19 volumio volumio[1146]: info: Starting MyVolumio Remote Streaming Endpoints Feb 24 06:05:19 volumio volumio[1146]: info: MyVolumio login type: Token Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Feb 24 06:05:19 volumio volumio[1146]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Feb 24 06:05:20 volumio volumio[1146]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Feb 24 06:05:20 volumio volumio[1146]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Feb 24 06:05:20 volumio volumio[1146]: info: Streaming services startup Feb 24 06:05:20 volumio volumio[1146]: info: Starting Streaming Daemon Feb 24 06:05:20 volumio sudo[2244]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 24 06:05:20 volumio sudo[2244]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 24 06:05:20 volumio volumio[1146]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Feb 24 06:05:20 volumio sudo[2244]: pam_unix(sudo:session): session closed for user root Feb 24 06:05:20 volumio volumio[1146]: error: Cannot start Volumio Streaming Daemon Feb 24 06:05:20 volumio volumio[1146]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 24 06:05:20 volumio volumio[1146]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 24 06:05:20 volumio ntpd[1033]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Feb 24 06:05:20 volumio volumio[1146]: error: MyVolumio Custom Token format not valid, refreshing it Feb 24 06:05:20 volumio ntpd[1033]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Feb 24 06:05:20 volumio ntpd[1033]: DNS: Pool skipping: 157.7.213.62 Feb 24 06:05:20 volumio ntpd[1033]: DNS: Pool skipping: 165.140.142.8 Feb 24 06:05:20 volumio ntpd[1033]: DNS: Pool skipping: 172.105.192.74 Feb 24 06:05:20 volumio ntpd[1033]: DNS: Pool skipping: 167.179.119.205 Feb 24 06:05:20 volumio ntpd[1033]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 Feb 24 06:05:21 volumio upmpdcli[2251]: writing RSA key Feb 24 06:05:22 volumio volumio[1146]: info: MyVolumio login type: Token Feb 24 06:05:22 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 24 06:05:22 volumio volumio[1146]: info: Received Get System Info Feb 24 06:05:22 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 24 06:05:22 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 24 06:05:22 volumio volumio[1146]: info: Discovery: Getting this device information Feb 24 06:05:22 volumio volumio[1146]: info: CoreCommandRouter::volumioGetState Feb 24 06:05:22 volumio volumio[1146]: info: CorePlayQueue::getTrack 0 Feb 24 06:05:22 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 24 06:05:22 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Feb 24 06:05:22 volumio volumio[1146]: info: MyVolumio login type: Token Feb 24 06:05:22 volumio volumio[1146]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 24 06:05:22 volumio volumio[1146]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Feb 24 06:05:22 volumio volumio[1146]: info: Volumio Network Manager: Network status updated: 1 Feb 24 06:05:23 volumio volumio[1146]: info: MyVolumio token set successfully Feb 24 06:05:23 volumio volumio[1146]: info: MYVOLUMIO: Adding device Feb 24 06:05:23 volumio volumio[1146]: info: MYVOLUMIO: Evaluating Server Feb 24 06:05:23 volumio volumio[1146]: info: MyVolumio Plan changed: premium Feb 24 06:05:23 volumio volumio[1146]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Feb 24 06:05:23 volumio volumio[1146]: info: Removing browser output: myVolumio user plan is not superstar Feb 24 06:05:23 volumio volumio[1146]: info: Removing audio output: Feb 24 06:05:23 volumio volumio[1146]: info: MYVOLUMIO: Adding device Feb 24 06:05:23 volumio volumio[1146]: info: MYVOLUMIO: Evaluating Server Feb 24 06:05:23 volumio volumio[1146]: info: Remote config written successfully Feb 24 06:05:23 volumio volumio[1146]: info: Starting Tunnel 1 Feb 24 06:05:23 volumio volumio[1146]: info: Starting Tunnel Connection Checker Feb 24 06:05:22 volumio ntpd[1033]: CLOCK: time stepped by -0.886873 Feb 24 06:05:22 volumio systemd-journald[588]: Time jumped backwards, rotating. Feb 24 06:05:22 volumio ntpd[1033]: INIT: MRU 10922 entries, 13 hash bits, 65536 bytes Feb 24 06:05:22 volumio volumio[1146]: error: Failed to ping endpoint as1.myvolumio.org : unknown error Feb 24 06:05:22 volumio volumio[1146]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 24 06:05:22 volumio volumio[1146]: Error: Unable to resolve or reject the same promise twice Feb 24 06:05:22 volumio volumio[1146]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Feb 24 06:05:22 volumio volumio[1146]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32371) Feb 24 06:05:22 volumio volumio[1146]: at Socket.emit (node:events:514:28) Feb 24 06:05:22 volumio volumio[1146]: at addChunk (node:internal/streams/readable:343:12) Feb 24 06:05:22 volumio volumio[1146]: at readableAddChunk (node:internal/streams/readable:316:9) Feb 24 06:05:22 volumio volumio[1146]: at Readable.push (node:internal/streams/readable:253:10) Feb 24 06:05:22 volumio volumio[1146]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Feb 24 06:05:22 volumio volumio[1146]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 24 06:05:23 volumio sudo[2308]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-24 06:04' Feb 24 06:05:23 volumio sudo[2308]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:31:57 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6759e875c98b942866984e844891d6c1"