Oct 13 13:11:02 volumio upmpdcli[1971]: writing RSA key Oct 13 13:11:02 volumio volumio[1100]: 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: 5 Oct 13 13:11:03 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 13 13:11:03 volumio volumio[1100]: info: CoreCommandRouter::volumioGetVisibleSources Oct 13 13:11:03 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 13:11:03 volumio volumio[1100]: info: CoreCommandRouter::volumioGetState Oct 13 13:11:03 volumio volumio[1100]: info: CorePlayQueue::getTrack 0 Oct 13 13:11:03 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 13 13:11:03 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 13 13:11:03 volumio volumio[1100]: info: Received Get System Info Oct 13 13:11:03 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 13 13:11:03 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 13 13:11:03 volumio volumio[1100]: info: Discovery: Getting this device information Oct 13 13:11:03 volumio volumio[1100]: info: CoreCommandRouter::volumioGetState Oct 13 13:11:03 volumio volumio[1100]: info: CorePlayQueue::getTrack 0 Oct 13 13:11:03 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 13 13:11:03 volumio volumio[1100]: info: CoreCommandRouter::volumioGetState Oct 13 13:11:03 volumio volumio[1100]: info: CorePlayQueue::getTrack 0 Oct 13 13:11:03 volumio volumio[1100]: info: Listing playlists Oct 13 13:11:03 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 13 13:11:03 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 13 13:11:03 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 13 13:11:03 volumio volumio[1100]: info: Received Get System Info Oct 13 13:11:03 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 13 13:11:03 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 13 13:11:03 volumio volumio[1100]: info: Discovery: Getting this device information Oct 13 13:11:03 volumio volumio[1100]: info: CoreCommandRouter::volumioGetState Oct 13 13:11:03 volumio volumio[1100]: info: CorePlayQueue::getTrack 0 Oct 13 13:11:03 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 13 13:11:03 volumio volumio[1100]: info: CoreCommandRouter::volumioGetState Oct 13 13:11:03 volumio volumio[1100]: info: CorePlayQueue::getTrack 0 Oct 13 13:11:05 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 13 13:11:05 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 13 13:11:05 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 13:11:05 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 13 13:11:07 volumio systemd[1]: systemd-hostnamed.service: Deactivated successfully. Oct 13 13:11:07 volumio volumio[1100]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=x86_amd64&variante=volumio&version=4.119&uuid=324c7bba432a0aecadb40bbbc4ebaaa0" http://updates.volumio.org/downloader-v1/track-device Oct 13 13:11:07 volumio volumio[1100]: curl: (6) Could not resolve host: updates.volumio.org Oct 13 13:11:07 volumio volumio[1100]: retrying in 5 seconds, trial 2 Oct 13 13:11:07 volumio volumio[1100]: info: Volumio Calling Home Oct 13 13:11:07 volumio volumio[1100]: error: MyVolumio Plugin failed to start in a timely fashion Oct 13 13:11:07 volumio volumio[1100]: [Metrics] CommandRouter: 46s 730.62ms Oct 13 13:11:07 volumio volumio[1100]: info: CoreCommandRouter::volumiosetStartupVolume Oct 13 13:11:07 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 13:11:07 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 13:11:07 volumio volumio[1100]: info: CoreCommandRouter::Close All Modals sent Oct 13 13:11:07 volumio volumio[1100]: info: CoreCommandRouter::Close All Modals sent Oct 13 13:11:07 volumio volumio[1100]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Oct 13 13:11:07 volumio volumio[1100]: ALSA lib confmisc.c:165:(snd_config_get_card) Cannot get card index for DACX3PRO Oct 13 13:11:07 volumio volumio[1100]: aplay: main:831: audio open error: No such device Oct 13 13:11:08 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 13 13:11:08 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 13 13:11:08 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 13 13:11:12 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 13 13:11:14 volumio volumio[1100]: info: BOOT COMPLETED Oct 13 13:11:27 volumio systemd-logind[652]: Lid opened. Oct 13 13:12:06 volumio kernel: perf: interrupt took too long (2506 > 2500), lowering kernel.perf_event_max_sample_rate to 79750 Oct 13 13:12:08 volumio dhcpcd[695]: eth0: carrier acquired Oct 13 13:12:08 volumio kernel: 8139too 0000:02:01.0 eth0: link up, 100Mbps, full-duplex, lpa 0x45E1 Oct 13 13:12:08 volumio dhcpcd[695]: eth0: IAID 38:f8:8c:85 Oct 13 13:12:08 volumio ifplugd(eth0)[915]: Link beat detected. Oct 13 13:12:08 volumio dhcpcd[695]: eth0: soliciting a DHCP lease Oct 13 13:12:08 volumio ifplugd(eth0)[915]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Oct 13 13:12:08 volumio ifplugd(eth0)[915]: client: ifup: interface eth0 already configured Oct 13 13:12:08 volumio ifplugd(eth0)[915]: Program executed successfully. Oct 13 13:12:08 volumio volumio[1100]: info: Received Get System Info Oct 13 13:12:08 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 13 13:12:08 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 13 13:12:08 volumio volumio[1100]: info: Discovery: Getting this device information Oct 13 13:12:08 volumio volumio[1100]: info: CoreCommandRouter::volumioGetState Oct 13 13:12:08 volumio volumio[1100]: info: CorePlayQueue::getTrack 0 Oct 13 13:12:08 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 13 13:12:08 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 13 13:12:08 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 13 13:12:09 volumio dhcpcd[695]: eth0: offered 192.168.1.46 from 192.168.1.1 Oct 13 13:12:09 volumio dhcpcd[695]: eth0: soliciting an IPv6 router Oct 13 13:12:09 volumio dhcpcd[695]: eth0: probing address 192.168.1.46/24 Oct 13 13:12:09 volumio wireless.js[658]: WIRELESS.JS - INFO: === SNM TRANSITION === Oct 13 13:12:09 volumio wireless.js[658]: WIRELESS.JS - INFO: Previous ethernet state: disconnected Oct 13 13:12:09 volumio wireless.js[658]: WIRELESS.JS - INFO: New ethernet state: connected Oct 13 13:12:09 volumio wireless.js[658]: WIRELESS.JS - INFO: Single Network Mode: enabled Oct 13 13:12:09 volumio wireless.js[658]: WIRELESS.JS - INFO: First start: no Oct 13 13:12:09 volumio wireless.js[658]: WIRELESS.JS - INFO: Action: Switch to ethernet (WiFi scan mode) Oct 13 13:12:09 volumio wireless.js[658]: WIRELESS.JS - INFO: === END TRANSITION === Oct 13 13:12:09 volumio wireless.js[658]: WIRELESS.JS - INFO: SNM: Ethernet connected, switching to ethernet (WiFi scan mode) Oct 13 13:12:09 volumio sudo[2166]: root : PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd -k wlan0 Oct 13 13:12:09 volumio sudo[2166]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 13 13:12:09 volumio dhcpcd[2167]: dhcpcd not running Oct 13 13:12:09 volumio sudo[2166]: pam_unix(sudo:session): session closed for user root Oct 13 13:12:09 volumio wireless.js[658]: dhcpcd not running Oct 13 13:12:09 volumio wireless.js[658]: WIRELESS.JS - INFO: Wireless.js initializing wireless flow Oct 13 13:12:09 volumio volumio5-onboarding[1593]: time=2026-10-13T13:12:09.729+03:00 level=INFO msg="service successfully established" component=discovery/localnet Oct 13 13:12:09 volumio systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Oct 13 13:12:09 volumio dnsmasq[1193]: exiting on receipt of SIGTERM Oct 13 13:12:09 volumio systemd[1]: dnsmasq.service: Deactivated successfully. Oct 13 13:12:09 volumio systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Oct 13 13:12:09 volumio dhcpcd[695]: wlan0: carrier lost Oct 13 13:12:09 volumio systemd[1]: Stopping hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Oct 13 13:12:09 volumio avahi-daemon[647]: Interface wlan0.IPv4 no longer relevant for mDNS. Oct 13 13:12:09 volumio avahi-daemon[647]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Oct 13 13:12:09 volumio avahi-daemon[647]: Withdrawing address record for 192.168.211.1 on wlan0. Oct 13 13:12:09 volumio systemd[1]: hostapd.service: Deactivated successfully. Oct 13 13:12:09 volumio avahi-daemon[647]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Oct 13 13:12:09 volumio avahi-daemon[647]: New relevant interface wlan0.IPv4 for mDNS. Oct 13 13:12:09 volumio avahi-daemon[647]: Registering new address record for 192.168.211.1 on wlan0.IPv4. Oct 13 13:12:09 volumio volumio[1100]: info: Discovery: A device disappeared from network Oct 13 13:12:09 volumio systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Oct 13 13:12:09 volumio sudo[2190]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Oct 13 13:12:09 volumio sudo[2190]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 13 13:12:09 volumio avahi-daemon[647]: Withdrawing address record for 192.168.211.1 on wlan0. Oct 13 13:12:09 volumio avahi-daemon[647]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Oct 13 13:12:09 volumio avahi-daemon[647]: Interface wlan0.IPv4 no longer relevant for mDNS. Oct 13 13:12:09 volumio sudo[2190]: pam_unix(sudo:session): session closed for user root Oct 13 13:12:09 volumio sudo[2193]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Oct 13 13:12:09 volumio sudo[2193]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 13 13:12:10 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Oct 13 13:12:10 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Oct 13 13:12:10 volumio systemd[1]: welcome.service: Deactivated successfully. Oct 13 13:12:10 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Oct 13 13:12:10 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Oct 13 13:12:10 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Oct 13 13:12:10 volumio sudo[2193]: pam_unix(sudo:session): session closed for user root Oct 13 13:12:10 volumio wireless.js[658]: WIRELESS.JS - INFO: Cleaning previous... Oct 13 13:12:10 volumio welcome[2195]: Resolved ip:[0] Oct 13 13:12:10 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Oct 13 13:12:10 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Oct 13 13:12:10 volumio sudo[2200]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Oct 13 13:12:10 volumio sudo[2200]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 13 13:12:10 volumio sudo[2200]: pam_unix(sudo:session): session closed for user root Oct 13 13:12:10 volumio wireless.js[658]: WIRELESS.JS - INFO: InterfaceValidator: READY - wlan0 is ready for operations Oct 13 13:12:10 volumio wireless.js[658]: WIRELESS.JS - INFO: InterfaceValidator: wlan0 became ready after 1ms Oct 13 13:12:10 volumio wireless.js[658]: WIRELESS.JS - INFO: ensureInterfaceReady: Interface ready (MAC: 00:1f:3a:2e:52:f3) Oct 13 13:12:10 volumio sudo[2208]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Oct 13 13:12:10 volumio sudo[2208]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 13:12:10 volumio sudo[2208]: pam_unix(sudo:session): session closed for user root Oct 13 13:12:10 volumio sudo[2216]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Oct 13 13:12:10 volumio sudo[2216]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 13:12:10 volumio volumio[1100]: info: Received Get System Info Oct 13 13:12:10 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 13 13:12:10 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 13 13:12:10 volumio volumio[1100]: info: Discovery: Getting this device information Oct 13 13:12:10 volumio volumio[1100]: info: CoreCommandRouter::volumioGetState Oct 13 13:12:10 volumio volumio[1100]: info: CorePlayQueue::getTrack 0 Oct 13 13:12:10 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 13 13:12:10 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 13 13:12:10 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 13 13:12:11 volumio sudo[2216]: pam_unix(sudo:session): session closed for user root Oct 13 13:12:11 volumio wireless.js[658]: WIRELESS.JS - INFO: Regdomain already correct: RU Oct 13 13:12:11 volumio volumio5-onboarding[1593]: time=2026-10-13T13:12:11.406+03:00 level=INFO msg="service successfully established" component=discovery/localnet Oct 13 13:12:11 volumio volumio[1100]: info: Received Get System Info Oct 13 13:12:11 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 13 13:12:11 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 13 13:12:11 volumio volumio[1100]: info: Discovery: Getting this device information Oct 13 13:12:11 volumio volumio[1100]: info: CoreCommandRouter::volumioGetState Oct 13 13:12:11 volumio volumio[1100]: info: CorePlayQueue::getTrack 0 Oct 13 13:12:11 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 13 13:12:11 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 13 13:12:11 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 13 13:12:12 volumio volumio5-onboarding[1593]: time=2026-10-13T13:12:12.406+03:00 level=INFO msg="service successfully established" component=discovery/localnet Oct 13 13:12:12 volumio ntpd[887]: IO: Deleting interface #3 wlan0, 192.168.211.1#123, interface stats: received=0, sent=0, dropped=0, active_time=116 secs Oct 13 13:12:14 volumio dhcpcd[695]: eth0: leased 192.168.1.46 for 25200 seconds Oct 13 13:12:14 volumio avahi-daemon[647]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.46. Oct 13 13:12:14 volumio avahi-daemon[647]: New relevant interface eth0.IPv4 for mDNS. Oct 13 13:12:14 volumio avahi-daemon[647]: Registering new address record for 192.168.1.46 on eth0.IPv4. Oct 13 13:12:14 volumio dhcpcd[695]: eth0: adding route to 192.168.1.0/24 Oct 13 13:12:14 volumio dhcpcd[695]: eth0: adding default route via 192.168.1.1 Oct 13 13:12:14 volumio systemd[1]: welcome.service: Deactivated successfully. Oct 13 13:12:14 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Oct 13 13:12:14 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Oct 13 13:12:14 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Oct 13 13:12:14 volumio welcome[2234]: Resolved ip:[1] 192.168.1.46 Oct 13 13:12:14 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Oct 13 13:12:14 volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Oct 13 13:12:14 volumio volumio[1100]: info: Received Get System Info Oct 13 13:12:14 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 13 13:12:14 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 13 13:12:14 volumio volumio[1100]: info: Discovery: Getting this device information Oct 13 13:12:14 volumio volumio[1100]: info: CoreCommandRouter::volumioGetState Oct 13 13:12:14 volumio volumio[1100]: info: CorePlayQueue::getTrack 0 Oct 13 13:12:14 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 13 13:12:14 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 13 13:12:14 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 13 13:12:15 volumio volumio[1100]: info: Discovery: adding d228a14c-76e6-48f7-993f-443a8ffb233f Oct 13 13:12:15 volumio volumio[1100]: info: Discovery: Found device Volumio Oct 13 13:12:15 volumio volumio[1100]: info: CoreCommandRouter::volumioGetState Oct 13 13:12:15 volumio volumio[1100]: info: CorePlayQueue::getTrack 0 Oct 13 13:12:15 volumio ntpd[887]: IO: Listen normally on 4 eth0 192.168.1.46:123 Oct 13 13:12:15 volumio ntpd[887]: IO: new interface(s) found: waking up resolver Oct 13 13:12:15 volumio ntpd[887]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Oct 13 13:12:15 volumio ntpd[887]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Oct 13 13:12:15 volumio ntpd[887]: DNS: Pool taking: 162.159.200.1 Oct 13 13:12:15 volumio ntpd[887]: DNS: Pool taking: 45.141.102.99 Oct 13 13:12:15 volumio ntpd[887]: DNS: Pool taking: 77.50.202.25 Oct 13 13:12:15 volumio ntpd[887]: DNS: Pool taking: 45.90.45.122 Oct 13 13:12:15 volumio ntpd[887]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 Oct 13 13:12:15 volumio volumio5-onboarding[1593]: time=2026-10-13T13:12:15.647+03:00 level=INFO msg="service successfully established" component=discovery/localnet Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Oct 13 13:12:16 volumio volumio[1100]: info: Adding plugin bluetooth to MyMusic Plugins Oct 13 13:12:16 volumio volumio[1100]: info: Adding plugin multiroom to MyMusic Plugins Oct 13 13:12:16 volumio volumio[1100]: info: Adding plugin metavolumio to MyMusic Plugins Oct 13 13:12:16 volumio volumio[1100]: info: Adding plugin cd_controller to MyMusic Plugins Oct 13 13:12:16 volumio volumio[1100]: info: Adding plugin qobuzconnect to MyMusic Plugins Oct 13 13:12:16 volumio volumio[1100]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 13 13:12:16 volumio volumio[1100]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 13 13:12:16 volumio volumio[1100]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Oct 13 13:12:16 volumio ntpd[887]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Oct 13 13:12:16 volumio ntpd[887]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Oct 13 13:12:16 volumio ntpd[887]: DNS: Pool taking: 195.90.182.235 Oct 13 13:12:16 volumio ntpd[887]: DNS: Pool taking: 217.28.222.15 Oct 13 13:12:16 volumio ntpd[887]: DNS: Pool taking: 217.117.245.254 Oct 13 13:12:16 volumio ntpd[887]: DNS: Pool taking: 82.146.53.58 Oct 13 13:12:16 volumio ntpd[887]: DNS: Pool taking: 2001:470:28:7c4:be24:11ff:fe96:aec0 Oct 13 13:12:16 volumio ntpd[887]: DNS: Pool taking: 2a00:ab00:403:37::2 Oct 13 13:12:16 volumio ntpd[887]: DNS: Pool taking: 2001:678:68c::3 Oct 13 13:12:16 volumio ntpd[887]: DNS: Pool taking: 2a03:aa00::136:50 Oct 13 13:12:16 volumio ntpd[887]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 Oct 13 13:12:17 volumio volumio[1100]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 13 13:12:17 volumio volumio[1100]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 13 13:12:17 volumio ntpd[887]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Oct 13 13:12:17 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 13:12:17 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 13:12:17 volumio ntpd[887]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Oct 13 13:12:17 volumio ntpd[887]: DNS: Pool taking: 92.255.126.12 Oct 13 13:12:17 volumio ntpd[887]: DNS: Pool taking: 85.193.65.152 Oct 13 13:12:17 volumio ntpd[887]: DNS: Pool taking: 93.95.100.85 Oct 13 13:12:17 volumio ntpd[887]: DNS: Pool taking: 193.192.36.3 Oct 13 13:12:17 volumio ntpd[887]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 Oct 13 13:12:17 volumio volumio[1100]: info: Starting MyVolumio Remote Streaming Endpoints Oct 13 13:12:17 volumio volumio[1100]: info: MyVolumio login type: Token Oct 13 13:12:17 volumio volumio[1100]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 13 13:12:17 volumio volumio[1100]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Oct 13 13:12:18 volumio volumio[1100]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Oct 13 13:12:18 volumio volumio[1100]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Oct 13 13:12:18 volumio volumio[1100]: info: Streaming services startup Oct 13 13:12:18 volumio volumio[1100]: info: Starting Streaming Daemon Oct 13 13:12:18 volumio volumio[1100]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Oct 13 13:12:18 volumio sudo[2271]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 13 13:12:18 volumio sudo[2271]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 13:12:18 volumio ntpd[887]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Oct 13 13:12:18 volumio ntpd[887]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Oct 13 13:12:18 volumio ntpd[887]: DNS: Pool taking: 87.103.245.205 Oct 13 13:12:18 volumio ntpd[887]: DNS: Pool taking: 90.188.6.85 Oct 13 13:12:18 volumio ntpd[887]: DNS: Pool taking: 87.249.44.53 Oct 13 13:12:18 volumio ntpd[887]: DNS: Pool taking: 89.109.251.19 Oct 13 13:12:18 volumio ntpd[887]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 Oct 13 13:12:18 volumio sudo[2271]: pam_unix(sudo:session): session closed for user root Oct 13 13:12:18 volumio volumio[1100]: info: Volumio Network Manager: Network status updated: 1 Oct 13 13:12:18 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 13 13:12:18 volumio volumio[1100]: info: Received Get System Info Oct 13 13:12:18 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 13 13:12:18 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 13 13:12:18 volumio volumio[1100]: info: Discovery: Getting this device information Oct 13 13:12:18 volumio volumio[1100]: info: CoreCommandRouter::volumioGetState Oct 13 13:12:18 volumio volumio[1100]: info: CorePlayQueue::getTrack 0 Oct 13 13:12:18 volumio volumio[1100]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 13 13:12:18 volumio volumio[1100]: error: Cannot start Volumio Streaming Daemon Oct 13 13:12:18 volumio volumio[1100]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 13 13:12:18 volumio volumio[1100]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 13 13:12:18 volumio volumio[1100]: error: MyVolumio Custom Token format not valid, refreshing it Oct 13 13:12:19 volumio volumio[1100]: info: MyVolumio login type: Token Oct 13 13:12:20 volumio volumio[1100]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Oct 13 13:12:21 volumio volumio[1100]: info: MyVolumio token set successfully Oct 13 13:12:21 volumio volumio[1100]: info: MYVOLUMIO: Adding device Oct 13 13:12:21 volumio volumio[1100]: info: MYVOLUMIO: Evaluating Server Oct 13 13:12:21 volumio volumio[1100]: info: MyVolumio status changed Oct 13 13:12:21 volumio volumio[1100]: info: Streaming services startup Oct 13 13:12:21 volumio volumio[1100]: info: Starting Streaming Daemon Oct 13 13:12:21 volumio volumio[1100]: info: Removing browser output: myVolumio user plan is not superstar Oct 13 13:12:21 volumio volumio[1100]: info: Removing audio output: Oct 13 13:12:21 volumio volumio[1100]: info: Stoppping Tunnel 1 Oct 13 13:12:21 volumio sudo[2302]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 13 13:12:21 volumio sudo[2302]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 13:12:21 volumio sudo[2302]: pam_unix(sudo:session): session closed for user root Oct 13 13:12:21 volumio volumio[1100]: error: Cannot start Volumio Streaming Daemon Oct 13 13:12:21 volumio volumio[1100]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 13 13:12:21 volumio volumio[1100]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 13 13:12:21 volumio sudo[2305]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Oct 13 13:12:21 volumio sudo[2305]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 13:12:20 volumio ntpd[887]: CLOCK: time stepped by -1.154556 Oct 13 13:12:20 volumio systemd-journald[511]: Time jumped backwards, rotating. Oct 13 13:12:20 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. Oct 13 13:12:20 volumio ntpd[887]: INIT: MRU 10922 entries, 13 hash bits, 65536 bytes Oct 13 13:12:20 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. Oct 13 13:12:20 volumio volumio[1100]: error: Failed to ping endpoint eu10.myvolumio.org : unknown error Oct 13 13:12:20 volumio volumio[1100]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 13:12:20 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. Oct 13 13:12:20 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. Oct 13 13:12:20 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. Oct 13 13:12:20 volumio volumio[1100]: Error: Unable to resolve or reject the same promise twice Oct 13 13:12:20 volumio volumio[1100]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Oct 13 13:12:20 volumio volumio[1100]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32371) Oct 13 13:12:20 volumio volumio[1100]: at Socket.emit (node:events:514:28) Oct 13 13:12:20 volumio volumio[1100]: at addChunk (node:internal/streams/readable:343:12) Oct 13 13:12:20 volumio volumio[1100]: at readableAddChunk (node:internal/streams/readable:316:9) Oct 13 13:12:20 volumio volumio[1100]: at Readable.push (node:internal/streams/readable:253:10) Oct 13 13:12:20 volumio volumio[1100]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Oct 13 13:12:20 volumio volumio[1100]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 13:12:20 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. Oct 13 13:12:20 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. Oct 13 13:12:20 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. Oct 13 13:12:20 volumio sudo[2305]: pam_unix(sudo:session): session closed for user root Oct 13 13:12:20 volumio sudo[2323]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-13 13:11' Oct 13 13:12:20 volumio sudo[2323]: 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"