-- Logs begin at Sun 2024-10-06 09:05:15 CST, end at Mon 2024-10-07 03:01:49 CST. -- Oct 07 03:00:11 rivo dhcpcd[3563]: eth0: carrier lost Oct 07 03:00:11 rivo kernel: meson6-dwmac ff3f0000.ethernet eth0: Link is Down Oct 07 03:00:11 rivo dhcpcd[3487]: eth0: carrier lost Oct 07 03:00:11 rivo avahi-daemon[2865]: Withdrawing address record for 192.168.0.39 on eth0. Oct 07 03:00:11 rivo avahi-daemon[2865]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.0.39. Oct 07 03:00:11 rivo dhcpcd[3487]: eth0: deleting route to 192.168.0.0/24 Oct 07 03:00:11 rivo avahi-daemon[2865]: Interface eth0.IPv4 no longer relevant for mDNS. Oct 07 03:00:11 rivo dhcpcd[3487]: eth0: deleting default route via 192.168.0.1 Oct 07 03:00:11 rivo volumio[3219]: info: Discovery: A device disappeared from network Oct 07 03:00:11 rivo volumio[3219]: info: Discovery: Device rivo disappeared from network Oct 07 03:00:11 rivo volumio[3219]: info: Discovery: A device disappeared from network Oct 07 03:00:11 rivo volumio[3219]: info: Discovery: Device volumio disappeared from network Oct 07 03:00:11 rivo volumio[3219]: info: Discovery: Disconnected from remote: 192.168.0.143 Oct 07 03:00:11 rivo volumio[3219]: info: MRS: Cleaning up device: 82cdcfb0-228a-4868-8ffd-59a35246aeda Oct 07 03:00:11 rivo volumio[3219]: info: Removing audio output: Oct 07 03:00:11 rivo volumio[3219]: info: Discovery: Disconnected from remote: 192.168.0.143 Oct 07 03:00:11 rivo volumio[3219]: info: Discovery: Disconnected from remote: 192.168.0.143 Oct 07 03:00:11 rivo dhcpcd[3563]: eth0: deleting route to 192.168.0.0/24 Oct 07 03:00:11 rivo dhcpcd[3563]: eth0: deleting default route via 192.168.0.1 Oct 07 03:00:12 rivo ifplugd(eth0)[3115]: Link beat lost. Oct 07 03:00:13 rivo ntpd[16517]: Deleting interface #3 eth0, 192.168.0.39#123, interface stats: received=297, sent=305, dropped=0, active_time=2388 secs Oct 07 03:00:13 rivo ntpd[16517]: 114.34.171.136 local addr 192.168.0.39 -> Oct 07 03:00:13 rivo ntpd[16517]: 183.177.72.202 local addr 192.168.0.39 -> Oct 07 03:00:13 rivo ntpd[16517]: 114.35.131.27 local addr 192.168.0.39 -> Oct 07 03:00:13 rivo ntpd[16517]: 210.243.152.152 local addr 192.168.0.39 -> Oct 07 03:00:13 rivo ntpd[16517]: 17.253.116.253 local addr 192.168.0.39 -> Oct 07 03:00:13 rivo ntpd[16517]: 118.163.81.63 local addr 192.168.0.39 -> Oct 07 03:00:13 rivo dhcpcd[3563]: eth0: carrier acquired Oct 07 03:00:13 rivo dhcpcd[3487]: eth0: carrier acquired Oct 07 03:00:13 rivo kernel: meson6-dwmac ff3f0000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Oct 07 03:00:13 rivo dhcpcd[3487]: eth0: IAID 00:11:30:01 Oct 07 03:00:13 rivo dhcpcd[3563]: eth0: IAID 00:11:30:01 Oct 07 03:00:13 rivo ifplugd(eth0)[3115]: Link beat detected. Oct 07 03:00:13 rivo dhcpcd[3563]: eth0: rebinding lease of 192.168.0.39 Oct 07 03:00:14 rivo dhcpcd[3563]: eth0: soliciting an IPv6 router Oct 07 03:00:14 rivo dhcpcd[3487]: eth0: soliciting an IPv6 router Oct 07 03:00:14 rivo dhcpcd[3487]: eth0: rebinding lease of 192.168.0.39 Oct 07 03:00:18 rivo dhcpcd[3563]: eth0: probing for an IPv4LL address Oct 07 03:00:18 rivo dhcpcd[3563]: eth0: DHCP lease expired Oct 07 03:00:19 rivo dhcpcd[3563]: eth0: soliciting a DHCP lease Oct 07 03:00:19 rivo dhcpcd[3487]: eth0: probing for an IPv4LL address Oct 07 03:00:19 rivo dhcpcd[3487]: eth0: DHCP lease expired Oct 07 03:00:19 rivo dhcpcd[3487]: eth0: soliciting a DHCP lease Oct 07 03:00:21 rivo dhcpcd[3487]: eth0: carrier lost Oct 07 03:00:21 rivo dhcpcd[3563]: eth0: carrier lost Oct 07 03:00:21 rivo kernel: meson6-dwmac ff3f0000.ethernet eth0: Link is Down Oct 07 03:00:22 rivo ifplugd(eth0)[3115]: Link beat lost. Oct 07 03:00:24 rivo dhcpcd[3487]: eth0: carrier acquired Oct 07 03:00:24 rivo dhcpcd[3563]: eth0: carrier acquired Oct 07 03:00:24 rivo kernel: meson6-dwmac ff3f0000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Oct 07 03:00:24 rivo dhcpcd[3563]: eth0: IAID 00:11:30:01 Oct 07 03:00:24 rivo dhcpcd[3487]: eth0: IAID 00:11:30:01 Oct 07 03:00:24 rivo ifplugd(eth0)[3115]: Link beat detected. Oct 07 03:00:24 rivo kernel: wl_iw_event: Link Down with 40:ae:30:03:90:25, reason=1 Oct 07 03:00:24 rivo kernel: CFG80211-ERROR) wl_is_linkdown : Link down Reason : WLC_E_LINK Oct 07 03:00:24 rivo kernel: link down if wlan0 may call cfg80211_disconnected. event : 16, reason=1 from 40:ae:30:03:90:25 Oct 07 03:00:24 rivo kernel: dhd_dbg_stop_pkt_monitor, 1963 Oct 07 03:00:24 rivo kernel: wl_iw_event: Link Down with 40:ae:30:03:90:25, reason=2 Oct 07 03:00:24 rivo kernel: CFG80211-ERROR) wl_cfg80211_tdls_config : No change in tdls state. Do nothing. tdls_enable:1 Oct 07 03:00:24 rivo kernel: CFG80211-ERROR) wl_is_linkdown : Link down Reason : WLC_E_LINK Oct 07 03:00:24 rivo kernel: CFG80211-ERROR) wl_cfg80211_tdls_config : No change in tdls state. Do nothing. tdls_enable:1 Oct 07 03:00:24 rivo wpa_supplicant[5734]: wlan0: CTRL-EVENT-DISCONNECTED bssid=40:ae:30:03:90:25 reason=0 Oct 07 03:00:24 rivo dhcpcd[3563]: eth0: soliciting a DHCP lease Oct 07 03:00:24 rivo dhcpcd[3563]: wlan0: carrier lost Oct 07 03:00:24 rivo wpa_supplicant[5734]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Oct 07 03:00:24 rivo wpa_supplicant[5734]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=JP Oct 07 03:00:24 rivo avahi-daemon[2865]: Withdrawing address record for 192.168.0.123 on wlan0. Oct 07 03:00:24 rivo avahi-daemon[2865]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.123. Oct 07 03:00:24 rivo avahi-daemon[2865]: Interface wlan0.IPv4 no longer relevant for mDNS. Oct 07 03:00:24 rivo volumio[3219]: info: Discovery: A device disappeared from network Oct 07 03:00:24 rivo volumio[3219]: info: Discovery: A device disappeared from network Oct 07 03:00:24 rivo dhcpcd[3563]: wlan0: deleting route to 192.168.0.0/24 Oct 07 03:00:24 rivo dhcpcd[3563]: wlan0: deleting default route via 192.168.0.1 Oct 07 03:00:24 rivo dhcpcd[3487]: eth0: soliciting a DHCP lease Oct 07 03:00:24 rivo dhcpcd[3563]: eth0: soliciting an IPv6 router Oct 07 03:00:24 rivo dhcpcd[3487]: eth0: soliciting an IPv6 router Oct 07 03:00:25 rivo ntpd[16517]: Deleting interface #4 wlan0, 192.168.0.123#123, interface stats: received=0, sent=6, dropped=0, active_time=2400 secs Oct 07 03:00:25 rivo ntpd[16517]: 118.163.81.63 local addr 192.168.0.123 -> Oct 07 03:00:25 rivo ntpd[16517]: 17.253.116.253 local addr 192.168.0.123 -> Oct 07 03:00:25 rivo ntpd[16517]: 210.243.152.152 local addr 192.168.0.123 -> Oct 07 03:00:25 rivo ntpd[16517]: 114.35.131.27 local addr 192.168.0.123 -> Oct 07 03:00:25 rivo ntpd[16517]: 183.177.72.202 local addr 192.168.0.123 -> Oct 07 03:00:25 rivo ntpd[16517]: 114.34.171.136 local addr 192.168.0.123 -> Oct 07 03:00:29 rivo dhcpcd[3563]: eth0: probing for an IPv4LL address Oct 07 03:00:29 rivo dhcpcd[3487]: eth0: probing for an IPv4LL address Oct 07 03:00:34 rivo dhcpcd[3563]: eth0: carrier lost Oct 07 03:00:34 rivo dhcpcd[3487]: eth0: carrier lost Oct 07 03:00:34 rivo kernel: meson6-dwmac ff3f0000.ethernet eth0: Link is Down Oct 07 03:00:35 rivo ifplugd(eth0)[3115]: Link beat lost. Oct 07 03:00:37 rivo dhcpcd[3487]: eth0: carrier acquired Oct 07 03:00:37 rivo dhcpcd[3563]: eth0: carrier acquired Oct 07 03:00:37 rivo kernel: meson6-dwmac ff3f0000.ethernet eth0: Link is Up - 1Gbps/Full - flow control off Oct 07 03:00:37 rivo dhcpcd[3487]: eth0: IAID 00:11:30:01 Oct 07 03:00:37 rivo dhcpcd[3563]: eth0: IAID 00:11:30:01 Oct 07 03:00:37 rivo dhcpcd[3487]: eth0: soliciting an IPv6 router Oct 07 03:00:37 rivo dhcpcd[3563]: eth0: soliciting a DHCP lease Oct 07 03:00:37 rivo dhcpcd[3563]: eth0: soliciting an IPv6 router Oct 07 03:00:38 rivo dhcpcd[3487]: eth0: soliciting a DHCP lease Oct 07 03:00:38 rivo ifplugd(eth0)[3115]: Link beat detected. Oct 07 03:00:41 rivo dhcpcd[3563]: eth0: carrier lost Oct 07 03:00:41 rivo dhcpcd[3487]: eth0: carrier lost Oct 07 03:00:41 rivo kernel: meson6-dwmac ff3f0000.ethernet eth0: Link is Down Oct 07 03:00:42 rivo ifplugd(eth0)[3115]: Link beat lost. Oct 07 03:00:47 rivo ntpd[16517]: Soliciting pool server 125.229.106.76 Oct 07 03:00:49 rivo ntpd[16517]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Oct 07 03:00:52 rivo ifplugd(eth0)[3115]: Executing '/etc/ifplugd/ifplugd.action eth0 down'. Oct 07 03:00:52 rivo ifplugd(eth0)[3115]: client: sending commands to master dhcpcd process Oct 07 03:00:52 rivo dhcpcd[20476]: sending commands to master dhcpcd process Oct 07 03:00:52 rivo dhcpcd[3563]: control command: /sbin/dhcpcd -k eth0 Oct 07 03:00:52 rivo dhcpcd[3563]: eth0: removing interface Oct 07 03:00:52 rivo ifplugd(eth0)[3115]: Program executed successfully. Oct 07 03:01:03 rivo ntpd[16517]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Oct 07 03:01:04 rivo ntpd[16517]: Soliciting pool server 2001:b031:5c02:ff00::5 Oct 07 03:01:21 rivo wpa_supplicant[5734]: wlan0: Trying to associate with 40:ae:30:03:90:24 (SSID='TP-Link_D22C' freq=2457 MHz) Oct 07 03:01:21 rivo kernel: Connecting with 40:ae:30:03:90:24 ssid "TP-Link_D22C", len (12) channel=10 Oct 07 03:01:21 rivo kernel: dhd_dbg_start_pkt_monitor, 1724 Oct 07 03:01:21 rivo kernel: wl_iw_event: Link UP with 40:ae:30:03:90:24 Oct 07 03:01:21 rivo kernel: wl_bss_connect_done succeeded with 40:ae:30:03:90:24 Oct 07 03:01:21 rivo kernel: CFG80211-ERROR) wl_cfg80211_scan_abort : scan abort failed Oct 07 03:01:21 rivo wpa_supplicant[5734]: wlan0: Associated with 40:ae:30:03:90:24 Oct 07 03:01:21 rivo wpa_supplicant[5734]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Oct 07 03:01:21 rivo wpa_supplicant[5734]: wlan0: WPA: Key negotiation completed with 40:ae:30:03:90:24 [PTK=CCMP GTK=CCMP] Oct 07 03:01:21 rivo wpa_supplicant[5734]: wlan0: CTRL-EVENT-CONNECTED - Connection to 40:ae:30:03:90:24 completed [id=0 id_str=] Oct 07 03:01:21 rivo dhcpcd[3563]: wlan0: carrier acquired Oct 07 03:01:21 rivo dhcpcd[3563]: wlan0: IAID 32:e5:b3:74 Oct 07 03:01:21 rivo wpa_supplicant[5734]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=JP Oct 07 03:01:21 rivo kernel: wl_bss_connect_done succeeded with 40:ae:30:03:90:24 vndr_oui: 8C-FD-F0 Oct 07 03:01:21 rivo wpa_supplicant[5734]: wlan0: CTRL-EVENT-DISCONNECTED bssid=40:ae:30:03:90:24 reason=3 Oct 07 03:01:21 rivo kernel: CFG80211-ERROR) wl_is_linkdown : Link down Reason : WLC_E_DEAUTH_IND Oct 07 03:01:21 rivo kernel: link down if wlan0 may call cfg80211_disconnected. event : 6, reason=3 from 40:ae:30:03:90:24 Oct 07 03:01:21 rivo kernel: dhd_dbg_stop_pkt_monitor, 1963 Oct 07 03:01:21 rivo kernel: wl_iw_event: Link Down with 40:ae:30:03:90:24, reason=2 Oct 07 03:01:21 rivo kernel: CFG80211-ERROR) wl_cfg80211_tdls_config : No change in tdls state. Do nothing. tdls_enable:1 Oct 07 03:01:21 rivo kernel: CFG80211-ERROR) wl_is_linkdown : Link down Reason : WLC_E_LINK Oct 07 03:01:21 rivo kernel: CFG80211-ERROR) wl_cfg80211_tdls_config : No change in tdls state. Do nothing. tdls_enable:1 Oct 07 03:01:21 rivo dhcpcd[3563]: wlan0: carrier lost Oct 07 03:01:21 rivo wpa_supplicant[5734]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Oct 07 03:01:21 rivo wpa_supplicant[5734]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=JP Oct 07 03:01:25 rivo wpa_supplicant[5734]: wlan0: Trying to associate with 40:ae:30:03:90:24 (SSID='TP-Link_D22C' freq=2457 MHz) Oct 07 03:01:25 rivo kernel: Connecting with 40:ae:30:03:90:24 ssid "TP-Link_D22C", len (12) channel=10 Oct 07 03:01:25 rivo kernel: dhd_dbg_start_pkt_monitor, 1724 Oct 07 03:01:25 rivo kernel: wl_iw_event: Link UP with 40:ae:30:03:90:24 Oct 07 03:01:25 rivo kernel: wl_bss_connect_done succeeded with 40:ae:30:03:90:24 Oct 07 03:01:25 rivo kernel: CFG80211-ERROR) wl_cfg80211_scan_abort : scan abort failed Oct 07 03:01:25 rivo wpa_supplicant[5734]: wlan0: Associated with 40:ae:30:03:90:24 Oct 07 03:01:25 rivo wpa_supplicant[5734]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Oct 07 03:01:25 rivo kernel: wl_bss_connect_done succeeded with 40:ae:30:03:90:24 vndr_oui: 8C-FD-F0 Oct 07 03:01:25 rivo wpa_supplicant[5734]: wlan0: WPA: Key negotiation completed with 40:ae:30:03:90:24 [PTK=CCMP GTK=CCMP] Oct 07 03:01:25 rivo wpa_supplicant[5734]: wlan0: CTRL-EVENT-CONNECTED - Connection to 40:ae:30:03:90:24 completed [id=0 id_str=] Oct 07 03:01:25 rivo dhcpcd[3563]: wlan0: carrier acquired Oct 07 03:01:25 rivo wpa_supplicant[5734]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=JP Oct 07 03:01:25 rivo dhcpcd[3563]: wlan0: IAID 32:e5:b3:74 Oct 07 03:01:25 rivo dhcpcd[3563]: wlan0: rebinding lease of 192.168.0.123 Oct 07 03:01:25 rivo dhcpcd[3563]: wlan0: soliciting an IPv6 router Oct 07 03:01:28 rivo dhcpcd[3563]: wlan0: probing address 192.168.0.123/24 Oct 07 03:01:33 rivo dhcpcd[3563]: wlan0: leased 192.168.0.123 for 7200 seconds Oct 07 03:01:33 rivo avahi-daemon[2865]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.123. Oct 07 03:01:33 rivo dhcpcd[3563]: wlan0: adding route to 192.168.0.0/24 Oct 07 03:01:33 rivo dhcpcd[3563]: wlan0: adding default route via 192.168.0.1 Oct 07 03:01:33 rivo avahi-daemon[2865]: New relevant interface wlan0.IPv4 for mDNS. Oct 07 03:01:33 rivo avahi-daemon[2865]: Registering new address record for 192.168.0.123 on wlan0.IPv4. Oct 07 03:01:33 rivo systemd[1]: Stopping Network Time Service... Oct 07 03:01:33 rivo ntpd[16517]: ntpd exiting on signal 15 (Terminated) Oct 07 03:01:33 rivo volumio[3219]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 07 03:01:33 rivo systemd[1]: ntp.service: Succeeded. Oct 07 03:01:33 rivo systemd[1]: Stopped Network Time Service. Oct 07 03:01:33 rivo volumio[3219]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Oct 07 03:01:33 rivo systemd[1]: Starting Network Time Service... Oct 07 03:01:33 rivo volumio[3219]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 07 03:01:34 rivo ntpd[20609]: ntpd 4.2.8p12@1.3728-o (1): Starting Oct 07 03:01:34 rivo ntpd[20609]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Oct 07 03:01:34 rivo systemd[1]: Started Network Time Service. Oct 07 03:01:34 rivo ntpd[20622]: proto: precision = 1.250 usec (-20) Oct 07 03:01:34 rivo ntpd[20622]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Oct 07 03:01:34 rivo ntpd[20622]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Oct 07 03:01:34 rivo ntpd[20622]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 649 days ago Oct 07 03:01:34 rivo ntpd[20622]: Listen and drop on 0 v6wildcard [::]:123 Oct 07 03:01:34 rivo ntpd[20622]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 07 03:01:34 rivo ntpd[20622]: Listen normally on 2 lo 127.0.0.1:123 Oct 07 03:01:34 rivo ntpd[20622]: Listen normally on 3 wlan0 192.168.0.123:123 Oct 07 03:01:34 rivo ntpd[20622]: Listening on routing socket on fd #20 for interface updates Oct 07 03:01:34 rivo ntpd[20622]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Oct 07 03:01:34 rivo ntpd[20622]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Oct 07 03:01:36 rivo dhcpcd[3487]: eth0: carrier acquired Oct 07 03:01:36 rivo kernel: meson6-dwmac ff3f0000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Oct 07 03:01:36 rivo dhcpcd[3487]: eth0: IAID 00:11:30:01 Oct 07 03:01:37 rivo dhcpcd[3487]: eth0: soliciting a DHCP lease Oct 07 03:01:37 rivo dhcpcd[3487]: eth0: soliciting an IPv6 router Oct 07 03:01:37 rivo ifplugd(eth0)[3115]: Link beat detected. Oct 07 03:01:37 rivo ifplugd(eth0)[3115]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Oct 07 03:01:37 rivo ifplugd(eth0)[3115]: client: sending commands to master dhcpcd process Oct 07 03:01:37 rivo dhcpcd[20647]: sending commands to master dhcpcd process Oct 07 03:01:37 rivo dhcpcd[3563]: control command: /sbin/dhcpcd eth0 Oct 07 03:01:37 rivo dhcpcd[3563]: eth0: carrier acquired Oct 07 03:01:37 rivo dhcpcd[3563]: eth0: IAID 00:11:30:01 Oct 07 03:01:37 rivo dhcpcd[3563]: eth0: soliciting a DHCP lease Oct 07 03:01:38 rivo ifplugd(eth0)[3115]: Program executed successfully. Oct 07 03:01:38 rivo nmbd[3084]: [2024/10/07 03:01:38.266035, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Oct 07 03:01:38 rivo nmbd[3084]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.0.39 for name WORKGROUP<1d>. Oct 07 03:01:38 rivo nmbd[3084]: This response was from IP 192.168.0.70, reporting an IP address of 192.168.0.70. Oct 07 03:01:38 rivo dhcpcd[3563]: eth0: soliciting an IPv6 router Oct 07 03:01:40 rivo volumiossh-tunnel[20436]: Timeout, server us2.myvolumio.org not responding. Oct 07 03:01:40 rivo autossh[20440]: ssh exited with error status 255; restarting ssh Oct 07 03:01:40 rivo autossh[20440]: starting ssh (count 9) Oct 07 03:01:40 rivo autossh[20440]: ssh child pid is 20680 Oct 07 03:01:40 rivo dhcpcd[3487]: eth0: offered 192.168.0.39 from 192.168.0.1 Oct 07 03:01:40 rivo dhcpcd[3487]: eth0: probing address 192.168.0.39/24 Oct 07 03:01:42 rivo dhcpcd[3563]: eth0: offered 192.168.0.39 from 192.168.0.1 Oct 07 03:01:42 rivo dhcpcd[3563]: eth0: probing address 192.168.0.39/24 Oct 07 03:01:45 rivo dhcpcd[3487]: eth0: leased 192.168.0.39 for infinity Oct 07 03:01:45 rivo dhcpcd[3487]: eth0: adding route to 192.168.0.0/24 Oct 07 03:01:45 rivo dhcpcd[3487]: eth0: adding default route via 192.168.0.1 Oct 07 03:01:45 rivo avahi-daemon[2865]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.0.39. Oct 07 03:01:45 rivo avahi-daemon[2865]: New relevant interface eth0.IPv4 for mDNS. Oct 07 03:01:45 rivo avahi-daemon[2865]: Registering new address record for 192.168.0.39 on eth0.IPv4. Oct 07 03:01:46 rivo ntpd[20622]: ntpd exiting on signal 15 (Terminated) Oct 07 03:01:46 rivo systemd[1]: Stopping Network Time Service... Oct 07 03:01:46 rivo volumio[3219]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 07 03:01:46 rivo systemd[1]: ntp.service: Succeeded. Oct 07 03:01:46 rivo systemd[1]: Stopped Network Time Service. Oct 07 03:01:46 rivo volumio[3219]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Oct 07 03:01:46 rivo systemd[1]: Starting Network Time Service... Oct 07 03:01:46 rivo volumio[3219]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 07 03:01:46 rivo ntpd[20715]: ntpd 4.2.8p12@1.3728-o (1): Starting Oct 07 03:01:46 rivo ntpd[20715]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Oct 07 03:01:46 rivo systemd[1]: Started Network Time Service. Oct 07 03:01:46 rivo ntpd[20730]: proto: precision = 1.250 usec (-20) Oct 07 03:01:46 rivo ntpd[20730]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Oct 07 03:01:46 rivo ntpd[20730]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Oct 07 03:01:46 rivo ntpd[20730]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 649 days ago Oct 07 03:01:46 rivo ntpd[20730]: Listen and drop on 0 v6wildcard [::]:123 Oct 07 03:01:46 rivo ntpd[20730]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 07 03:01:46 rivo ntpd[20730]: Listen normally on 2 lo 127.0.0.1:123 Oct 07 03:01:46 rivo ntpd[20730]: Listen normally on 3 eth0 192.168.0.39:123 Oct 07 03:01:46 rivo ntpd[20730]: Listen normally on 4 wlan0 192.168.0.123:123 Oct 07 03:01:46 rivo ntpd[20730]: Listening on routing socket on fd #21 for interface updates Oct 07 03:01:46 rivo ntpd[20730]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Oct 07 03:01:46 rivo ntpd[20730]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Oct 07 03:01:46 rivo volumiossh-tunnel[20436]: Warning: Permanently added '[us2.myvolumio.org]:2222,[137.184.235.84]:2222' (RSA) to the list of known hosts. Oct 07 03:01:47 rivo dhcpcd[3563]: eth0: leased 192.168.0.39 for infinity Oct 07 03:01:47 rivo dhcpcd[3563]: eth0: adding route to 192.168.0.0/24 Oct 07 03:01:47 rivo dhcpcd[3563]: eth0: adding default route via 192.168.0.1 Oct 07 03:01:47 rivo volumiossh-tunnel[20436]: Warning: remote port forwarding failed for listen port 8091 Oct 07 03:01:47 rivo ntpd[20730]: ntpd exiting on signal 15 (Terminated) Oct 07 03:01:47 rivo systemd[1]: Stopping Network Time Service... Oct 07 03:01:47 rivo volumio[3219]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 07 03:01:47 rivo systemd[1]: ntp.service: Succeeded. Oct 07 03:01:47 rivo systemd[1]: Stopped Network Time Service. Oct 07 03:01:47 rivo volumio[3219]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Oct 07 03:01:47 rivo systemd[1]: Starting Network Time Service... Oct 07 03:01:47 rivo volumio[3219]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 07 03:01:47 rivo ntpd[20763]: ntpd 4.2.8p12@1.3728-o (1): Starting Oct 07 03:01:47 rivo ntpd[20763]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Oct 07 03:01:47 rivo systemd[1]: Started Network Time Service. Oct 07 03:01:47 rivo ntpd[20769]: proto: precision = 1.250 usec (-20) Oct 07 03:01:47 rivo ntpd[20769]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Oct 07 03:01:47 rivo ntpd[20769]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Oct 07 03:01:47 rivo ntpd[20769]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 649 days ago Oct 07 03:01:47 rivo ntpd[20769]: Listen and drop on 0 v6wildcard [::]:123 Oct 07 03:01:47 rivo ntpd[20769]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 07 03:01:47 rivo ntpd[20769]: Listen normally on 2 lo 127.0.0.1:123 Oct 07 03:01:47 rivo ntpd[20769]: Listen normally on 3 eth0 192.168.0.39:123 Oct 07 03:01:47 rivo ntpd[20769]: Listen normally on 4 wlan0 192.168.0.123:123 Oct 07 03:01:47 rivo ntpd[20769]: Listening on routing socket on fd #21 for interface updates Oct 07 03:01:47 rivo ntpd[20769]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Oct 07 03:01:47 rivo ntpd[20769]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Oct 07 03:01:47 rivo volumio[3219]: verbose: New Socket.io Connection to 192.168.0.39:3000 from 192.168.0.121 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Oct 07 03:01:47 rivo volumio[3219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Oct 07 03:01:47 rivo volumio[3219]: info: CoreCommandRouter::volumioGetState Oct 07 03:01:47 rivo volumio[3219]: info: CorePlayQueue::getTrack 1 Oct 07 03:01:48 rivo volumio[3219]: info: Discovery: adding ce9a4d4b-c650-41ad-976c-396722650571 Oct 07 03:01:48 rivo volumio[3219]: info: Discovery: Found device Rivo Oct 07 03:01:48 rivo volumio[3219]: info: CoreCommandRouter::volumioGetState Oct 07 03:01:48 rivo volumio[3219]: info: CorePlayQueue::getTrack 1 Oct 07 03:01:48 rivo volumio[3219]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 07 03:01:48 rivo volumio[3219]: Error: The value NaN is not a number Oct 07 03:01:48 rivo volumio[3219]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20) Oct 07 03:01:48 rivo volumio[3219]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25) Oct 07 03:01:48 rivo volumio[3219]: at ControllerVolumioDiscovery.updateMultiroomDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:323:25) Oct 07 03:01:48 rivo volumio[3219]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:273:10) Oct 07 03:01:48 rivo volumio[3219]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12) Oct 07 03:01:48 rivo volumio[3219]: at Browser.emit (events.js:400:28) Oct 07 03:01:48 rivo volumio[3219]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) Oct 07 03:01:48 rivo volumio[3219]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7) Oct 07 03:01:48 rivo volumio[3219]: at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5) Oct 07 03:01:48 rivo volumio[3219]: at next (/volumio/node_modules/mdns/lib/browser.js:109:21) Oct 07 03:01:48 rivo volumio[3219]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 Oct 07 03:01:48 rivo volumio[3219]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7) Oct 07 03:01:48 rivo volumio[3219]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) Oct 07 03:01:48 rivo volumio[3219]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 07 03:01:48 rivo ntpd[20769]: Soliciting pool server 210.243.152.152 Oct 07 03:01:49 rivo ntpd[20769]: Soliciting pool server 220.135.175.159 Oct 07 03:01:49 rivo ntpd[20769]: Soliciting pool server 122.117.253.246 Oct 07 03:01:49 rivo sudo[20795]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-07 03:00 Oct 07 03:01:49 rivo sudo[20795]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:47:06 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="b3e08c3e210a64867536255c2503fb09"