Aug 31 14:48:00 volumio volumio-remote-updater[840]: [2026-08-31 14:48:00] [connect] Successful connection Aug 31 14:48:07 volumio dhcpcd[906]: eth0: carrier lost Aug 31 14:48:07 volumio dhcpcd[721]: eth0: carrier lost Aug 31 14:48:07 volumio kernel: bcmgenet fd580000.ethernet eth0: Link is Down Aug 31 14:48:07 volumio avahi-daemon[821]: Withdrawing address record for 192.168.1.143 on eth0. Aug 31 14:48:07 volumio avahi-daemon[821]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.1.143. Aug 31 14:48:07 volumio avahi-daemon[821]: Interface eth0.IPv4 no longer relevant for mDNS. Aug 31 14:48:07 volumio dhcpcd[906]: eth0: deleting route to 192.168.1.0/24 Aug 31 14:48:07 volumio dhcpcd[906]: eth0: deleting default route via 192.168.1.1 Aug 31 14:48:07 volumio dhcpcd[721]: eth0: deleting route to 192.168.1.0/24 Aug 31 14:48:07 volumio dhcpcd[721]: eth0: deleting default route via 192.168.1.1 Aug 31 14:48:07 volumio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Aug 31 14:48:07 volumio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Aug 31 14:48:07 volumio systemd[1]: welcome.service: Deactivated successfully. Aug 31 14:48:07 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Aug 31 14:48:07 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Aug 31 14:48:07 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Aug 31 14:48:07 volumio ifplugd(eth0)[1077]: Link beat lost. Aug 31 14:48:07 volumio welcome[4910]: Resolved ip:[0] Aug 31 14:48:07 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Aug 31 14:48:07 volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Aug 31 14:48:08 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:08.163+07:00 level=INFO msg="emitting ethernet info changed event" component=server peer="00:00:00:00:00:00%01 @ 0x1d97740" available=true connected=false macAddress= ip4Address= ip6Address= Aug 31 14:48:09 volumio ntpd[1057]: IO: Deleting interface #3 eth0, 192.168.1.143#123, interface stats: received=143, sent=148, dropped=0, active_time=1401 secs Aug 31 14:48:09 volumio ntpd[1057]: PROTO: 202.28.116.236 unlink local addr 192.168.1.143 -> Aug 31 14:48:09 volumio ntpd[1057]: PROTO: 202.28.92.208 unlink local addr 192.168.1.143 -> Aug 31 14:48:09 volumio ntpd[1057]: PROTO: 124.109.2.169 unlink local addr 192.168.1.143 -> Aug 31 14:48:09 volumio ntpd[1057]: PROTO: 202.28.117.7 unlink local addr 192.168.1.143 -> Aug 31 14:48:09 volumio ntpd[1057]: PROTO: 203.159.70.33 unlink local addr 192.168.1.143 -> Aug 31 14:48:09 volumio ntpd[1057]: PROTO: 202.28.33.225 unlink local addr 192.168.1.143 -> Aug 31 14:48:11 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:11.473+07:00 level=WARN msg="pending write exceeded maximum retries, dropping" component=ble/conn addr=1 chunks=1 index=0 tries=11 Aug 31 14:48:11 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:11.473+07:00 level=ERROR msg="failed to send event" component=server dst="00:00:00:00:00:00%01 @ 0x1d97740" event=SERVER_EVENT_TYPE_ETHERNET_INFO_CHANGED error="peer is gone" Aug 31 14:48:11 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:11.473+07:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.1.123:57172,00:00:00:00:00:00%08 @ 0x20542d0" available=true connected=false macAddress= ip4Address= ip6Address= Aug 31 14:48:12 volumio dhcpcd[906]: eth0: carrier acquired Aug 31 14:48:12 volumio dhcpcd[721]: eth0: carrier acquired Aug 31 14:48:12 volumio dhcpcd[721]: eth0: IAID 01:6d:9d:c2 Aug 31 14:48:12 volumio dhcpcd[906]: eth0: IAID 01:6d:9d:c2 Aug 31 14:48:12 volumio kernel: bcmgenet fd580000.ethernet eth0: Link is Up - 1Gbps/Full - flow control off Aug 31 14:48:12 volumio dhcpcd[906]: eth0: soliciting an IPv6 router Aug 31 14:48:12 volumio dhcpcd[906]: eth0: rebinding lease of 192.168.1.143 Aug 31 14:48:12 volumio ifplugd(eth0)[1077]: Link beat detected. Aug 31 14:48:12 volumio dhcpcd[721]: eth0: rebinding lease of 192.168.1.143 Aug 31 14:48:12 volumio dhcpcd[721]: eth0: soliciting an IPv6 router Aug 31 14:48:13 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:13.319+07:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.1.123:57172,00:00:00:00:00:00%08 @ 0x20542d0" available=true connected=false macAddress= ip4Address= ip6Address= Aug 31 14:48:15 volumio volumio-remote-updater[840]: [2026-08-31 14:48:15] [connect] Successful connection Aug 31 14:48:16 volumio dhcpcd[721]: eth0: probing address 192.168.1.143/24 Aug 31 14:48:17 volumio dhcpcd[906]: eth0: probing address 192.168.1.143/24 Aug 31 14:48:17 volumio kernel: vc4-drm gpu: [drm] User-defined mode not supported: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x68 0x5 Aug 31 14:48:17 volumio kernel: vc4-drm gpu: [drm] User-defined mode not supported: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x68 0x5 Aug 31 14:48:17 volumio kernel: vc4-drm gpu: [drm] User-defined mode not supported: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x68 0x5 Aug 31 14:48:18 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:18.162+07:00 level=ERROR msg="failed to update discovery on Ethernet info change" error="failed to get system info: could not get system info: context deadline exceeded" Aug 31 14:48:18 volumio kernel: vc4-drm gpu: [drm] User-defined mode not supported: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x68 0x5 Aug 31 14:48:20 volumio dhcpcd[721]: eth0: leased 192.168.1.143 for 86400 seconds Aug 31 14:48:20 volumio avahi-daemon[821]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.143. Aug 31 14:48:20 volumio avahi-daemon[821]: New relevant interface eth0.IPv4 for mDNS. Aug 31 14:48:20 volumio avahi-daemon[821]: Registering new address record for 192.168.1.143 on eth0.IPv4. Aug 31 14:48:20 volumio dhcpcd[721]: eth0: adding route to 192.168.1.0/24 Aug 31 14:48:20 volumio dhcpcd[721]: eth0: adding default route via 192.168.1.1 Aug 31 14:48:20 volumio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Aug 31 14:48:20 volumio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Aug 31 14:48:20 volumio systemd[1]: welcome.service: Deactivated successfully. Aug 31 14:48:20 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Aug 31 14:48:20 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Aug 31 14:48:21 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Aug 31 14:48:21 volumio welcome[4967]: Resolved ip:[1] 192.168.1.143 Aug 31 14:48:21 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Aug 31 14:48:21 volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Aug 31 14:48:21 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:21.418+07:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.1.123:57722 Aug 31 14:48:21 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:21.440+07:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.1.123:57172,00:00:00:00:00:00%08 @ 0x20542d0" available=true connected=true macAddress=e4:5f:01:6d:9d:c2 ip4Address=192.168.1.143/24 ip6Address= Aug 31 14:48:21 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:21.443+07:00 level=ERROR msg="failed to read message" component=conn/ws remoteAddr=192.168.1.123:57172 error="read tcp 192.168.1.143:7331->192.168.1.123:57172: read: connection reset by peer" Aug 31 14:48:21 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:21.443+07:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.1.123:57172 Aug 31 14:48:21 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:21.443+07:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.1.123:57172 Aug 31 14:48:22 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:22.317+07:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.1.123:57725 Aug 31 14:48:22 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:22.336+07:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" latency=-22.690185ms timeout=10s Aug 31 14:48:22 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:22.352+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" latency=-22.690185ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=15.759642ms Aug 31 14:48:22 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:22.380+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" latency=-22.690185ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=43.410518ms Aug 31 14:48:22 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:22.383+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" latency=-22.690185ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=46.419766ms Aug 31 14:48:22 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:22.436+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" latency=-22.690185ms timeout=10s endpoint=https://google.com duration=99.952111ms Aug 31 14:48:22 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:22.476+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" latency=-22.690185ms timeout=10s endpoint=https://www.googleapis.com duration=139.926422ms Aug 31 14:48:22 volumio ntpd[1057]: IO: Listen normally on 4 eth0 192.168.1.143:123 Aug 31 14:48:22 volumio ntpd[1057]: IO: new interface(s) found: waking up resolver Aug 31 14:48:22 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:22.536+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" latency=-22.690185ms timeout=10s endpoint=http://pushupdates.volumio.org duration=198.757862ms Aug 31 14:48:22 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:22.590+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" latency=-22.690185ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=253.205142ms Aug 31 14:48:22 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:22.590+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" latency=-22.690185ms timeout=10s endpoint=https://functions.volumio.cloud duration=253.599212ms Aug 31 14:48:22 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:22.595+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" latency=-22.690185ms timeout=10s endpoint=https://securetoken.googleapis.com duration=258.294685ms Aug 31 14:48:22 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:22.601+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" latency=-22.690185ms timeout=10s endpoint=https://functions.volumio.cloud duration=264.003073ms Aug 31 14:48:22 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:22.603+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" latency=-22.690185ms timeout=10s endpoint=https://database.volumio.cloud duration=265.730798ms Aug 31 14:48:23 volumio dhcpcd[906]: eth0: leased 192.168.1.143 for 86400 seconds Aug 31 14:48:23 volumio dhcpcd[906]: eth0: adding route to 192.168.1.0/24 Aug 31 14:48:23 volumio dhcpcd[906]: eth0: adding default route via 192.168.1.1 Aug 31 14:48:23 volumio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Aug 31 14:48:23 volumio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Aug 31 14:48:23 volumio systemd[1]: welcome.service: Deactivated successfully. Aug 31 14:48:23 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Aug 31 14:48:23 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Aug 31 14:48:23 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Aug 31 14:48:23 volumio welcome[4997]: Resolved ip:[1] 192.168.1.143 Aug 31 14:48:23 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Aug 31 14:48:23 volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Aug 31 14:48:23 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:23.319+07:00 level=ERROR msg="failed to update discovery on Ethernet info change" error="failed to get system info: could not get system info: context deadline exceeded" Aug 31 14:48:23 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:23.426+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" latency=-22.690185ms timeout=10s endpoint=http://cddb.volumio.org duration=1.089726129s Aug 31 14:48:23 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:23.491+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" latency=-22.690185ms timeout=10s endpoint=http://plugins.volumio.org duration=1.154315734s Aug 31 14:48:23 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:23.686+07:00 level=INFO msg="emitting ethernet info changed event" component=server peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" available=true connected=true macAddress=e4:5f:01:6d:9d:c2 ip4Address=192.168.1.143/24 ip6Address= Aug 31 14:48:30 volumio volumio-remote-updater[840]: [2026-08-31 14:48:30] [connect] Successful connection Aug 31 14:48:31 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:31.440+07:00 level=ERROR msg="failed to update discovery on Ethernet info change" error="failed to get system info: could not get system info: context deadline exceeded" Aug 31 14:48:33 volumio volumio5-onboarding[1553]: time=2026-08-31T14:48:33.686+07:00 level=ERROR msg="failed to update discovery on Ethernet info change" error="failed to get system info: could not get system info: context deadline exceeded" Aug 31 14:48:45 volumio volumio-remote-updater[840]: [2026-08-31 14:48:45] [connect] Successful connection Aug 31 14:49:00 volumio volumio5-onboarding[1553]: time=2026-08-31T14:49:00.402+07:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" latency=-5.07819ms timeout=10s Aug 31 14:49:00 volumio volumio5-onboarding[1553]: time=2026-08-31T14:49:00.417+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" latency=-5.07819ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=15.416978ms Aug 31 14:49:00 volumio volumio5-onboarding[1553]: time=2026-08-31T14:49:00.446+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" latency=-5.07819ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=42.790783ms Aug 31 14:49:00 volumio volumio5-onboarding[1553]: time=2026-08-31T14:49:00.449+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" latency=-5.07819ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=46.201175ms Aug 31 14:49:00 volumio volumio5-onboarding[1553]: time=2026-08-31T14:49:00.493+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" latency=-5.07819ms timeout=10s endpoint=https://google.com duration=91.342879ms Aug 31 14:49:00 volumio volumio-remote-updater[840]: [2026-08-31 14:49:00] [connect] Successful connection Aug 31 14:49:00 volumio volumio5-onboarding[1553]: time=2026-08-31T14:49:00.541+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" latency=-5.07819ms timeout=10s endpoint=https://www.googleapis.com duration=139.43074ms Aug 31 14:49:00 volumio volumio5-onboarding[1553]: time=2026-08-31T14:49:00.606+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" latency=-5.07819ms timeout=10s endpoint=http://pushupdates.volumio.org duration=203.289612ms Aug 31 14:49:00 volumio volumio5-onboarding[1553]: time=2026-08-31T14:49:00.655+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" latency=-5.07819ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=253.01529ms Aug 31 14:49:00 volumio volumio5-onboarding[1553]: time=2026-08-31T14:49:00.661+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" latency=-5.07819ms timeout=10s endpoint=https://database.volumio.cloud duration=257.6963ms Aug 31 14:49:00 volumio volumio5-onboarding[1553]: time=2026-08-31T14:49:00.665+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" latency=-5.07819ms timeout=10s endpoint=https://securetoken.googleapis.com duration=263.145802ms Aug 31 14:49:00 volumio volumio5-onboarding[1553]: time=2026-08-31T14:49:00.737+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" latency=-5.07819ms timeout=10s endpoint=https://functions.volumio.cloud duration=334.886207ms Aug 31 14:49:00 volumio volumio5-onboarding[1553]: time=2026-08-31T14:49:00.745+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" latency=-5.07819ms timeout=10s endpoint=https://functions.volumio.cloud duration=342.165136ms Aug 31 14:49:01 volumio volumio5-onboarding[1553]: time=2026-08-31T14:49:01.238+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" latency=-5.07819ms timeout=10s endpoint=http://plugins.volumio.org duration=835.107048ms Aug 31 14:49:01 volumio volumio5-onboarding[1553]: time=2026-08-31T14:49:01.268+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%08,192.168.1.123:57725 @ 0x20542d0" latency=-5.07819ms timeout=10s endpoint=http://cddb.volumio.org duration=865.044198ms Aug 31 14:49:15 volumio volumio-remote-updater[840]: [2026-08-31 14:49:15] [connect] Successful connection Aug 31 14:49:18 volumio volumio[1259]: --2026-08-31 14:35:23-- https://github.com/balbuze/Spectrum-peppyspectrum/raw/main/Zipped-folders/Choose Aug 31 14:49:18 volumio volumio[1259]: Resolving github.com (github.com)... 20.205.243.166 Aug 31 14:49:18 volumio volumio[1259]: Connecting to github.com (github.com)|20.205.243.166|:443... connected. Aug 31 14:49:18 volumio volumio[1259]: HTTP request sent, awaiting response... 404 Not Found Aug 31 14:49:18 volumio volumio[1259]: 2026-08-31 14:35:24 ERROR 404: Not Found. Aug 31 14:49:18 volumio volumio[1259]: --2026-08-31 14:35:24-- http://a/ Aug 31 14:49:18 volumio volumio[1259]: Resolving a (a)... failed: Device or resource busy. Aug 31 14:49:18 volumio volumio[1259]: wget: unable to resolve host address ‘a’ Aug 31 14:49:18 volumio volumio[1259]: --2026-08-31 14:35:24-- http://packet.zip/ Aug 31 14:49:18 volumio volumio[1259]: Resolving packet.zip (packet.zip)... 185.126.158.214 Aug 31 14:49:18 volumio volumio[1259]: Connecting to packet.zip (packet.zip)|185.126.158.214|:80... failed: Connection timed out. Aug 31 14:49:18 volumio volumio[1259]: Retrying. Aug 31 14:49:18 volumio volumio[1259]: --2026-08-31 14:37:42-- (try: 2) http://packet.zip/ Aug 31 14:49:18 volumio volumio[1259]: Connecting to packet.zip (packet.zip)|185.126.158.214|:80... failed: Connection timed out. Aug 31 14:49:18 volumio volumio[1259]: Retrying. Aug 31 14:49:18 volumio volumio[1259]: --2026-08-31 14:40:01-- (try: 3) http://packet.zip/ Aug 31 14:49:18 volumio volumio[1259]: Connecting to packet.zip (packet.zip)|185.126.158.214|:80... failed: Connection timed out. Aug 31 14:49:18 volumio volumio[1259]: Retrying. Aug 31 14:49:18 volumio volumio[1259]: --2026-08-31 14:42:21-- (try: 4) http://packet.zip/ Aug 31 14:49:18 volumio volumio[1259]: Connecting to packet.zip (packet.zip)|185.126.158.214|:80... failed: Connection timed out. Aug 31 14:49:18 volumio volumio[1259]: Retrying. Aug 31 14:49:18 volumio volumio[1259]: --2026-08-31 14:44:40-- (try: 5) http://packet.zip/ Aug 31 14:49:18 volumio volumio[1259]: Connecting to packet.zip (packet.zip)|185.126.158.214|:80... failed: Connection timed out. Aug 31 14:49:18 volumio volumio[1259]: Retrying. Aug 31 14:49:18 volumio volumio[1259]: --2026-08-31 14:46:59-- (try: 6) http://packet.zip/ Aug 31 14:49:18 volumio volumio[1259]: Connecting to packet.zip (packet.zip)|185.126.158.214|:80... failed: Network is unreachable. Aug 31 14:49:18 volumio volumio[1259]: error: PeppySpectrum --- An error occurs while downloading or installing Spectrums Aug 31 14:49:18 volumio volumio[1259]: /bin/rm: cannot remove '/tmp/Choose': No such file or directory Aug 31 14:49:18 volumio volumio[1259]: /bin/rm: cannot remove 'a': No such file or directory Aug 31 14:49:18 volumio volumio[1259]: /bin/rm: cannot remove 'packet.zip*': No such file or directory Aug 31 14:49:18 volumio volumio[1259]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 14:49:18 volumio volumio[1259]: Error: Command failed: /bin/rm /tmp/Choose a packet.zip* Aug 31 14:49:18 volumio volumio[1259]: /bin/rm: cannot remove '/tmp/Choose': No such file or directory Aug 31 14:49:18 volumio volumio[1259]: /bin/rm: cannot remove 'a': No such file or directory Aug 31 14:49:18 volumio volumio[1259]: /bin/rm: cannot remove 'packet.zip*': No such file or directory Aug 31 14:49:18 volumio volumio[1259]: at checkExecSyncError (node:child_process:887:11) Aug 31 14:49:18 volumio volumio[1259]: at execSync (node:child_process:959:15) Aug 31 14:49:18 volumio volumio[1259]: at /data/plugins/user_interface/peppyspectrum/index.js:770:19 Aug 31 14:49:18 volumio volumio[1259]: at new Promise () Aug 31 14:49:18 volumio volumio[1259]: at peppyspectrum.dlspectrum (/data/plugins/user_interface/peppyspectrum/index.js:745:12) Aug 31 14:49:18 volumio volumio[1259]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Aug 31 14:49:18 volumio volumio[1259]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:337:42) Aug 31 14:49:18 volumio volumio[1259]: at Socket.emit (node:events:514:28) Aug 31 14:49:18 volumio volumio[1259]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Aug 31 14:49:18 volumio volumio[1259]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) { Aug 31 14:49:18 volumio volumio[1259]: status: 1, Aug 31 14:49:18 volumio volumio[1259]: signal: null, Aug 31 14:49:18 volumio volumio[1259]: output: [ Aug 31 14:49:18 volumio volumio[1259]: null, Aug 31 14:49:18 volumio volumio[1259]: , Aug 31 14:49:18 volumio volumio[1259]: Aug 31 14:49:18 volumio volumio[1259]: ], Aug 31 14:49:18 volumio volumio[1259]: pid: 5092, Aug 31 14:49:18 volumio volumio[1259]: stdout: , Aug 31 14:49:18 volumio volumio[1259]: stderr: Aug 31 14:49:18 volumio volumio[1259]: } Aug 31 14:49:18 volumio volumio[1259]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 14:49:18 volumio sudo[5108]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-31 14:48' Aug 31 14:49:18 volumio sudo[5108]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"