May 31 06:16:40 volumio hostapd[2812]: wlan0: STA 62:cc:47:e2:ee:7b IEEE 802.11: associated May 31 06:16:40 volumio hostapd[2812]: wlan0: STA 62:cc:47:e2:ee:7b RADIUS: starting accounting session 212C28BE5934A70B May 31 06:16:40 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... May 31 06:16:40 volumio dbus-daemon[620]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.42' (uid=0 pid=3100 comm="timedatectl show --property=NTPSynchronized --valu") May 31 06:16:40 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... May 31 06:16:40 volumio dbus-daemon[620]: [system] Successfully activated service 'org.freedesktop.timedate1' May 31 06:16:40 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. May 31 06:16:41 volumio setdatetime-helper.sh[3099]: Time is already synchronized. May 31 06:16:41 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. May 31 06:16:41 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. May 31 06:16:41 volumio dnsmasq-dhcp[2820]: DHCPREQUEST(wlan0) 192.168.211.134 62:cc:47:e2:ee:7b May 31 06:16:41 volumio dnsmasq-dhcp[2820]: DHCPACK(wlan0) 192.168.211.134 62:cc:47:e2:ee:7b Pixel-7-Pro May 31 06:16:44 volumio sudo[3107]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 31 06:16:44 volumio sudo[3107]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:16:44 volumio sudo[3105]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 31 06:16:44 volumio sudo[3105]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:16:44 volumio sudo[3107]: pam_unix(sudo:session): session closed for user root May 31 06:16:44 volumio sudo[3105]: pam_unix(sudo:session): session closed for user root May 31 06:16:45 volumio volumio[1020]: verbose: New Socket.io Connection to 192.168.211.1 from 192.168.211.134 UA: Mozilla/5.0 (Linux; Android 16; Pixel 7 Pro Build/BP4A.251205.006; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.34 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 May 31 06:16:45 volumio sudo[3111]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 31 06:16:45 volumio sudo[3111]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:16:45 volumio sudo[3111]: pam_unix(sudo:session): session closed for user root May 31 06:16:45 volumio sudo[3113]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 31 06:16:45 volumio sudo[3113]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:16:45 volumio sudo[3113]: pam_unix(sudo:session): session closed for user root May 31 06:16:45 volumio volumio[1020]: verbose: New Socket.io Connection to 192.168.211.1 from 192.168.211.134 UA: Mozilla/5.0 (Linux; Android 16; Pixel 7 Pro Build/BP4A.251205.006; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.34 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 May 31 06:16:46 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 31 06:16:47 volumio volumio[1020]: info: CoreCommandRouter::volumioGetVisibleSources May 31 06:16:47 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 31 06:16:47 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 31 06:16:47 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 31 06:16:47 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 31 06:16:47 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 31 06:16:47 volumio volumio[1020]: info: Received Get System Info May 31 06:16:47 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 31 06:16:47 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 31 06:16:47 volumio volumio[1020]: info: Discovery: Getting this device information May 31 06:16:47 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 31 06:16:47 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 31 06:16:47 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 31 06:16:47 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 31 06:16:47 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 31 06:16:47 volumio volumio[1020]: info: Listing playlists May 31 06:16:47 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 31 06:16:47 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 31 06:16:47 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 31 06:16:47 volumio volumio[1020]: info: Received Get System Info May 31 06:16:47 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 31 06:16:47 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 31 06:16:47 volumio volumio[1020]: info: Discovery: Getting this device information May 31 06:16:47 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 31 06:16:47 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 31 06:16:47 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 31 06:16:48 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 31 06:16:50 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse May 31 06:16:55 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 31 06:16:57 volumio volumio[1020]: info: CoreCommandRouter::Close All Modals sent May 31 06:16:57 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: appearance , setTOSAccepted May 31 06:16:59 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 31 06:17:01 volumio sudo[3150]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 31 06:17:01 volumio sudo[3150]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:17:01 volumio sudo[3150]: pam_unix(sudo:session): session closed for user root May 31 06:17:01 volumio sudo[3152]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 31 06:17:01 volumio sudo[3152]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:17:01 volumio sudo[3152]: pam_unix(sudo:session): session closed for user root May 31 06:17:01 volumio volumio[1020]: verbose: New Socket.io Connection to 192.168.211.1 from 192.168.211.134 UA: Mozilla/5.0 (Linux; Android 16; Pixel 7 Pro Build/BP4A.251205.006; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.34 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 May 31 06:17:01 volumio volumio[1020]: info: Received Get System Info May 31 06:17:01 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 31 06:17:01 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 31 06:17:01 volumio volumio[1020]: info: Discovery: Getting this device information May 31 06:17:01 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 31 06:17:01 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 31 06:17:01 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 31 06:17:01 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 31 06:17:01 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 31 06:17:01 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 31 06:17:01 volumio volumio[1020]: info: CoreCommandRouter::volumioGetVisibleSources May 31 06:17:01 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 31 06:17:01 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 31 06:17:01 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 31 06:17:01 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 31 06:17:01 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 31 06:17:01 volumio volumio[1020]: info: Received Get System Info May 31 06:17:01 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 31 06:17:01 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 31 06:17:01 volumio volumio[1020]: info: Discovery: Getting this device information May 31 06:17:01 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 31 06:17:01 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 31 06:17:01 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 31 06:17:01 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 31 06:17:01 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 31 06:17:01 volumio volumio[1020]: info: Listing playlists May 31 06:17:11 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. May 31 06:17:11 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 31 06:17:17 volumio sudo[3174]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 31 06:17:17 volumio sudo[3174]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:17:17 volumio sudo[3174]: pam_unix(sudo:session): session closed for user root May 31 06:17:17 volumio sudo[3176]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 31 06:17:17 volumio sudo[3176]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:17:17 volumio sudo[3176]: pam_unix(sudo:session): session closed for user root May 31 06:17:17 volumio volumio[1020]: verbose: New Socket.io Connection to 192.168.211.1 from 192.168.211.134 UA: Mozilla/5.0 (Linux; Android 16; Pixel 7 Pro Build/BP4A.251205.006; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.34 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 May 31 06:17:17 volumio volumio[1020]: info: Received Get System Info May 31 06:17:17 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 31 06:17:17 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 31 06:17:17 volumio volumio[1020]: info: Discovery: Getting this device information May 31 06:17:17 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 31 06:17:17 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 31 06:17:17 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 31 06:17:17 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 31 06:17:17 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 31 06:17:17 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 31 06:17:17 volumio volumio[1020]: info: CoreCommandRouter::volumioGetVisibleSources May 31 06:17:17 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 31 06:17:17 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 31 06:17:17 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 31 06:17:17 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 31 06:17:17 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 31 06:17:17 volumio volumio[1020]: info: Received Get System Info May 31 06:17:17 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 31 06:17:17 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 31 06:17:17 volumio volumio[1020]: info: Discovery: Getting this device information May 31 06:17:17 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 31 06:17:17 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 31 06:17:17 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 31 06:17:17 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 31 06:17:17 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 31 06:17:17 volumio volumio[1020]: info: Listing playlists May 31 06:17:17 volumio volumio[1020]: info: Received Get System Info May 31 06:17:17 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 31 06:17:17 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 31 06:17:17 volumio volumio[1020]: info: Discovery: Getting this device information May 31 06:17:17 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 31 06:17:17 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 31 06:17:17 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 31 06:17:17 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 31 06:17:17 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 31 06:17:19 volumio volumio[1020]: info: CoreCommandRouter::getUIConfigOnPlugin May 31 06:17:19 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 31 06:17:20 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork May 31 06:17:20 volumio sudo[3185]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 May 31 06:17:20 volumio sudo[3185]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:17:20 volumio sudo[3190]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 31 06:17:20 volumio sudo[3190]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:17:20 volumio sudo[3190]: pam_unix(sudo:session): session closed for user root May 31 06:17:20 volumio sudo[3196]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 31 06:17:20 volumio sudo[3196]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:17:20 volumio sudo[3185]: pam_unix(sudo:session): session closed for user root May 31 06:17:20 volumio sudo[3196]: pam_unix(sudo:session): session closed for user root May 31 06:17:20 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache May 31 06:17:20 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks May 31 06:17:20 volumio sudo[3202]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 31 06:17:20 volumio sudo[3202]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:17:20 volumio sudo[3209]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 31 06:17:20 volumio sudo[3209]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:17:20 volumio sudo[3202]: pam_unix(sudo:session): session closed for user root May 31 06:17:20 volumio sudo[3209]: pam_unix(sudo:session): session closed for user root May 31 06:17:20 volumio sudo[3212]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 31 06:17:20 volumio sudo[3212]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:17:20 volumio sudo[3212]: pam_unix(sudo:session): session closed for user root May 31 06:17:20 volumio sudo[3216]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 31 06:17:20 volumio sudo[3216]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:17:20 volumio sudo[3216]: pam_unix(sudo:session): session closed for user root May 31 06:17:20 volumio kernel: ieee80211 phy0: brcmf_vif_set_mgmt_ie: vndr ie set error : -52 May 31 06:17:20 volumio kernel: ieee80211 phy0: brcmf_cfg80211_scan: scan error (-52) May 31 06:17:20 volumio volumio[1020]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan May 31 06:17:20 volumio volumio[1020]: wlan0 Interface doesn't support scanning : Invalid exchange May 31 06:17:20 volumio volumio[1020]: info: Cannot use regular scanning, forcing with ap-force May 31 06:17:20 volumio sudo[3221]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force May 31 06:17:20 volumio sudo[3221]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:17:21 volumio sudo[3221]: pam_unix(sudo:session): session closed for user root May 31 06:17:27 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 31 06:17:35 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings May 31 06:17:35 volumio volumio[1020]: info: Saving new wireless network May 31 06:17:35 volumio sudo[3253]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf May 31 06:17:35 volumio sudo[3253]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:17:35 volumio sudo[3253]: pam_unix(sudo:session): session closed for user root May 31 06:17:35 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart May 31 06:17:35 volumio volumio[1020]: info: Discovery: Restarting Advertising due to device name change May 31 06:17:35 volumio sudo[3256]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service May 31 06:17:35 volumio sudo[3256]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:17:35 volumio systemd[1]: Starting wireless.service - Wireless Services... May 31 06:17:36 volumio systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... May 31 06:17:36 volumio dnsmasq[2820]: exiting on receipt of SIGTERM May 31 06:17:36 volumio systemd[1]: dnsmasq.service: Deactivated successfully. May 31 06:17:36 volumio systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. May 31 06:17:36 volumio systemd[1]: Stopping hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... May 31 06:17:36 volumio volumio[1020]: info: Discovery: A device disappeared from network May 31 06:17:36 volumio volumio[1020]: info: Discovery: Device volumio disappeared from network May 31 06:17:36 volumio volumio[1020]: info: Discovery: A device disappeared from network May 31 06:17:37 volumio dhcpcd[746]: wlan0: carrier lost May 31 06:17:37 volumio avahi-daemon[612]: Withdrawing address record for 169.254.153.196 on wlan0. May 31 06:17:37 volumio dhcpcd[746]: wlan0: deleting route to 169.254.0.0/16 May 31 06:17:37 volumio dhcpcd[746]: wlan0: deleting default route May 31 06:17:37 volumio systemd[1]: hostapd.service: Deactivated successfully. May 31 06:17:37 volumio systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. May 31 06:17:37 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. May 31 06:17:37 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... May 31 06:17:37 volumio systemd[1]: welcome.service: Deactivated successfully. May 31 06:17:37 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. May 31 06:17:37 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... May 31 06:17:37 volumio sudo[3300]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 May 31 06:17:37 volumio sudo[3300]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 31 06:17:37 volumio avahi-daemon[612]: Withdrawing address record for 192.168.211.1 on wlan0. May 31 06:17:37 volumio avahi-daemon[612]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. May 31 06:17:37 volumio avahi-daemon[612]: Interface wlan0.IPv4 no longer relevant for mDNS. May 31 06:17:37 volumio sudo[3300]: pam_unix(sudo:session): session closed for user root May 31 06:17:37 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... May 31 06:17:37 volumio welcome[3299]: Resolved ip:[0] May 31 06:17:37 volumio sudo[3302]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down May 31 06:17:37 volumio sudo[3302]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 31 06:17:37 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. May 31 06:17:37 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. May 31 06:17:37 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. May 31 06:17:37 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... May 31 06:17:37 volumio systemd[1]: welcome.service: Deactivated successfully. May 31 06:17:37 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. May 31 06:17:37 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... May 31 06:17:37 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... May 31 06:17:37 volumio sudo[3302]: pam_unix(sudo:session): session closed for user root May 31 06:17:37 volumio welcome[3309]: Resolved ip:[0] May 31 06:17:38 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. May 31 06:17:38 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. May 31 06:17:38 volumio sudo[3320]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 31 06:17:38 volumio sudo[3320]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:17:38 volumio sudo[3320]: pam_unix(sudo:session): session closed for user root May 31 06:17:38 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 31 06:17:38 volumio sudo[3322]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get May 31 06:17:38 volumio sudo[3322]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:17:38 volumio sudo[3322]: pam_unix(sudo:session): session closed for user root May 31 06:17:38 volumio sudo[3330]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 31 06:17:38 volumio sudo[3330]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:17:38 volumio sudo[3330]: pam_unix(sudo:session): session closed for user root May 31 06:17:38 volumio sudo[3332]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan May 31 06:17:38 volumio sudo[3332]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:17:38 volumio sudo[3332]: pam_unix(sudo:session): session closed for user root May 31 06:17:38 volumio sudo[3338]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 31 06:17:38 volumio sudo[3338]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:17:38 volumio sudo[3338]: pam_unix(sudo:session): session closed for user root May 31 06:17:38 volumio sudo[3340]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set DE May 31 06:17:38 volumio sudo[3340]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:17:38 volumio sudo[3340]: pam_unix(sudo:session): session closed for user root May 31 06:17:39 volumio sudo[3348]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 May 31 06:17:39 volumio sudo[3348]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 31 06:17:39 volumio sudo[3348]: pam_unix(sudo:session): session closed for user root May 31 06:17:39 volumio sudo[3350]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down May 31 06:17:39 volumio sudo[3350]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 31 06:17:39 volumio sudo[3350]: pam_unix(sudo:session): session closed for user root May 31 06:17:39 volumio wpa_supplicant[3355]: Successfully initialized wpa_supplicant May 31 06:17:39 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 31 06:17:39 volumio sudo[3356]: root : PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd May 31 06:17:39 volumio sudo[3356]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 31 06:17:39 volumio dhcpcd[746]: ps_ctl_dispatch: cannot handle another client May 31 06:17:39 volumio dhcpcd[746]: control_free: No such file or directory May 31 06:17:39 volumio sudo[3356]: pam_unix(sudo:session): session closed for user root May 31 06:17:40 volumio wpa_supplicant[3360]: wlan0: Trying to associate with 3c:a6:2f:6f:72:38 (SSID='CCBS 2' freq=2462 MHz) May 31 06:17:40 volumio wpa_supplicant[3360]: wlan0: Associated with 3c:a6:2f:6f:72:38 May 31 06:17:40 volumio wpa_supplicant[3360]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 May 31 06:17:40 volumio wpa_supplicant[3360]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=DE May 31 06:17:40 volumio wpa_supplicant[3360]: wlan0: WPA: Key negotiation completed with 3c:a6:2f:6f:72:38 [PTK=CCMP GTK=CCMP] May 31 06:17:40 volumio wpa_supplicant[3360]: wlan0: CTRL-EVENT-CONNECTED - Connection to 3c:a6:2f:6f:72:38 completed [id=0 id_str=] May 31 06:17:40 volumio dhcpcd[746]: wlan0: carrier acquired May 31 06:17:40 volumio dhcpcd[746]: wlan0: connected to Access Point: CCBS 2 May 31 06:17:40 volumio dhcpcd[746]: wlan0: IAID eb:a8:f4:61 May 31 06:17:40 volumio sudo[3378]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 31 06:17:40 volumio sudo[3378]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:17:40 volumio sudo[3378]: pam_unix(sudo:session): session closed for user root May 31 06:17:40 volumio volumio[1020]: info: Discovery: Started advertising with name: Volumio May 31 06:17:41 volumio dhcpcd[746]: wlan0: soliciting a DHCP lease May 31 06:17:41 volumio dhcpcd[746]: wlan0: offered 192.168.178.30 from 192.168.178.1 May 31 06:17:41 volumio dhcpcd[746]: wlan0: probing address 192.168.178.30/24 May 31 06:17:41 volumio dhcpcd[746]: wlan0: soliciting an IPv6 router May 31 06:17:41 volumio sudo[3385]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 31 06:17:41 volumio sudo[3385]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:17:41 volumio sudo[3385]: pam_unix(sudo:session): session closed for user root May 31 06:17:42 volumio volumio[1020]: info: Discovery: adding 48d0ef05-7484-4e06-b9d1-86d0cbcbf1ad May 31 06:17:42 volumio volumio[1020]: info: Discovery: Found device Volumio May 31 06:17:42 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 31 06:17:42 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 31 06:17:42 volumio ntpd[823]: IO: Deleting interface #7 wlan0, 192.168.211.1#123, interface stats: received=0, sent=0, dropped=0, active_time=195 secs May 31 06:17:42 volumio ntpd[823]: IO: Deleting interface #8 wlan0, 169.254.153.196#123, interface stats: received=0, sent=0, dropped=0, active_time=183 secs May 31 06:17:42 volumio sudo[3390]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 31 06:17:42 volumio sudo[3390]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:17:42 volumio sudo[3390]: pam_unix(sudo:session): session closed for user root May 31 06:17:43 volumio sudo[3394]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 31 06:17:43 volumio sudo[3394]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:17:43 volumio sudo[3394]: pam_unix(sudo:session): session closed for user root May 31 06:17:44 volumio sudo[3398]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 31 06:17:44 volumio sudo[3398]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:17:44 volumio sudo[3398]: pam_unix(sudo:session): session closed for user root May 31 06:17:45 volumio sudo[3402]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 31 06:17:45 volumio sudo[3402]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:17:45 volumio sudo[3402]: pam_unix(sudo:session): session closed for user root May 31 06:17:46 volumio sudo[3406]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 31 06:17:46 volumio sudo[3406]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:17:46 volumio sudo[3406]: pam_unix(sudo:session): session closed for user root May 31 06:17:46 volumio dhcpcd[746]: wlan0: leased 192.168.178.30 for 864000 seconds May 31 06:17:46 volumio avahi-daemon[612]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.30. May 31 06:17:46 volumio avahi-daemon[612]: New relevant interface wlan0.IPv4 for mDNS. May 31 06:17:46 volumio avahi-daemon[612]: Registering new address record for 192.168.178.30 on wlan0.IPv4. May 31 06:17:46 volumio dhcpcd[746]: wlan0: adding route to 192.168.178.0/24 May 31 06:17:46 volumio dhcpcd[746]: wlan0: adding default route via 192.168.178.1 May 31 06:17:46 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. May 31 06:17:46 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... May 31 06:17:47 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... May 31 06:17:47 volumio systemd[1]: welcome.service: Deactivated successfully. May 31 06:17:47 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. May 31 06:17:47 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... May 31 06:17:47 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... May 31 06:17:47 volumio welcome[3430]: Resolved ip:[1] 192.168.178.30 May 31 06:17:47 volumio dbus-daemon[620]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.46' (uid=0 pid=3431 comm="timedatectl show --property=NTPSynchronized --valu") May 31 06:17:47 volumio volumio[1020]: compat.c: read() failed: Resource temporarily unavailable May 31 06:17:47 volumio volumio[1020]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 31 06:17:47 volumio volumio[1020]: Error: dns service error: unknown May 31 06:17:47 volumio volumio[1020]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { May 31 06:17:47 volumio volumio[1020]: errorCode: -65537 May 31 06:17:47 volumio volumio[1020]: } May 31 06:17:47 volumio volumio[1020]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 31 06:17:47 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... May 31 06:17:47 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. May 31 06:17:47 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. May 31 06:17:47 volumio sudo[3453]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 31 06:17:47 volumio sudo[3453]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 06:17:47 volumio sudo[3453]: pam_unix(sudo:session): session closed for user root May 31 06:17:47 volumio dbus-daemon[620]: [system] Successfully activated service 'org.freedesktop.timedate1' May 31 06:17:47 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. May 31 06:17:47 volumio setdatetime-helper.sh[3428]: Time is already synchronized. May 31 06:17:47 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. May 31 06:17:47 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. May 31 06:17:47 volumio sudo[3456]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 31 06:17:47 volumio sudo[3456]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 31 06:17:47 volumio sudo[3456]: pam_unix(sudo:session): session closed for user root May 31 06:17:47 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... May 31 06:17:47 volumio systemd[1]: shairport-sync.service: Deactivated successfully. May 31 06:17:47 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 31 06:17:47 volumio systemd[1]: shairport-sync.service: Consumed 2.580s CPU time. May 31 06:17:47 volumio avahi-daemon[612]: Got SIGTERM, quitting. May 31 06:17:47 volumio avahi-daemon[612]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.30. May 31 06:17:47 volumio systemd[1]: Stopping avahi-daemon.service - Avahi mDNS/DNS-SD Stack... May 31 06:17:47 volumio avahi-daemon[612]: Leaving mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. May 31 06:17:47 volumio avahi-daemon[612]: avahi-daemon 0.8 exiting. May 31 06:17:47 volumio systemd[1]: avahi-daemon.service: Deactivated successfully. May 31 06:17:47 volumio systemd[1]: Stopped avahi-daemon.service - Avahi mDNS/DNS-SD Stack. May 31 06:17:47 volumio dbus-daemon[620]: [system] Activating via systemd: service name='org.freedesktop.Avahi' unit='dbus-org.freedesktop.Avahi.service' requested by ':1.49' (uid=0 pid=1064 comm="/usr/sbin/smbd --foreground --no-process-group") May 31 06:17:47 volumio systemd[1]: Starting avahi-daemon.service - Avahi mDNS/DNS-SD Stack... May 31 06:17:47 volumio avahi-daemon[3461]: Process 612 died: No such process; trying to remove PID file. (/run/avahi-daemon//pid) May 31 06:17:47 volumio avahi-daemon[3461]: Found user 'avahi' (UID 103) and group 'avahi' (GID 109). May 31 06:17:47 volumio avahi-daemon[3461]: Successfully dropped root privileges. May 31 06:17:47 volumio avahi-daemon[3461]: avahi-daemon 0.8 starting up. May 31 06:17:47 volumio dbus-daemon[620]: [system] Successfully activated service 'org.freedesktop.Avahi' May 31 06:17:47 volumio systemd[1]: Started avahi-daemon.service - Avahi mDNS/DNS-SD Stack. May 31 06:17:47 volumio avahi-daemon[3461]: Successfully called chroot(). May 31 06:17:47 volumio avahi-daemon[3461]: Successfully dropped remaining capabilities. May 31 06:17:47 volumio avahi-daemon[3461]: No service file found in /etc/avahi/services. May 31 06:17:47 volumio avahi-daemon[3461]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.30. May 31 06:17:47 volumio avahi-daemon[3461]: New relevant interface wlan0.IPv4 for mDNS. May 31 06:17:47 volumio avahi-daemon[3461]: Joining mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. May 31 06:17:47 volumio avahi-daemon[3461]: New relevant interface lo.IPv4 for mDNS. May 31 06:17:47 volumio avahi-daemon[3461]: Network interface enumeration completed. May 31 06:17:47 volumio avahi-daemon[3461]: Registering new address record for 192.168.178.30 on wlan0.IPv4. May 31 06:17:47 volumio avahi-daemon[3461]: Registering new address record for 127.0.0.1 on lo.IPv4. May 31 06:17:47 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 31 06:17:48 volumio systemd[1]: Started wireless.service - Wireless Services. May 31 06:17:48 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 31 06:17:48 volumio sudo[3256]: pam_unix(sudo:session): session closed for user root May 31 06:17:48 volumio sudo[3468]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-05-31 06:16' May 31 06:17:48 volumio sudo[3468]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="4a70cb031e64a8e498efc3e29470650871ff7d54" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat May 31 04:09:10 UTC 2025" VOLUMIO_VERSION="4.005" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="f9bd4447a30d4b2c74b3880e7a50e48b"