Oct 16 16:01:03 volumio volumio[1198]: info: Discovery: Remote connection error: 192.168.10.31 Oct 16 16:01:11 volumio volumio[1198]: info: Discovery: Remote connection error: 192.168.10.31 Oct 16 16:01:14 volumio volumio[1198]: info: Discovery: Remote connection error: 192.168.10.31 Oct 16 16:01:22 volumio volumio[1198]: info: Discovery: Remote connection error: 192.168.10.31 Oct 16 16:01:30 volumio volumio[1198]: info: Discovery: Remote connection error: 192.168.10.31 Oct 16 16:01:38 volumio volumio[1198]: info: Discovery: Remote connection error: 192.168.10.31 Oct 16 16:01:41 volumio volumio[1198]: info: Discovery: Remote connection error: 192.168.10.31 Oct 16 16:01:50 volumio volumio[1198]: info: Discovery: Remote connection error: 192.168.10.31 Oct 16 16:01:58 volumio volumio[1198]: info: Discovery: Remote connection error: 192.168.10.31 Oct 16 16:02:01 volumio volumio[1198]: info: Discovery: Remote connection error: 192.168.10.31 Oct 16 16:02:04 volumio volumio[1198]: info: Discovery: Remote connection error: 192.168.10.31 Oct 16 16:02:07 volumio volumio[1198]: info: Discovery: Remote connection error: 192.168.10.31 Oct 16 16:02:10 volumio volumio[1198]: info: Discovery: Remote connection error: 192.168.10.31 Oct 16 16:02:13 volumio nmbd[1034]: [2026/10/16 16:02:13.183354, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Oct 16 16:02:13 volumio nmbd[1034]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.10.30 for name WORKGROUP<1d>. Oct 16 16:02:13 volumio nmbd[1034]: This response was from IP 192.168.10.35, reporting an IP address of 192.168.10.35. Oct 16 16:02:18 volumio volumio[1198]: info: Discovery: Remote connection error: 192.168.10.31 Oct 16 16:02:27 volumio volumio[1198]: info: Discovery: Remote connection error: 192.168.10.31 Oct 16 16:02:35 volumio volumio[1198]: info: Discovery: Remote connection error: 192.168.10.31 Oct 16 16:02:36 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:36.427Z level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.10.9:54104 @ 0x2a76030" latency=439.127987ms timeout=10s Oct 16 16:02:36 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:36.530Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.10.9:54104 @ 0x2a76030" latency=439.127987ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=102.86241ms Oct 16 16:02:36 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:36.739Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.10.9:54104 @ 0x2a76030" latency=439.127987ms timeout=10s endpoint=https://securetoken.googleapis.com duration=308.971603ms Oct 16 16:02:36 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:36.772Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.10.9:54104 @ 0x2a76030" latency=439.127987ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=342.732079ms Oct 16 16:02:36 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:36.801Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.10.9:54104 @ 0x2a76030" latency=439.127987ms timeout=10s endpoint=https://www.googleapis.com duration=373.156685ms Oct 16 16:02:36 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:36.804Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.10.9:54104 @ 0x2a76030" latency=439.127987ms timeout=10s endpoint=https://google.com duration=376.277817ms Oct 16 16:02:36 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:36.815Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.10.9:54104 @ 0x2a76030" latency=439.127987ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=387.972244ms Oct 16 16:02:36 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:36.822Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.10.9:54104 @ 0x2a76030" latency=439.127987ms timeout=10s endpoint=http://plugins.volumio.org duration=390.22463ms Oct 16 16:02:36 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:36.885Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.10.9:54104 @ 0x2a76030" latency=439.127987ms timeout=10s endpoint=https://functions.volumio.cloud duration=456.949023ms Oct 16 16:02:36 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:36.890Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.10.9:54104 @ 0x2a76030" latency=439.127987ms timeout=10s endpoint=https://functions.volumio.cloud duration=458.428027ms Oct 16 16:02:36 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:36.942Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.10.9:54104 @ 0x2a76030" latency=439.127987ms timeout=10s endpoint=http://pushupdates.volumio.org duration=510.196236ms Oct 16 16:02:37 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:37.033Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.10.9:54104 @ 0x2a76030" latency=439.127987ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=605.886281ms Oct 16 16:02:37 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:37.040Z level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.10.9:54104 @ 0x2a76030" latency=439.127987ms timeout=10s endpoint=http://cddb.volumio.org duration=611.619745ms error="Head \"http://gnudb.gnudb.org/~cddb/cddb.cgi/\": EOF" Oct 16 16:02:37 volumio volumio[1198]: verbose: New Socket.io Connection to 192.168.10.30 from 192.168.10.9 UA: Mozilla/5.0 (Linux; Android 15; P33_ROW Build/AP3A.241105.008; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/155.0.8059.43 Safari/537.36 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 5 Oct 16 16:02:37 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 16 16:02:37 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:37.988Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.10.9:54104 @ 0x2a76030" latency=439.127987ms timeout=10s endpoint=https://database.volumio.cloud duration=1.557498952s Oct 16 16:02:38 volumio volumio[1198]: info: CoreCommandRouter::volumioGetVisibleSources Oct 16 16:02:38 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:02:38 volumio volumio[1198]: info: CoreCommandRouter::volumioGetState Oct 16 16:02:38 volumio volumio[1198]: info: CorePlayQueue::getTrack 0 Oct 16 16:02:38 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 16 16:02:38 volumio volumio[1198]: info: CoreCommandRouter::volumioGetQueue Oct 16 16:02:38 volumio volumio[1198]: info: CoreStateMachine::getQueue Oct 16 16:02:38 volumio volumio[1198]: info: CorePlayQueue::getQueue Oct 16 16:02:38 volumio volumio[1198]: info: Listing playlists Oct 16 16:02:38 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 16 16:02:38 volumio volumio[1198]: info: Received Get System Info Oct 16 16:02:38 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 16:02:38 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 16:02:38 volumio volumio[1198]: info: Discovery: Getting this device information Oct 16 16:02:38 volumio volumio[1198]: info: CoreCommandRouter::volumioGetState Oct 16 16:02:38 volumio volumio[1198]: info: CorePlayQueue::getTrack 0 Oct 16 16:02:38 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 16:02:38 volumio volumio[1198]: info: CoreCommandRouter::volumioGetState Oct 16 16:02:38 volumio volumio[1198]: info: CorePlayQueue::getTrack 0 Oct 16 16:02:38 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 16 16:02:41 volumio dhcpcd[689]: eth0: carrier lost Oct 16 16:02:41 volumio dhcpcd[805]: eth0: carrier lost Oct 16 16:02:41 volumio kernel: lan78xx 1-1.1.1:1.0 eth0: Link is Down Oct 16 16:02:41 volumio avahi-daemon[711]: Withdrawing address record for 192.168.10.30 on eth0. Oct 16 16:02:41 volumio avahi-daemon[711]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.10.30. Oct 16 16:02:41 volumio dhcpcd[805]: eth0: deleting route to 192.168.10.0/24 Oct 16 16:02:41 volumio dhcpcd[805]: eth0: deleting default route via 192.168.10.1 Oct 16 16:02:41 volumio dhcpcd[689]: eth0: deleting route to 192.168.10.0/24 Oct 16 16:02:41 volumio dhcpcd[689]: eth0: deleting default route via 192.168.10.1 Oct 16 16:02:41 volumio avahi-daemon[711]: Interface eth0.IPv4 no longer relevant for mDNS. Oct 16 16:02:41 volumio volumio[1198]: info: Discovery: A device disappeared from network Oct 16 16:02:41 volumio volumio[1198]: info: Discovery: A device disappeared from network Oct 16 16:02:41 volumio volumio[1198]: info: Discovery: A device disappeared from network Oct 16 16:02:41 volumio volumio[1198]: info: Discovery: A device disappeared from network Oct 16 16:02:41 volumio volumio[1198]: info: Discovery: A device disappeared from network Oct 16 16:02:41 volumio volumio[1198]: info: Discovery: A device disappeared from network Oct 16 16:02:41 volumio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Oct 16 16:02:41 volumio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Oct 16 16:02:41 volumio systemd[1]: welcome.service: Deactivated successfully. Oct 16 16:02:41 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Oct 16 16:02:41 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Oct 16 16:02:41 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Oct 16 16:02:41 volumio welcome[15258]: Resolved ip:[0] Oct 16 16:02:41 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Oct 16 16:02:41 volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Oct 16 16:02:41 volumio ifplugd(eth0)[914]: Link beat lost. Oct 16 16:02:41 volumio volumio[1198]: info: Received Get System Info Oct 16 16:02:41 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 16:02:41 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 16:02:41 volumio volumio[1198]: info: Discovery: Getting this device information Oct 16 16:02:41 volumio volumio[1198]: info: CoreCommandRouter::volumioGetState Oct 16 16:02:41 volumio volumio[1198]: info: CorePlayQueue::getTrack 0 Oct 16 16:02:41 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 16:02:41 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:41.704Z level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.10.9:54104 @ 0x2a76030" available=true connected=false macAddress= ip4Address= ip6Address= Oct 16 16:02:41 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 16 16:02:41 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 16 16:02:42 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:42.622Z level=INFO msg="service successfully established" component=discovery/localnet Oct 16 16:02:42 volumio ntpd[902]: IO: Deleting interface #489 eth0, 192.168.10.30#123, interface stats: received=1, sent=1, dropped=0, active_time=122 secs Oct 16 16:02:42 volumio ntpd[902]: PROTO: 142.91.108.61 unlink local addr 192.168.10.30 -> Oct 16 16:02:42 volumio ntpd[902]: PROTO: 133.18.147.168 unlink local addr 192.168.10.30 -> Oct 16 16:02:42 volumio ntpd[902]: PROTO: 138.2.23.206 unlink local addr 192.168.10.30 -> Oct 16 16:02:42 volumio ntpd[902]: PROTO: 45.77.20.103 unlink local addr 192.168.10.30 -> Oct 16 16:02:42 volumio ntpd[902]: PROTO: 43.229.16.158 unlink local addr 192.168.10.30 -> Oct 16 16:02:42 volumio ntpd[902]: PROTO: 167.179.119.205 unlink local addr 192.168.10.30 -> Oct 16 16:02:42 volumio ntpd[902]: PROTO: 172.105.192.74 unlink local addr 192.168.10.30 -> Oct 16 16:02:44 volumio dhcpcd[689]: eth0: carrier acquired Oct 16 16:02:44 volumio dhcpcd[805]: eth0: carrier acquired Oct 16 16:02:44 volumio kernel: lan78xx 1-1.1.1:1.0 eth0: Link is Up - 1Gbps/Full - flow control rx/tx Oct 16 16:02:44 volumio dhcpcd[689]: eth0: IAID eb:f6:35:2d Oct 16 16:02:44 volumio dhcpcd[689]: eth0: probing address 192.168.10.30/24 Oct 16 16:02:44 volumio dhcpcd[805]: eth0: IAID eb:f6:35:2d Oct 16 16:02:44 volumio dhcpcd[805]: eth0: probing address 192.168.10.30/24 Oct 16 16:02:44 volumio dhcpcd[689]: eth0: soliciting an IPv6 router Oct 16 16:02:44 volumio ifplugd(eth0)[914]: Link beat detected. Oct 16 16:02:44 volumio dhcpcd[805]: eth0: soliciting an IPv6 router Oct 16 16:02:44 volumio volumio[1198]: info: Received Get System Info Oct 16 16:02:44 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 16:02:44 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 16:02:44 volumio volumio[1198]: info: Discovery: Getting this device information Oct 16 16:02:44 volumio volumio[1198]: info: CoreCommandRouter::volumioGetState Oct 16 16:02:44 volumio volumio[1198]: info: CorePlayQueue::getTrack 0 Oct 16 16:02:44 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 16:02:44 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:44.943Z level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.10.9:54104 @ 0x2a76030" available=true connected=false macAddress= ip4Address= ip6Address= Oct 16 16:02:44 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 16 16:02:44 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 16 16:02:45 volumio volumio[1198]: info: Discovery: Remote connection error: 192.168.10.31 Oct 16 16:02:45 volumio volumio[1198]: info: Discovery: Remote connection timeout: 192.168.10.31 Oct 16 16:02:45 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:45.853Z level=INFO msg="service successfully established" component=discovery/localnet Oct 16 16:02:46 volumio volumio[1198]: info: Volumio Network Manager: Network status updated: 0 Oct 16 16:02:49 volumio avahi-daemon[711]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.10.30. Oct 16 16:02:49 volumio dhcpcd[805]: eth0: using static address 192.168.10.30/24 Oct 16 16:02:49 volumio avahi-daemon[711]: New relevant interface eth0.IPv4 for mDNS. Oct 16 16:02:49 volumio avahi-daemon[711]: Registering new address record for 192.168.10.30 on eth0.IPv4. Oct 16 16:02:49 volumio dhcpcd[805]: eth0: adding route to 192.168.10.0/24 Oct 16 16:02:49 volumio dhcpcd[805]: eth0: adding default route via 192.168.10.1 Oct 16 16:02:49 volumio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Oct 16 16:02:49 volumio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Oct 16 16:02:49 volumio systemd[1]: welcome.service: Deactivated successfully. Oct 16 16:02:49 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Oct 16 16:02:49 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Oct 16 16:02:49 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Oct 16 16:02:49 volumio welcome[15318]: Resolved ip:[1] 192.168.10.30 Oct 16 16:02:49 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Oct 16 16:02:49 volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Oct 16 16:02:49 volumio dhcpcd[689]: eth0: using static address 192.168.10.30/24 Oct 16 16:02:49 volumio dhcpcd[689]: eth0: adding route to 192.168.10.0/24 Oct 16 16:02:49 volumio dhcpcd[689]: eth0: adding default route via 192.168.10.1 Oct 16 16:02:49 volumio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Oct 16 16:02:49 volumio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Oct 16 16:02:49 volumio systemd[1]: welcome.service: Deactivated successfully. Oct 16 16:02:49 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Oct 16 16:02:49 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Oct 16 16:02:49 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Oct 16 16:02:49 volumio welcome[15347]: Resolved ip:[1] 192.168.10.30 Oct 16 16:02:49 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Oct 16 16:02:49 volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Oct 16 16:02:50 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:50.351Z level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.10.9:54104 @ 0x2a76030" available=true connected=true macAddress=b8:27:eb:f6:35:2d ip4Address=192.168.10.30/24 ip6Address= Oct 16 16:02:50 volumio volumio[1198]: info: Received Get System Info Oct 16 16:02:50 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 16:02:50 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 16:02:50 volumio volumio[1198]: info: Discovery: Getting this device information Oct 16 16:02:50 volumio volumio[1198]: info: CoreCommandRouter::volumioGetState Oct 16 16:02:50 volumio volumio[1198]: info: CorePlayQueue::getTrack 0 Oct 16 16:02:50 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 16:02:50 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 16 16:02:50 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 16 16:02:50 volumio volumio[1198]: info: Discovery: adding b06dd525-1f51-4e8a-bc10-5f7c6da1acce Oct 16 16:02:50 volumio volumio[1198]: info: Discovery: Found device Volumio Oct 16 16:02:50 volumio volumio[1198]: info: CoreCommandRouter::volumioGetState Oct 16 16:02:50 volumio volumio[1198]: info: CorePlayQueue::getTrack 0 Oct 16 16:02:50 volumio volumio[1198]: info: Discovery: this is already registered, b06dd525-1f51-4e8a-bc10-5f7c6da1acce Oct 16 16:02:50 volumio volumio[1198]: info: Discovery: Found device Volumio Oct 16 16:02:50 volumio volumio[1198]: info: CoreCommandRouter::volumioGetState Oct 16 16:02:50 volumio volumio[1198]: info: CorePlayQueue::getTrack 0 Oct 16 16:02:50 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:50.734Z level=ERROR msg="failed to read message" component=conn/ws remoteAddr=192.168.10.9:54104 error="read tcp 192.168.10.30:7331->192.168.10.9:54104: read: connection reset by peer" Oct 16 16:02:50 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:50.734Z level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.10.9:54104 Oct 16 16:02:50 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:50.734Z level=INFO msg="connection to address closed" component=conn/multi addr=192.168.10.9:54104 Oct 16 16:02:50 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:50.736Z level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.10.9:51758 Oct 16 16:02:50 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:50.763Z level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.10.9:51758 @ 0x2b56630" latency=277.453812ms timeout=10s Oct 16 16:02:50 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:50.763Z level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.10.9:51758 @ 0x2b56630" latency=283.400739ms timeout=20s Oct 16 16:02:50 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:50.764Z level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.10.9:51758 @ 0x2b56630" Oct 16 16:02:50 volumio volumio[1198]: info: Received Get System Info Oct 16 16:02:50 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 16:02:50 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 16:02:50 volumio volumio[1198]: info: Discovery: Getting this device information Oct 16 16:02:50 volumio volumio[1198]: info: CoreCommandRouter::volumioGetState Oct 16 16:02:50 volumio volumio[1198]: info: CorePlayQueue::getTrack 0 Oct 16 16:02:50 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 16:02:50 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:50.767Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.10.9:51758 @ 0x2b56630" latency=277.453812ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=4.023628ms Oct 16 16:02:50 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:50.768Z level=INFO msg="emitting device name changed event" component=server peer="192.168.10.9:51758 @ 0x2b56630" name=Volumio Oct 16 16:02:50 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:50.770Z level=INFO msg="emitting device language changed event" component=server peer="192.168.10.9:51758 @ 0x2b56630" language=ja Oct 16 16:02:50 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:50.774Z level=INFO msg="emitting device timezone changed event" component=server peer="192.168.10.9:51758 @ 0x2b56630" timezone=Asia/Tokyo Oct 16 16:02:50 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:50.775Z level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.10.9:51758 @ 0x2b56630" available=true connected=true macAddress=b8:27:eb:f6:35:2d ip4Address=192.168.10.30/24 ip6Address= Oct 16 16:02:50 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Oct 16 16:02:50 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:50.778Z level=INFO msg="emitting wifi info changed event" component=server peer="192.168.10.9:51758 @ 0x2b56630" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Oct 16 16:02:50 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:50.779Z level=INFO msg="emitting device setup status changed event" component=server peer="192.168.10.9:51758 @ 0x2b56630" setupComplete=true Oct 16 16:02:50 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Oct 16 16:02:50 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 16 16:02:50 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 16:02:50 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 16 16:02:50 volumio volumio[1198]: amixer -c 0 info | grep "bcm2835 ALSA" Oct 16 16:02:50 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:50.836Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.10.9:51758 @ 0x2b56630" latency=277.453812ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=71.65385ms Oct 16 16:02:50 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:50.838Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.10.9:51758 @ 0x2b56630" latency=277.453812ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=74.496441ms Oct 16 16:02:50 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:50.869Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.10.9:51758 @ 0x2b56630" latency=277.453812ms timeout=10s endpoint=https://www.googleapis.com duration=104.957349ms Oct 16 16:02:50 volumio volumio[1198]: amixer -c 1 info | grep "bcm2835 Headphones" Oct 16 16:02:50 volumio volumio[1198]: Card sysdefault:1 'Headphones'/'bcm2835 Headphones' Oct 16 16:02:50 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:50.906Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.10.9:51758 @ 0x2b56630" latency=277.453812ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=141.461458ms Oct 16 16:02:50 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:50.930Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.10.9:51758 @ 0x2b56630" latency=277.453812ms timeout=10s endpoint=https://functions.volumio.cloud duration=165.577185ms Oct 16 16:02:50 volumio volumio[1198]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 2 Oct 16 16:02:50 volumio volumio[1198]: /bin/sh: 1: /usr/local/bin/alsacap: not found Oct 16 16:02:50 volumio volumio[1198]: {"cmd":"/usr/local/bin/alsacap -C 2","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 2\n/bin/sh: 1: /usr/local/bin/alsacap: not found\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)"} Oct 16 16:02:50 volumio volumio[1198]: amixer -c 2 info | grep "vc4-hdmi" Oct 16 16:02:50 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:50.937Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.10.9:51758 @ 0x2b56630" latency=277.453812ms timeout=10s endpoint=https://functions.volumio.cloud duration=173.521525ms Oct 16 16:02:50 volumio ntpd[902]: IO: Listen normally on 490 eth0 192.168.10.30:123 Oct 16 16:02:50 volumio ntpd[902]: IO: new interface(s) found: waking up resolver Oct 16 16:02:50 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:50.949Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.10.9:51758 @ 0x2b56630" latency=277.453812ms timeout=10s endpoint=http://plugins.volumio.org duration=184.564913ms Oct 16 16:02:50 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:50.949Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.10.9:51758 @ 0x2b56630" latency=277.453812ms timeout=10s endpoint=https://database.volumio.cloud duration=184.653403ms Oct 16 16:02:50 volumio volumio[1198]: Card sysdefault:2 'vc4hdmi'/'vc4-hdmi' Oct 16 16:02:50 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:50.967Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.10.9:51758 @ 0x2b56630" latency=277.453812ms timeout=10s endpoint=https://google.com duration=203.358477ms Oct 16 16:02:50 volumio volumio[1198]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 5 Oct 16 16:02:50 volumio volumio[1198]: /bin/sh: 1: /usr/local/bin/alsacap: not found Oct 16 16:02:50 volumio volumio[1198]: {"cmd":"/usr/local/bin/alsacap -C 5","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 5\n/bin/sh: 1: /usr/local/bin/alsacap: not found\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)"} Oct 16 16:02:50 volumio volumio[1198]: amixer -c 5 info | grep "USB Audio DAC" Oct 16 16:02:50 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:50.987Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.10.9:51758 @ 0x2b56630" latency=277.453812ms timeout=10s endpoint=https://securetoken.googleapis.com duration=221.961103ms Oct 16 16:02:51 volumio volumio[1198]: Card sysdefault:5 'DAC'/'Burr-Brown from TI USB Audio DAC at usb-3f980000.usb-1.2, full speed' Oct 16 16:02:51 volumio volumio[1198]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 5 Oct 16 16:02:51 volumio volumio[1198]: /bin/sh: 1: /usr/local/bin/alsacap: not found Oct 16 16:02:51 volumio volumio[1198]: {"cmd":"/usr/local/bin/alsacap -C 5","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 5\n/bin/sh: 1: /usr/local/bin/alsacap: not found\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)"} Oct 16 16:02:51 volumio volumio[1198]: amixer -c 5 info | grep "USB Audio DAC" Oct 16 16:02:51 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:51.015Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.10.9:51758 @ 0x2b56630" latency=277.453812ms timeout=10s endpoint=http://pushupdates.volumio.org duration=251.048579ms Oct 16 16:02:51 volumio volumio[1198]: Card sysdefault:5 'DAC'/'Burr-Brown from TI USB Audio DAC at usb-3f980000.usb-1.2, full speed' Oct 16 16:02:51 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:51.044Z level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.10.9:51758 @ 0x2b56630" selectedOutputId=5 Oct 16 16:02:51 volumio volumio[1198]: info: Received Get System Info Oct 16 16:02:51 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 16:02:51 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 16:02:51 volumio volumio[1198]: info: Discovery: Getting this device information Oct 16 16:02:51 volumio volumio[1198]: info: CoreCommandRouter::volumioGetState Oct 16 16:02:51 volumio volumio[1198]: info: CorePlayQueue::getTrack 0 Oct 16 16:02:51 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 16:02:51 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:51.057Z level=INFO msg="emitting software info changed event" component=server peer="192.168.10.9:51758 @ 0x2b56630" currentVersion=4.119 latestVersion=4.119 Oct 16 16:02:51 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:51.057Z level=INFO msg="emitting software update progress event" component=server peer="192.168.10.9:51758 @ 0x2b56630" status=UPDATE_STATUS_NONE progress=0 Oct 16 16:02:51 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:51.058Z level=INFO msg="emitting user changed event" component=server peer="192.168.10.9:51758 @ 0x2b56630" userId= Oct 16 16:02:51 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:51.058Z level=INFO msg="emitting music providers changed event" component=server peer="192.168.10.9:51758 @ 0x2b56630" providers=3 Oct 16 16:02:51 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:51.059Z level=INFO msg="emitting plugins changed event" component=server peer="192.168.10.9:51758 @ 0x2b56630" plugins=77 Oct 16 16:02:51 volumio volumio[1198]: info: CoreCommandRouter::volumioGetState Oct 16 16:02:51 volumio volumio[1198]: info: CorePlayQueue::getTrack 0 Oct 16 16:02:51 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:51.070Z level=INFO msg="emitting player state changed event" component=server peer="192.168.10.9:51758 @ 0x2b56630" state=STATUS_PLAYING positionMs=252627 volume=27 Oct 16 16:02:51 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:51.071Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.9:51758 @ 0x2b56630" id="music-library/NAS/share/John Coltrane/Village Vanguard 11-01-1961/01-Chasin' The Trane.flac" title="Chasin' The Trane" Oct 16 16:02:51 volumio volumio[1198]: info: Discovery: this is already registered, b06dd525-1f51-4e8a-bc10-5f7c6da1acce Oct 16 16:02:51 volumio volumio[1198]: info: Discovery: Found device Volumio Oct 16 16:02:51 volumio volumio[1198]: info: CoreCommandRouter::volumioGetState Oct 16 16:02:51 volumio volumio[1198]: info: CorePlayQueue::getTrack 0 Oct 16 16:02:51 volumio volumio[1198]: info: Discovery: this is already registered, b06dd525-1f51-4e8a-bc10-5f7c6da1acce Oct 16 16:02:51 volumio volumio[1198]: info: Discovery: Found device Volumio Oct 16 16:02:51 volumio volumio[1198]: info: CoreCommandRouter::volumioGetState Oct 16 16:02:51 volumio volumio[1198]: info: CorePlayQueue::getTrack 0 Oct 16 16:02:51 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:51.285Z level=INFO msg="service successfully established" component=discovery/localnet Oct 16 16:02:51 volumio volumio5-onboarding[2088]: time=2026-10-16T07:02:51.332Z level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.10.9:51758 @ 0x2b56630" latency=277.453812ms timeout=10s endpoint=http://cddb.volumio.org duration=568.341083ms error="Head \"http://gnudb.gnudb.org/~cddb/cddb.cgi/\": EOF" Oct 16 16:02:51 volumio volumio[1198]: info: Discovery: this is already registered, b06dd525-1f51-4e8a-bc10-5f7c6da1acce Oct 16 16:02:51 volumio volumio[1198]: info: Discovery: Found device Volumio Oct 16 16:02:51 volumio volumio[1198]: info: CoreCommandRouter::volumioGetState Oct 16 16:02:51 volumio volumio[1198]: info: CorePlayQueue::getTrack 0 Oct 16 16:02:51 volumio volumio[1198]: info: Discovery: this is already registered, b06dd525-1f51-4e8a-bc10-5f7c6da1acce Oct 16 16:02:51 volumio volumio[1198]: info: Discovery: Found device Volumio Oct 16 16:02:51 volumio volumio[1198]: info: CoreCommandRouter::volumioGetState Oct 16 16:02:51 volumio volumio[1198]: info: CorePlayQueue::getTrack 0 Oct 16 16:02:53 volumio volumio[1198]: info: Discovery: Remote connection error: 192.168.10.31 Oct 16 16:02:54 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 16 16:02:54 volumio volumio[1198]: info: CURURI: artists://GONTITI Oct 16 16:02:54 volumio volumio[1198]: info: Preload queue cleared Oct 16 16:02:54 volumio volumio[1198]: info: Preload queue cleared Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/BEST-Gontiti/01-放課後の音樂室.flac Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/BEST-Gontiti/02-風の國 (2001MIX).flac Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/BEST-Gontiti/03-Buon Giorno.flac Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/BEST-Gontiti/04-My Favourite Things.flac Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/BEST-Gontiti/05-28.flac Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/BEST-Gontiti/06-Snow Flower.flac Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/BEST-Gontiti/07-無能の人.flac Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/BEST-Gontiti/08-枯葉.flac Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/BEST-Gontiti/09-Tiny Lips.flac Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/BEST-Gontiti/10-動物達集まる-Hilo-.flac Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/BEST-Gontiti/11-Share The Moonlight.flac Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/BEST-Gontiti/12-ロミオとジュリエット.flac Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/BEST-Gontiti/13-Right Side Of Sorrow.flac Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/BEST-Gontiti/14-鹽と太陽.flac Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/BEST-Gontiti/15-Belly's.flac Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/BEST-Gontiti/16-Templo.flac Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/BEST-Gontiti/17-Pirouette.flac Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/BEST-Gontiti/18-Chinese Bellflower.flac Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/KIT/01 QED.flac Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/KIT/02 水の誘惑.flac Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/KIT/03 Cool Comedy.flac Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/KIT/04 Elephant Swing.flac Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/KIT/05 Hermaphroditos.flac Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/KIT/06 Rush Order.flac Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/KIT/07 君の自転車.flac Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/KIT/08 My Jellyfish.flac Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/KIT/09 Buon Giorno.flac Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/KIT/10 Loose Trek.flac Oct 16 16:02:54 volumio volumio[1198]: info: Preloading song: music-library/NAS/share/GONTITI/KIT/11 いちばん大事なもの.flac Oct 16 16:02:54 volumio volumio[1198]: info: Exploding uri music-library/NAS/share/GONTITI/BEST-Gontiti/01-放課後の音樂室.flac in service mpd Oct 16 16:02:54 volumio volumio[1198]: info: ALBUMART /albumart?cacheid=295&web=GONTITI/BEST-Gontiti/extralarge&path=%2Fmnt%2FNAS%2Fshare%2FGONTITI%2FBEST-Gontiti%2F01-%E6%94%BE%E8%AA%B2%E5%BE%8C%E3%81%AE%E9%9F%B3%EF%A5%9C%E5%AE%A4.flac&metadata=false Oct 16 16:02:54 volumio volumio[1198]: info: URI /mnt/NAS/share/GONTITI/BEST-Gontiti/01-放課後の音樂室.flac Oct 16 16:02:54 volumio volumio[1198]: info: Exploding uri music-library/NAS/share/GONTITI/BEST-Gontiti/02-風の國 (2001MIX).flac in service mpd Oct 16 16:02:54 volumio volumio[1198]: info: ALBUMART /albumart?cacheid=295&web=GONTITI/BEST-Gontiti/extralarge&path=%2Fmnt%2FNAS%2Fshare%2FGONTITI%2FBEST-Gontiti%2F02-%E9%A2%A8%E3%81%AE%E5%9C%8B%20(2001MIX).flac&metadata=false Oct 16 16:02:54 volumio volumio[1198]: info: URI /mnt/NAS/share/GONTITI/BEST-Gontiti/02-風の國 (2001MIX).flac Oct 16 16:02:54 volumio volumio[1198]: info: Exploding uri music-library/NAS/share/GONTITI/BEST-Gontiti/03-Buon Giorno.flac in service mpd Oct 16 16:02:54 volumio volumio[1198]: info: Exploding uri music-library/NAS/share/GONTITI/BEST-Gontiti/04-My Favourite Things.flac in service mpd Oct 16 16:02:55 volumio volumio[1198]: info: ALBUMART /albumart?cacheid=295&web=GONTITI/BEST-Gontiti/extralarge&path=%2Fmnt%2FNAS%2Fshare%2FGONTITI%2FBEST-Gontiti%2F03-Buon%20Giorno.flac&metadata=false Oct 16 16:02:55 volumio volumio[1198]: info: URI /mnt/NAS/share/GONTITI/BEST-Gontiti/03-Buon Giorno.flac Oct 16 16:02:55 volumio volumio[1198]: info: ALBUMART /albumart?cacheid=295&web=GONTITI/BEST-Gontiti/extralarge&path=%2Fmnt%2FNAS%2Fshare%2FGONTITI%2FBEST-Gontiti%2F04-My%20Favourite%20Things.flac&metadata=false Oct 16 16:02:55 volumio volumio[1198]: info: URI /mnt/NAS/share/GONTITI/BEST-Gontiti/04-My Favourite Things.flac Oct 16 16:02:55 volumio volumio[1198]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 16:02:55 volumio volumio[1198]: TypeError: Cannot read properties of null (reading 'slice') Oct 16 16:02:55 volumio volumio[1198]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Oct 16 16:02:55 volumio volumio[1198]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Oct 16 16:02:55 volumio volumio[1198]: at Object.onceWrapper (node:events:629:26) Oct 16 16:02:55 volumio volumio[1198]: at ClientRequest.emit (node:events:514:28) Oct 16 16:02:55 volumio volumio[1198]: at HTTPParser.parserOnIncomingClient [as onIncoming] (node:_http_client:693:27) Oct 16 16:02:55 volumio volumio[1198]: at HTTPParser.parserOnHeadersComplete (node:_http_common:119:17) Oct 16 16:02:55 volumio volumio[1198]: at TLSSocket.socketOnData (node:_http_client:535:22) Oct 16 16:02:55 volumio volumio[1198]: at TLSSocket.emit (node:events:514:28) Oct 16 16:02:55 volumio volumio[1198]: at addChunk (node:internal/streams/readable:343:12) Oct 16 16:02:55 volumio volumio[1198]: at readableAddChunk (node:internal/streams/readable:316:9) Oct 16 16:02:55 volumio volumio[1198]: at Readable.push (node:internal/streams/readable:253:10) Oct 16 16:02:55 volumio volumio[1198]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:190:23) Oct 16 16:02:55 volumio volumio[1198]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 16:02:55 volumio sudo[15407]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-16 16:01' Oct 16 16:02:55 volumio sudo[15407]: 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"