May 17 20:29:07 eros systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 224. May 17 20:29:07 eros systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. May 17 20:29:07 eros systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. May 17 20:29:07 eros upmpdcli[13571]: Could not open config: /tmp/upmpdcli.conf May 17 20:29:07 eros systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE May 17 20:29:07 eros systemd[1]: upmpdcli.service: Failed with result 'exit-code'. May 17 20:29:22 eros systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 225. May 17 20:29:22 eros systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. May 17 20:29:22 eros systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. May 17 20:29:22 eros upmpdcli[13613]: Could not open config: /tmp/upmpdcli.conf May 17 20:29:22 eros systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE May 17 20:29:22 eros systemd[1]: upmpdcli.service: Failed with result 'exit-code'. May 17 20:29:37 eros volumio5-onboarding[3936]: time=2026-05-17T20:29:37.790+02:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.211.141:44260 @ 0x14a4720" latency=-3543h21m27.70339636s timeout=10s May 17 20:29:37 eros volumio5-onboarding[3936]: time=2026-05-17T20:29:37.792+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.211.141:44260 @ 0x14a4720" latency=-3543h21m27.70339636s timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=1.022379ms error="Head \"https://radio-directory.firebaseapp.com\": dial tcp: lookup radio-directory.firebaseapp.com: device or resource busy" May 17 20:29:37 eros volumio5-onboarding[3936]: time=2026-05-17T20:29:37.793+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.211.141:44260 @ 0x14a4720" latency=-3543h21m27.70339636s timeout=10s endpoint=https://functions.volumio.cloud duration=948.754µs error="Head \"https://functions.volumio.cloud\": dial tcp: lookup functions.volumio.cloud: device or resource busy" May 17 20:29:37 eros volumio5-onboarding[3936]: time=2026-05-17T20:29:37.794+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.211.141:44260 @ 0x14a4720" latency=-3543h21m27.70339636s timeout=10s endpoint=https://securetoken.googleapis.com duration=831.628µs error="Head \"https://securetoken.googleapis.com\": dial tcp: lookup securetoken.googleapis.com: device or resource busy" May 17 20:29:37 eros volumio5-onboarding[3936]: time=2026-05-17T20:29:37.795+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.211.141:44260 @ 0x14a4720" latency=-3543h21m27.70339636s timeout=10s endpoint=https://www.googleapis.com duration=1.338964ms error="Head \"https://www.googleapis.com\": dial tcp: lookup www.googleapis.com: device or resource busy" May 17 20:29:37 eros volumio5-onboarding[3936]: time=2026-05-17T20:29:37.795+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.211.141:44260 @ 0x14a4720" latency=-3543h21m27.70339636s timeout=10s endpoint=https://myvolumio.firebaseio.com duration=880.628µs error="Head \"https://myvolumio.firebaseio.com\": dial tcp: lookup myvolumio.firebaseio.com: device or resource busy" May 17 20:29:37 eros volumio5-onboarding[3936]: time=2026-05-17T20:29:37.795+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.211.141:44260 @ 0x14a4720" latency=-3543h21m27.70339636s timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=1.647548ms error="Head \"https://oauth-performer.dfs.volumio.org\": dial tcp: lookup oauth-performer.dfs.volumio.org: device or resource busy" May 17 20:29:37 eros volumio5-onboarding[3936]: time=2026-05-17T20:29:37.796+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.211.141:44260 @ 0x14a4720" latency=-3543h21m27.70339636s timeout=10s endpoint=http://cddb.volumio.org duration=757.169µs error="Head \"http://cddb.volumio.org\": dial tcp: lookup cddb.volumio.org: device or resource busy" May 17 20:29:37 eros volumio5-onboarding[3936]: time=2026-05-17T20:29:37.796+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.211.141:44260 @ 0x14a4720" latency=-3543h21m27.70339636s timeout=10s endpoint=https://functions.volumio.cloud duration=980.796µs error="Head \"https://functions.volumio.cloud\": dial tcp: lookup functions.volumio.cloud: device or resource busy" May 17 20:29:37 eros volumio5-onboarding[3936]: time=2026-05-17T20:29:37.796+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.211.141:44260 @ 0x14a4720" latency=-3543h21m27.70339636s timeout=10s endpoint=http://plugins.volumio.org duration=944.337µs error="Head \"http://plugins.volumio.org\": dial tcp: lookup plugins.volumio.org: device or resource busy" May 17 20:29:37 eros volumio5-onboarding[3936]: time=2026-05-17T20:29:37.796+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.211.141:44260 @ 0x14a4720" latency=-3543h21m27.70339636s timeout=10s endpoint=https://google.com duration=738.711µs error="Head \"https://google.com\": dial tcp: lookup google.com: device or resource busy" May 17 20:29:37 eros volumio5-onboarding[3936]: time=2026-05-17T20:29:37.797+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.211.141:44260 @ 0x14a4720" latency=-3543h21m27.70339636s timeout=10s endpoint=https://database.volumio.cloud duration=637.252µs error="Head \"https://database.volumio.cloud\": dial tcp: lookup database.volumio.cloud: device or resource busy" May 17 20:29:37 eros systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 226. May 17 20:29:37 eros volumio5-onboarding[3936]: time=2026-05-17T20:29:37.797+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.211.141:44260 @ 0x14a4720" latency=-3543h21m27.70339636s timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=1.711256ms error="Head \"https://browsing-performer.dfs.volumio.org\": dial tcp: lookup browsing-performer.dfs.volumio.org: device or resource busy" May 17 20:29:37 eros volumio5-onboarding[3936]: time=2026-05-17T20:29:37.797+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.211.141:44260 @ 0x14a4720" latency=-3543h21m27.70339636s timeout=10s endpoint=http://pushupdates.volumio.org duration=1.750715ms error="Head \"http://pushupdates.volumio.org\": dial tcp: lookup pushupdates.volumio.org: device or resource busy" May 17 20:29:37 eros systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. May 17 20:29:37 eros systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. May 17 20:29:37 eros upmpdcli[13645]: Could not open config: /tmp/upmpdcli.conf May 17 20:29:37 eros systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE May 17 20:29:37 eros systemd[1]: upmpdcli.service: Failed with result 'exit-code'. May 17 20:29:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 17 20:29:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 17 20:29:37 eros volumio[3424]: info: Discovery: Getting this device information May 17 20:29:37 eros volumio[3424]: info: CoreCommandRouter::volumioGetState May 17 20:29:37 eros volumio[3424]: info: CorePlayQueue::getTrack 0 May 17 20:29:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 17 20:29:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 17 20:29:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 17 20:29:37 eros volumio[3424]: info: Discovery: Getting this device information May 17 20:29:37 eros volumio[3424]: info: CoreCommandRouter::volumioGetState May 17 20:29:37 eros volumio[3424]: info: CorePlayQueue::getTrack 0 May 17 20:29:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 17 20:29:37 eros volumio[3424]: verbose: New Socket.io Connection to 192.168.211.1:3000 from 192.168.211.141 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 May 17 20:29:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 17 20:29:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 17 20:29:37 eros volumio[3424]: verbose: New Socket.io Connection to 192.168.211.1:3000 from 192.168.211.141 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 May 17 20:29:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 17 20:29:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 17 20:29:47 eros volumio[3424]: info: CoreCommandRouter::getUIConfigOnPlugin May 17 20:29:47 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 17 20:29:47 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork May 17 20:29:47 eros sudo[13674]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 May 17 20:29:47 eros sudo[13674]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:29:47 eros sudo[13678]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 17 20:29:47 eros sudo[13678]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:29:47 eros sudo[13684]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 17 20:29:47 eros sudo[13684]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:29:47 eros kernel: wl_iw_get_wireless_stats: WLC_GET_RSSI error=-22 May 17 20:29:47 eros sudo[13678]: pam_unix(sudo:session): session closed for user root May 17 20:29:47 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache May 17 20:29:47 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks May 17 20:29:47 eros sudo[13689]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 17 20:29:47 eros kernel: wl_iw_get_wireless_stats: WLC_GET_RSSI error=-22 May 17 20:29:47 eros sudo[13674]: pam_unix(sudo:session): session closed for user root May 17 20:29:47 eros sudo[13684]: pam_unix(sudo:session): session closed for user root May 17 20:29:47 eros sudo[13689]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:29:47 eros sudo[13700]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:29:47 eros sudo[13696]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 17 20:29:47 eros sudo[13700]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:29:47 eros sudo[13696]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:29:47 eros kernel: wl_iw_get_wireless_stats: WLC_GET_RSSI error=-22 May 17 20:29:47 eros sudo[13689]: pam_unix(sudo:session): session closed for user root May 17 20:29:47 eros sudo[13700]: pam_unix(sudo:session): session closed for user root May 17 20:29:47 eros sudo[13696]: pam_unix(sudo:session): session closed for user root May 17 20:29:47 eros sudo[13706]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 17 20:29:47 eros sudo[13706]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:29:47 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:47 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:47 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:47 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:47 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:48 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:48 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:48 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:48 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:48 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:48 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:48 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:48 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:48 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:48 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:48 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:48 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:48 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:48 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:48 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:48 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:48 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:48 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:48 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:48 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:48 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:48 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:48 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:48 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:48 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:48 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:49 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:49 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:49 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:49 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:49 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 8 May 17 20:29:50 eros kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fa9e000 drv_status 0x0 e_type 69 e_states 0 May 17 20:29:50 eros sudo[13706]: pam_unix(sudo:session): session closed for user root May 17 20:29:51 eros volumio5-onboarding[3936]: time=2026-05-17T20:29:51.151+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.211.141:44260 @ 0x14a4720" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 17 20:29:51 eros volumio[3424]: info: Received Get System Info May 17 20:29:51 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 17 20:29:51 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 17 20:29:51 eros volumio[3424]: info: Discovery: Getting this device information May 17 20:29:51 eros volumio[3424]: info: CoreCommandRouter::volumioGetState May 17 20:29:51 eros volumio[3424]: info: CorePlayQueue::getTrack 0 May 17 20:29:51 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 17 20:29:51 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 17 20:29:51 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 17 20:29:52 eros volumio5-onboarding[3936]: time=2026-05-17T20:29:52.085+02:00 level=INFO msg="service successfully established" component=discovery/localnet May 17 20:29:53 eros systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 227. May 17 20:29:53 eros systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. May 17 20:29:53 eros systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. May 17 20:29:53 eros upmpdcli[13728]: Could not open config: /tmp/upmpdcli.conf May 17 20:29:53 eros systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE May 17 20:29:53 eros systemd[1]: upmpdcli.service: Failed with result 'exit-code'. May 17 20:30:08 eros systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 228. May 17 20:30:08 eros systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. May 17 20:30:08 eros systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. May 17 20:30:08 eros upmpdcli[13759]: Could not open config: /tmp/upmpdcli.conf May 17 20:30:08 eros systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE May 17 20:30:08 eros systemd[1]: upmpdcli.service: Failed with result 'exit-code'. May 17 20:30:11 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings May 17 20:30:11 eros volumio[3424]: info: Saving new wireless network May 17 20:30:11 eros sudo[13784]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf May 17 20:30:11 eros sudo[13784]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:11 eros sudo[13784]: pam_unix(sudo:session): session closed for user root May 17 20:30:11 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart May 17 20:30:11 eros sudo[13787]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service May 17 20:30:11 eros sudo[13787]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:11 eros systemd[1]: Stopping wireless.service - Wireless Services... May 17 20:30:11 eros systemd[1]: wireless.service: Deactivated successfully. May 17 20:30:11 eros systemd[1]: Stopped wireless.service - Wireless Services. May 17 20:30:11 eros systemd[1]: Starting wireless.service - Wireless Services... May 17 20:30:12 eros wireless.js[13789]: WIRELESS.JS - INFO: Single Network Mode enabled (default) - only one network device can be active at a time between ethernet and wireless May 17 20:30:12 eros wireless.js[13789]: WIRELESS.JS - INFO: Wireless.js initializing wireless flow May 17 20:30:12 eros sudo[13808]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:12 eros sudo[13808]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:12 eros sudo[13808]: pam_unix(sudo:session): session closed for user root May 17 20:30:12 eros systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... May 17 20:30:12 eros dnsmasq[13061]: exiting on receipt of SIGTERM May 17 20:30:12 eros systemd[1]: dnsmasq.service: Deactivated successfully. May 17 20:30:12 eros systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. May 17 20:30:12 eros kernel: CFG80211-ERROR) wl_cfg80211_change_station : WLC_SCB_AUTHORIZE sta_flags_mask not set May 17 20:30:12 eros systemd[1]: Stopping hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... May 17 20:30:12 eros kernel: wl_cfg80211_del_station: Disconnect STA : ff:ff:ff:ff:ff:ff scb_val.val 3 May 17 20:30:12 eros kernel: wl_notify_connect_status_ap: event WLC_E_DEAUTH(5) status 0 reason 3 May 17 20:30:12 eros kernel: wl_notify_connect_status_ap: deauthenticated device 1a:d5:c2:9a:62:75 May 17 20:30:12 eros kernel: wl_notify_connect_status_ap: event WLC_E_DEAUTH(5) status 0 reason 7 May 17 20:30:12 eros kernel: wl_notify_connect_status_ap: deauthenticated device 1a:d5:c2:9a:62:75 May 17 20:30:12 eros kernel: wl_notify_connect_status_ap: event WLC_E_DEAUTH(5) status 0 reason 7 May 17 20:30:12 eros kernel: wl_notify_connect_status_ap: deauthenticated device 1a:d5:c2:9a:62:75 May 17 20:30:13 eros kernel: wl_iw_event: Link Down with 40:d9:5a:6f:43:ea, reason=4 May 17 20:30:13 eros systemd[1]: hostapd.service: Deactivated successfully. May 17 20:30:13 eros kernel: CFG80211-ERROR) wl_bss_iovar_war : wl bss 2 May 17 20:30:13 eros systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. May 17 20:30:13 eros sudo[13817]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 May 17 20:30:13 eros sudo[13817]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 17 20:30:13 eros avahi-daemon[2913]: Withdrawing address record for 192.168.211.1 on wlan0. May 17 20:30:13 eros avahi-daemon[2913]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. May 17 20:30:13 eros avahi-daemon[2913]: Interface wlan0.IPv4 no longer relevant for mDNS. May 17 20:30:13 eros volumio[3424]: info: Discovery: A device disappeared from network May 17 20:30:13 eros sudo[13817]: pam_unix(sudo:session): session closed for user root May 17 20:30:13 eros volumio[3424]: info: Discovery: A device disappeared from network May 17 20:30:13 eros sudo[13821]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down May 17 20:30:13 eros sudo[13821]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 17 20:30:13 eros systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. May 17 20:30:13 eros systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... May 17 20:30:13 eros systemd[1]: welcome.service: Deactivated successfully. May 17 20:30:13 eros systemd[1]: Stopped welcome.service - Show a welcome message on console. May 17 20:30:13 eros systemd[1]: Stopping welcome.service - Show a welcome message on console... May 17 20:30:13 eros systemd[1]: Starting welcome.service - Show a welcome message on console... May 17 20:30:13 eros kernel: dhd_stop: Enter ffffffc04fa9e000 May 17 20:30:13 eros kernel: CFGP2P-ERROR) wl_cfgp2p_disable_discovery : do nothing, not initialized May 17 20:30:13 eros kernel: CFGP2P-ERROR) wl_cfgp2p_deinit_priv : In May 17 20:30:13 eros kernel: dhd_tcpack_suppress_set: TCP ACK Suppress mode 1 -> mode 0 May 17 20:30:13 eros kernel: wl_android_wifi_off in 1 May 17 20:30:13 eros kernel: wl_android_wifi_off in 2: g_wifi_on=1, on_failure=1 May 17 20:30:13 eros kernel: dhd_dbg_detach_pkt_monitor, 2204 May 17 20:30:13 eros kernel: dhd_bus_devreset: == Power OFF == May 17 20:30:13 eros kernel: bcmsdh_oob_intr_unregister: Enter May 17 20:30:13 eros kernel: dhd_txglom_enable: enable 0 May 17 20:30:13 eros kernel: dhd_conf_set_txglom_params: txglom_mode=copy May 17 20:30:13 eros kernel: dhd_conf_set_txglom_params: txglomsize=0, deferred_tx_len=0 May 17 20:30:13 eros kernel: dhd_conf_set_txglom_params: txinrx_thres=128, dhd_txminmax=-1 May 17 20:30:13 eros kernel: dhd_conf_set_txglom_params: tx_max_offset=0, txctl_tmo_fix=300 May 17 20:30:13 eros kernel: dhd_bus_devreset: WLAN OFF DONE May 17 20:30:13 eros kernel: wifi_platform_set_power = 0 May 17 20:30:13 eros kernel: ======== PULL WL_REG_ON(-1) LOW! ======== May 17 20:30:13 eros kernel: aml_wifi wifi: [extern_wifi_set_enable] WIFI Disable! 482 May 17 20:30:13 eros kernel: wl_android_wifi_off out May 17 20:30:13 eros kernel: wl_ext_iapsta_dettach_netdev: Enter May 17 20:30:13 eros kernel: dhd_stop: Exit May 17 20:30:13 eros dhcpcd[2977]: wlan0: carrier lost May 17 20:30:13 eros sudo[13821]: pam_unix(sudo:session): session closed for user root May 17 20:30:13 eros welcome[13824]: Resolved ip:[0] May 17 20:30:13 eros wireless.js[13789]: WIRELESS.JS - INFO: Cleaning previous... May 17 20:30:13 eros sudo[13827]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:13 eros sudo[13827]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:13 eros systemd[1]: Finished welcome.service - Show a welcome message on console. May 17 20:30:13 eros systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. May 17 20:30:13 eros sudo[13827]: pam_unix(sudo:session): session closed for user root May 17 20:30:13 eros sudo[13836]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 17 20:30:13 eros sudo[13836]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 17 20:30:13 eros kernel: dhd_open: Enter ffffffc04fa9e000 May 17 20:30:13 eros kernel: dhd_open : no mutex held. set lock May 17 20:30:13 eros kernel: Dongle Host Driver, version 1.579.77.41.10 (r) May 17 20:30:13 eros kernel: wl_ext_iapsta_attach_netdev: ifidx=0, bssidx=0 May 17 20:30:13 eros kernel: wl_android_wifi_on in 1 May 17 20:30:13 eros kernel: wl_android_wifi_on in 2: g_wifi_on=0 May 17 20:30:13 eros kernel: wifi_platform_set_power = 1 May 17 20:30:13 eros kernel: ======== PULL WL_REG_ON(-1) HIGH! ======== May 17 20:30:13 eros kernel: aml_wifi wifi: [extern_wifi_set_enable] WIFI Disable! 482 May 17 20:30:14 eros kernel: aml_wifi wifi: [extern_wifi_set_enable] WIFI Enable! 482 May 17 20:30:14 eros kernel: sdio_reset_comm(): May 17 20:30:14 eros kernel: meson-mmc: actual_clock :400000, HHI_nand: 0x80 May 17 20:30:14 eros kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000023c May 17 20:30:14 eros kernel: meson-mmc: actual_clock :0, HHI_nand: 0x80 May 17 20:30:14 eros kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000023c May 17 20:30:14 eros kernel: meson-mmc: actual_clock :400000, HHI_nand: 0x80 May 17 20:30:14 eros kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000023c May 17 20:30:14 eros kernel: sdio: queuing unknown CIS tuple 0x80 (2 bytes) May 17 20:30:14 eros kernel: sdio: queuing unknown CIS tuple 0x80 (3 bytes) May 17 20:30:14 eros kernel: sdio: queuing unknown CIS tuple 0x80 (3 bytes) May 17 20:30:14 eros kernel: sdio: queuing unknown CIS tuple 0x80 (7 bytes) May 17 20:30:14 eros kernel: sdio: queuing unknown CIS tuple 0x81 (9 bytes) May 17 20:30:14 eros kernel: sdio: queuing unknown CIS tuple 0x8e (9 bytes) May 17 20:30:14 eros kernel: meson-aml-mmc ffe03000.sdio: divider requested rate 200000000 != actual rate 199999997: ret=0 May 17 20:30:14 eros kernel: meson-mmc: actual_clock :199999997, HHI_nand: 0x80 May 17 20:30:14 eros kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x10000245 May 17 20:30:14 eros kernel: meson-mmc: Data 1 aligned delay is 0 May 17 20:30:14 eros kernel: meson-mmc: sdio: clk 199999997 tuning start May 17 20:30:14 eros kernel: meson-mmc: Tuning transfer error: nmatch=0 tuning_err:0xffffffac May 17 20:30:14 eros kernel: meson-mmc: sdio: rx_tuning_result[1] = 40 May 17 20:30:14 eros kernel: meson-mmc: sdio: rx_tuning_result[2] = 40 May 17 20:30:14 eros kernel: meson-mmc: sdio: rx_tuning_result[3] = 40 May 17 20:30:14 eros kernel: meson-mmc: sdio: rx_tuning_result[4] = 40 May 17 20:30:14 eros kernel: meson-mmc: [prev_map] fixed_adj_win_map:30 May 17 20:30:14 eros kernel: meson-mmc: [0]=0 May 17 20:30:14 eros kernel: meson-mmc: [1]=1 May 17 20:30:14 eros kernel: meson-mmc: [2]=1 May 17 20:30:14 eros kernel: meson-mmc: [3]=1 May 17 20:30:14 eros kernel: meson-mmc: [4]=1 May 17 20:30:14 eros kernel: meson-mmc: [_find_fixed_adj_valid_win]retry test fixed adj... May 17 20:30:14 eros kernel: meson-mmc: step:4, delay1:0x4104104, delay2:0x4004104 May 17 20:30:14 eros kernel: meson-mmc: Tuning transfer error: nmatch=0 tuning_err:0xffffffac May 17 20:30:14 eros kernel: meson-mmc: sdio: rx_tuning_result[1] = 40 May 17 20:30:14 eros kernel: meson-mmc: sdio: rx_tuning_result[2] = 40 May 17 20:30:14 eros kernel: meson-mmc: sdio: rx_tuning_result[3] = 40 May 17 20:30:14 eros kernel: meson-mmc: sdio: rx_tuning_result[4] = 40 May 17 20:30:14 eros kernel: meson-mmc: [_find_fixed_adj_valid_win]retry test fixed adj... May 17 20:30:14 eros kernel: meson-mmc: step:8, delay1:0x8208208, delay2:0x8008208 May 17 20:30:14 eros kernel: meson-mmc: sdio: rx_tuning_result[0] = 40 May 17 20:30:14 eros kernel: meson-mmc: sdio: rx_tuning_result[1] = 40 May 17 20:30:14 eros kernel: meson-mmc: sdio: rx_tuning_result[2] = 40 May 17 20:30:14 eros kernel: meson-mmc: sdio: rx_tuning_result[3] = 40 May 17 20:30:14 eros kernel: meson-mmc: sdio: rx_tuning_result[4] = 40 May 17 20:30:14 eros kernel: meson-mmc: [_find_fixed_adj_valid_win]retry test fixed adj... May 17 20:30:14 eros kernel: meson-mmc: step:12, delay1:0xc30c30c, delay2:0xc00c30c May 17 20:30:14 eros kernel: meson-mmc: sdio: rx_tuning_result[0] = 40 May 17 20:30:14 eros kernel: meson-mmc: Tuning transfer error: nmatch=0 tuning_err:0xffffffac May 17 20:30:14 eros kernel: meson-mmc: sdio: rx_tuning_result[2] = 40 May 17 20:30:14 eros kernel: meson-mmc: sdio: rx_tuning_result[3] = 40 May 17 20:30:14 eros kernel: meson-mmc: sdio: rx_tuning_result[4] = 40 May 17 20:30:14 eros kernel: meson-mmc: [>>>>>>>>bitmap_xor_dst] fixed_adj_win_map:2 May 17 20:30:14 eros kernel: meson-mmc: [0]=0 May 17 20:30:14 eros kernel: meson-mmc: [1]=1 May 17 20:30:14 eros kernel: meson-mmc: [2]=0 May 17 20:30:14 eros kernel: meson-mmc: [3]=0 May 17 20:30:14 eros kernel: meson-mmc: [4]=0 May 17 20:30:14 eros kernel: meson-mmc: [_find_fixed_adj_valid_win] fir_adj:1 May 17 20:30:14 eros kernel: meson-mmc: [>>>>>>>>prev_map_range] fixed_adj_win_map:495 May 17 20:30:14 eros kernel: meson-mmc: [1]=1 May 17 20:30:14 eros kernel: meson-mmc: [2]=1 May 17 20:30:14 eros kernel: meson-mmc: [3]=1 May 17 20:30:14 eros kernel: meson-mmc: [4]=1 May 17 20:30:14 eros kernel: meson-mmc: [0]=0 May 17 20:30:14 eros kernel: meson-mmc: left:3, right:0, mid:4, size:4 May 17 20:30:14 eros kernel: meson-mmc: step:0, delay1:0x0, delay2:0x0 May 17 20:30:14 eros kernel: meson-mmc: sdio: sd_emmc_regs->gclock=0x10000245,sd_emmc_regs->gadjust=0x32000 May 17 20:30:14 eros kernel: meson-mmc: delay1:0x0, delay2:0x0 May 17 20:30:14 eros kernel: sdioh_start: set sd_f2_blocksize 256 May 17 20:30:14 eros kernel: dhd_bus_devreset: == WLAN ON == May 17 20:30:14 eros kernel: F1 signature read @0x18000000=0x17294359 May 17 20:30:14 eros kernel: F1 signature OK, socitype:0x1 chip:0x4359 rev:0x9 pkg:0x2 May 17 20:30:14 eros kernel: DHD: dongle ram size is set to 917504(orig 917504) at 0x160000 May 17 20:30:14 eros kernel: dhd_bus_set_default_min_res_mask: Unhandled chip id May 17 20:30:14 eros kernel: dhd_os_open_image: /lib/firmware/brcm/config_bcm4359c0_ag.txt (185 bytes) open success May 17 20:30:14 eros kernel: dhd_conf_read_sdio_params: dhd_slpauto = 0 May 17 20:30:14 eros kernel: dhd_conf_read_others: ccode = ALL May 17 20:30:14 eros kernel: dhd_conf_read_others: regrev = 38 May 17 20:30:14 eros kernel: dhd_conf_read_nv_by_chip: nv_by_chip_count=5 May 17 20:30:14 eros kernel: dhd_conf_read_nv_by_chip: chip=0xa9a6, chiprev=0, name=nvram_ap6212.txt May 17 20:30:14 eros kernel: dhd_conf_read_nv_by_chip: chip=0xa9a6, chiprev=1, name=nvram_ap6212a.txt May 17 20:30:14 eros kernel: dhd_conf_read_nv_by_chip: chip=0x4345, chiprev=6, name=nvram_ap6255.txt May 17 20:30:14 eros kernel: dhd_conf_read_nv_by_chip: chip=0x4354, chiprev=2, name=nvram_ap6356.txt May 17 20:30:14 eros kernel: dhd_conf_read_nv_by_chip: chip=0x4359, chiprev=9, name=nvram_ap6359sa.txt May 17 20:30:14 eros kernel: Final fw_path=/lib/firmware/brcm/fw_bcm4359c0_ag.bin May 17 20:30:14 eros kernel: Final nv_path=/lib/firmware/brcm/nvram_ap6359sa.txt May 17 20:30:14 eros kernel: Final clm_path=/lib/firmware/brcm/clm.blob May 17 20:30:14 eros kernel: Final conf_path=/lib/firmware/brcm/config_bcm4359c0_ag.txt May 17 20:30:14 eros kernel: dhd_os_open_image: /lib/firmware/brcm/fw_bcm4359c0_ag.bin (595758 bytes) open success May 17 20:30:14 eros kernel: dhd_os_open_image: /lib/firmware/brcm/nvram_ap6359sa.txt (5861 bytes) open success May 17 20:30:14 eros kernel: NVRAM version: AP6398S_NVRAM_V1.1_20170926 May 17 20:30:14 eros kernel: dhdsdio_write_vars: Download, Upload and compare of NVRAM succeeded. May 17 20:30:14 eros kernel: dhd_bus_init: enable 0x06, ready 0x06 (waited 0us) May 17 20:30:14 eros kernel: si_get_pmu_reg_addr: addrRET: 18000670 May 17 20:30:14 eros kernel: bcmsdh_oob_intr_register: HW_OOB irq=70 flags=0x8 May 17 20:30:14 eros kernel: dhd_get_memdump_info: File [/data/misc/wifi/.memdump.info] doesn't exist May 17 20:30:14 eros kernel: dhd_get_memdump_info: MEMDUMP ENABLED = 2 May 17 20:30:14 eros kernel: dhd_tcpack_suppress_set: TCP ACK Suppress mode 0 -> mode 1 May 17 20:30:14 eros kernel: dhd_apply_default_clm: Ignore clm file /lib/firmware/brcm/clm.blob May 17 20:30:14 eros kernel: Firmware up: op_mode=0x0405, MAC=40:d9:5a:6f:43:ea May 17 20:30:14 eros kernel: Driver: 1.579.77.41.10 (r) Firmware: wl0: Jan 19 2018 12:14:30 version 9.87.51.11.8 (a85e25e@shgit) (r) FWID 01-cb5aa0a5 CLM: 9.7.5 May 17 20:30:14 eros kernel: dhd_txglom_enable: enable 1 May 17 20:30:14 eros kernel: dhd_conf_set_txglom_params: txglom_mode=copy May 17 20:30:14 eros kernel: dhd_conf_set_txglom_params: txglomsize=36, deferred_tx_len=0 May 17 20:30:14 eros kernel: dhd_conf_set_txglom_params: txinrx_thres=128, dhd_txminmax=-1 May 17 20:30:14 eros kernel: dhd_conf_set_txglom_params: tx_max_offset=0, txctl_tmo_fix=300 May 17 20:30:14 eros kernel: dhd_conf_get_disable_proptx: fw_proptx=0, disable_proptx=1 May 17 20:30:14 eros kernel: dhd_pno_init: Support Android Location Service May 17 20:30:14 eros kernel: rtt_do_get_ioctl: failed to send getbuf proxd iovar (CMD ID : 1), status=-23 May 17 20:30:14 eros kernel: dhd_rtt_init : FTM is not supported May 17 20:30:14 eros kernel: dhd_preinit_ioctls: SensorHub diabled 0 May 17 20:30:14 eros kernel: dhd_preinit_ioctls failed to set ShubHub disable May 17 20:30:14 eros kernel: failed to set WNM capabilities May 17 20:30:14 eros kernel: dhd_conf_set_country: set country ALL, revision 38 May 17 20:30:14 eros kernel: CONFIG-ERROR) dhd_conf_set_bufiovar: country setting failed -2 May 17 20:30:14 eros kernel: Country code: US (US/0) May 17 20:30:14 eros kernel: CONFIG-ERROR) dhd_conf_set_intiovar: txbf setting failed -23 May 17 20:30:15 eros kernel: wl_android_wifi_on: Success May 17 20:30:15 eros dhcpcd[2977]: wlan0: carrier acquired May 17 20:30:15 eros kernel: dhd_open : the lock is released. May 17 20:30:15 eros kernel: dhd_open: Exit ret=0 May 17 20:30:15 eros sudo[13836]: pam_unix(sudo:session): session closed for user root May 17 20:30:15 eros volumio[3424]: info: Received Get System Info May 17 20:30:15 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 17 20:30:15 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 17 20:30:15 eros volumio[3424]: info: Discovery: Getting this device information May 17 20:30:15 eros volumio5-onboarding[3936]: time=2026-05-17T20:30:15.069+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.211.141:44260 @ 0x14a4720" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 17 20:30:15 eros volumio[3424]: info: CoreCommandRouter::volumioGetState May 17 20:30:15 eros volumio[3424]: info: CorePlayQueue::getTrack 0 May 17 20:30:15 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 17 20:30:15 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 17 20:30:15 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 17 20:30:15 eros sudo[13852]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:15 eros sudo[13852]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:15 eros dhcpcd[2977]: wlan0: IAID 5a:6f:43:ea May 17 20:30:15 eros sudo[13852]: pam_unix(sudo:session): session closed for user root May 17 20:30:15 eros wireless.js[13789]: WIRELESS.JS - INFO: InterfaceValidator: READY - wlan0 is ready for operations May 17 20:30:15 eros wireless.js[13789]: WIRELESS.JS - INFO: InterfaceValidator: wlan0 became ready after 4ms May 17 20:30:15 eros wireless.js[13789]: WIRELESS.JS - INFO: ensureInterfaceReady: Interface ready (MAC: 40:d9:5a:6f:43:ea) May 17 20:30:15 eros sudo[13860]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get May 17 20:30:15 eros sudo[13860]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:15 eros sudo[13860]: pam_unix(sudo:session): session closed for user root May 17 20:30:15 eros sudo[13867]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan May 17 20:30:15 eros sudo[13867]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:15 eros dhcpcd[2977]: wlan0: soliciting an IPv6 router May 17 20:30:15 eros volumio5-onboarding[3936]: time=2026-05-17T20:30:15.571+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.211.141:44260 @ 0x14a4720" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 17 20:30:15 eros volumio[3424]: info: Received Get System Info May 17 20:30:15 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 17 20:30:15 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 17 20:30:15 eros volumio[3424]: info: Discovery: Getting this device information May 17 20:30:15 eros volumio[3424]: info: CoreCommandRouter::volumioGetState May 17 20:30:15 eros volumio[3424]: info: CorePlayQueue::getTrack 0 May 17 20:30:15 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 17 20:30:15 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 17 20:30:15 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 17 20:30:15 eros sudo[13872]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:15 eros sudo[13872]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:15 eros sudo[13872]: pam_unix(sudo:session): session closed for user root May 17 20:30:16 eros ntpd[3141]: IO: Deleting interface #4 wlan0, 192.168.211.1#123, interface stats: received=0, sent=0, dropped=0, active_time=262 secs May 17 20:30:16 eros sudo[13876]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:16 eros sudo[13876]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:16 eros sudo[13876]: pam_unix(sudo:session): session closed for user root May 17 20:30:16 eros dhcpcd[2977]: wlan0: soliciting a DHCP lease May 17 20:30:17 eros volumio5-onboarding[3936]: time=2026-05-17T20:30:17.068+02:00 level=INFO msg="service successfully established" component=discovery/localnet May 17 20:30:17 eros sudo[13867]: pam_unix(sudo:session): session closed for user root May 17 20:30:17 eros wireless.js[13789]: WIRELESS.JS - INFO: SETTING APPROPRIATE REG DOMAIN: ES May 17 20:30:17 eros sudo[13881]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set ES May 17 20:30:17 eros sudo[13881]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:17 eros sudo[13881]: pam_unix(sudo:session): session closed for user root May 17 20:30:17 eros wireless.js[13789]: WIRELESS.JS - INFO: SUCCESSFULLY SET NEW REGDOMAIN: ES May 17 20:30:17 eros wireless.js[13789]: WIRELESS.JS - INFO: Start wireless flow May 17 20:30:17 eros sudo[13890]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:17 eros sudo[13890]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:17 eros sudo[13890]: pam_unix(sudo:session): session closed for user root May 17 20:30:17 eros volumio[3424]: info: Received Get System Info May 17 20:30:17 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 17 20:30:17 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 17 20:30:17 eros volumio[3424]: info: Discovery: Getting this device information May 17 20:30:17 eros volumio[3424]: info: CoreCommandRouter::volumioGetState May 17 20:30:17 eros volumio[3424]: info: CorePlayQueue::getTrack 0 May 17 20:30:17 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 17 20:30:17 eros volumio5-onboarding[3936]: time=2026-05-17T20:30:17.845+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.211.141:44260 @ 0x14a4720" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 17 20:30:17 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 17 20:30:17 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 17 20:30:18 eros sudo[13897]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:18 eros sudo[13897]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:18 eros sudo[13897]: pam_unix(sudo:session): session closed for user root May 17 20:30:18 eros volumio5-onboarding[3936]: time=2026-05-17T20:30:18.837+02:00 level=INFO msg="service successfully established" component=discovery/localnet May 17 20:30:19 eros sudo[13921]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:19 eros sudo[13921]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:19 eros sudo[13921]: pam_unix(sudo:session): session closed for user root May 17 20:30:20 eros sudo[13928]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:20 eros sudo[13928]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:20 eros sudo[13928]: pam_unix(sudo:session): session closed for user root May 17 20:30:21 eros volumio[3424]: info: Discovery: Networking Restart detected, restarting advertisement and browsing May 17 20:30:21 eros volumio[3424]: info: Discovery: Restarting Advertising May 17 20:30:21 eros volumio[3424]: info: Discovery: Stopping existing advertisement May 17 20:30:21 eros volumio[3424]: info: Discovery: Restarting Browsing May 17 20:30:21 eros sudo[13936]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:21 eros sudo[13936]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:21 eros sudo[13936]: pam_unix(sudo:session): session closed for user root May 17 20:30:22 eros volumio[3424]: info: Discovery: A device disappeared from network May 17 20:30:22 eros volumio[3424]: info: Discovery: A device disappeared from network May 17 20:30:22 eros sudo[13943]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:22 eros sudo[13943]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:22 eros sudo[13943]: pam_unix(sudo:session): session closed for user root May 17 20:30:23 eros systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 229. May 17 20:30:23 eros systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. May 17 20:30:23 eros systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. May 17 20:30:23 eros sudo[13957]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:23 eros sudo[13957]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:23 eros upmpdcli[13946]: Could not open config: /tmp/upmpdcli.conf May 17 20:30:23 eros systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE May 17 20:30:23 eros systemd[1]: upmpdcli.service: Failed with result 'exit-code'. May 17 20:30:23 eros sudo[13957]: pam_unix(sudo:session): session closed for user root May 17 20:30:24 eros sudo[13962]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:24 eros sudo[13962]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:24 eros sudo[13962]: pam_unix(sudo:session): session closed for user root May 17 20:30:25 eros sudo[13969]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:25 eros sudo[13969]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:25 eros sudo[13969]: pam_unix(sudo:session): session closed for user root May 17 20:30:25 eros wireless.js[13789]: WIRELESS.JS - INFO: Stopped hotspot (if there).. May 17 20:30:25 eros sudo[13976]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 May 17 20:30:25 eros sudo[13976]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 17 20:30:25 eros sudo[13976]: pam_unix(sudo:session): session closed for user root May 17 20:30:25 eros sudo[13979]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down May 17 20:30:25 eros sudo[13979]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 17 20:30:25 eros kernel: dhd_stop: Enter ffffffc04fa9e000 May 17 20:30:25 eros kernel: CFGP2P-ERROR) wl_cfgp2p_disable_discovery : do nothing, not initialized May 17 20:30:25 eros kernel: CFGP2P-ERROR) wl_cfgp2p_deinit_priv : In May 17 20:30:25 eros kernel: dhd_tcpack_suppress_set: TCP ACK Suppress mode 1 -> mode 0 May 17 20:30:25 eros kernel: wl_android_wifi_off in 1 May 17 20:30:25 eros kernel: wl_android_wifi_off in 2: g_wifi_on=1, on_failure=1 May 17 20:30:25 eros kernel: dhd_dbg_detach_pkt_monitor, 2204 May 17 20:30:25 eros kernel: dhd_bus_devreset: == Power OFF == May 17 20:30:25 eros kernel: bcmsdh_oob_intr_unregister: Enter May 17 20:30:25 eros kernel: dhd_txglom_enable: enable 0 May 17 20:30:25 eros kernel: dhd_conf_set_txglom_params: txglom_mode=copy May 17 20:30:25 eros kernel: dhd_conf_set_txglom_params: txglomsize=0, deferred_tx_len=0 May 17 20:30:25 eros kernel: dhd_conf_set_txglom_params: txinrx_thres=128, dhd_txminmax=-1 May 17 20:30:25 eros kernel: dhd_conf_set_txglom_params: tx_max_offset=0, txctl_tmo_fix=300 May 17 20:30:25 eros kernel: dhd_bus_devreset: WLAN OFF DONE May 17 20:30:25 eros kernel: wifi_platform_set_power = 0 May 17 20:30:25 eros kernel: ======== PULL WL_REG_ON(-1) LOW! ======== May 17 20:30:25 eros kernel: aml_wifi wifi: [extern_wifi_set_enable] WIFI Disable! 482 May 17 20:30:25 eros dhcpcd[2977]: wlan0: carrier lost May 17 20:30:25 eros kernel: wl_android_wifi_off out May 17 20:30:25 eros kernel: wl_ext_iapsta_dettach_netdev: Enter May 17 20:30:25 eros kernel: dhd_stop: Exit May 17 20:30:25 eros sudo[13979]: pam_unix(sudo:session): session closed for user root May 17 20:30:25 eros wireless.js[13789]: WIRELESS.JS - INFO: InterfaceValidator: READY - wlan0 is ready for operations May 17 20:30:25 eros wireless.js[13789]: WIRELESS.JS - INFO: STAGE 1: wlan0 validated and ready (MAC: 40:d9:5a:6f:43:ea, USB: false) May 17 20:30:26 eros wpa_supplicant[13995]: Successfully initialized wpa_supplicant May 17 20:30:26 eros kernel: dhd_open: Enter ffffffc04fa9e000 May 17 20:30:26 eros kernel: dhd_open : no mutex held. set lock May 17 20:30:26 eros kernel: Dongle Host Driver, version 1.579.77.41.10 (r) May 17 20:30:26 eros kernel: wl_ext_iapsta_attach_netdev: ifidx=0, bssidx=0 May 17 20:30:26 eros kernel: wl_android_wifi_on in 1 May 17 20:30:26 eros kernel: wl_android_wifi_on in 2: g_wifi_on=0 May 17 20:30:26 eros kernel: wifi_platform_set_power = 1 May 17 20:30:26 eros kernel: ======== PULL WL_REG_ON(-1) HIGH! ======== May 17 20:30:26 eros kernel: aml_wifi wifi: [extern_wifi_set_enable] WIFI Disable! 482 May 17 20:30:26 eros kernel: aml_wifi wifi: [extern_wifi_set_enable] WIFI Enable! 482 May 17 20:30:26 eros volumio[3424]: info: Discovery: Started advertising with name: Eros May 17 20:30:26 eros kernel: sdio_reset_comm(): May 17 20:30:26 eros kernel: meson-mmc: actual_clock :400000, HHI_nand: 0x80 May 17 20:30:26 eros kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000023c May 17 20:30:26 eros kernel: meson-mmc: actual_clock :0, HHI_nand: 0x80 May 17 20:30:26 eros kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000023c May 17 20:30:26 eros kernel: meson-mmc: actual_clock :400000, HHI_nand: 0x80 May 17 20:30:26 eros kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000023c May 17 20:30:26 eros kernel: sdio: queuing unknown CIS tuple 0x80 (2 bytes) May 17 20:30:26 eros kernel: sdio: queuing unknown CIS tuple 0x80 (3 bytes) May 17 20:30:26 eros kernel: sdio: queuing unknown CIS tuple 0x80 (3 bytes) May 17 20:30:26 eros kernel: sdio: queuing unknown CIS tuple 0x80 (7 bytes) May 17 20:30:26 eros kernel: sdio: queuing unknown CIS tuple 0x81 (9 bytes) May 17 20:30:26 eros kernel: sdio: queuing unknown CIS tuple 0x8e (9 bytes) May 17 20:30:26 eros kernel: meson-aml-mmc ffe03000.sdio: divider requested rate 200000000 != actual rate 199999997: ret=0 May 17 20:30:26 eros kernel: meson-mmc: actual_clock :199999997, HHI_nand: 0x80 May 17 20:30:26 eros kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x10000245 May 17 20:30:26 eros kernel: meson-mmc: Data 1 aligned delay is 0 May 17 20:30:26 eros kernel: meson-mmc: sdio: clk 199999997 tuning start May 17 20:30:26 eros kernel: meson-mmc: Tuning transfer error: nmatch=0 tuning_err:0xffffffac May 17 20:30:26 eros kernel: meson-mmc: sdio: rx_tuning_result[1] = 40 May 17 20:30:26 eros kernel: meson-mmc: sdio: rx_tuning_result[2] = 40 May 17 20:30:26 eros kernel: meson-mmc: sdio: rx_tuning_result[3] = 40 May 17 20:30:26 eros kernel: meson-mmc: sdio: rx_tuning_result[4] = 40 May 17 20:30:26 eros kernel: meson-mmc: [prev_map] fixed_adj_win_map:30 May 17 20:30:26 eros kernel: meson-mmc: [0]=0 May 17 20:30:26 eros kernel: meson-mmc: [1]=1 May 17 20:30:26 eros kernel: meson-mmc: [2]=1 May 17 20:30:26 eros kernel: meson-mmc: [3]=1 May 17 20:30:26 eros kernel: meson-mmc: [4]=1 May 17 20:30:26 eros kernel: meson-mmc: [_find_fixed_adj_valid_win]retry test fixed adj... May 17 20:30:26 eros kernel: meson-mmc: step:4, delay1:0x4104104, delay2:0x4004104 May 17 20:30:26 eros kernel: meson-mmc: Tuning transfer error: nmatch=0 tuning_err:0xffffffac May 17 20:30:26 eros kernel: meson-mmc: sdio: rx_tuning_result[1] = 40 May 17 20:30:26 eros kernel: meson-mmc: sdio: rx_tuning_result[2] = 40 May 17 20:30:26 eros kernel: meson-mmc: sdio: rx_tuning_result[3] = 40 May 17 20:30:26 eros kernel: meson-mmc: sdio: rx_tuning_result[4] = 40 May 17 20:30:26 eros kernel: meson-mmc: [_find_fixed_adj_valid_win]retry test fixed adj... May 17 20:30:26 eros kernel: meson-mmc: step:8, delay1:0x8208208, delay2:0x8008208 May 17 20:30:26 eros kernel: meson-mmc: Tuning transfer error: nmatch=16 tuning_err:0xffffffac May 17 20:30:26 eros kernel: meson-mmc: sdio: rx_tuning_result[1] = 40 May 17 20:30:26 eros kernel: meson-mmc: sdio: rx_tuning_result[2] = 40 May 17 20:30:26 eros kernel: meson-mmc: sdio: rx_tuning_result[3] = 40 May 17 20:30:26 eros kernel: meson-mmc: sdio: rx_tuning_result[4] = 40 May 17 20:30:26 eros kernel: meson-mmc: [_find_fixed_adj_valid_win]retry test fixed adj... May 17 20:30:26 eros kernel: meson-mmc: step:12, delay1:0xc30c30c, delay2:0xc00c30c May 17 20:30:26 eros kernel: meson-mmc: sdio: rx_tuning_result[0] = 40 May 17 20:30:26 eros kernel: meson-mmc: Tuning transfer error: nmatch=0 tuning_err:0xffffffac May 17 20:30:26 eros kernel: meson-mmc: sdio: rx_tuning_result[2] = 40 May 17 20:30:26 eros kernel: meson-mmc: sdio: rx_tuning_result[3] = 40 May 17 20:30:26 eros kernel: meson-mmc: sdio: rx_tuning_result[4] = 40 May 17 20:30:26 eros kernel: meson-mmc: [>>>>>>>>bitmap_xor_dst] fixed_adj_win_map:2 May 17 20:30:26 eros kernel: meson-mmc: [0]=0 May 17 20:30:26 eros kernel: meson-mmc: [1]=1 May 17 20:30:26 eros kernel: meson-mmc: [2]=0 May 17 20:30:26 eros kernel: meson-mmc: [3]=0 May 17 20:30:26 eros kernel: meson-mmc: [4]=0 May 17 20:30:26 eros kernel: meson-mmc: [_find_fixed_adj_valid_win] fir_adj:1 May 17 20:30:26 eros kernel: meson-mmc: [>>>>>>>>prev_map_range] fixed_adj_win_map:495 May 17 20:30:26 eros kernel: meson-mmc: [1]=1 May 17 20:30:26 eros kernel: meson-mmc: [2]=1 May 17 20:30:26 eros kernel: meson-mmc: [3]=1 May 17 20:30:26 eros kernel: meson-mmc: [4]=1 May 17 20:30:26 eros kernel: meson-mmc: [0]=0 May 17 20:30:26 eros kernel: meson-mmc: left:3, right:0, mid:4, size:4 May 17 20:30:26 eros kernel: meson-mmc: step:0, delay1:0x0, delay2:0x0 May 17 20:30:26 eros kernel: meson-mmc: sdio: sd_emmc_regs->gclock=0x10000245,sd_emmc_regs->gadjust=0x32000 May 17 20:30:26 eros kernel: meson-mmc: delay1:0x0, delay2:0x0 May 17 20:30:26 eros kernel: sdioh_start: set sd_f2_blocksize 256 May 17 20:30:26 eros kernel: dhd_bus_devreset: == WLAN ON == May 17 20:30:26 eros kernel: F1 signature read @0x18000000=0x17294359 May 17 20:30:26 eros kernel: F1 signature OK, socitype:0x1 chip:0x4359 rev:0x9 pkg:0x2 May 17 20:30:26 eros kernel: DHD: dongle ram size is set to 917504(orig 917504) at 0x160000 May 17 20:30:26 eros kernel: dhd_bus_set_default_min_res_mask: Unhandled chip id May 17 20:30:26 eros kernel: dhd_os_open_image: /lib/firmware/brcm/config_bcm4359c0_ag.txt (185 bytes) open success May 17 20:30:26 eros kernel: dhd_conf_read_sdio_params: dhd_slpauto = 0 May 17 20:30:26 eros kernel: dhd_conf_read_others: ccode = ALL May 17 20:30:26 eros kernel: dhd_conf_read_others: regrev = 38 May 17 20:30:26 eros kernel: dhd_conf_read_nv_by_chip: nv_by_chip_count=5 May 17 20:30:26 eros kernel: dhd_conf_read_nv_by_chip: chip=0xa9a6, chiprev=0, name=nvram_ap6212.txt May 17 20:30:26 eros kernel: dhd_conf_read_nv_by_chip: chip=0xa9a6, chiprev=1, name=nvram_ap6212a.txt May 17 20:30:26 eros kernel: dhd_conf_read_nv_by_chip: chip=0x4345, chiprev=6, name=nvram_ap6255.txt May 17 20:30:26 eros kernel: dhd_conf_read_nv_by_chip: chip=0x4354, chiprev=2, name=nvram_ap6356.txt May 17 20:30:26 eros kernel: dhd_conf_read_nv_by_chip: chip=0x4359, chiprev=9, name=nvram_ap6359sa.txt May 17 20:30:26 eros kernel: Final fw_path=/lib/firmware/brcm/fw_bcm4359c0_ag.bin May 17 20:30:26 eros kernel: Final nv_path=/lib/firmware/brcm/nvram_ap6359sa.txt May 17 20:30:26 eros kernel: Final clm_path=/lib/firmware/brcm/clm.blob May 17 20:30:26 eros kernel: Final conf_path=/lib/firmware/brcm/config_bcm4359c0_ag.txt May 17 20:30:26 eros kernel: dhd_os_open_image: /lib/firmware/brcm/fw_bcm4359c0_ag.bin (595758 bytes) open success May 17 20:30:27 eros kernel: dhd_os_open_image: /lib/firmware/brcm/nvram_ap6359sa.txt (5861 bytes) open success May 17 20:30:27 eros kernel: NVRAM version: AP6398S_NVRAM_V1.1_20170926 May 17 20:30:27 eros kernel: dhdsdio_write_vars: Download, Upload and compare of NVRAM succeeded. May 17 20:30:27 eros kernel: dhd_bus_init: enable 0x06, ready 0x06 (waited 0us) May 17 20:30:27 eros kernel: si_get_pmu_reg_addr: addrRET: 18000670 May 17 20:30:27 eros kernel: bcmsdh_oob_intr_register: HW_OOB irq=70 flags=0x8 May 17 20:30:27 eros kernel: dhd_get_memdump_info: File [/data/misc/wifi/.memdump.info] doesn't exist May 17 20:30:27 eros kernel: dhd_get_memdump_info: MEMDUMP ENABLED = 2 May 17 20:30:27 eros kernel: dhd_tcpack_suppress_set: TCP ACK Suppress mode 0 -> mode 1 May 17 20:30:27 eros kernel: dhd_apply_default_clm: Ignore clm file /lib/firmware/brcm/clm.blob May 17 20:30:27 eros kernel: Firmware up: op_mode=0x0405, MAC=40:d9:5a:6f:43:ea May 17 20:30:27 eros kernel: Driver: 1.579.77.41.10 (r) Firmware: wl0: Jan 19 2018 12:14:30 version 9.87.51.11.8 (a85e25e@shgit) (r) FWID 01-cb5aa0a5 CLM: 9.7.5 May 17 20:30:27 eros kernel: dhd_txglom_enable: enable 1 May 17 20:30:27 eros kernel: dhd_conf_set_txglom_params: txglom_mode=copy May 17 20:30:27 eros kernel: dhd_conf_set_txglom_params: txglomsize=36, deferred_tx_len=0 May 17 20:30:27 eros kernel: dhd_conf_set_txglom_params: txinrx_thres=128, dhd_txminmax=-1 May 17 20:30:27 eros kernel: dhd_conf_set_txglom_params: tx_max_offset=0, txctl_tmo_fix=300 May 17 20:30:27 eros kernel: dhd_conf_get_disable_proptx: fw_proptx=0, disable_proptx=1 May 17 20:30:27 eros kernel: dhd_pno_init: Support Android Location Service May 17 20:30:27 eros kernel: rtt_do_get_ioctl: failed to send getbuf proxd iovar (CMD ID : 1), status=-23 May 17 20:30:27 eros kernel: dhd_rtt_init : FTM is not supported May 17 20:30:27 eros kernel: dhd_preinit_ioctls: SensorHub diabled 0 May 17 20:30:27 eros kernel: dhd_preinit_ioctls failed to set ShubHub disable May 17 20:30:27 eros kernel: failed to set WNM capabilities May 17 20:30:27 eros kernel: dhd_conf_set_country: set country ALL, revision 38 May 17 20:30:27 eros kernel: CONFIG-ERROR) dhd_conf_set_bufiovar: country setting failed -2 May 17 20:30:27 eros kernel: Country code: US (US/0) May 17 20:30:27 eros kernel: CONFIG-ERROR) dhd_conf_set_intiovar: txbf setting failed -23 May 17 20:30:27 eros kernel: wl_android_wifi_on: Success May 17 20:30:27 eros dhcpcd[2977]: wlan0: carrier acquired May 17 20:30:27 eros kernel: dhd_open : the lock is released. May 17 20:30:27 eros kernel: dhd_open: Exit ret=0 May 17 20:30:27 eros volumio[3424]: info: Received Get System Info May 17 20:30:27 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 17 20:30:27 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 17 20:30:27 eros volumio[3424]: info: Discovery: Getting this device information May 17 20:30:27 eros volumio[3424]: info: CoreCommandRouter::volumioGetState May 17 20:30:27 eros volumio[3424]: info: CorePlayQueue::getTrack 0 May 17 20:30:27 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 17 20:30:27 eros volumio5-onboarding[3936]: time=2026-05-17T20:30:27.288+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.211.141:44260 @ 0x14a4720" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 17 20:30:27 eros sudo[14004]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:27 eros sudo[14004]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:27 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 17 20:30:27 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 17 20:30:27 eros dhcpcd[2977]: wlan0: IAID 5a:6f:43:ea May 17 20:30:27 eros sudo[14004]: pam_unix(sudo:session): session closed for user root May 17 20:30:27 eros dhcpcd[2977]: wlan0: carrier lost - roaming May 17 20:30:27 eros dhcpcd[2977]: wlan0: carrier lost - roaming May 17 20:30:27 eros kernel: P2P interface registered May 17 20:30:27 eros kernel: wl_cfgp2p_add_p2p_disc_if: wdev: ffffffc046ee0400, wdev->net: (null) May 17 20:30:27 eros kernel: WLC_E_IF: NO_IF set, event Ignored May 17 20:30:27 eros kernel: P2P interface started May 17 20:30:27 eros sudo[14031]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 17 20:30:27 eros sudo[14031]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 17 20:30:27 eros sudo[14031]: pam_unix(sudo:session): session closed for user root May 17 20:30:27 eros volumio[3424]: info: Discovery: adding 3f4a7488-6281-4a82-8e5c-47f7499416b6 May 17 20:30:27 eros volumio[3424]: info: Discovery: Found device Eros May 17 20:30:27 eros volumio[3424]: info: CoreCommandRouter::volumioGetState May 17 20:30:27 eros volumio[3424]: info: CorePlayQueue::getTrack 0 May 17 20:30:27 eros volumio[3424]: info: Discovery: this is already registered, 3f4a7488-6281-4a82-8e5c-47f7499416b6 May 17 20:30:27 eros volumio[3424]: info: Discovery: Found device Eros May 17 20:30:27 eros volumio[3424]: info: CoreCommandRouter::volumioGetState May 17 20:30:27 eros volumio[3424]: info: CorePlayQueue::getTrack 0 May 17 20:30:27 eros volumio[3424]: info: Discovery: this is already registered, 3f4a7488-6281-4a82-8e5c-47f7499416b6 May 17 20:30:27 eros volumio[3424]: info: Discovery: Found device Eros May 17 20:30:27 eros volumio[3424]: info: CoreCommandRouter::volumioGetState May 17 20:30:27 eros volumio[3424]: info: CorePlayQueue::getTrack 0 May 17 20:30:27 eros sudo[14040]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:27 eros sudo[14040]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:27 eros sudo[14040]: pam_unix(sudo:session): session closed for user root May 17 20:30:27 eros volumio[3424]: info: Received Get System Info May 17 20:30:27 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 17 20:30:27 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 17 20:30:27 eros volumio[3424]: info: Discovery: Getting this device information May 17 20:30:27 eros volumio[3424]: info: CoreCommandRouter::volumioGetState May 17 20:30:27 eros volumio[3424]: info: CorePlayQueue::getTrack 0 May 17 20:30:27 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 17 20:30:27 eros volumio5-onboarding[3936]: time=2026-05-17T20:30:27.796+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.211.141:44260 @ 0x14a4720" available=true connected=false macAddress= ip4Address= ip6Address= ssid= May 17 20:30:27 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 17 20:30:27 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 17 20:30:28 eros dhcpcd[2977]: wlan0: soliciting an IPv6 router May 17 20:30:28 eros wireless.js[13789]: WIRELESS.JS - INFO: DHCP IP fallback May 17 20:30:28 eros wireless.js[13789]: WIRELESS.JS - INFO: STAGE 2: Starting event-driven WPA state monitor May 17 20:30:28 eros wireless.js[13789]: WIRELESS.JS - INFO: WpaStateMachine: Starting state monitor for wlan0 May 17 20:30:28 eros sudo[14046]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:28 eros sudo[14046]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:28 eros sudo[14046]: pam_unix(sudo:session): session closed for user root May 17 20:30:28 eros wireless.js[13789]: WIRELESS.JS - INFO: WpaStateMachine: State transition: NULL -> SCANNING (duration: 0ms) May 17 20:30:29 eros volumio5-onboarding[3936]: time=2026-05-17T20:30:29.213+02:00 level=INFO msg="service successfully established" component=discovery/localnet May 17 20:30:29 eros sudo[14064]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:29 eros sudo[14064]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:29 eros wpa_supplicant[14029]: wlan0: Trying to associate with 22:c5:a8:2c:24:4e (SSID='Gaia' freq=2412 MHz) May 17 20:30:29 eros kernel: Connecting with 22:c5:a8:2c:24:4e ssid "Gaia", len (4) channel=1 May 17 20:30:29 eros kernel: dhd_dbg_start_pkt_monitor, 1724 May 17 20:30:29 eros sudo[14064]: pam_unix(sudo:session): session closed for user root May 17 20:30:29 eros kernel: wl_iw_event: Link UP with 22:c5:a8:2c:24:4e May 17 20:30:29 eros kernel: wl_bss_connect_done succeeded with 22:c5:a8:2c:24:4e May 17 20:30:29 eros kernel: CFG80211-ERROR) wl_cfg80211_scan_abort : scan abort failed May 17 20:30:29 eros wpa_supplicant[14029]: wlan0: Associated with 22:c5:a8:2c:24:4e May 17 20:30:29 eros wpa_supplicant[14029]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 May 17 20:30:29 eros wpa_supplicant[14029]: wlan0: WPA: Key negotiation completed with 22:c5:a8:2c:24:4e [PTK=CCMP GTK=CCMP] May 17 20:30:29 eros wpa_supplicant[14029]: wlan0: CTRL-EVENT-CONNECTED - Connection to 22:c5:a8:2c:24:4e completed [id=0 id_str=] May 17 20:30:29 eros dhcpcd[2977]: wlan0: carrier acquired May 17 20:30:29 eros dhcpcd[2977]: wlan0: connected to Access Point: Gaia May 17 20:30:29 eros dhcpcd[2977]: wlan0: IAID 5a:6f:43:ea May 17 20:30:29 eros kernel: wl_bss_connect_done succeeded with 22:c5:a8:2c:24:4e vndr_oui: 00-10-18 May 17 20:30:30 eros wireless.js[13789]: WIRELESS.JS - INFO: WpaStateMachine: State transition: SCANNING -> COMPLETED (duration: 1023ms) May 17 20:30:30 eros wireless.js[13789]: WIRELESS.JS - INFO: WpaStateMachine: COMPLETED - connection successful May 17 20:30:30 eros wireless.js[13789]: WIRELESS.JS - INFO: STAGE 2: Connection successful - Connected to 22:c5:a8:2c:24:4e May 17 20:30:30 eros wireless.js[13789]: WIRELESS.JS - INFO: Onboard WiFi adapter detected, using standard dhcpcd flow May 17 20:30:30 eros dhcpcd[2977]: wlan0: soliciting an IPv6 router May 17 20:30:30 eros volumio5-onboarding[3936]: time=2026-05-17T20:30:30.349+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.211.141:44260 @ 0x14a4720" available=true connected=true macAddress=40:d9:5a:6f:43:ea ip4Address= ip6Address= ssid=Gaia May 17 20:30:30 eros volumio[3424]: info: Received Get System Info May 17 20:30:30 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 17 20:30:30 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 17 20:30:30 eros volumio[3424]: info: Discovery: Getting this device information May 17 20:30:30 eros volumio[3424]: info: CoreCommandRouter::volumioGetState May 17 20:30:30 eros volumio[3424]: info: CorePlayQueue::getTrack 0 May 17 20:30:30 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 17 20:30:30 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 17 20:30:30 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 17 20:30:30 eros sudo[14081]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:30 eros sudo[14081]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:30 eros sudo[14081]: pam_unix(sudo:session): session closed for user root May 17 20:30:30 eros dhcpcd[2977]: wlan0: soliciting a DHCP lease May 17 20:30:30 eros dhcpcd[2977]: wlan0: probing address 192.168.149.15/24 May 17 20:30:30 eros dhcpcd[14086]: ps_bpf_recvmsg: Invalid argument May 17 20:30:31 eros sudo[14087]: root : PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd wlan0 May 17 20:30:31 eros sudo[14087]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 17 20:30:31 eros dhcpcd[2977]: ps_ctl_dispatch: cannot handle another client May 17 20:30:31 eros dhcpcd[2977]: control_free: No such file or directory May 17 20:30:31 eros sudo[14087]: pam_unix(sudo:session): session closed for user root May 17 20:30:31 eros volumio5-onboarding[3936]: time=2026-05-17T20:30:31.284+02:00 level=INFO msg="service successfully established" component=discovery/localnet May 17 20:30:31 eros sudo[14090]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:31 eros sudo[14090]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:31 eros sudo[14090]: pam_unix(sudo:session): session closed for user root May 17 20:30:32 eros dhcpcd[14086]: ps_bpf_recvmsg: Invalid argument May 17 20:30:32 eros sudo[14094]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:32 eros sudo[14094]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:32 eros sudo[14094]: pam_unix(sudo:session): session closed for user root May 17 20:30:33 eros wireless.js[13789]: WIRELESS.JS - INFO: Start ap May 17 20:30:33 eros wireless.js[13789]: WIRELESS.JS - INFO: Notified systemd about wireless ready May 17 20:30:33 eros systemd[1]: Started wireless.service - Wireless Services. May 17 20:30:33 eros sudo[13787]: pam_unix(sudo:session): session closed for user root May 17 20:30:33 eros sudo[14103]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:33 eros sudo[14103]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:33 eros sudo[14103]: pam_unix(sudo:session): session closed for user root May 17 20:30:34 eros dhcpcd[14086]: ps_bpf_recvmsg: Invalid argument May 17 20:30:34 eros wireless.js[13789]: WIRELESS.JS - INFO: trying... May 17 20:30:34 eros sudo[14113]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 17 20:30:34 eros sudo[14113]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:34 eros sudo[14113]: pam_unix(sudo:session): session closed for user root May 17 20:30:34 eros sudo[14116]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:34 eros sudo[14116]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 17 20:30:34 eros sudo[14116]: pam_unix(sudo:session): session closed for user root May 17 20:30:34 eros wireless.js[13789]: WIRELESS.JS - INFO: ... wlan0 IPv4 is undefined, ipV6 is undefined May 17 20:30:34 eros sudo[14120]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:34 eros sudo[14120]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:34 eros sudo[14120]: pam_unix(sudo:session): session closed for user root May 17 20:30:35 eros wireless.js[13789]: WIRELESS.JS - INFO: trying... May 17 20:30:35 eros sudo[14129]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 17 20:30:35 eros sudo[14129]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:35 eros sudo[14129]: pam_unix(sudo:session): session closed for user root May 17 20:30:35 eros sudo[14132]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:35 eros sudo[14132]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 17 20:30:35 eros sudo[14132]: pam_unix(sudo:session): session closed for user root May 17 20:30:35 eros wireless.js[13789]: WIRELESS.JS - INFO: ... wlan0 IPv4 is undefined, ipV6 is undefined May 17 20:30:35 eros sudo[14136]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:35 eros sudo[14136]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:35 eros sudo[14136]: pam_unix(sudo:session): session closed for user root May 17 20:30:36 eros dhcpcd[2977]: wlan0: leased 192.168.149.15 for 3599 seconds May 17 20:30:36 eros avahi-daemon[2913]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.149.15. May 17 20:30:36 eros avahi-daemon[2913]: New relevant interface wlan0.IPv4 for mDNS. May 17 20:30:36 eros avahi-daemon[2913]: Registering new address record for 192.168.149.15 on wlan0.IPv4. May 17 20:30:36 eros dhcpcd[2977]: wlan0: adding route to 192.168.149.0/24 May 17 20:30:36 eros dhcpcd[2977]: wlan0: adding default route via 192.168.149.52 May 17 20:30:36 eros dhcpcd[14086]: ps_bpf_recvmsg: Invalid argument May 17 20:30:36 eros wireless.js[13789]: WIRELESS.JS - INFO: trying... May 17 20:30:36 eros systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. May 17 20:30:36 eros systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... May 17 20:30:36 eros systemd[1]: welcome.service: Deactivated successfully. May 17 20:30:36 eros systemd[1]: Stopped welcome.service - Show a welcome message on console. May 17 20:30:36 eros systemd[1]: Stopping welcome.service - Show a welcome message on console... May 17 20:30:36 eros systemd[1]: Starting welcome.service - Show a welcome message on console... May 17 20:30:36 eros welcome[14160]: Resolved ip:[1] 192.168.149.15 May 17 20:30:36 eros systemd[1]: Finished welcome.service - Show a welcome message on console. May 17 20:30:36 eros systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. May 17 20:30:36 eros sudo[14184]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 17 20:30:36 eros sudo[14184]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:36 eros sudo[14184]: pam_unix(sudo:session): session closed for user root May 17 20:30:36 eros sudo[14188]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:36 eros sudo[14188]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 17 20:30:36 eros sudo[14188]: pam_unix(sudo:session): session closed for user root May 17 20:30:36 eros wireless.js[13789]: WIRELESS.JS - INFO: ... wlan0 IPv4 is 192.168.149.15, ipV6 is undefined May 17 20:30:36 eros wireless.js[13789]: WIRELESS.JS - INFO: Connected to SSID: Gaia May 17 20:30:36 eros wireless.js[13789]: WIRELESS.JS - INFO: It's done! AP May 17 20:30:36 eros wireless.js[13789]: WIRELESS.JS - INFO: Notified systemd about wireless ready May 17 20:30:36 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 17 20:30:36 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 17 20:30:36 eros volumio[3424]: info: Discovery: Getting this device information May 17 20:30:36 eros volumio[3424]: info: CoreCommandRouter::volumioGetState May 17 20:30:36 eros volumio[3424]: info: CorePlayQueue::getTrack 0 May 17 20:30:36 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 17 20:30:36 eros sudo[14194]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:36 eros sudo[14194]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:36 eros volumio[3424]: verbose: New Socket.io Connection to 192.168.149.15:3000 from 192.168.149.86 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 May 17 20:30:36 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 17 20:30:36 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 17 20:30:36 eros sudo[14194]: pam_unix(sudo:session): session closed for user root May 17 20:30:36 eros volumio5-onboarding[3936]: time=2026-05-17T20:30:36.678+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.211.141:44260 @ 0x14a4720" available=true connected=true macAddress=40:d9:5a:6f:43:ea ip4Address=192.168.149.15/24 ip6Address= ssid=Gaia May 17 20:30:36 eros volumio[3424]: info: Received Get System Info May 17 20:30:36 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 17 20:30:36 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 17 20:30:36 eros volumio[3424]: info: Discovery: Getting this device information May 17 20:30:36 eros volumio[3424]: info: CoreCommandRouter::volumioGetState May 17 20:30:36 eros volumio[3424]: info: CorePlayQueue::getTrack 0 May 17 20:30:36 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 17 20:30:36 eros sudo[14198]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 17 20:30:36 eros sudo[14198]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:36 eros sudo[14198]: pam_unix(sudo:session): session closed for user root May 17 20:30:36 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 17 20:30:36 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 17 20:30:37 eros volumio[3424]: info: Discovery: this is already registered, 3f4a7488-6281-4a82-8e5c-47f7499416b6 May 17 20:30:37 eros volumio[3424]: info: Discovery: Found device Eros May 17 20:30:37 eros volumio[3424]: info: CoreCommandRouter::volumioGetState May 17 20:30:37 eros volumio[3424]: info: CorePlayQueue::getTrack 0 May 17 20:30:37 eros volumio[3424]: info: Discovery: this is already registered, 3f4a7488-6281-4a82-8e5c-47f7499416b6 May 17 20:30:37 eros volumio[3424]: info: Discovery: Found device Eros May 17 20:30:37 eros volumio[3424]: info: CoreCommandRouter::volumioGetState May 17 20:30:37 eros volumio[3424]: info: CorePlayQueue::getTrack 0 May 17 20:30:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 17 20:30:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 17 20:30:37 eros volumio[3424]: info: Discovery: Getting this device information May 17 20:30:37 eros volumio[3424]: info: CoreCommandRouter::volumioGetState May 17 20:30:37 eros volumio[3424]: info: CorePlayQueue::getTrack 0 May 17 20:30:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 17 20:30:37 eros volumio[3424]: info: Discovery: this is already registered, 3f4a7488-6281-4a82-8e5c-47f7499416b6 May 17 20:30:37 eros volumio[3424]: info: Discovery: Found device Eros May 17 20:30:37 eros volumio[3424]: info: CoreCommandRouter::volumioGetState May 17 20:30:37 eros volumio[3424]: info: CorePlayQueue::getTrack 0 May 17 20:30:37 eros volumio[3424]: verbose: New Socket.io Connection to 192.168.149.15:3000 from 192.168.149.86 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 May 17 20:30:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 17 20:30:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 17 20:30:37 eros volumio[3424]: verbose: New Socket.io Connection to 192.168.149.15:3000 from 192.168.149.86 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 May 17 20:30:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 17 20:30:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 17 20:30:37 eros volumio[3424]: info: Discovery: Getting this device information May 17 20:30:37 eros volumio[3424]: info: CoreCommandRouter::volumioGetState May 17 20:30:37 eros volumio[3424]: info: CorePlayQueue::getTrack 0 May 17 20:30:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 17 20:30:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 17 20:30:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 17 20:30:37 eros volumio[3424]: info: Discovery: Getting this device information May 17 20:30:37 eros volumio[3424]: info: CoreCommandRouter::volumioGetState May 17 20:30:37 eros volumio[3424]: info: CorePlayQueue::getTrack 0 May 17 20:30:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 17 20:30:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 17 20:30:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages May 17 20:30:37 eros ntpd[3141]: IO: Listen normally on 5 wlan0 192.168.149.15:123 May 17 20:30:37 eros ntpd[3141]: IO: new interface(s) found: waking up resolver May 17 20:30:37 eros ntpd[3141]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 May 17 20:30:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone May 17 20:30:37 eros ntpd[3141]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 May 17 20:30:37 eros ntpd[3141]: DNS: Pool taking: 212.227.145.233 May 17 20:30:37 eros ntpd[3141]: DNS: Pool taking: 85.49.251.3 May 17 20:30:37 eros ntpd[3141]: DNS: Pool taking: 162.159.200.123 May 17 20:30:37 eros ntpd[3141]: DNS: Pool taking: 94.143.139.219 May 17 20:30:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork May 17 20:30:37 eros ntpd[3141]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 May 17 20:30:37 eros sudo[14205]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 May 17 20:30:37 eros sudo[14205]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:37 eros sudo[14210]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 17 20:30:37 eros sudo[14210]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:37 eros sudo[14210]: pam_unix(sudo:session): session closed for user root May 17 20:30:37 eros sudo[14205]: pam_unix(sudo:session): session closed for user root May 17 20:30:37 eros sudo[14221]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 17 20:30:37 eros sudo[14221]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:37 eros sudo[14216]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 17 20:30:37 eros sudo[14216]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:37 eros sudo[14228]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 17 20:30:37 eros sudo[14228]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:37 eros sudo[14216]: pam_unix(sudo:session): session closed for user root May 17 20:30:37 eros sudo[14221]: pam_unix(sudo:session): session closed for user root May 17 20:30:37 eros sudo[14228]: pam_unix(sudo:session): session closed for user root May 17 20:30:37 eros sudo[14233]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:37 eros sudo[14233]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:37 eros volumio5-onboarding[3936]: time=2026-05-17T20:30:37.742+02:00 level=INFO msg="service successfully established" component=discovery/localnet May 17 20:30:37 eros sudo[14233]: pam_unix(sudo:session): session closed for user root May 17 20:30:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 17 20:30:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 17 20:30:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 17 20:30:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 17 20:30:37 eros volumio[3424]: info: Discovery: Getting this device information May 17 20:30:37 eros volumio[3424]: info: CoreCommandRouter::volumioGetState May 17 20:30:37 eros volumio[3424]: info: CorePlayQueue::getTrack 0 May 17 20:30:37 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 17 20:30:37 eros volumio5-onboarding[3936]: time=2026-05-17T20:30:37.836+02:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.149.86:48434 May 17 20:30:37 eros volumio[3424]: info: CoreCommandRouter::volumioGetState May 17 20:30:37 eros volumio[3424]: info: CorePlayQueue::getTrack 0 May 17 20:30:37 eros volumio5-onboarding[3936]: time=2026-05-17T20:30:37.902+02:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.149.86:48434 @ 0x14a4b40" latency=-3543h21m27.701405598s timeout=10s May 17 20:30:38 eros dhcpcd[14086]: ps_bpf_recvmsg: Invalid argument May 17 20:30:38 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection May 17 20:30:38 eros volumio[3424]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo May 17 20:30:38 eros volumio5-onboarding[3936]: time=2026-05-17T20:30:38.270+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.149.86:48434 @ 0x14a4b40" latency=-3543h21m27.701405598s timeout=10s endpoint=http://pushupdates.volumio.org duration=356.718178ms May 17 20:30:38 eros sudo[14246]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 20:30:38 eros sudo[14246]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:38 eros sudo[14246]: pam_unix(sudo:session): session closed for user root May 17 20:30:38 eros sudo[14250]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 17 20:30:38 eros sudo[14250]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 17 20:30:38 eros sudo[14250]: pam_unix(sudo:session): session closed for user root May 17 20:30:38 eros ntpd[3141]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 May 17 20:30:38 eros ntpd[3141]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 May 17 20:30:38 eros ntpd[3141]: DNS: Pool taking: 195.95.153.59 May 17 20:30:38 eros ntpd[3141]: DNS: Pool taking: 82.165.173.235 May 17 20:30:38 eros ntpd[3141]: DNS: Pool skipping: 162.159.200.123 May 17 20:30:38 eros ntpd[3141]: DNS: Pool taking: 84.77.195.114 May 17 20:30:38 eros ntpd[3141]: DNS: Pool taking: 2001:ba0:214:a800::1 May 17 20:30:38 eros ntpd[3141]: DNS: Pool taking: 2001:ba0:294:4600::1 May 17 20:30:38 eros ntpd[3141]: DNS: Pool taking: 2001:ba0:21f:4900:: May 17 20:30:38 eros ntpd[3141]: DNS: Pool taking: 2a01:7e02::f03c:94ff:fe0f:f728 May 17 20:30:38 eros ntpd[3141]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 May 17 20:30:38 eros volumio[3424]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 17 20:30:38 eros volumio[3424]: Error: certificate is not yet valid May 17 20:30:38 eros volumio[3424]: at TLSSocket.onConnectSecure (node:_tls_wrap:1627:34) May 17 20:30:38 eros volumio[3424]: at TLSSocket.emit (node:events:514:28) May 17 20:30:38 eros volumio[3424]: at TLSSocket._finishInit (node:_tls_wrap:1038:8) May 17 20:30:38 eros volumio[3424]: at ssl.onhandshakedone (node:_tls_wrap:824:12) { May 17 20:30:38 eros volumio[3424]: code: 'CERT_NOT_YET_VALID' May 17 20:30:38 eros volumio[3424]: } May 17 20:30:38 eros volumio[3424]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 17 20:30:38 eros volumio5-onboarding[3936]: time=2026-05-17T20:30:38.698+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.149.86:48434 @ 0x14a4b40" latency=-3543h21m27.701405598s timeout=10s endpoint=https://functions.volumio.cloud duration=770.94112ms error="Head \"https://functions.volumio.cloud\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-05-17T20:30:38+02:00 is before 2026-08-30T15:33:48Z" May 17 20:30:38 eros volumio5-onboarding[3936]: time=2026-05-17T20:30:38.698+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.149.86:48434 @ 0x14a4b40" latency=-3543h21m27.701405598s timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=784.436798ms error="Head \"https://browsing-performer.dfs.volumio.org\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-05-17T20:30:38+02:00 is before 2026-09-22T11:37:09Z" May 17 20:30:38 eros volumio5-onboarding[3936]: time=2026-05-17T20:30:38.699+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.149.86:48434 @ 0x14a4b40" latency=-3543h21m27.701405598s timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=795.97976ms error="Head \"https://radio-directory.firebaseapp.com\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-05-17T20:30:38+02:00 is before 2026-09-23T18:00:29Z" May 17 20:30:38 eros volumio5-onboarding[3936]: time=2026-05-17T20:30:38.698+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.149.86:48434 @ 0x14a4b40" latency=-3543h21m27.701405598s timeout=10s endpoint=https://functions.volumio.cloud duration=771.32133ms error="Head \"https://functions.volumio.cloud\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-05-17T20:30:38+02:00 is before 2026-08-30T15:33:48Z" May 17 20:30:38 eros volumio5-onboarding[3936]: time=2026-05-17T20:30:38.699+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.149.86:48434 @ 0x14a4b40" latency=-3543h21m27.701405598s timeout=10s endpoint=https://google.com duration=772.149084ms error="Head \"https://google.com\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-05-17T20:30:38+02:00 is before 2026-09-18T20:00:11Z" May 17 20:30:38 eros volumio5-onboarding[3936]: time=2026-05-17T20:30:38.699+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.149.86:48434 @ 0x14a4b40" latency=-3543h21m27.701405598s timeout=10s endpoint=https://securetoken.googleapis.com duration=786.25493ms error="Head \"https://securetoken.googleapis.com\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-05-17T20:30:38+02:00 is before 2026-09-18T20:01:43Z" May 17 20:30:38 eros volumio5-onboarding[3936]: time=2026-05-17T20:30:38.699+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.149.86:48434 @ 0x14a4b40" latency=-3543h21m27.701405598s timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=795.7163ms error="Head \"https://oauth-performer.dfs.volumio.org\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-05-17T20:30:38+02:00 is before 2026-09-06T23:37:31Z" May 17 20:30:38 eros volumio5-onboarding[3936]: time=2026-05-17T20:30:38.700+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.149.86:48434 @ 0x14a4b40" latency=-3543h21m27.701405598s timeout=10s endpoint=https://database.volumio.cloud duration=769.055113ms error="Head \"https://database.volumio.cloud\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-05-17T20:30:38+02:00 is before 2026-08-30T15:33:48Z" May 17 20:30:38 eros volumio5-onboarding[3936]: time=2026-05-17T20:30:38.700+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.149.86:48434 @ 0x14a4b40" latency=-3543h21m27.701405598s timeout=10s endpoint=https://myvolumio.firebaseio.com duration=786.268055ms error="Head \"https://myvolumio.firebaseio.com\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-05-17T20:30:38+02:00 is before 2026-09-04T14:02:57Z" May 17 20:30:38 eros volumio5-onboarding[3936]: time=2026-05-17T20:30:38.698+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.149.86:48434 @ 0x14a4b40" latency=-3543h21m27.701405598s timeout=10s endpoint=https://www.googleapis.com duration=766.39552ms error="Head \"https://www.googleapis.com\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2026-05-17T20:30:38+02:00 is before 2026-09-18T20:01:43Z" May 17 20:30:38 eros volumio5-onboarding[3936]: time=2026-05-17T20:30:38.741+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.149.86:48434 @ 0x14a4b40" latency=-3543h21m27.701405598s timeout=10s endpoint=http://plugins.volumio.org duration=824.807913ms May 17 20:30:38 eros volumio5-onboarding[3936]: time=2026-05-17T20:30:38.785+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.149.86:48434 @ 0x14a4b40" latency=-3543h21m27.701405598s timeout=10s endpoint=http://cddb.volumio.org duration=867.521204ms error="Head \"http://gnudb.gnudb.org/~cddb/cddb.cgi/\": EOF" May 17 20:30:38 eros systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 230. May 17 20:30:38 eros systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. May 17 20:30:38 eros systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. May 17 20:30:38 eros upmpdcli[14264]: Could not open config: /tmp/upmpdcli.conf May 17 20:30:38 eros systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE May 17 20:30:38 eros systemd[1]: upmpdcli.service: Failed with result 'exit-code'. May 17 20:30:39 eros ntpd[3141]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 May 17 20:30:39 eros ntpd[3141]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 May 17 20:30:39 eros ntpd[3141]: DNS: Pool taking: 194.164.164.175 May 17 20:30:39 eros ntpd[3141]: DNS: Pool taking: 92.113.12.77 May 17 20:30:39 eros ntpd[3141]: DNS: Pool taking: 92.113.12.78 May 17 20:30:39 eros ntpd[3141]: DNS: Pool skipping: 212.227.145.233 May 17 20:30:39 eros ntpd[3141]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 May 17 20:30:39 eros sudo[14267]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-05-17 20:29' May 17 20:30:39 eros sudo[14267]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="9ccd1247f8cab3c5d64c23a96d243f6bfa34d032" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="9938d7179e3b7c4e41f3e2d60c255985cff08fee" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="primo2rev2" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun May 17 17:32:08 UTC 2026" VOLUMIO_VERSION="4.158" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Primo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Primo" VOLUMIO_HASH="43d420a3aa41c50690ebfe378df38e2b"