-- Logs begin at Sun 2025-06-01 18:56:15 +07, end at Sun 2025-06-01 22:12:33 +07. -- Jun 01 22:11:00 rivoplus volumio[3247]: info: CoreCommandRouter::servicePushState Jun 01 22:11:00 rivoplus volumio[3247]: info: CoreStateMachine::pushState Jun 01 22:11:00 rivoplus volumio[3247]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 22:11:00 rivoplus volumio[3247]: info: CoreCommandRouter::volumioPushState Jun 01 22:11:00 rivoplus volumio[3247]: info: CoreCommandRouter::volumioGetState Jun 01 22:11:00 rivoplus volumio[3247]: info: MRS: Pushing multiroomSync output update for this device Jun 01 22:11:00 rivoplus volumio[3247]: info: MRS: Pushing multiroomSync output Jun 01 22:11:04 rivoplus volumio[3247]: info: CoreCommandRouter::servicePushState Jun 01 22:11:04 rivoplus volumio[3247]: info: CoreStateMachine::pushState Jun 01 22:11:04 rivoplus volumio[3247]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 22:11:04 rivoplus volumio[3247]: info: CoreCommandRouter::volumioPushState Jun 01 22:11:04 rivoplus volumio[3247]: info: CoreCommandRouter::volumioGetState Jun 01 22:11:04 rivoplus volumio[3247]: info: MRS: Pushing multiroomSync output update for this device Jun 01 22:11:04 rivoplus volumio[3247]: info: MRS: Pushing multiroomSync output Jun 01 22:11:08 rivoplus volumio[3247]: info: CoreCommandRouter::servicePushState Jun 01 22:11:08 rivoplus volumio[3247]: info: CoreStateMachine::pushState Jun 01 22:11:08 rivoplus volumio[3247]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 22:11:08 rivoplus volumio[3247]: info: CoreCommandRouter::volumioPushState Jun 01 22:11:08 rivoplus volumio[3247]: info: CoreCommandRouter::volumioGetState Jun 01 22:11:08 rivoplus volumio[3247]: info: MRS: Pushing multiroomSync output update for this device Jun 01 22:11:08 rivoplus volumio[3247]: info: MRS: Pushing multiroomSync output Jun 01 22:11:08 rivoplus volumio[3247]: info: MCU Signalled Playback Inactive Jun 01 22:11:13 rivoplus volumio[3247]: info: CoreCommandRouter::servicePushState Jun 01 22:11:13 rivoplus volumio[3247]: info: CoreStateMachine::pushState Jun 01 22:11:13 rivoplus volumio[3247]: info: CoreCommandRouter::volumioPushState Jun 01 22:11:13 rivoplus volumio[3247]: info: CoreCommandRouter::volumioGetState Jun 01 22:11:13 rivoplus volumio[3247]: info: MRS: Pushing multiroomSync output update for this device Jun 01 22:11:13 rivoplus volumio[3247]: info: MRS: Pushing multiroomSync output Jun 01 22:11:42 rivoplus ntpd[10491]: Soliciting pool server 2401:5f80:5001:1f::31f Jun 01 22:11:45 rivoplus ntpd[10491]: Soliciting pool server 103.184.124.254 Jun 01 22:11:47 rivoplus ntpd[10491]: Soliciting pool server 115.165.161.155 Jun 01 22:12:03 rivoplus dhcpcd[3466]: eth0: carrier lost Jun 01 22:12:03 rivoplus dhcpcd[3351]: eth0: carrier lost Jun 01 22:12:03 rivoplus kernel: meson6-dwmac ff3f0000.ethernet eth0: Link is Down Jun 01 22:12:03 rivoplus dnsmasq[3269]: reading /etc/resolv.conf Jun 01 22:12:03 rivoplus dnsmasq[3269]: using nameserver 8.8.8.8#53 Jun 01 22:12:03 rivoplus dnsmasq[3269]: using nameserver 1.1.1.1#53 Jun 01 22:12:03 rivoplus dnsmasq[3269]: using nameserver 8.8.8.8#53 Jun 01 22:12:03 rivoplus dnsmasq[3269]: using nameserver 1.1.1.1#53 Jun 01 22:12:03 rivoplus dnsmasq[3269]: using nameserver 208.67.222.222#53 Jun 01 22:12:03 rivoplus dnsmasq[3269]: using nameserver 208.67.220.220#53 Jun 01 22:12:03 rivoplus dnsmasq[3269]: using nameserver 208.67.222.222#53 Jun 01 22:12:03 rivoplus dnsmasq[3269]: using nameserver 208.67.220.220#53 Jun 01 22:12:03 rivoplus avahi-daemon[2855]: Withdrawing address record for 192.168.2.5 on eth0. Jun 01 22:12:03 rivoplus avahi-daemon[2855]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.2.5. Jun 01 22:12:03 rivoplus avahi-daemon[2855]: Interface eth0.IPv4 no longer relevant for mDNS. Jun 01 22:12:03 rivoplus volumio[3247]: info: Discovery: A device disappeared from network Jun 01 22:12:03 rivoplus volumio[3247]: info: Discovery: Device rivoplus disappeared from network Jun 01 22:12:03 rivoplus dhcpcd[3466]: wlan0: adding default route Jun 01 22:12:03 rivoplus dhcpcd[3466]: eth0: deleting route to 192.168.2.0/24 Jun 01 22:12:03 rivoplus dhcpcd[3466]: eth0: deleting default route via 192.168.2.1 Jun 01 22:12:03 rivoplus dhcpcd[3351]: eth0: deleting route to 192.168.2.0/24 Jun 01 22:12:03 rivoplus dhcpcd[3351]: eth0: deleting default route via 192.168.2.1 Jun 01 22:12:03 rivoplus dnsmasq[3269]: no servers found in /etc/resolv.conf, will retry Jun 01 22:12:03 rivoplus ifplugd(eth0)[3113]: Link beat lost. Jun 01 22:12:04 rivoplus ntpd[10491]: Deleting interface #3 eth0, 192.168.2.5#123, interface stats: received=36, sent=44, dropped=0, active_time=155 secs Jun 01 22:12:04 rivoplus ntpd[10491]: 27.71.27.209 local addr 192.168.2.5 -> Jun 01 22:12:04 rivoplus ntpd[10491]: 103.199.19.135 local addr 192.168.2.5 -> Jun 01 22:12:04 rivoplus ntpd[10491]: 103.188.82.179 local addr 192.168.2.5 -> Jun 01 22:12:04 rivoplus ntpd[10491]: 103.70.115.65 local addr 192.168.2.5 -> Jun 01 22:12:04 rivoplus volumio[3247]: info: Reporting MCU Network Status: 0 Jun 01 22:12:04 rivoplus volumio[3247]: info: Volumio Network Manager: Network status updated: 0 Jun 01 22:12:10 rivoplus volumio[3247]: [VRCP] RAAT stopped playing Jun 01 22:12:10 rivoplus volumio[3247]: info: CoreCommandRouter::servicePushState Jun 01 22:12:10 rivoplus volumio[3247]: info: CoreStateMachine::pushState Jun 01 22:12:10 rivoplus volumio[3247]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 22:12:10 rivoplus volumio[3247]: info: CoreCommandRouter::volumioPushState Jun 01 22:12:10 rivoplus volumio[3247]: info: CoreCommandRouter::volumioGetState Jun 01 22:12:10 rivoplus volumio[3247]: info: MRS: Pushing multiroomSync output update for this device Jun 01 22:12:10 rivoplus volumio[3247]: info: MRS: Pushing multiroomSync output Jun 01 22:12:10 rivoplus volumio[3247]: info: CorePlayQueue::getTrack 2 Jun 01 22:12:10 rivoplus volumio[3247]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received raat Jun 01 22:12:13 rivoplus ifplugd(eth0)[3113]: Executing '/etc/ifplugd/ifplugd.action eth0 down'. Jun 01 22:12:13 rivoplus ifplugd(eth0)[3113]: client: sending commands to master dhcpcd process Jun 01 22:12:13 rivoplus dhcpcd[10974]: sending commands to master dhcpcd process Jun 01 22:12:13 rivoplus dhcpcd[3466]: control command: /sbin/dhcpcd -k eth0 Jun 01 22:12:13 rivoplus dhcpcd[3466]: eth0: removing interface Jun 01 22:12:13 rivoplus dnsmasq[3269]: reading /etc/resolv.conf Jun 01 22:12:13 rivoplus dnsmasq[3269]: using nameserver 208.67.222.222#53 Jun 01 22:12:13 rivoplus dnsmasq[3269]: using nameserver 208.67.220.220#53 Jun 01 22:12:13 rivoplus ifplugd(eth0)[3113]: Program executed successfully. Jun 01 22:12:25 rivoplus dhcpcd[3351]: eth0: carrier acquired Jun 01 22:12:26 rivoplus kernel: meson6-dwmac ff3f0000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Jun 01 22:12:26 rivoplus ifplugd(eth0)[3113]: Link beat detected. Jun 01 22:12:26 rivoplus dhcpcd[3351]: eth0: IAID 00:27:1a:01 Jun 01 22:12:26 rivoplus ifplugd(eth0)[3113]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Jun 01 22:12:26 rivoplus ifplugd(eth0)[3113]: client: sending commands to master dhcpcd process Jun 01 22:12:26 rivoplus dhcpcd[11053]: sending commands to master dhcpcd process Jun 01 22:12:26 rivoplus dhcpcd[3466]: control command: /sbin/dhcpcd eth0 Jun 01 22:12:26 rivoplus dhcpcd[3466]: eth0: carrier acquired Jun 01 22:12:26 rivoplus dhcpcd[3466]: eth0: IAID 00:27:1a:01 Jun 01 22:12:26 rivoplus ifplugd(eth0)[3113]: Program executed successfully. Jun 01 22:12:26 rivoplus dhcpcd[3351]: eth0: rebinding lease of 192.168.2.5 Jun 01 22:12:26 rivoplus dhcpcd[3351]: eth0: probing address 192.168.2.5/24 Jun 01 22:12:26 rivoplus dhcpcd[3351]: eth0: soliciting an IPv6 router Jun 01 22:12:26 rivoplus dhcpcd[3466]: eth0: rebinding lease of 192.168.2.5 Jun 01 22:12:26 rivoplus dhcpcd[3466]: eth0: probing address 192.168.2.5/24 Jun 01 22:12:26 rivoplus dhcpcd[3466]: eth0: soliciting an IPv6 router Jun 01 22:12:31 rivoplus dhcpcd[3466]: eth0: leased 192.168.2.5 for 1800 seconds Jun 01 22:12:31 rivoplus dhcpcd[3466]: eth0: adding route to 192.168.2.0/24 Jun 01 22:12:31 rivoplus dhcpcd[3466]: eth0: adding default route via 192.168.2.1 Jun 01 22:12:31 rivoplus dhcpcd[3466]: wlan0: deleting default route Jun 01 22:12:31 rivoplus avahi-daemon[2855]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.2.5. Jun 01 22:12:31 rivoplus avahi-daemon[2855]: New relevant interface eth0.IPv4 for mDNS. Jun 01 22:12:31 rivoplus avahi-daemon[2855]: Registering new address record for 192.168.2.5 on eth0.IPv4. Jun 01 22:12:31 rivoplus dnsmasq[3269]: reading /etc/resolv.conf Jun 01 22:12:31 rivoplus dnsmasq[3269]: using nameserver 8.8.8.8#53 Jun 01 22:12:31 rivoplus dnsmasq[3269]: using nameserver 1.1.1.1#53 Jun 01 22:12:31 rivoplus dnsmasq[3269]: using nameserver 208.67.222.222#53 Jun 01 22:12:31 rivoplus dnsmasq[3269]: using nameserver 208.67.220.220#53 Jun 01 22:12:31 rivoplus ntpd[10491]: ntpd exiting on signal 15 (Terminated) Jun 01 22:12:31 rivoplus ntpd[10491]: 103.70.115.65 local addr 169.254.114.32 -> Jun 01 22:12:31 rivoplus systemd[1]: Stopping Network Time Service... Jun 01 22:12:31 rivoplus ntpd[10491]: 103.188.82.179 local addr 169.254.114.32 -> Jun 01 22:12:31 rivoplus ntpd[10491]: 103.199.19.135 local addr 169.254.114.32 -> Jun 01 22:12:31 rivoplus ntpd[10491]: 27.71.27.209 local addr 169.254.114.32 -> Jun 01 22:12:31 rivoplus systemd[1]: ntp.service: Succeeded. Jun 01 22:12:31 rivoplus systemd[1]: Stopped Network Time Service. Jun 01 22:12:31 rivoplus systemd[1]: Starting Network Time Service... Jun 01 22:12:31 rivoplus dhcpcd[3351]: eth0: leased 192.168.2.5 for 1800 seconds Jun 01 22:12:31 rivoplus dhcpcd[3351]: eth0: adding route to 192.168.2.0/24 Jun 01 22:12:31 rivoplus dhcpcd[3351]: eth0: adding default route via 192.168.2.1 Jun 01 22:12:31 rivoplus ntpd[11114]: ntpd 4.2.8p12@1.3728-o (1): Starting Jun 01 22:12:31 rivoplus ntpd[11114]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Jun 01 22:12:31 rivoplus systemd[1]: Started Network Time Service. Jun 01 22:12:31 rivoplus ntpd[11140]: proto: precision = 1.250 usec (-20) Jun 01 22:12:31 rivoplus ntpd[11140]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Jun 01 22:12:31 rivoplus ntpd[11140]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Jun 01 22:12:31 rivoplus ntpd[11140]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 887 days ago Jun 01 22:12:31 rivoplus ntpd[11140]: Listen and drop on 0 v6wildcard [::]:123 Jun 01 22:12:31 rivoplus ntpd[11140]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jun 01 22:12:31 rivoplus ntpd[11140]: Listen normally on 2 lo 127.0.0.1:123 Jun 01 22:12:31 rivoplus ntpd[11140]: Listen normally on 3 eth0 192.168.2.5:123 Jun 01 22:12:31 rivoplus ntpd[11140]: Listen normally on 4 wlan0 192.168.211.1:123 Jun 01 22:12:31 rivoplus ntpd[11140]: Listen normally on 5 wlan0 169.254.114.32:123 Jun 01 22:12:31 rivoplus ntpd[11140]: Listening on routing socket on fd #22 for interface updates Jun 01 22:12:31 rivoplus ntpd[11140]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Jun 01 22:12:31 rivoplus ntpd[11140]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Jun 01 22:12:32 rivoplus volumio[3247]: info: CoreCommandRouter::servicePushState Jun 01 22:12:32 rivoplus volumio[3247]: info: CoreStateMachine::pushState Jun 01 22:12:32 rivoplus volumio[3247]: info: CoreCommandRouter::volumioPushState Jun 01 22:12:32 rivoplus volumio[3247]: info: CoreCommandRouter::volumioGetState Jun 01 22:12:32 rivoplus volumio[3247]: info: MRS: Pushing multiroomSync output update for this device Jun 01 22:12:32 rivoplus volumio[3247]: info: MRS: Pushing multiroomSync output Jun 01 22:12:32 rivoplus volumio[3247]: info: CorePlayQueue::getTrack 2 Jun 01 22:12:32 rivoplus volumio[3247]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received raat Jun 01 22:12:32 rivoplus volumio[3247]: info: CoreCommandRouter::servicePushState Jun 01 22:12:32 rivoplus volumio[3247]: info: CoreStateMachine::pushState Jun 01 22:12:32 rivoplus volumio[3247]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 22:12:32 rivoplus volumio[3247]: info: CoreCommandRouter::volumioPushState Jun 01 22:12:32 rivoplus volumio[3247]: info: CoreCommandRouter::volumioGetState Jun 01 22:12:32 rivoplus volumio[3247]: info: MRS: Pushing multiroomSync output update for this device Jun 01 22:12:32 rivoplus volumio[3247]: info: MRS: Pushing multiroomSync output Jun 01 22:12:32 rivoplus ntpd[11140]: ntpd exiting on signal 15 (Terminated) Jun 01 22:12:32 rivoplus systemd[1]: Stopping Network Time Service... Jun 01 22:12:32 rivoplus systemd[1]: ntp.service: Succeeded. Jun 01 22:12:32 rivoplus systemd[1]: Stopped Network Time Service. Jun 01 22:12:32 rivoplus systemd[1]: Starting Network Time Service... Jun 01 22:12:32 rivoplus ntpd[11164]: ntpd 4.2.8p12@1.3728-o (1): Starting Jun 01 22:12:32 rivoplus ntpd[11164]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Jun 01 22:12:32 rivoplus systemd[1]: Started Network Time Service. Jun 01 22:12:32 rivoplus ntpd[11170]: proto: precision = 1.250 usec (-20) Jun 01 22:12:32 rivoplus ntpd[11170]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Jun 01 22:12:32 rivoplus ntpd[11170]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Jun 01 22:12:32 rivoplus ntpd[11170]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 887 days ago Jun 01 22:12:32 rivoplus ntpd[11170]: Listen and drop on 0 v6wildcard [::]:123 Jun 01 22:12:32 rivoplus ntpd[11170]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jun 01 22:12:32 rivoplus ntpd[11170]: Listen normally on 2 lo 127.0.0.1:123 Jun 01 22:12:32 rivoplus ntpd[11170]: Listen normally on 3 eth0 192.168.2.5:123 Jun 01 22:12:32 rivoplus ntpd[11170]: Listen normally on 4 wlan0 192.168.211.1:123 Jun 01 22:12:32 rivoplus ntpd[11170]: Listen normally on 5 wlan0 169.254.114.32:123 Jun 01 22:12:32 rivoplus ntpd[11170]: Listening on routing socket on fd #22 for interface updates Jun 01 22:12:32 rivoplus ntpd[11170]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Jun 01 22:12:32 rivoplus ntpd[11170]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Jun 01 22:12:32 rivoplus volumio[3247]: info: Discovery: adding a6c77f9d-2d6b-41fd-be57-317cf98a0e2f Jun 01 22:12:32 rivoplus volumio[3247]: info: Discovery: Found device Rivoplus Jun 01 22:12:32 rivoplus volumio[3247]: info: CoreCommandRouter::volumioGetState Jun 01 22:12:32 rivoplus volumio[3247]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 01 22:12:32 rivoplus volumio[3247]: Error: The value NaN is not a number Jun 01 22:12:32 rivoplus volumio[3247]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20) Jun 01 22:12:32 rivoplus volumio[3247]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25) Jun 01 22:12:32 rivoplus volumio[3247]: at ControllerVolumioDiscovery.updateMultiroomDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:323:25) Jun 01 22:12:32 rivoplus volumio[3247]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:273:10) Jun 01 22:12:32 rivoplus volumio[3247]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12) Jun 01 22:12:32 rivoplus volumio[3247]: at Browser.emit (events.js:400:28) Jun 01 22:12:32 rivoplus volumio[3247]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) Jun 01 22:12:32 rivoplus volumio[3247]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7) Jun 01 22:12:32 rivoplus volumio[3247]: at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5) Jun 01 22:12:32 rivoplus volumio[3247]: at next (/volumio/node_modules/mdns/lib/browser.js:109:21) Jun 01 22:12:32 rivoplus volumio[3247]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 Jun 01 22:12:32 rivoplus volumio[3247]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7) Jun 01 22:12:32 rivoplus volumio[3247]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) Jun 01 22:12:32 rivoplus volumio[3247]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 01 22:12:33 rivoplus sudo[11181]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-01 22:11 Jun 01 22:12:33 rivoplus sudo[11181]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 01 22:12:33 rivoplus ntpd[11170]: Soliciting pool server 115.165.161.155 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 06:04:38 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="0064c1a7ac4363e567dacab062cb5da8"