Jun 21 20:18:01 volumio volumio[1250]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=x86_amd64&variante=volumio&version=4.013&uuid=2555036e45a3ac768b31f583ef435573" http://updates.volumio.org/downloader-v1/track-device Jun 21 20:18:01 volumio volumio[1250]: % Total % Received % Xferd Average Speed Time Time Time Current Jun 21 20:18:01 volumio volumio[1250]: Dload Upload Total Spent Left Speed Jun 21 20:18:01 volumio volumio[1250]: [764B blob data] Jun 21 20:18:01 volumio volumio[1250]: retrying in 5 seconds, trial 2 Jun 21 20:18:01 volumio volumio[1250]: info: Volumio Calling Home Jun 21 20:18:04 volumio kernel: logitech-hidpp-device 0003:046D:4054.0005: HID++ 4.5 device connected. Jun 21 20:18:08 volumio ntpd[1095]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Jun 21 20:18:08 volumio ntpd[1095]: DNS: dns_check: DNS error: -11, System error Jun 21 20:18:08 volumio ntpd[1095]: DNS: dns_take_status: 0.debian.pool.ntp.org=>error, 12 Jun 21 20:18:13 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Jun 21 20:18:13 volumio volumio[1250]: info: Loading i18n strings for locale it Jun 21 20:18:13 volumio volumio[1250]: Updating browse sources language Jun 21 20:18:13 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 21 20:18:13 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Jun 21 20:18:13 volumio volumio[1250]: info: Setting timezone to UTC Jun 21 20:18:13 volumio sudo[2531]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Jun 21 20:18:13 volumio sudo[2531]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:18:13 volumio sudo[2531]: pam_unix(sudo:session): session closed for user root Jun 21 20:18:13 volumio sudo[2536]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/UTC /etc/localtime Jun 21 20:18:13 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jun 21 20:18:13 volumio sudo[2536]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:18:13 volumio sudo[2536]: pam_unix(sudo:session): session closed for user root Jun 21 20:18:13 volumio setdatetime-helper.sh[2534]: Time is already synchronized. Jun 21 20:18:13 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Jun 21 20:18:13 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Jun 21 20:18:13 volumio sudo[2542]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Jun 21 20:18:13 volumio sudo[2542]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:18:13 volumio sudo[2542]: pam_unix(sudo:session): session closed for user root Jun 21 20:18:13 volumio sudo[2546]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone UTC Jun 21 20:18:13 volumio sudo[2546]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:18:14 volumio sudo[2546]: pam_unix(sudo:session): session closed for user root Jun 21 20:18:15 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Jun 21 20:18:15 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 21 20:18:37 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Jun 21 20:18:37 volumio volumio[1250]: info: Setting timezone to Europe/Rome Jun 21 20:18:37 volumio sudo[2602]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Jun 21 20:18:37 volumio sudo[2602]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:18:37 volumio sudo[2602]: pam_unix(sudo:session): session closed for user root Jun 21 20:18:37 volumio sudo[2606]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Rome /etc/localtime Jun 21 20:18:37 volumio sudo[2606]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:18:37 volumio sudo[2606]: pam_unix(sudo:session): session closed for user root Jun 21 20:18:37 volumio sudo[2610]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Jun 21 20:18:37 volumio sudo[2610]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:18:37 volumio sudo[2610]: pam_unix(sudo:session): session closed for user root Jun 21 20:18:37 volumio sudo[2614]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Rome Jun 21 20:18:37 volumio sudo[2614]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:18:37 volumio systemd-timedated[2437]: Changed time zone to 'Europe/Rome' (CEST). Jun 21 20:18:37 volumio sudo[2614]: pam_unix(sudo:session): session closed for user root Jun 21 20:18:41 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Jun 21 20:18:41 volumio volumio[1250]: info: Loading i18n strings for locale it Jun 21 20:18:41 volumio volumio[1250]: Updating browse sources language Jun 21 20:18:41 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 21 20:18:41 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Jun 21 20:18:41 volumio volumio[1250]: info: Setting timezone to Europe/Rome Jun 21 20:18:41 volumio sudo[2624]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Jun 21 20:18:41 volumio sudo[2624]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:18:42 volumio sudo[2624]: pam_unix(sudo:session): session closed for user root Jun 21 20:18:42 volumio sudo[2628]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Rome /etc/localtime Jun 21 20:18:42 volumio sudo[2628]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:18:42 volumio sudo[2628]: pam_unix(sudo:session): session closed for user root Jun 21 20:18:42 volumio sudo[2632]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Jun 21 20:18:42 volumio sudo[2632]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:18:42 volumio sudo[2632]: pam_unix(sudo:session): session closed for user root Jun 21 20:18:42 volumio sudo[2636]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Rome Jun 21 20:18:42 volumio sudo[2636]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:18:42 volumio sudo[2636]: pam_unix(sudo:session): session closed for user root Jun 21 20:18:42 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Jun 21 20:18:42 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Jun 21 20:18:42 volumio sudo[2639]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 21 20:18:42 volumio sudo[2639]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:18:43 volumio sudo[2639]: pam_unix(sudo:session): session closed for user root Jun 21 20:18:44 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Jun 21 20:18:44 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 21 20:18:59 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Jun 21 20:18:59 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Jun 21 20:18:59 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 21 20:18:59 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 20:18:59 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 21 20:19:07 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Jun 21 20:19:07 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 21 20:19:12 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Jun 21 20:19:12 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 21 20:19:12 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Jun 21 20:19:14 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jun 21 20:19:14 volumio volumio[1250]: info: Preparing to save Alsa Options, stopping services first Jun 21 20:19:14 volumio volumio[1250]: info: CoreCommandRouter::volumioGetState Jun 21 20:19:14 volumio volumio[1250]: info: CorePlayQueue::getTrack 0 Jun 21 20:19:14 volumio volumio[1250]: info: CoreCommandRouter::volumioPause Jun 21 20:19:14 volumio volumio[1250]: info: CoreStateMachine::pause Jun 21 20:19:14 volumio volumio[1250]: info: Saving Audio Output to: {"i2s":false,"output_device":{"value":"5","label":"Tone1"},"disallowPush":true} Jun 21 20:19:14 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 21 20:19:14 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 21 20:19:14 volumio volumio[1250]: info: Setting mixer Tone1 for card Tone1 Jun 21 20:19:14 volumio volumio[1250]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jun 21 20:19:14 volumio volumio[1250]: info: Updating Volume Controller Parameters: Device: 5 Name: Tone1 Mixer: Tone1 Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jun 21 20:19:14 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jun 21 20:19:14 volumio volumio[1250]: info: Disabling external Volume Control Jun 21 20:19:14 volumio volumio[1250]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 21 20:19:14 volumio volumio[1250]: info: Preparing to generate the ALSA configuration file Jun 21 20:19:14 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Jun 21 20:19:14 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Jun 21 20:19:14 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Jun 21 20:19:14 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Jun 21 20:19:14 volumio sudo[2749]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 21 20:19:14 volumio sudo[2749]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:19:14 volumio sudo[2751]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 21 20:19:14 volumio sudo[2751]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:19:14 volumio sudo[2751]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:14 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 21 20:19:14 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 20:19:14 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 21 20:19:14 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 21 20:19:14 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 21 20:19:14 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 21 20:19:14 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 21 20:19:14 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 21 20:19:14 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 21 20:19:14 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 21 20:19:14 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 21 20:19:14 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 21 20:19:14 volumio volumio[1250]: info: VolumeController:: Volume=100 Mute =false Jun 21 20:19:14 volumio volumio[1250]: info: CoreStateMachine::pushState Jun 21 20:19:14 volumio volumio[1250]: info: CorePlayQueue::getTrack 0 Jun 21 20:19:14 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 21 20:19:14 volumio volumio[1250]: info: CoreCommandRouter::volumioPushState Jun 21 20:19:14 volumio volumio[1250]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Jun 21 20:19:14 volumio volumio[1250]: wlan0 Interface doesn't support scanning : Device or resource busy Jun 21 20:19:14 volumio volumio[1250]: info: Cannot use regular scanning, forcing with ap-force Jun 21 20:19:14 volumio sudo[2764]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Jun 21 20:19:14 volumio sudo[2764]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:19:14 volumio sudo[2764]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:14 volumio volumio[1250]: command failed: Device or resource busy (-16) Jun 21 20:19:14 volumio volumio[1250]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Jun 21 20:19:14 volumio volumio[1250]: command failed: Device or resource busy (-16) Jun 21 20:19:14 volumio volumio[1250]: info: Asound.conf file written Jun 21 20:19:14 volumio sudo[2768]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jun 21 20:19:14 volumio sudo[2768]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:19:14 volumio sudo[2768]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:15 volumio volumio[1250]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Jun 21 20:19:15 volumio volumio[1250]: No state is present for card Audio Jun 21 20:19:15 volumio volumio[1250]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Jun 21 20:19:15 volumio volumio[1250]: Found hardware: "HdmiLpeAudio" "" "" "" "" Jun 21 20:19:15 volumio volumio[1250]: Hardware is initialized using a generic method Jun 21 20:19:15 volumio volumio[1250]: No state is present for card Audio Jun 21 20:19:15 volumio volumio[1250]: alsa-lib main.c:844:(execute_sequence) exec '/bin/rm -rf /var/lib/alsa/card1.conf.d' failed (exit code 1) Jun 21 20:19:15 volumio volumio[1250]: No state is present for card bytcrrt5640 Jun 21 20:19:15 volumio volumio[1250]: Found hardware: "bytcr-rt5640" "" "cfg-spk:2 cfg-mic:in3 aif:1" "" "" Jun 21 20:19:15 volumio volumio[1250]: Hardware is initialized using a generic method Jun 21 20:19:15 volumio volumio[1250]: No state is present for card bytcrrt5640 Jun 21 20:19:15 volumio volumio[1250]: No state is present for card Tone1 Jun 21 20:19:15 volumio volumio[1250]: Found hardware: "USB-Audio" "USB Mixer" "USB3353:a001" "" "" Jun 21 20:19:15 volumio volumio[1250]: Hardware is initialized using a generic method Jun 21 20:19:15 volumio volumio[1250]: No state is present for card Tone1 Jun 21 20:19:15 volumio volumio[1250]: info: Output device has changed, restarting MPD Jun 21 20:19:15 volumio volumio[1250]: info: Output device has changed, restarting Shairport Sync Jun 21 20:19:15 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 20:19:15 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 20:19:15 volumio sudo[2777]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 21 20:19:15 volumio sudo[2777]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:19:15 volumio sudo[2777]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:15 volumio sudo[2779]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 21 20:19:15 volumio sudo[2779]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:19:15 volumio volumio[1250]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 21 20:19:15 volumio volumio[1250]: info: Output device has changed, restarting MPD Jun 21 20:19:15 volumio volumio[1250]: info: Output device has changed, restarting Shairport Sync Jun 21 20:19:15 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 20:19:15 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 20:19:15 volumio sudo[2787]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 21 20:19:15 volumio sudo[2787]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:19:15 volumio sudo[2787]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:15 volumio sudo[2790]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 21 20:19:15 volumio sudo[2790]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:19:15 volumio volumio[1250]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 21 20:19:15 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jun 21 20:19:15 volumio volumio[1250]: info: MPD Permissions set Jun 21 20:19:15 volumio volumio[1250]: info: MPD Permissions set Jun 21 20:19:15 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Jun 21 20:19:15 volumio dbus-daemon[870]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.32' (uid=0 pid=2797 comm="timedatectl show --property=NTPSynchronized --valu") Jun 21 20:19:15 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 20:19:15 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 20:19:15 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 20:19:15 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 20:19:15 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 20:19:15 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 20:19:15 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 20:19:15 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 20:19:15 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 20:19:15 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 21 20:19:15 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Jun 21 20:19:15 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 20:19:15 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 20:19:15 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 20:19:15 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 20:19:15 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 20:19:15 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 20:19:15 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 20:19:15 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 20:19:15 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 20:19:15 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 20:19:15 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 21 20:19:15 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 20:19:15 volumio volumio[1250]: info: Starting Shairport Sync Jun 21 20:19:15 volumio volumio[1250]: info: Starting Shairport Sync Jun 21 20:19:15 volumio sudo[2820]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 21 20:19:15 volumio sudo[2820]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:19:15 volumio sudo[2818]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 21 20:19:15 volumio sudo[2818]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:19:15 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jun 21 20:19:15 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Jun 21 20:19:15 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jun 21 20:19:15 volumio systemd[1]: shairport-sync.service: Consumed 2.683s CPU time. Jun 21 20:19:15 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jun 21 20:19:15 volumio sudo[2820]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:15 volumio dbus-daemon[870]: [system] Successfully activated service 'org.freedesktop.timedate1' Jun 21 20:19:15 volumio sudo[2818]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:15 volumio volumio[1250]: info: Shairport-Sync Started Jun 21 20:19:15 volumio volumio[1250]: info: Shairport-Sync Started Jun 21 20:19:15 volumio systemd[1]: mpd.service: Deactivated successfully. Jun 21 20:19:15 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Jun 21 20:19:15 volumio systemd[1]: mpd.service: Consumed 2.577s CPU time. Jun 21 20:19:15 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Jun 21 20:19:15 volumio setdatetime-helper.sh[2789]: Time is already synchronized. Jun 21 20:19:16 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Jun 21 20:19:16 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Jun 21 20:19:16 volumio systemd[1]: mpd.socket: Deactivated successfully. Jun 21 20:19:16 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jun 21 20:19:16 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jun 21 20:19:16 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jun 21 20:19:16 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Jun 21 20:19:16 volumio sudo[2749]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:16 volumio sudo[2839]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 21 20:19:16 volumio sudo[2839]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 21 20:19:16 volumio sudo[2839]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:17 volumio mpd[2842]: 2025-06-21T20:19:17 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 21 20:19:17 volumio systemd[1]: Started mpd.service - Music Player Daemon. Jun 21 20:19:17 volumio sudo[2790]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:17 volumio sudo[2779]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:17 volumio volumio[1250]: error: MPD error: The expression evaluated to a falsy value: Jun 21 20:19:17 volumio volumio[1250]: assert.ok(self.idling) Jun 21 20:19:17 volumio volumio[1250]: error: The expression evaluated to a falsy value: Jun 21 20:19:17 volumio volumio[1250]: assert.ok(self.idling) Jun 21 20:19:17 volumio volumio[1250]: error: updateQueue error: null Jun 21 20:19:18 volumio volumio[1250]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jun 21 20:19:18 volumio volumio[1250]: info: CoreStateMachine::getcurrentVolume Jun 21 20:19:18 volumio volumio[1250]: info: CoreCommandRouter::volumioRetrievevolume Jun 21 20:19:18 volumio volumio[1250]: info: VolumeController:: Volume=100 Mute =false Jun 21 20:19:18 volumio volumio[1250]: info: CoreStateMachine::pushState Jun 21 20:19:18 volumio volumio[1250]: info: CorePlayQueue::getTrack 0 Jun 21 20:19:18 volumio volumio[1250]: info: CoreCommandRouter::volumioPushState Jun 21 20:19:18 volumio volumio[1250]: info: CoreStateMachine::updateTrackBlock Jun 21 20:19:18 volumio volumio[1250]: info: CorePlayQueue::getTrackBlock Jun 21 20:19:18 volumio volumio[1250]: info: CoreCommandRouter::volumioRetrievevolume Jun 21 20:19:18 volumio volumio[1250]: info: VolumeController:: Volume=100 Mute =false Jun 21 20:19:18 volumio volumio[1250]: info: CoreStateMachine::pushState Jun 21 20:19:18 volumio volumio[1250]: info: CorePlayQueue::getTrack 0 Jun 21 20:19:18 volumio volumio[1250]: info: CoreCommandRouter::volumioPushState Jun 21 20:19:19 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 21 20:19:37 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: wizard , connectWirelessNetwork Jun 21 20:19:37 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , getWiredInfo Jun 21 20:19:37 volumio sudo[2899]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 21 20:19:37 volumio sudo[2899]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:19:37 volumio sudo[2899]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:37 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings Jun 21 20:19:37 volumio volumio[1250]: info: Saving new wireless network Jun 21 20:19:37 volumio sudo[2902]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf Jun 21 20:19:37 volumio sudo[2902]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:19:37 volumio sudo[2902]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:37 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Jun 21 20:19:37 volumio volumio[1250]: info: Discovery: Restarting Advertising due to device name change Jun 21 20:19:38 volumio sudo[2906]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Jun 21 20:19:38 volumio sudo[2906]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:19:38 volumio systemd[1]: Starting wireless.service - Wireless Services... Jun 21 20:19:38 volumio systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Jun 21 20:19:38 volumio dnsmasq[2063]: exiting on receipt of SIGTERM Jun 21 20:19:38 volumio systemd[1]: dnsmasq.service: Deactivated successfully. Jun 21 20:19:38 volumio systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Jun 21 20:19:38 volumio systemd[1]: Stopping hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Jun 21 20:19:38 volumio systemd[1]: hostapd.service: Deactivated successfully. Jun 21 20:19:38 volumio systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Jun 21 20:19:38 volumio sudo[2927]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Jun 21 20:19:38 volumio sudo[2927]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 21 20:19:38 volumio avahi-daemon[868]: Withdrawing address record for 192.168.211.1 on wlan0. Jun 21 20:19:38 volumio avahi-daemon[868]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Jun 21 20:19:38 volumio avahi-daemon[868]: Joining mDNS multicast group on interface wlan0.IPv4 with address 169.254.247.72. Jun 21 20:19:38 volumio avahi-daemon[868]: Withdrawing address record for 169.254.247.72 on wlan0. Jun 21 20:19:38 volumio avahi-daemon[868]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 169.254.247.72. Jun 21 20:19:38 volumio avahi-daemon[868]: Interface wlan0.IPv4 no longer relevant for mDNS. Jun 21 20:19:38 volumio dhcpcd[948]: wlan0: pid 2928 deleted IP address 169.254.247.72/16 Jun 21 20:19:38 volumio dhcpcd[948]: wlan0: deleting route to 169.254.0.0/16 Jun 21 20:19:38 volumio dhcpcd[948]: wlan0: deleting default route Jun 21 20:19:38 volumio sudo[2927]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:38 volumio volumio[1250]: info: Discovery: A device disappeared from network Jun 21 20:19:38 volumio volumio[1250]: info: Discovery: Device volumio disappeared from network Jun 21 20:19:38 volumio sudo[2931]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Jun 21 20:19:38 volumio sudo[2931]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 21 20:19:38 volumio dhcpcd[948]: wlan0: probing for an IPv4LL address Jun 21 20:19:38 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Jun 21 20:19:38 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Jun 21 20:19:38 volumio systemd[1]: welcome.service: Deactivated successfully. Jun 21 20:19:38 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Jun 21 20:19:38 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Jun 21 20:19:38 volumio dhcpcd[948]: wlan0: carrier lost Jun 21 20:19:38 volumio sudo[2931]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:38 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Jun 21 20:19:38 volumio welcome[2940]: Resolved ip:[0] Jun 21 20:19:38 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Jun 21 20:19:38 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Jun 21 20:19:38 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Jun 21 20:19:38 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Jun 21 20:19:38 volumio systemd[1]: welcome.service: Deactivated successfully. Jun 21 20:19:38 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Jun 21 20:19:38 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Jun 21 20:19:38 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Jun 21 20:19:38 volumio welcome[2964]: Resolved ip:[0] Jun 21 20:19:38 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Jun 21 20:19:38 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Jun 21 20:19:38 volumio sudo[2971]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jun 21 20:19:38 volumio sudo[2971]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:19:38 volumio sudo[2971]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:38 volumio sudo[2973]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Jun 21 20:19:38 volumio sudo[2973]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:19:38 volumio sudo[2973]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:38 volumio sudo[2981]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jun 21 20:19:38 volumio sudo[2981]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:19:38 volumio sudo[2981]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:38 volumio sudo[2983]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Jun 21 20:19:38 volumio sudo[2983]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:19:38 volumio volumio[1250]: info: Discovery: A device disappeared from network Jun 21 20:19:39 volumio ntpd[1095]: IO: Deleting interface #5 wlan0, 192.168.211.1#123, interface stats: received=0, sent=0, dropped=0, active_time=136 secs Jun 21 20:19:39 volumio ntpd[1095]: IO: Deleting interface #6 wlan0, 169.254.247.72#123, interface stats: received=0, sent=0, dropped=0, active_time=124 secs Jun 21 20:19:40 volumio sudo[2983]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:40 volumio sudo[2991]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jun 21 20:19:40 volumio sudo[2991]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:19:40 volumio sudo[2991]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:40 volumio sudo[2993]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set IT Jun 21 20:19:40 volumio sudo[2993]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:19:40 volumio sudo[2993]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:40 volumio sudo[3001]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Jun 21 20:19:40 volumio sudo[3001]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 21 20:19:40 volumio sudo[3001]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:40 volumio sudo[3003]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Jun 21 20:19:40 volumio sudo[3003]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 21 20:19:40 volumio sudo[3003]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:40 volumio wpa_supplicant[3008]: Successfully initialized wpa_supplicant Jun 21 20:19:40 volumio sudo[3009]: root : PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Jun 21 20:19:40 volumio sudo[3009]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 21 20:19:40 volumio sudo[3009]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:40 volumio dhcpcd[948]: control command: /sbin/dhcpcd Jun 21 20:19:40 volumio dhcpcd[948]: control_free: No such file or directory Jun 21 20:19:40 volumio dhcpcd[948]: lo: IAID 00:00:00:00 Jun 21 20:19:40 volumio dhcpcd[948]: lo: adding address fe80::14b9:ba0c:1bb0:9e3c Jun 21 20:19:40 volumio dhcpcd[948]: ipv6_addaddr1: Permission denied Jun 21 20:19:40 volumio dhcpcd[948]: lo: using static address 127.0.0.1/8 Jun 21 20:19:40 volumio dhcpcd[948]: lo: adding route to 127.0.0.0/8 Jun 21 20:19:40 volumio systemd[1]: Reached target ip-changed@lo.target - IP Address changed on lo. Jun 21 20:19:41 volumio sudo[3041]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 21 20:19:41 volumio sudo[3041]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:19:41 volumio sudo[3041]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:42 volumio wpa_supplicant[3031]: MBO: Disable MBO/OCE due to misbehaving AP not having enabled PMF Jun 21 20:19:42 volumio wpa_supplicant[3031]: wlan0: Trying to associate with 7c:13:1d:f5:7d:83 (SSID='milan' freq=2447 MHz) Jun 21 20:19:42 volumio sudo[3046]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 21 20:19:42 volumio sudo[3046]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:19:42 volumio sudo[3046]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:42 volumio wpa_supplicant[3031]: wlan0: Associated with 7c:13:1d:f5:7d:83 Jun 21 20:19:42 volumio wpa_supplicant[3031]: MBO: Disable MBO/OCE due to misbehaving AP not having enabled PMF Jun 21 20:19:42 volumio wpa_supplicant[3031]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Jun 21 20:19:42 volumio wpa_supplicant[3031]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=IT Jun 21 20:19:42 volumio wpa_supplicant[3031]: wlan0: WPA: Key negotiation completed with 7c:13:1d:f5:7d:83 [PTK=CCMP GTK=CCMP] Jun 21 20:19:42 volumio wpa_supplicant[3031]: wlan0: CTRL-EVENT-CONNECTED - Connection to 7c:13:1d:f5:7d:83 completed [id=0 id_str=] Jun 21 20:19:42 volumio dhcpcd[948]: wlan0: carrier acquired Jun 21 20:19:42 volumio dhcpcd[948]: wlan0: connected to Access Point: milan Jun 21 20:19:42 volumio dhcpcd[948]: wlan0: IAID bd:c7:dd:a4 Jun 21 20:19:42 volumio volumio[1250]: info: Discovery: Started advertising with name: Volumio Jun 21 20:19:43 volumio dhcpcd[948]: wlan0: soliciting a DHCP lease Jun 21 20:19:43 volumio sudo[3054]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 21 20:19:43 volumio sudo[3054]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:19:43 volumio sudo[3054]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:43 volumio dhcpcd[948]: wlan0: offered 192.168.100.62 from 192.168.100.1 Jun 21 20:19:43 volumio dhcpcd[948]: wlan0: probing address 192.168.100.62/24 Jun 21 20:19:43 volumio dhcpcd[948]: wlan0: soliciting an IPv6 router Jun 21 20:19:43 volumio volumio[1250]: info: Discovery: adding ed85c5e7-56fd-46b4-8930-d61e89797e48 Jun 21 20:19:43 volumio volumio[1250]: info: Discovery: Found device Volumio Jun 21 20:19:43 volumio volumio[1250]: info: CoreCommandRouter::volumioGetState Jun 21 20:19:43 volumio volumio[1250]: info: CorePlayQueue::getTrack 0 Jun 21 20:19:44 volumio sudo[3076]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 21 20:19:44 volumio sudo[3076]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:19:44 volumio sudo[3076]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:45 volumio sudo[3081]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 21 20:19:45 volumio sudo[3081]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:19:45 volumio sudo[3081]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:46 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Jun 21 20:19:46 volumio sudo[3088]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 21 20:19:46 volumio sudo[3088]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:19:46 volumio sudo[3088]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:47 volumio sudo[3093]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 21 20:19:47 volumio sudo[3093]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:19:47 volumio sudo[3093]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:48 volumio dhcpcd[948]: wlan0: leased 192.168.100.62 for 86400 seconds Jun 21 20:19:48 volumio avahi-daemon[868]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.100.62. Jun 21 20:19:48 volumio avahi-daemon[868]: New relevant interface wlan0.IPv4 for mDNS. Jun 21 20:19:48 volumio avahi-daemon[868]: Registering new address record for 192.168.100.62 on wlan0.IPv4. Jun 21 20:19:48 volumio dhcpcd[948]: wlan0: adding route to 192.168.100.0/24 Jun 21 20:19:48 volumio dhcpcd[948]: wlan0: adding default route via 192.168.100.1 Jun 21 20:19:48 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Jun 21 20:19:48 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Jun 21 20:19:48 volumio systemd[1]: welcome.service: Deactivated successfully. Jun 21 20:19:48 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Jun 21 20:19:48 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Jun 21 20:19:48 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Jun 21 20:19:48 volumio welcome[3105]: Resolved ip:[1] 192.168.100.62 Jun 21 20:19:48 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Jun 21 20:19:48 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Jun 21 20:19:48 volumio volumio[1250]: compat.c: read() failed: Resource temporarily unavailable Jun 21 20:19:48 volumio volumio[1250]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 21 20:19:48 volumio volumio[1250]: Error: dns service error: unknown Jun 21 20:19:48 volumio volumio[1250]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Jun 21 20:19:48 volumio volumio[1250]: errorCode: -65537 Jun 21 20:19:48 volumio volumio[1250]: } Jun 21 20:19:48 volumio volumio[1250]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 21 20:19:48 volumio sudo[3142]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 21 20:19:48 volumio sudo[3142]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 21 20:19:48 volumio sudo[3142]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:48 volumio sudo[3145]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 21 20:19:48 volumio sudo[3145]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 21 20:19:48 volumio sudo[3145]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:48 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jun 21 20:19:48 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Jun 21 20:19:48 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jun 21 20:19:48 volumio systemd[1]: shairport-sync.service: Consumed 1.939s CPU time. Jun 21 20:19:48 volumio avahi-daemon[868]: Got SIGTERM, quitting. Jun 21 20:19:48 volumio avahi-daemon[868]: Leaving mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Jun 21 20:19:48 volumio systemd[1]: Stopping avahi-daemon.service - Avahi mDNS/DNS-SD Stack... Jun 21 20:19:48 volumio avahi-daemon[868]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.100.62. Jun 21 20:19:48 volumio dbus-daemon[870]: [system] Activating via systemd: service name='org.freedesktop.Avahi' unit='dbus-org.freedesktop.Avahi.service' requested by ':1.39' (uid=0 pid=1302 comm="/usr/sbin/smbd --foreground --no-process-group") Jun 21 20:19:48 volumio avahi-daemon[868]: avahi-daemon 0.8 exiting. Jun 21 20:19:48 volumio systemd[1]: avahi-daemon.service: Deactivated successfully. Jun 21 20:19:48 volumio systemd[1]: Stopped avahi-daemon.service - Avahi mDNS/DNS-SD Stack. Jun 21 20:19:48 volumio systemd[1]: Starting avahi-daemon.service - Avahi mDNS/DNS-SD Stack... Jun 21 20:19:48 volumio avahi-daemon[3150]: Process 868 died: No such process; trying to remove PID file. (/run/avahi-daemon//pid) Jun 21 20:19:48 volumio avahi-daemon[3150]: Found user 'avahi' (UID 103) and group 'avahi' (GID 109). Jun 21 20:19:48 volumio avahi-daemon[3150]: Successfully dropped root privileges. Jun 21 20:19:48 volumio avahi-daemon[3150]: avahi-daemon 0.8 starting up. Jun 21 20:19:48 volumio dbus-daemon[870]: [system] Successfully activated service 'org.freedesktop.Avahi' Jun 21 20:19:48 volumio systemd[1]: Started avahi-daemon.service - Avahi mDNS/DNS-SD Stack. Jun 21 20:19:48 volumio avahi-daemon[3150]: Successfully called chroot(). Jun 21 20:19:48 volumio avahi-daemon[3150]: Successfully dropped remaining capabilities. Jun 21 20:19:48 volumio avahi-daemon[3150]: No service file found in /etc/avahi/services. Jun 21 20:19:48 volumio avahi-daemon[3150]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.100.62. Jun 21 20:19:48 volumio avahi-daemon[3150]: New relevant interface wlan0.IPv4 for mDNS. Jun 21 20:19:48 volumio avahi-daemon[3150]: Joining mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Jun 21 20:19:48 volumio avahi-daemon[3150]: New relevant interface lo.IPv4 for mDNS. Jun 21 20:19:48 volumio avahi-daemon[3150]: Network interface enumeration completed. Jun 21 20:19:48 volumio avahi-daemon[3150]: Registering new address record for 192.168.100.62 on wlan0.IPv4. Jun 21 20:19:48 volumio avahi-daemon[3150]: Registering new address record for 127.0.0.1 on lo.IPv4. Jun 21 20:19:48 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jun 21 20:19:48 volumio systemd[1]: Started wireless.service - Wireless Services. Jun 21 20:19:48 volumio sudo[2906]: pam_unix(sudo:session): session closed for user root Jun 21 20:19:48 volumio sudo[3171]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-06-21 20:18' Jun 21 20:19:48 volumio sudo[3171]: 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="cee9bb5b0ee50e4898478097a64b5c6c77d5a212" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="b0310d60a07948a2a8a2e8db322034758c86aad6" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat Jun 21 14:38:57 UTC 2025" VOLUMIO_VERSION="4.013" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="c5acc6ec89a6c3d47d2a3d11db95c56a"