-- Logs begin at Sat 2026-03-28 09:55:40 EET, end at Sat 2026-03-28 10:03:03 EET. -- Mar 28 10:01:01 studio volumio-time-update[2835]: volumio-time-update-util: Date not found in response Mar 28 10:01:01 studio volumio-time-update[2835]: volumio-time-update-util: Retrying in 5 seconds... Mar 28 10:01:06 studio volumio-time-update[2835]: volumio-time-update-util: Fetching time from Volumio... Mar 28 10:01:07 studio volumio[3257]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Mar 28 10:01:08 studio ntpd[3764]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Mar 28 10:01:24 studio volumio-time-update[2835]: volumio-time-update-util: Date not found in response Mar 28 10:01:24 studio volumio-time-update[2835]: volumio-time-update-util: Retrying in 5 seconds... Mar 28 10:01:25 studio volumio[3257]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Mar 28 10:01:26 studio ntpd[3764]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Mar 28 10:01:29 studio volumio-time-update[2835]: volumio-time-update-util: Fetching time from Volumio... Mar 28 10:01:44 studio volumio[3257]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Mar 28 10:01:44 studio ntpd[3764]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Mar 28 10:01:47 studio volumio-time-update[2835]: volumio-time-update-util: Date not found in response Mar 28 10:01:47 studio volumio-time-update[2835]: volumio-time-update-util: Retrying in 5 seconds... Mar 28 10:01:50 studio dhcpcd[3376]: eth0: carrier lost Mar 28 10:01:50 studio kernel: meson6-dwmac ff3f0000.ethernet eth0: Link is Down Mar 28 10:01:50 studio avahi-daemon[2818]: Withdrawing address record for 192.168.0.139 on eth0. Mar 28 10:01:50 studio avahi-daemon[2818]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.0.139. Mar 28 10:01:50 studio avahi-daemon[2818]: Interface eth0.IPv4 no longer relevant for mDNS. Mar 28 10:01:50 studio ifplugd(eth0)[3068]: Link beat lost. Mar 28 10:01:50 studio volumio[3257]: info: Discovery: A device disappeared from network Mar 28 10:01:50 studio dhcpcd[3376]: wlan0: adding default route Mar 28 10:01:50 studio dhcpcd[3376]: eth0: deleting route to 192.168.0.0/24 Mar 28 10:01:50 studio dhcpcd[3376]: eth0: deleting default route via 192.168.0.1 Mar 28 10:01:50 studio dnsmasq[3282]: reading /etc/resolv.conf Mar 28 10:01:50 studio dnsmasq[3282]: using nameserver 208.67.222.222#53 Mar 28 10:01:50 studio dnsmasq[3282]: using nameserver 208.67.220.220#53 Mar 28 10:01:50 studio volumio[3257]: info: Received Get System Info Mar 28 10:01:50 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 28 10:01:50 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 28 10:01:50 studio volumio[3257]: info: Discovery: Getting this device information Mar 28 10:01:50 studio volumio[3257]: info: CoreCommandRouter::volumioGetState Mar 28 10:01:50 studio volumio[3257]: info: CorePlayQueue::getTrack 0 Mar 28 10:01:50 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 28 10:01:50 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 28 10:01:50 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 28 10:01:50 studio volumio[3257]: info: Received Get System Info Mar 28 10:01:50 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 28 10:01:50 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 28 10:01:50 studio volumio[3257]: info: Discovery: Getting this device information Mar 28 10:01:50 studio volumio[3257]: info: CoreCommandRouter::volumioGetState Mar 28 10:01:50 studio volumio[3257]: info: CorePlayQueue::getTrack 0 Mar 28 10:01:50 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 28 10:01:50 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 28 10:01:50 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 28 10:01:51 studio ntpd[3764]: Deleting interface #3 eth0, 192.168.0.139#123, interface stats: received=0, sent=0, dropped=0, active_time=332 secs Mar 28 10:01:51 studio volumio[3257]: info: Reporting MCU Network Status: 0 Mar 28 10:01:51 studio volumio[3257]: info: Volumio Network Manager: Network status updated: 0 Mar 28 10:01:52 studio volumio-time-update[2835]: volumio-time-update-util: Fetching time from Volumio... Mar 28 10:01:52 studio volumio5-onboarding[3583]: time=2026-03-28T10:01:52.643+02:00 level=INFO msg="service successfully established" component=discovery/localnet Mar 28 10:02:00 studio ifplugd(eth0)[3068]: Executing '/etc/ifplugd/ifplugd.action eth0 down'. Mar 28 10:02:00 studio ifplugd(eth0)[3068]: client: sending commands to master dhcpcd process Mar 28 10:02:00 studio dhcpcd[4755]: sending commands to master dhcpcd process Mar 28 10:02:00 studio dhcpcd[3376]: control command: /sbin/dhcpcd -k eth0 Mar 28 10:02:00 studio dhcpcd[3376]: eth0: removing interface Mar 28 10:02:00 studio ifplugd(eth0)[3068]: Program executed successfully. Mar 28 10:02:02 studio ntpd[3764]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Mar 28 10:02:12 studio volumio-time-update[2835]: volumio-time-update-util: Date not found in response Mar 28 10:02:12 studio volumio-time-update[2835]: volumio-time-update-util: Retrying in 5 seconds... Mar 28 10:02:17 studio volumio-time-update[2835]: volumio-time-update-util: Fetching time from Volumio... Mar 28 10:02:22 studio volumio[3257]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 28 10:02:22 studio ntpd[3764]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Mar 28 10:02:37 studio volumio-time-update[2835]: volumio-time-update-util: Date not found in response Mar 28 10:02:37 studio volumio-time-update[2835]: volumio-time-update-util: Retrying in 5 seconds... Mar 28 10:02:42 studio volumio[3257]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Mar 28 10:02:42 studio volumio-time-update[2835]: volumio-time-update-util: Fetching time from Volumio... Mar 28 10:02:42 studio ntpd[3764]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Mar 28 10:02:46 studio kernel: meson6-dwmac ff3f0000.ethernet eth0: Link is Up - 1Gbps/Full - flow control off Mar 28 10:02:47 studio volumio[3257]: info: Received Get System Info Mar 28 10:02:47 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 28 10:02:47 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 28 10:02:47 studio volumio[3257]: info: Discovery: Getting this device information Mar 28 10:02:47 studio volumio[3257]: info: CoreCommandRouter::volumioGetState Mar 28 10:02:47 studio volumio[3257]: info: CorePlayQueue::getTrack 0 Mar 28 10:02:47 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 28 10:02:47 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 28 10:02:47 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 28 10:02:47 studio ifplugd(eth0)[3068]: Link beat detected. Mar 28 10:02:47 studio ifplugd(eth0)[3068]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Mar 28 10:02:47 studio ifplugd(eth0)[3068]: client: sending commands to master dhcpcd process Mar 28 10:02:47 studio dhcpcd[4930]: sending commands to master dhcpcd process Mar 28 10:02:47 studio dhcpcd[3376]: control command: /sbin/dhcpcd eth0 Mar 28 10:02:47 studio dhcpcd[3376]: eth0: carrier acquired Mar 28 10:02:47 studio dhcpcd[3376]: eth0: IAID 00:21:0b:01 Mar 28 10:02:47 studio volumio5-onboarding[3583]: time=2026-03-28T10:02:47.927+02:00 level=INFO msg="service successfully established" component=discovery/localnet Mar 28 10:02:47 studio ifplugd(eth0)[3068]: Program executed successfully. Mar 28 10:02:48 studio volumio[3257]: info: Received Get System Info Mar 28 10:02:48 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 28 10:02:48 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 28 10:02:48 studio volumio[3257]: info: Discovery: Getting this device information Mar 28 10:02:48 studio volumio[3257]: info: CoreCommandRouter::volumioGetState Mar 28 10:02:48 studio dhcpcd[3376]: eth0: soliciting an IPv6 router Mar 28 10:02:48 studio volumio[3257]: info: CorePlayQueue::getTrack 0 Mar 28 10:02:48 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 28 10:02:48 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 28 10:02:48 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 28 10:02:48 studio dhcpcd[3376]: eth0: rebinding lease of 192.168.0.139 Mar 28 10:02:48 studio dhcpcd[3376]: eth0: probing address 192.168.0.139/24 Mar 28 10:02:49 studio volumio5-onboarding[3583]: time=2026-03-28T10:02:49.067+02:00 level=INFO msg="service successfully established" component=discovery/localnet Mar 28 10:02:53 studio dhcpcd[3376]: eth0: leased 192.168.0.139 for 7200 seconds Mar 28 10:02:53 studio dhcpcd[3376]: eth0: adding route to 192.168.0.0/24 Mar 28 10:02:53 studio dhcpcd[3376]: eth0: adding default route via 192.168.0.1 Mar 28 10:02:53 studio dhcpcd[3376]: wlan0: deleting default route Mar 28 10:02:53 studio avahi-daemon[2818]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.0.139. Mar 28 10:02:53 studio avahi-daemon[2818]: New relevant interface eth0.IPv4 for mDNS. Mar 28 10:02:53 studio avahi-daemon[2818]: Registering new address record for 192.168.0.139 on eth0.IPv4. Mar 28 10:02:53 studio dnsmasq[3282]: reading /etc/resolv.conf Mar 28 10:02:53 studio dnsmasq[3282]: using nameserver 192.168.0.1#53 Mar 28 10:02:53 studio dnsmasq[3282]: using nameserver 208.67.222.222#53 Mar 28 10:02:53 studio dnsmasq[3282]: using nameserver 208.67.220.220#53 Mar 28 10:02:53 studio ntpd[3764]: ntpd exiting on signal 15 (Terminated) Mar 28 10:02:53 studio systemd[1]: Stopping Network Time Service... Mar 28 10:02:53 studio systemd[1]: ntp.service: Succeeded. Mar 28 10:02:53 studio systemd[1]: Stopped Network Time Service. Mar 28 10:02:54 studio systemd[1]: Starting Network Time Service... Mar 28 10:02:54 studio ntpd[5008]: ntpd 4.2.8p12@1.3728-o (1): Starting Mar 28 10:02:54 studio ntpd[5008]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Mar 28 10:02:54 studio systemd[1]: Started Network Time Service. Mar 28 10:02:54 studio ntpd[5024]: proto: precision = 1.208 usec (-20) Mar 28 10:02:54 studio ntpd[5024]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Mar 28 10:02:54 studio ntpd[5024]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Mar 28 10:02:54 studio ntpd[5024]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 1187 days ago Mar 28 10:02:54 studio ntpd[5024]: Listen and drop on 0 v6wildcard [::]:123 Mar 28 10:02:54 studio ntpd[5024]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Mar 28 10:02:54 studio ntpd[5024]: Listen normally on 2 lo 127.0.0.1:123 Mar 28 10:02:54 studio ntpd[5024]: Listen normally on 3 eth0 192.168.0.139:123 Mar 28 10:02:54 studio ntpd[5024]: Listen normally on 4 wlan0 192.168.211.1:123 Mar 28 10:02:54 studio ntpd[5024]: Listen normally on 5 wlan0 169.254.139.152:123 Mar 28 10:02:54 studio ntpd[5024]: Listening on routing socket on fd #22 for interface updates Mar 28 10:02:54 studio ntpd[5024]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 28 10:02:54 studio ntpd[5024]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 28 10:02:54 studio volumio[3257]: info: Received Get System Info Mar 28 10:02:54 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 28 10:02:54 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 28 10:02:54 studio volumio[3257]: info: Discovery: Getting this device information Mar 28 10:02:54 studio volumio[3257]: info: CoreCommandRouter::volumioGetState Mar 28 10:02:54 studio volumio[3257]: info: CorePlayQueue::getTrack 0 Mar 28 10:02:54 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 28 10:02:54 studio volumio[3257]: info: Received Get System Info Mar 28 10:02:54 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 28 10:02:54 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 28 10:02:54 studio volumio[3257]: info: Discovery: Getting this device information Mar 28 10:02:54 studio volumio[3257]: info: CoreCommandRouter::volumioGetState Mar 28 10:02:54 studio volumio[3257]: info: CorePlayQueue::getTrack 0 Mar 28 10:02:54 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 28 10:02:54 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 28 10:02:54 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 28 10:02:54 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 28 10:02:54 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 28 10:02:55 studio ntpd[5024]: Soliciting pool server 185.117.82.66 Mar 28 10:02:56 studio ntpd[5024]: Soliciting pool server 162.159.200.123 Mar 28 10:02:56 studio volumio5-onboarding[3583]: time=2026-03-28T10:02:56.082+02:00 level=INFO msg="service successfully established" component=discovery/localnet Mar 28 10:02:56 studio ntpd[5024]: Soliciting pool server 193.238.174.38 Mar 28 10:02:57 studio ntpd[5024]: Soliciting pool server 213.91.190.205 Mar 28 10:02:57 studio ntpd[5024]: Soliciting pool server 78.159.131.45 Mar 28 10:02:57 studio ntpd[5024]: Soliciting pool server 195.85.215.215 Mar 28 10:02:58 studio ntpd[5024]: Soliciting pool server 195.85.215.8 Mar 28 10:02:58 studio ntpd[5024]: Soliciting pool server 88.203.195.14 Mar 28 10:02:58 studio ntpd[5024]: Soliciting pool server 95.43.236.49 Mar 28 10:02:58 studio ntpd[5024]: Soliciting pool server 162.159.200.1 Mar 28 10:02:59 studio ntpd[5024]: Soliciting pool server 176.12.60.87 Mar 28 10:02:59 studio ntpd[5024]: Soliciting pool server 185.117.82.71 Mar 28 10:02:59 studio ntpd[5024]: Soliciting pool server 78.130.168.61 Mar 28 10:03:00 studio ntpd[5024]: Soliciting pool server 82.118.235.227 Mar 28 10:03:00 studio ntpd[5024]: Soliciting pool server 87.120.244.14 Mar 28 10:03:01 studio ntpd[5024]: Soliciting pool server 94.26.6.190 Mar 28 10:03:01 studio ntpd[5024]: Soliciting pool server 2001:ac8:30:68:0:2:0:10 Mar 28 10:03:02 studio volumio[3257]: info: Reporting MCU Network Status: 1 Mar 28 10:03:02 studio volumio[3257]: info: Volumio Network Manager: Network status updated: 1 Mar 28 10:03:02 studio volumio[3257]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Mar 28 10:03:02 studio volumio[3257]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Mar 28 10:03:02 studio volumio[3257]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Mar 28 10:03:02 studio volumio[3257]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Mar 28 10:03:02 studio volumio[3257]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 28 10:03:02 studio volumio[3257]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Mar 28 10:03:02 studio volumio[3257]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Mar 28 10:03:02 studio volumio[3257]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Mar 28 10:03:02 studio volumio[3257]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Mar 28 10:03:02 studio volumio[3257]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13 Mar 28 10:03:02 studio volumio[3257]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14 Mar 28 10:03:02 studio volumio[3257]: info: Discovery: adding ac9d78a0-8755-43bb-9296-1d93ac97f46c Mar 28 10:03:02 studio volumio[3257]: info: Discovery: Found device Studio Mar 28 10:03:02 studio volumio[3257]: info: CoreCommandRouter::volumioGetState Mar 28 10:03:02 studio volumio[3257]: info: CorePlayQueue::getTrack 0 Mar 28 10:03:02 studio volumio[3257]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 15 Mar 28 10:03:02 studio volumio-time-update[2835]: volumio-time-update-util: Date not found in response Mar 28 10:03:02 studio volumio-time-update[2835]: volumio-time-update-util: Retrying in 5 seconds... Mar 28 10:03:02 studio volumio[3257]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 16 Mar 28 10:03:02 studio volumio[3257]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 17 Mar 28 10:03:02 studio volumio[3257]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 18 Mar 28 10:03:02 studio volumio[3257]: info: CoreCommandRouter::volumioGetState Mar 28 10:03:02 studio volumio[3257]: info: CorePlayQueue::getTrack 0 Mar 28 10:03:02 studio volumio[3257]: info: MCU Signalled Playback Inactive Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Mar 28 10:03:03 studio volumio[3257]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Mar 28 10:02:41 studio ntpd[5024]: receive: Unexpected origin timestamp 0xed7209b8.106610a4 does not match aorg 0000000000.00000000 from server@88.203.195.14 xmt 0xed7209a1.d49fc82d Mar 28 10:02:41 studio ntpd[5024]: receive: Unexpected origin timestamp 0xed7209b8.106e4e31 does not match aorg 0000000000.00000000 from server@213.91.190.205 xmt 0xed7209a1.d4ea5aa0 Mar 28 10:02:41 studio ntpd[5024]: receive: Unexpected origin timestamp 0xed7209b8.105cfe3c does not match aorg 0000000000.00000000 from server@176.12.60.87 xmt 0xed7209a1.d4e2ae8e Mar 28 10:02:41 studio ntpd[5024]: receive: Unexpected origin timestamp 0xed7209b8.106a4109 does not match aorg 0000000000.00000000 from server@78.159.131.45 xmt 0xed7209a1.d772ea29 Mar 28 10:02:43 studio volumio[3257]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Mar 28 10:02:43 studio volumio[3257]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Mar 28 10:02:43 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 28 10:02:43 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 28 10:02:43 studio volumio[3257]: info: Starting MyVolumio Remote Streaming Endpoints Mar 28 10:02:43 studio volumio[3257]: info: MyVolumio login type: Token Mar 28 10:02:43 studio volumio[3257]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Mar 28 10:02:43 studio volumio[3257]: error: [MyVolumio PluginManager] Could not read package.json file: Error: /myvolumio/plugins/music_service/streaming_services//package.json: ENOENT: no such file or directory, open '/myvolumio/plugins/music_service/streaming_services//package.json' Mar 28 10:02:43 studio volumio[3257]: error: MyVolumio Custom Token format not valid, refreshing it Mar 28 10:02:44 studio volumio[3257]: info: MyVolumio login type: Token Mar 28 10:02:44 studio volumio[3257]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Mar 28 10:02:45 studio volumio[3257]: info: MyVolumio token set successfully Mar 28 10:02:45 studio volumio[3257]: info: MYVOLUMIO: Adding device Mar 28 10:02:45 studio volumio[3257]: info: MYVOLUMIO: Evaluating Server Mar 28 10:02:45 studio volumio-time-update[2835]: volumio-time-update-util: Fetching time from Volumio... Mar 28 10:02:45 studio volumio-time-update[2835]: volumio-time-update-util: Setting system time to: 2026-03-28 10:02:45 Mar 28 10:02:45 studio sudo[5068]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2026-03-28 10:02:45 Mar 28 10:02:45 studio sudo[5068]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 10:02:45 studio dbus-daemon[2819]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.17' (uid=0 pid=5072 comm="timedatectl set-time 2026-03-28 10:02:45 " label="kernel") Mar 28 10:02:45 studio systemd[1]: Starting Time & Date Service... Mar 28 10:02:45 studio volumio[3257]: info: MyVolumio status changed Mar 28 10:02:45 studio volumio[3257]: info: Streaming services startup Mar 28 10:02:45 studio volumio[3257]: info: Starting Streaming Daemon Mar 28 10:02:45 studio volumio[3257]: info: Removing browser output: myVolumio user plan is not superstar Mar 28 10:02:45 studio volumio[3257]: info: Removing audio output: Mar 28 10:02:45 studio volumio[3257]: info: Stoppping Tunnel 1 Mar 28 10:02:45 studio sudo[5084]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 28 10:02:45 studio sudo[5084]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 10:02:45 studio sudo[5084]: pam_unix(sudo:session): session closed for user root Mar 28 10:02:45 studio dbus-daemon[2819]: [system] Successfully activated service 'org.freedesktop.timedate1' Mar 28 10:02:45 studio systemd[1]: Started Time & Date Service. Mar 28 10:02:45 studio sudo[5088]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Mar 28 10:02:45 studio sudo[5088]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 10:02:45 studio systemd-timedated[5075]: Changed local time to Sat Mar 28 10:02:45 2026 Mar 28 10:02:45 studio volumio[3257]: error: Cannot start Volumio Streaming Daemon Mar 28 10:02:45 studio volumio[3257]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 28 10:02:45 studio volumio[3257]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 28 10:02:45 studio volumio-time-update[2835]: volumio-time-update-util: System time updated successfully. Mar 28 10:02:45 studio sudo[5068]: pam_unix(sudo:session): session closed for user root Mar 28 10:02:45 studio volumio[3257]: error: Failed to ping endpoint au1.myvolumio.org : unknown error Mar 28 10:02:45 studio systemd[1]: Started Volumio Time Update Utility. Mar 28 10:02:45 studio volumio[3257]: info: Setting Geolocation for MyVolumio to eu4 Mar 28 10:02:45 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 28 10:02:45 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 28 10:02:45 studio volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 28 10:02:45 studio systemd[1]: Reached target Multi-User System. Mar 28 10:02:45 studio systemd[1]: Reached target Graphical Interface. Mar 28 10:02:45 studio volumio[3257]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 28 10:02:45 studio volumio[3257]: Error: Unable to resolve or reject the same promise twice Mar 28 10:02:45 studio volumio[3257]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Mar 28 10:02:45 studio volumio[3257]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32086) Mar 28 10:02:45 studio volumio[3257]: at Socket.emit (events.js:412:35) Mar 28 10:02:45 studio volumio[3257]: at endReadableNT (internal/streams/readable.js:1333:12) Mar 28 10:02:45 studio volumio[3257]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Mar 28 10:02:45 studio volumio[3257]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 28 10:02:45 studio systemd[1]: Starting Update UTMP about System Runlevel Changes... Mar 28 10:02:45 studio sudo[5088]: pam_unix(sudo:session): session closed for user root Mar 28 10:02:45 studio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Mar 28 10:02:45 studio systemd[1]: Started Update UTMP about System Runlevel Changes. Mar 28 10:02:45 studio systemd[1]: Startup finished in 12.884s (kernel) + 7min 28.109s (userspace) = 7min 40.993s. Mar 28 10:02:45 studio sudo[5105]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-28 10:01 Mar 28 10:02:45 studio sudo[5105]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 11:19:27 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo Plus" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo Plus" VOLUMIO_HASH="a7285124ffc88c43265bb2db03526f6a"