Dec 06 10:14:03 volumio hostapd[2191]: wlan0: STA 28:16:a8:6b:ee:02 IEEE 802.11: authenticated Dec 06 10:14:03 volumio hostapd[2191]: wlan0: STA 28:16:a8:6b:ee:02 IEEE 802.11: associated (aid 1) Dec 06 10:14:03 volumio hostapd[2191]: wlan0: STA 28:16:a8:6b:ee:02 RADIUS: starting accounting session A997BCCCDAEC445A Dec 06 10:14:07 volumio dnsmasq-dhcp[2196]: DHCPDISCOVER(wlan0) 28:16:a8:6b:ee:02 Dec 06 10:14:07 volumio dnsmasq-dhcp[2196]: DHCPOFFER(wlan0) 192.168.211.179 28:16:a8:6b:ee:02 Dec 06 10:14:07 volumio dnsmasq-dhcp[2196]: DHCPREQUEST(wlan0) 192.168.211.179 28:16:a8:6b:ee:02 Dec 06 10:14:07 volumio dnsmasq-dhcp[2196]: DHCPACK(wlan0) 192.168.211.179 28:16:a8:6b:ee:02 Winston Dec 06 10:14:13 volumio sudo[3794]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 06 10:14:13 volumio sudo[3794]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:14:13 volumio sudo[3796]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 06 10:14:13 volumio sudo[3796]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:14:13 volumio sudo[3794]: pam_unix(sudo:session): session closed for user root Dec 06 10:14:13 volumio sudo[3796]: pam_unix(sudo:session): session closed for user root Dec 06 10:14:13 volumio volumio[1362]: verbose: New Socket.io Connection to 192.168.211.1 from 192.168.211.179 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Dec 06 10:14:13 volumio volumio[1362]: info: CoreCommandRouter::volumioGetVisibleSources Dec 06 10:14:13 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 06 10:14:13 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Dec 06 10:14:13 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Dec 06 10:14:13 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Dec 06 10:14:13 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Dec 06 10:14:13 volumio volumio[1362]: info: Received Get System Info Dec 06 10:14:13 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 06 10:14:13 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 06 10:14:13 volumio volumio[1362]: info: Discovery: Getting this device information Dec 06 10:14:13 volumio volumio[1362]: info: CoreCommandRouter::volumioGetState Dec 06 10:14:13 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Dec 06 10:14:13 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 06 10:14:13 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 06 10:14:13 volumio volumio-remote-updater[2519]: Test mode disabled Dec 06 10:14:13 volumio volumio-remote-updater[2519]: Alpha mode disabled Dec 06 10:14:13 volumio volumio-remote-updater[2519]: Alpha legacy test mode disabled Dec 06 10:14:13 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 06 10:14:13 volumio volumio[1362]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 06 10:14:13 volumio volumio-remote-updater[2519]: curl_easy_perform() failed: Couldn't resolve host name Dec 06 10:14:13 volumio volumio-remote-updater[2519]: terminate called after throwing an instance of 'std::invalid_argument' Dec 06 10:14:13 volumio volumio-remote-updater[2519]: what(): parse error - unexpected end of input Dec 06 10:14:13 volumio systemd[1]: volumio-remote-updater.service: Main process exited, code=killed, status=6/ABRT Dec 06 10:14:13 volumio systemd[1]: volumio-remote-updater.service: Failed with result 'signal'. Dec 06 10:14:14 volumio systemd[1]: volumio-remote-updater.service: Scheduled restart job, restart counter is at 3. Dec 06 10:14:14 volumio systemd[1]: Stopped volumio-remote-updater.service - Volumio Remote OTA Updater. Dec 06 10:14:14 volumio systemd[1]: Started volumio-remote-updater.service - Volumio Remote OTA Updater. Dec 06 10:14:14 volumio volumio-remote-updater[3801]: Volumio OTA Client: 1.7.0 Dec 06 10:14:14 volumio volumio-remote-updater[3801]: Error: No active session Dec 06 10:14:14 volumio volumio-remote-updater[3801]: [2025-12-05 21:14:14] [connect] Successful connection Dec 06 10:14:14 volumio volumio-remote-updater[3801]: [2025-12-05 21:14:14] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1764969254 101 Dec 06 10:14:14 volumio volumio[1362]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 4 Dec 06 10:14:14 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Dec 06 10:14:14 volumio volumio[1362]: info: Loading i18n strings for locale en Dec 06 10:14:14 volumio volumio[1362]: Updating browse sources language Dec 06 10:14:14 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 06 10:14:14 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Dec 06 10:14:14 volumio volumio[1362]: info: Setting timezone to Pacific/Auckland Dec 06 10:14:14 volumio sudo[3807]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Dec 06 10:14:14 volumio sudo[3807]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:14:14 volumio sudo[3807]: pam_unix(sudo:session): session closed for user root Dec 06 10:14:14 volumio sudo[3811]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Pacific/Auckland /etc/localtime Dec 06 10:14:14 volumio sudo[3811]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:14:14 volumio sudo[3811]: pam_unix(sudo:session): session closed for user root Dec 06 10:14:14 volumio sudo[3816]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Dec 06 10:14:14 volumio sudo[3816]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:14:14 volumio sudo[3816]: pam_unix(sudo:session): session closed for user root Dec 06 10:14:14 volumio sudo[3821]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Pacific/Auckland Dec 06 10:14:14 volumio sudo[3821]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:14:14 volumio dbus-daemon[943]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.26' (uid=0 pid=3822 comm="/usr/bin/timedatectl set-timezone Pacific/Auckland") Dec 06 10:14:15 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Dec 06 10:14:15 volumio dbus-daemon[943]: [system] Successfully activated service 'org.freedesktop.timedate1' Dec 06 10:14:15 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Dec 06 10:14:15 volumio sudo[3821]: pam_unix(sudo:session): session closed for user root Dec 06 10:14:15 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 06 10:14:18 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Dec 06 10:14:18 volumio volumio[1362]: info: Loading i18n strings for locale en Dec 06 10:14:18 volumio volumio[1362]: Updating browse sources language Dec 06 10:14:18 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 06 10:14:18 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Dec 06 10:14:18 volumio volumio[1362]: info: Setting timezone to Pacific/Auckland Dec 06 10:14:18 volumio sudo[3844]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Dec 06 10:14:18 volumio sudo[3844]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:14:18 volumio sudo[3844]: pam_unix(sudo:session): session closed for user root Dec 06 10:14:18 volumio sudo[3848]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Pacific/Auckland /etc/localtime Dec 06 10:14:18 volumio sudo[3848]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:14:18 volumio sudo[3848]: pam_unix(sudo:session): session closed for user root Dec 06 10:14:18 volumio sudo[3852]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Dec 06 10:14:18 volumio sudo[3852]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:14:18 volumio sudo[3852]: pam_unix(sudo:session): session closed for user root Dec 06 10:14:18 volumio sudo[3857]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Pacific/Auckland Dec 06 10:14:18 volumio sudo[3857]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:14:18 volumio sudo[3857]: pam_unix(sudo:session): session closed for user root Dec 06 10:14:18 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 06 10:14:18 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 06 10:14:18 volumio sudo[3860]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 06 10:14:18 volumio sudo[3860]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:14:24 volumio sudo[3860]: pam_unix(sudo:session): session closed for user root Dec 06 10:14:26 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Dec 06 10:14:26 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Dec 06 10:14:26 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 06 10:14:26 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 06 10:14:26 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Dec 06 10:14:33 volumio volumio[1362]: info: Preparing to save Alsa Options, stopping services first Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::volumioGetState Dec 06 10:14:33 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::volumioPause Dec 06 10:14:33 volumio volumio[1362]: info: CoreStateMachine::pause Dec 06 10:14:33 volumio volumio[1362]: info: Saving Audio Output to: {"i2s":false,"output_device":{"value":"5","label":"SMSL USB AUDIO"},"disallowPush":true} Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 06 10:14:33 volumio volumio[1362]: info: Device 5 does not have any Mixer Control Available Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 06 10:14:33 volumio volumio[1362]: info: Updating Volume Controller Parameters: Device: 5 Name: SMSL USB AUDIO Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Dec 06 10:14:33 volumio volumio[1362]: info: Disabling external Volume Control Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 06 10:14:33 volumio volumio[1362]: info: CoreStateMachine::pushState Dec 06 10:14:33 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::volumioPushState Dec 06 10:14:33 volumio volumio[1362]: info: Preparing to generate the ALSA configuration file Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 06 10:14:33 volumio sudo[3913]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 06 10:14:33 volumio sudo[3913]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:14:33 volumio sudo[3915]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 06 10:14:33 volumio sudo[3915]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:14:33 volumio sudo[3915]: pam_unix(sudo:session): session closed for user root Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 06 10:14:33 volumio volumio[1362]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Dec 06 10:14:33 volumio volumio[1362]: wlan0 Interface doesn't support scanning : Device or resource busy Dec 06 10:14:33 volumio volumio[1362]: info: Cannot use regular scanning, forcing with ap-force Dec 06 10:14:33 volumio sudo[3926]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Dec 06 10:14:33 volumio sudo[3926]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:14:33 volumio sudo[3926]: pam_unix(sudo:session): session closed for user root Dec 06 10:14:33 volumio volumio[1362]: command failed: Device or resource busy (-16) Dec 06 10:14:33 volumio volumio[1362]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Dec 06 10:14:33 volumio volumio[1362]: command failed: Device or resource busy (-16) Dec 06 10:14:33 volumio volumio[1362]: info: Asound.conf file written Dec 06 10:14:33 volumio sudo[3930]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 06 10:14:33 volumio sudo[3930]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:14:33 volumio sudo[3930]: pam_unix(sudo:session): session closed for user root Dec 06 10:14:33 volumio volumio[1362]: No state is present for card PCH Dec 06 10:14:33 volumio volumio[1362]: Found hardware: "HDA-Intel" "Intel Broxton HDMI" "HDA:8086280a,80860101,00100000" "0x10ec" "0x111a" Dec 06 10:14:33 volumio volumio[1362]: Hardware is initialized using a generic method Dec 06 10:14:33 volumio volumio[1362]: No state is present for card PCH Dec 06 10:14:33 volumio volumio[1362]: No state is present for card Device Dec 06 10:14:33 volumio volumio[1362]: Found hardware: "USB-Audio" "USB Mixer" "USB0d8c:0014" "" "" Dec 06 10:14:33 volumio volumio[1362]: Hardware is initialized using a generic method Dec 06 10:14:33 volumio volumio[1362]: No state is present for card Device Dec 06 10:14:33 volumio volumio[1362]: No state is present for card AUDIO Dec 06 10:14:33 volumio volumio[1362]: Found hardware: "USB-Audio" "USB Mixer" "USB152a:85dd" "" "" Dec 06 10:14:33 volumio volumio[1362]: Hardware is initialized using a generic method Dec 06 10:14:33 volumio volumio[1362]: No state is present for card AUDIO Dec 06 10:14:33 volumio volumio[1362]: info: Output device has changed, restarting MPD Dec 06 10:14:33 volumio volumio[1362]: info: Output device has changed, restarting Shairport Sync Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 06 10:14:33 volumio sudo[3937]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 06 10:14:33 volumio sudo[3937]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:14:33 volumio sudo[3937]: pam_unix(sudo:session): session closed for user root Dec 06 10:14:33 volumio sudo[3940]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 06 10:14:33 volumio sudo[3940]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:14:33 volumio volumio[1362]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 06 10:14:33 volumio volumio[1362]: info: Output device has changed, restarting MPD Dec 06 10:14:33 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 06 10:14:33 volumio volumio[1362]: info: Output device has changed, restarting Shairport Sync Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 06 10:14:33 volumio sudo[3949]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 06 10:14:33 volumio sudo[3949]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:14:33 volumio sudo[3947]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 06 10:14:33 volumio volumio[1362]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 06 10:14:33 volumio sudo[3947]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:14:33 volumio sudo[3947]: pam_unix(sudo:session): session closed for user root Dec 06 10:14:33 volumio volumio[1362]: info: MPD Permissions set Dec 06 10:14:33 volumio volumio[1362]: info: MPD Permissions set Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 06 10:14:33 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 06 10:14:33 volumio volumio[1362]: info: Starting Shairport Sync Dec 06 10:14:33 volumio volumio[1362]: info: Starting Shairport Sync Dec 06 10:14:33 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 06 10:14:33 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 06 10:14:33 volumio systemd[1]: mpd.service: Consumed 1.614s CPU time. Dec 06 10:14:33 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 06 10:14:33 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 06 10:14:33 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 06 10:14:33 volumio sudo[3975]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 06 10:14:33 volumio sudo[3974]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 06 10:14:33 volumio sudo[3974]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:14:33 volumio sudo[3975]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:14:33 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 06 10:14:33 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 06 10:14:33 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 06 10:14:33 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 06 10:14:33 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 06 10:14:33 volumio systemd[1]: shairport-sync.service: Consumed 6.120s CPU time. Dec 06 10:14:33 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 06 10:14:33 volumio sudo[3975]: pam_unix(sudo:session): session closed for user root Dec 06 10:14:33 volumio sudo[3974]: pam_unix(sudo:session): session closed for user root Dec 06 10:14:33 volumio volumio[1362]: info: Shairport-Sync Started Dec 06 10:14:33 volumio volumio[1362]: info: Shairport-Sync Started Dec 06 10:14:33 volumio sudo[3979]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 06 10:14:33 volumio sudo[3979]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 06 10:14:33 volumio sudo[3979]: pam_unix(sudo:session): session closed for user root Dec 06 10:14:34 volumio mpd[3996]: 2025-12-06T10:14:34 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 06 10:14:34 volumio systemd[1]: Started mpd.service - Music Player Daemon. Dec 06 10:14:34 volumio sudo[3949]: pam_unix(sudo:session): session closed for user root Dec 06 10:14:34 volumio sudo[3940]: pam_unix(sudo:session): session closed for user root Dec 06 10:14:34 volumio volumio[1362]: error: MPD error: The expression evaluated to a falsy value: Dec 06 10:14:34 volumio volumio[1362]: assert.ok(self.idling) Dec 06 10:14:34 volumio volumio[1362]: error: The expression evaluated to a falsy value: Dec 06 10:14:34 volumio volumio[1362]: assert.ok(self.idling) Dec 06 10:14:34 volumio volumio[1362]: error: updateQueue error: null Dec 06 10:14:37 volumio volumio[1362]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Dec 06 10:14:37 volumio volumio[1362]: info: CoreStateMachine::getcurrentVolume Dec 06 10:14:37 volumio volumio[1362]: info: CoreCommandRouter::volumioRetrievevolume Dec 06 10:14:37 volumio volumio[1362]: info: CoreStateMachine::pushState Dec 06 10:14:37 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Dec 06 10:14:37 volumio volumio[1362]: info: CoreCommandRouter::volumioPushState Dec 06 10:14:37 volumio sudo[4018]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 06 10:14:37 volumio sudo[4018]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:14:37 volumio sudo[4020]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 06 10:14:37 volumio sudo[4020]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:14:37 volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 06 10:14:37 volumio systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 06 10:14:37 volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 06 10:14:37 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 06 10:14:37 volumio sudo[4018]: pam_unix(sudo:session): session closed for user root Dec 06 10:14:37 volumio sudo[4020]: pam_unix(sudo:session): session closed for user root Dec 06 10:14:37 volumio mpd_monitor.sh[4023]: MPD Monitor Service: Starting MPD Monitor Service Dec 06 10:14:37 volumio volumio[1362]: info: Successfully started MPD Monitor Dec 06 10:14:37 volumio volumio[1362]: info: Successfully started MPD Monitor Dec 06 10:14:39 volumio sudo[3913]: pam_unix(sudo:session): session closed for user root Dec 06 10:14:45 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Dec 06 10:14:45 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 06 10:14:47 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: wizard , connectWirelessNetwork Dec 06 10:14:47 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: network , getWiredInfo Dec 06 10:14:47 volumio sudo[4053]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 06 10:14:47 volumio sudo[4053]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:14:47 volumio sudo[4053]: pam_unix(sudo:session): session closed for user root Dec 06 10:14:48 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Dec 06 10:14:48 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 06 10:14:48 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Dec 06 10:14:52 volumio volumio[1362]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 06 10:14:54 volumio volumio[1362]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 06 10:14:54 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Dec 06 10:14:54 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Dec 06 10:14:54 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Dec 06 10:14:54 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Dec 06 10:14:54 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Dec 06 10:14:56 volumio volumio[1362]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 06 10:14:57 volumio volumio[1362]: info: CALLMETHOD: system_controller system saveUpdateSettings [object Object] Dec 06 10:14:57 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , saveUpdateSettings Dec 06 10:14:57 volumio volumio[1362]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'value') Dec 06 10:14:58 volumio volumio[1362]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 06 10:14:59 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Dec 06 10:14:59 volumio volumio[1362]: info: CoreCommandRouter::Reload Ui Dec 06 10:14:59 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard Dec 06 10:14:59 volumio volumio[1362]: info: Wizard terminated Successfully Dec 06 10:14:59 volumio volumio[1362]: info: CoreCommandRouter::volumiosetStartupVolume Dec 06 10:14:59 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 06 10:14:59 volumio volumio[1362]: info: Executing Deferred Wifi Connection Dec 06 10:14:59 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings Dec 06 10:14:59 volumio volumio[1362]: info: Saving new wireless network Dec 06 10:14:59 volumio sudo[4088]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf Dec 06 10:14:59 volumio sudo[4088]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:14:59 volumio sudo[4088]: pam_unix(sudo:session): session closed for user root Dec 06 10:14:59 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Dec 06 10:14:59 volumio volumio[1362]: info: Discovery: Restarting Advertising due to device name change Dec 06 10:14:59 volumio sudo[4091]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Dec 06 10:14:59 volumio sudo[4091]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:14:59 volumio systemd[1]: Stopping wireless.service - Wireless Services... Dec 06 10:14:59 volumio systemd[1]: wireless.service: Deactivated successfully. Dec 06 10:14:59 volumio systemd[1]: Stopped wireless.service - Wireless Services. Dec 06 10:14:59 volumio systemd[1]: Starting wireless.service - Wireless Services... Dec 06 10:14:59 volumio wireless.js[4101]: WIRELESS.JS: Single Network Mode enabled, only one network device can be active at a time between ethernet and wireless Dec 06 10:14:59 volumio wireless.js[4101]: WIRELESS.JS: Wireless.js initializing wireless flow Dec 06 10:14:59 volumio wireless.js[4101]: WIRELESS.JS: Cleaning previous... Dec 06 10:14:59 volumio systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Dec 06 10:14:59 volumio dnsmasq[2196]: exiting on receipt of SIGTERM Dec 06 10:14:59 volumio systemd[1]: dnsmasq.service: Deactivated successfully. Dec 06 10:14:59 volumio systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Dec 06 10:14:59 volumio systemd[1]: Stopping hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Dec 06 10:14:59 volumio dhcpcd[1036]: wlan0: carrier lost Dec 06 10:14:59 volumio avahi-daemon[941]: Interface wlan0.IPv4 no longer relevant for mDNS. Dec 06 10:14:59 volumio avahi-daemon[941]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Dec 06 10:14:59 volumio kernel: iwlwifi 0000:02:00.0: Applying debug destination EXTERNAL_DRAM Dec 06 10:14:59 volumio kernel: iwlwifi 0000:02:00.0: Applying debug destination EXTERNAL_DRAM Dec 06 10:14:59 volumio kernel: iwlwifi 0000:02:00.0: FW already configured (0) - re-configuring Dec 06 10:14:59 volumio avahi-daemon[941]: Withdrawing address record for 192.168.211.1 on wlan0. Dec 06 10:14:59 volumio avahi-daemon[941]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Dec 06 10:14:59 volumio avahi-daemon[941]: New relevant interface wlan0.IPv4 for mDNS. Dec 06 10:14:59 volumio avahi-daemon[941]: Registering new address record for 192.168.211.1 on wlan0.IPv4. Dec 06 10:14:59 volumio systemd[1]: hostapd.service: Deactivated successfully. Dec 06 10:14:59 volumio systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Dec 06 10:14:59 volumio volumio[1362]: info: Discovery: A device disappeared from network Dec 06 10:14:59 volumio volumio[1362]: info: Discovery: Device volumio disappeared from network Dec 06 10:14:59 volumio sudo[4146]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Dec 06 10:14:59 volumio sudo[4146]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 06 10:14:59 volumio avahi-daemon[941]: Withdrawing address record for 192.168.211.1 on wlan0. Dec 06 10:14:59 volumio avahi-daemon[941]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Dec 06 10:14:59 volumio avahi-daemon[941]: Interface wlan0.IPv4 no longer relevant for mDNS. Dec 06 10:14:59 volumio sudo[4146]: pam_unix(sudo:session): session closed for user root Dec 06 10:14:59 volumio sudo[4149]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Dec 06 10:14:59 volumio sudo[4149]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 06 10:14:59 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Dec 06 10:14:59 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Dec 06 10:14:59 volumio systemd[1]: welcome.service: Deactivated successfully. Dec 06 10:14:59 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Dec 06 10:14:59 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Dec 06 10:14:59 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Dec 06 10:14:59 volumio welcome[4151]: Resolved ip:[0] Dec 06 10:14:59 volumio sudo[4149]: pam_unix(sudo:session): session closed for user root Dec 06 10:14:59 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Dec 06 10:14:59 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Dec 06 10:14:59 volumio wireless.js[4101]: WIRELESS.JS: Stopped aP Dec 06 10:15:00 volumio sudo[4162]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 06 10:15:00 volumio sudo[4162]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:00 volumio kernel: iwlwifi 0000:02:00.0: Applying debug destination EXTERNAL_DRAM Dec 06 10:15:00 volumio kernel: iwlwifi 0000:02:00.0: Applying debug destination EXTERNAL_DRAM Dec 06 10:15:00 volumio kernel: iwlwifi 0000:02:00.0: FW already configured (0) - re-configuring Dec 06 10:15:00 volumio sudo[4162]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:00 volumio sudo[4164]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Dec 06 10:15:00 volumio sudo[4164]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:00 volumio sudo[4164]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:00 volumio volumio[1362]: info: Discovery: A device disappeared from network Dec 06 10:15:00 volumio sudo[4173]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 06 10:15:00 volumio sudo[4173]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:00 volumio sudo[4174]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 06 10:15:00 volumio sudo[4173]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:00 volumio sudo[4174]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:00 volumio sudo[4174]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:00 volumio sudo[4176]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Dec 06 10:15:00 volumio sudo[4176]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:00 volumio volumio[1362]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Dec 06 10:15:01 volumio sudo[4184]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 06 10:15:01 volumio sudo[4184]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:01 volumio sudo[4184]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:01 volumio volumio[1362]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Dec 06 10:15:01 volumio ntpd[1206]: IO: Deleting interface #4 wlan0, 192.168.211.1#123, interface stats: received=0, sent=0, dropped=0, active_time=518 secs Dec 06 10:15:01 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 06 10:15:02 volumio volumio[1362]: info: CoreCommandRouter::volumioGetVisibleSources Dec 06 10:15:02 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 06 10:15:02 volumio volumio[1362]: info: CoreCommandRouter::volumioGetState Dec 06 10:15:02 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Dec 06 10:15:02 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 06 10:15:02 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 06 10:15:02 volumio volumio[1362]: info: Received Get System Info Dec 06 10:15:02 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 06 10:15:02 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 06 10:15:02 volumio volumio[1362]: info: Discovery: Getting this device information Dec 06 10:15:02 volumio volumio[1362]: info: CoreCommandRouter::volumioGetState Dec 06 10:15:02 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Dec 06 10:15:02 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 06 10:15:02 volumio volumio[1362]: info: CoreCommandRouter::volumioGetState Dec 06 10:15:02 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Dec 06 10:15:02 volumio volumio[1362]: info: Listing playlists Dec 06 10:15:02 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 06 10:15:02 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 06 10:15:02 volumio sudo[4188]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 06 10:15:02 volumio sudo[4188]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:02 volumio sudo[4188]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:02 volumio volumio[1362]: info: CoreCommandRouter::volumioGetState Dec 06 10:15:02 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Dec 06 10:15:03 volumio sudo[4192]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 06 10:15:03 volumio sudo[4192]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:03 volumio sudo[4192]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:03 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 06 10:15:03 volumio volumio[1362]: info: Received Get System Info Dec 06 10:15:03 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 06 10:15:03 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 06 10:15:03 volumio volumio[1362]: info: Discovery: Getting this device information Dec 06 10:15:03 volumio volumio[1362]: info: CoreCommandRouter::volumioGetState Dec 06 10:15:03 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Dec 06 10:15:03 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 06 10:15:03 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 06 10:15:03 volumio sudo[4176]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:03 volumio wireless.js[4101]: WIRELESS.JS: SETTING APPROPRIATE REG DOMAIN: NZ Dec 06 10:15:03 volumio sudo[4197]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 06 10:15:03 volumio sudo[4197]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:03 volumio sudo[4197]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:03 volumio sudo[4199]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set NZ Dec 06 10:15:03 volumio sudo[4199]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:03 volumio sudo[4199]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:03 volumio wireless.js[4101]: WIRELESS.JS: SUCCESSFULLY SET NEW REGDOMAIN: NZ Dec 06 10:15:03 volumio wireless.js[4101]: WIRELESS.JS: Start wireless flow Dec 06 10:15:03 volumio wireless.js[4101]: WIRELESS.JS: Stopped hotspot (if there).. Dec 06 10:15:03 volumio sudo[4207]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Dec 06 10:15:03 volumio sudo[4207]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 06 10:15:03 volumio sudo[4207]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:03 volumio sudo[4209]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Dec 06 10:15:03 volumio sudo[4209]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 06 10:15:03 volumio sudo[4209]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:03 volumio wireless.js[4101]: WIRELESS.JS: DHCP IP fallback Dec 06 10:15:04 volumio wireless.js[4101]: WIRELESS.JS: Start ap Dec 06 10:15:04 volumio wpa_supplicant[4214]: Successfully initialized wpa_supplicant Dec 06 10:15:04 volumio sudo[4215]: root : PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Dec 06 10:15:04 volumio sudo[4215]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 06 10:15:04 volumio dhcpcd[1036]: control command: /sbin/dhcpcd Dec 06 10:15:04 volumio sudo[4215]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:04 volumio dhcpcd[1036]: control_free: No such file or directory Dec 06 10:15:04 volumio kernel: iwlwifi 0000:02:00.0: Applying debug destination EXTERNAL_DRAM Dec 06 10:15:04 volumio kernel: iwlwifi 0000:02:00.0: Applying debug destination EXTERNAL_DRAM Dec 06 10:15:04 volumio kernel: iwlwifi 0000:02:00.0: FW already configured (0) - re-configuring Dec 06 10:15:04 volumio dhcpcd[1036]: lo: IAID 00:00:00:00 Dec 06 10:15:04 volumio dhcpcd[1036]: lo: adding address fe80::eba6:630e:93ba:d165 Dec 06 10:15:04 volumio dhcpcd[1036]: ipv6_addaddr1: Permission denied Dec 06 10:15:04 volumio dhcpcd[1036]: lo: using static address 127.0.0.1/8 Dec 06 10:15:04 volumio dhcpcd[1036]: lo: adding route to 127.0.0.0/8 Dec 06 10:15:04 volumio systemd[1]: Reached target ip-changed@lo.target - IP Address changed on lo. Dec 06 10:15:04 volumio volumio[1362]: info: Discovery: Started advertising with name: Volumio Dec 06 10:15:04 volumio wpa_supplicant[4248]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=DRIVER type=WORLD Dec 06 10:15:04 volumio sudo[4244]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 06 10:15:04 volumio sudo[4244]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:04 volumio sudo[4244]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:04 volumio volumio[1362]: info: Discovery: adding 3e9c75a5-f564-4169-a092-41ccddcb8ca0 Dec 06 10:15:04 volumio volumio[1362]: info: Discovery: Found device Volumio Dec 06 10:15:04 volumio volumio[1362]: info: CoreCommandRouter::volumioGetState Dec 06 10:15:04 volumio volumio[1362]: info: CorePlayQueue::getTrack 0 Dec 06 10:15:05 volumio wireless.js[4101]: WIRELESS.JS: trying... Dec 06 10:15:05 volumio sudo[4254]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 06 10:15:05 volumio sudo[4254]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:05 volumio sudo[4254]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:05 volumio sudo[4257]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 06 10:15:05 volumio sudo[4257]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:05 volumio sudo[4257]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:06 volumio wireless.js[4101]: WIRELESS.JS: trying... Dec 06 10:15:06 volumio sudo[4276]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 06 10:15:06 volumio sudo[4276]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:06 volumio sudo[4276]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:06 volumio sudo[4279]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 06 10:15:06 volumio sudo[4279]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:06 volumio sudo[4279]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:07 volumio wireless.js[4101]: WIRELESS.JS: trying... Dec 06 10:15:07 volumio sudo[4284]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 06 10:15:07 volumio sudo[4284]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:07 volumio sudo[4284]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:07 volumio sudo[4287]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 06 10:15:07 volumio sudo[4287]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:07 volumio sudo[4287]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:07 volumio wpa_supplicant[4248]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=DRIVER type=COUNTRY alpha2=US Dec 06 10:15:07 volumio wpa_supplicant[4248]: wlan0: SME: Trying to authenticate with 9c:a2:f4:d2:71:a7 (SSID='BishopAsh' freq=5200 MHz) Dec 06 10:15:07 volumio kernel: wlan0: authenticate with 9c:a2:f4:d2:71:a7 (local address=90:61:ae:fe:5d:a8) Dec 06 10:15:07 volumio kernel: wlan0: send auth to 9c:a2:f4:d2:71:a7 (try 1/3) Dec 06 10:15:07 volumio wpa_supplicant[4248]: wlan0: Trying to associate with 9c:a2:f4:d2:71:a7 (SSID='BishopAsh' freq=5200 MHz) Dec 06 10:15:07 volumio kernel: wlan0: authenticated Dec 06 10:15:07 volumio kernel: wlan0: associate with 9c:a2:f4:d2:71:a7 (try 1/3) Dec 06 10:15:07 volumio kernel: wlan0: RX AssocResp from 9c:a2:f4:d2:71:a7 (capab=0x1511 status=0 aid=3) Dec 06 10:15:07 volumio wpa_supplicant[4248]: wlan0: Associated with 9c:a2:f4:d2:71:a7 Dec 06 10:15:07 volumio wpa_supplicant[4248]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Dec 06 10:15:07 volumio kernel: wlan0: associated Dec 06 10:15:07 volumio wpa_supplicant[4248]: wlan0: WPA: Key negotiation completed with 9c:a2:f4:d2:71:a7 [PTK=CCMP GTK=TKIP] Dec 06 10:15:07 volumio wpa_supplicant[4248]: wlan0: CTRL-EVENT-CONNECTED - Connection to 9c:a2:f4:d2:71:a7 completed [id=0 id_str=] Dec 06 10:15:07 volumio dhcpcd[1036]: wlan0: carrier acquired Dec 06 10:15:07 volumio dhcpcd[1036]: wlan0: connected to Access Point: BishopAsh Dec 06 10:15:07 volumio dhcpcd[1036]: wlan0: IAID ae:fe:5d:a8 Dec 06 10:15:07 volumio kernel: wlan0: Limiting TX power to 27 (30 - 3) dBm as advertised by 9c:a2:f4:d2:71:a7 Dec 06 10:15:08 volumio wireless.js[4101]: WIRELESS.JS: trying... Dec 06 10:15:08 volumio sudo[4293]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 06 10:15:08 volumio sudo[4293]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:08 volumio sudo[4293]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:08 volumio sudo[4296]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 06 10:15:08 volumio sudo[4296]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:08 volumio sudo[4296]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:08 volumio dhcpcd[1036]: wlan0: soliciting an IPv6 router Dec 06 10:15:09 volumio wireless.js[4101]: WIRELESS.JS: trying... Dec 06 10:15:09 volumio sudo[4301]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 06 10:15:09 volumio sudo[4301]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:09 volumio sudo[4301]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:09 volumio dhcpcd[1036]: wlan0: soliciting a DHCP lease Dec 06 10:15:09 volumio dhcpcd[1036]: wlan0: offered 192.168.68.14 from 192.168.68.1 Dec 06 10:15:09 volumio dhcpcd[1036]: wlan0: probing address 192.168.68.14/22 Dec 06 10:15:09 volumio sudo[4306]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 06 10:15:09 volumio sudo[4306]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:09 volumio sudo[4306]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:10 volumio wireless.js[4101]: WIRELESS.JS: trying... Dec 06 10:15:10 volumio sudo[4311]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 06 10:15:10 volumio sudo[4311]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:10 volumio sudo[4311]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:10 volumio sudo[4314]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 06 10:15:10 volumio sudo[4314]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:10 volumio sudo[4314]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:11 volumio wireless.js[4101]: WIRELESS.JS: trying... Dec 06 10:15:11 volumio sudo[4319]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 06 10:15:11 volumio sudo[4319]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:11 volumio sudo[4319]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:11 volumio sudo[4322]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 06 10:15:11 volumio sudo[4322]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:11 volumio sudo[4322]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:11 volumio volumio[1362]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 06 10:15:12 volumio wireless.js[4101]: WIRELESS.JS: trying... Dec 06 10:15:12 volumio sudo[4327]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 06 10:15:12 volumio sudo[4327]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:12 volumio sudo[4327]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:12 volumio sudo[4330]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 06 10:15:12 volumio sudo[4330]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:12 volumio sudo[4330]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:13 volumio wireless.js[4101]: WIRELESS.JS: trying... Dec 06 10:15:13 volumio sudo[4336]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 06 10:15:13 volumio sudo[4336]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:13 volumio sudo[4336]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:13 volumio nmbd[1259]: [2025/12/06 10:15:13.072611, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Dec 06 10:15:13 volumio nmbd[1259]: Packet send failed to 192.168.68.62(45402) ERRNO=Network is unreachable Dec 06 10:15:13 volumio nmbd[1259]: [2025/12/06 10:15:13.072865, 0] ../../source3/nmbd/nmbd_packets.c:1027(reply_netbios_packet) Dec 06 10:15:13 volumio nmbd[1259]: reply_netbios_packet: send_packet to IP 192.168.68.62 port 45402 failed Dec 06 10:15:13 volumio sudo[4340]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 06 10:15:13 volumio sudo[4340]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:13 volumio sudo[4340]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:14 volumio wireless.js[4101]: WIRELESS.JS: trying... Dec 06 10:15:14 volumio sudo[4345]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 06 10:15:14 volumio sudo[4345]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:14 volumio sudo[4345]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:14 volumio sudo[4348]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 06 10:15:14 volumio sudo[4348]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 10:15:14 volumio sudo[4348]: pam_unix(sudo:session): session closed for user root Dec 06 10:15:14 volumio dhcpcd[1036]: wlan0: leased 192.168.68.14 for 86400 seconds Dec 06 10:15:14 volumio avahi-daemon[941]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.68.14. Dec 06 10:15:14 volumio avahi-daemon[941]: New relevant interface wlan0.IPv4 for mDNS. Dec 06 10:15:14 volumio avahi-daemon[941]: Registering new address record for 192.168.68.14 on wlan0.IPv4. Dec 06 10:15:14 volumio dhcpcd[1036]: wlan0: adding route to 192.168.68.0/22 Dec 06 10:15:14 volumio dhcpcd[1036]: wlan0: adding default route via 192.168.68.1 Dec 06 10:15:14 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Dec 06 10:15:14 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Dec 06 10:15:14 volumio systemd[1]: welcome.service: Deactivated successfully. Dec 06 10:15:14 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Dec 06 10:15:14 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Dec 06 10:15:14 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Dec 06 10:15:14 volumio welcome[4363]: Resolved ip:[1] 192.168.68.14 Dec 06 10:15:14 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Dec 06 10:15:14 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Dec 06 10:15:14 volumio volumio[1362]: compat.c: read() failed: Resource temporarily unavailable Dec 06 10:15:14 volumio volumio[1362]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 06 10:15:14 volumio volumio[1362]: Error: dns service error: unknown Dec 06 10:15:14 volumio volumio[1362]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Dec 06 10:15:14 volumio volumio[1362]: errorCode: -65537 Dec 06 10:15:14 volumio volumio[1362]: } Dec 06 10:15:14 volumio volumio[1362]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 06 10:15:14 volumio sudo[4390]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-06 10:14' Dec 06 10:15:14 volumio sudo[4390]: 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 21:07:15 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="4b5c74f40f473b90a542bf010b97924b"