Dec 19 10:00:00 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Dec 19 10:00:00 volumio volumio[1314]: info: Setting timezone to Europe/Vaduz Dec 19 10:00:00 volumio sudo[2539]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Dec 19 10:00:00 volumio sudo[2539]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:00:00 volumio sudo[2539]: pam_unix(sudo:session): session closed for user root Dec 19 10:00:00 volumio sudo[2543]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Vaduz /etc/localtime Dec 19 10:00:00 volumio sudo[2543]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:00:00 volumio sudo[2543]: pam_unix(sudo:session): session closed for user root Dec 19 10:00:00 volumio sudo[2547]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Dec 19 10:00:00 volumio sudo[2547]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:00:00 volumio sudo[2547]: pam_unix(sudo:session): session closed for user root Dec 19 10:00:00 volumio sudo[2551]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Vaduz Dec 19 10:00:00 volumio sudo[2551]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:00:00 volumio sudo[2551]: pam_unix(sudo:session): session closed for user root Dec 19 10:00:00 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 19 10:00:00 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 19 10:00:00 volumio sudo[2554]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 19 10:00:00 volumio sudo[2554]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:00:01 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Dec 19 10:00:01 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 19 10:00:06 volumio sudo[2554]: pam_unix(sudo:session): session closed for user root Dec 19 10:00:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Dec 19 10:00:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Dec 19 10:00:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 19 10:00:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 10:00:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 19 10:00:28 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Dec 19 10:00:28 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 19 10:00:30 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Dec 19 10:00:30 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 19 10:00:30 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Dec 19 10:00:51 volumio kernel: usb 1-7: new full-speed USB device number 4 using xhci_hcd Dec 19 10:00:52 volumio kernel: usb 1-7: New USB device found, idVendor=046d, idProduct=0a90, bcdDevice=36.06 Dec 19 10:00:52 volumio kernel: usb 1-7: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Dec 19 10:00:52 volumio kernel: usb 1-7: Product: Zone Wireless Dec 19 10:00:52 volumio kernel: usb 1-7: Manufacturer: Logitech Dec 19 10:00:52 volumio kernel: usb 1-7: SerialNumber: 2024ML00C4U8 Dec 19 10:00:52 volumio kernel: input: Logitech Zone Wireless Consumer Control as /devices/pci0000:00/0000:00:15.0/usb1/1-7/1-7:1.3/0003:046D:0A90.0002/input/input15 Dec 19 10:00:52 volumio kernel: input: Logitech Zone Wireless as /devices/pci0000:00/0000:00:15.0/usb1/1-7/1-7:1.3/0003:046D:0A90.0002/input/input16 Dec 19 10:00:52 volumio kernel: input: Logitech Zone Wireless as /devices/pci0000:00/0000:00:15.0/usb1/1-7/1-7:1.3/0003:046D:0A90.0002/input/input17 Dec 19 10:00:52 volumio kernel: input: Logitech Zone Wireless as /devices/pci0000:00/0000:00:15.0/usb1/1-7/1-7:1.3/0003:046D:0A90.0002/input/input18 Dec 19 10:00:52 volumio kernel: input: Logitech Zone Wireless as /devices/pci0000:00/0000:00:15.0/usb1/1-7/1-7:1.3/0003:046D:0A90.0002/input/input19 Dec 19 10:00:52 volumio kernel: input: Logitech Zone Wireless as /devices/pci0000:00/0000:00:15.0/usb1/1-7/1-7:1.3/0003:046D:0A90.0002/input/input20 Dec 19 10:00:52 volumio kernel: hid-generic 0003:046D:0A90.0002: input,hiddev0,hidraw1: USB HID v1.11 Device [Logitech Zone Wireless] on usb-0000:00:15.0-7/input3 Dec 19 10:00:52 volumio kernel: usbcore: registered new interface driver snd-usb-audio Dec 19 10:00:52 volumio (udev-worker)[2696]: controlC5: Process '/usr/sbin/alsactl -E HOME=/run/alsa -E XDG_RUNTIME_DIR=/run/alsa/runtime restore 5' failed with exit code 99. Dec 19 10:00:52 volumio volumio[1314]: info: Dec 19 10:00:52 volumio volumio[1314]: ---------------------------- USB Audio Device Attached Dec 19 10:00:52 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Dec 19 10:00:52 volumio volumio[1314]: info: No valid Plugin REST Endpoint Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Dec 19 10:01:07 volumio volumio[1314]: info: Preparing to save Alsa Options, stopping services first Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::volumioGetState Dec 19 10:01:07 volumio volumio[1314]: info: CorePlayQueue::getTrack 0 Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::volumioPause Dec 19 10:01:07 volumio volumio[1314]: info: CoreStateMachine::pause Dec 19 10:01:07 volumio volumio[1314]: info: Saving Audio Output to: {"i2s":false,"output_device":{"value":"0,0","label":"Analog Out"},"disallowPush":true} Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 19 10:01:07 volumio volumio[1314]: info: Found match in Cards Database: setting mixer for card Analog Out Dec 19 10:01:07 volumio volumio[1314]: info: Setting mixer Master for card Analog Out Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 19 10:01:07 volumio volumio[1314]: info: Updating Volume Controller Parameters: Device: 0,0 Name: Analog Out Mixer: Master Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Dec 19 10:01:07 volumio volumio[1314]: info: Disabling external Volume Control Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 19 10:01:07 volumio volumio[1314]: info: Preparing to generate the ALSA configuration file Dec 19 10:01:07 volumio volumio[1314]: info: Asound.conf file unchanged, so no further update is needed Dec 19 10:01:07 volumio volumio[1314]: info: Output device has changed, restarting MPD Dec 19 10:01:07 volumio volumio[1314]: info: Output device has changed, restarting Shairport Sync Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 10:01:07 volumio sudo[2781]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 19 10:01:07 volumio sudo[2781]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:07 volumio sudo[2781]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:07 volumio sudo[2785]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 19 10:01:07 volumio sudo[2785]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:07 volumio volumio[1314]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 19 10:01:07 volumio volumio[1314]: info: MPD Permissions set Dec 19 10:01:07 volumio volumio[1314]: info: VolumeController:: Volume=41 Mute =false Dec 19 10:01:07 volumio volumio[1314]: info: CoreStateMachine::pushState Dec 19 10:01:07 volumio volumio[1314]: info: CorePlayQueue::getTrack 0 Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::volumioPushState Dec 19 10:01:07 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 19 10:01:07 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:07 volumio volumio[1314]: info: Starting Shairport Sync Dec 19 10:01:08 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 19 10:01:08 volumio sudo[2805]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 19 10:01:08 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 19 10:01:08 volumio sudo[2805]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:08 volumio systemd[1]: mpd.service: Consumed 1.124s CPU time. Dec 19 10:01:08 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 19 10:01:08 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 19 10:01:08 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 19 10:01:08 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 19 10:01:08 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 19 10:01:08 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 19 10:01:08 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 19 10:01:08 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 19 10:01:08 volumio systemd[1]: shairport-sync.service: Consumed 1.373s CPU time. Dec 19 10:01:08 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 19 10:01:08 volumio sudo[2805]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:08 volumio volumio[1314]: info: Shairport-Sync Started Dec 19 10:01:08 volumio sudo[2808]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 19 10:01:08 volumio sudo[2808]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 19 10:01:08 volumio sudo[2808]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:08 volumio mpd[2824]: 2025-12-19T10:01:08 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 19 10:01:08 volumio systemd[1]: Started mpd.service - Music Player Daemon. Dec 19 10:01:08 volumio sudo[2785]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:08 volumio volumio[1314]: error: updateQueue error: null Dec 19 10:01:09 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Dec 19 10:01:11 volumio volumio[1314]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Dec 19 10:01:11 volumio volumio[1314]: info: CoreStateMachine::getcurrentVolume Dec 19 10:01:11 volumio volumio[1314]: info: CoreCommandRouter::volumioRetrievevolume Dec 19 10:01:11 volumio volumio[1314]: info: VolumeController:: Volume=41 Mute =false Dec 19 10:01:11 volumio volumio[1314]: info: CoreStateMachine::pushState Dec 19 10:01:11 volumio volumio[1314]: info: CorePlayQueue::getTrack 0 Dec 19 10:01:11 volumio volumio[1314]: info: CoreCommandRouter::volumioPushState Dec 19 10:01:11 volumio volumio[1314]: info: CoreStateMachine::updateTrackBlock Dec 19 10:01:11 volumio volumio[1314]: info: CorePlayQueue::getTrackBlock Dec 19 10:01:11 volumio volumio[1314]: info: CoreCommandRouter::volumioRetrievevolume Dec 19 10:01:11 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Dec 19 10:01:11 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 19 10:01:11 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 10:01:11 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 19 10:01:11 volumio volumio[1314]: info: VolumeController:: Volume=41 Mute =false Dec 19 10:01:11 volumio volumio[1314]: info: CoreStateMachine::pushState Dec 19 10:01:11 volumio volumio[1314]: info: CorePlayQueue::getTrack 0 Dec 19 10:01:11 volumio volumio[1314]: info: CoreCommandRouter::volumioPushState Dec 19 10:01:11 volumio sudo[2843]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 19 10:01:11 volumio sudo[2843]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:11 volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 19 10:01:11 volumio systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 19 10:01:11 volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 19 10:01:11 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 19 10:01:11 volumio mpd_monitor.sh[2845]: MPD Monitor Service: Starting MPD Monitor Service Dec 19 10:01:11 volumio sudo[2843]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:11 volumio volumio[1314]: info: Successfully started MPD Monitor Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Dec 19 10:01:21 volumio volumio[1314]: info: Preparing to save Alsa Options, stopping services first Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::volumioGetState Dec 19 10:01:21 volumio volumio[1314]: info: CorePlayQueue::getTrack 0 Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::volumioPause Dec 19 10:01:21 volumio volumio[1314]: info: CoreStateMachine::pause Dec 19 10:01:21 volumio volumio[1314]: info: Saving Audio Output to: {"i2s":false,"output_device":{"value":"5","label":"Zone Wireless"},"disallowPush":true} Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 19 10:01:21 volumio volumio[1314]: info: Setting mixer PCM for card Zone Wireless Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 19 10:01:21 volumio volumio[1314]: info: Updating Volume Controller Parameters: Device: 5 Name: Zone Wireless Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Dec 19 10:01:21 volumio volumio[1314]: info: Disabling external Volume Control Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 19 10:01:21 volumio volumio[1314]: info: Preparing to generate the ALSA configuration file Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 19 10:01:21 volumio sudo[2886]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 19 10:01:21 volumio sudo[2886]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:21 volumio sudo[2888]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 19 10:01:21 volumio sudo[2888]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:21 volumio sudo[2888]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 19 10:01:21 volumio volumio[1314]: info: VolumeController:: Volume=25 Mute =false Dec 19 10:01:21 volumio volumio[1314]: info: CoreStateMachine::pushState Dec 19 10:01:21 volumio volumio[1314]: info: CorePlayQueue::getTrack 0 Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::volumioPushState Dec 19 10:01:21 volumio volumio[1314]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Dec 19 10:01:21 volumio volumio[1314]: wlan0 Interface doesn't support scanning : Device or resource busy Dec 19 10:01:21 volumio volumio[1314]: info: Cannot use regular scanning, forcing with ap-force Dec 19 10:01:21 volumio sudo[2902]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Dec 19 10:01:21 volumio sudo[2902]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:21 volumio sudo[2902]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:21 volumio volumio[1314]: command failed: Device or resource busy (-16) Dec 19 10:01:21 volumio volumio[1314]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Dec 19 10:01:21 volumio volumio[1314]: command failed: Device or resource busy (-16) Dec 19 10:01:21 volumio volumio[1314]: info: Asound.conf file written Dec 19 10:01:21 volumio sudo[2907]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 19 10:01:21 volumio sudo[2907]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:21 volumio sudo[2907]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:21 volumio volumio[1314]: No state is present for card PCH Dec 19 10:01:21 volumio volumio[1314]: Found hardware: "HDA-Intel" "Realtek Generic" "HDA:10ec0256,10ec119e,00100002 HDA:8086280d,80860101,00100000" "0x10ec" "0x119e" Dec 19 10:01:21 volumio volumio[1314]: Hardware is initialized using a generic method Dec 19 10:01:21 volumio volumio[1314]: No state is present for card PCH Dec 19 10:01:21 volumio volumio[1314]: No state is present for card Wireless Dec 19 10:01:21 volumio volumio[1314]: Found hardware: "USB-Audio" "USB Mixer" "USB046d:0a90" "" "" Dec 19 10:01:21 volumio volumio[1314]: Hardware is initialized using a generic method Dec 19 10:01:21 volumio volumio[1314]: No state is present for card Wireless Dec 19 10:01:21 volumio volumio[1314]: info: Output device has changed, restarting MPD Dec 19 10:01:21 volumio volumio[1314]: info: Output device has changed, restarting Shairport Sync Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 10:01:21 volumio sudo[2915]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 19 10:01:21 volumio sudo[2915]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:21 volumio sudo[2913]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 19 10:01:21 volumio sudo[2913]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:21 volumio sudo[2913]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:21 volumio volumio[1314]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 19 10:01:21 volumio volumio[1314]: info: Output device has changed, restarting MPD Dec 19 10:01:21 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 19 10:01:21 volumio volumio[1314]: info: Output device has changed, restarting Shairport Sync Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 10:01:21 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 19 10:01:21 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 19 10:01:21 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 19 10:01:21 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 19 10:01:21 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 19 10:01:21 volumio sudo[2923]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 19 10:01:21 volumio sudo[2923]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:21 volumio sudo[2923]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:21 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 19 10:01:21 volumio volumio[1314]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 19 10:01:21 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 19 10:01:21 volumio volumio[1314]: info: MPD Permissions set Dec 19 10:01:21 volumio volumio[1314]: info: MPD Permissions set Dec 19 10:01:21 volumio sudo[2926]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 19 10:01:21 volumio sudo[2926]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:21 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 19 10:01:21 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 19 10:01:21 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 19 10:01:21 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 19 10:01:21 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:21 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 19 10:01:21 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 19 10:01:21 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 10:01:21 volumio volumio[1314]: info: Starting Shairport Sync Dec 19 10:01:21 volumio volumio[1314]: info: Starting Shairport Sync Dec 19 10:01:21 volumio sudo[2954]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 19 10:01:21 volumio sudo[2954]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:21 volumio sudo[2945]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 19 10:01:21 volumio sudo[2945]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 19 10:01:21 volumio sudo[2945]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:21 volumio sudo[2956]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 19 10:01:21 volumio sudo[2956]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:21 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 19 10:01:21 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 19 10:01:21 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 19 10:01:21 volumio systemd[1]: shairport-sync.service: Consumed 1.175s CPU time. Dec 19 10:01:21 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 19 10:01:21 volumio sudo[2954]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:21 volumio volumio[1314]: info: Shairport-Sync Started Dec 19 10:01:21 volumio sudo[2956]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:21 volumio volumio[1314]: info: Shairport-Sync Started Dec 19 10:01:22 volumio mpd[2959]: 2025-12-19T10:01:22 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 19 10:01:22 volumio systemd[1]: Started mpd.service - Music Player Daemon. Dec 19 10:01:22 volumio sudo[2926]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:22 volumio volumio[1314]: error: updateQueue error: null Dec 19 10:01:22 volumio sudo[2915]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:22 volumio volumio[1314]: error: updateQueue error: null Dec 19 10:01:25 volumio volumio[1314]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Dec 19 10:01:25 volumio volumio[1314]: info: CoreStateMachine::getcurrentVolume Dec 19 10:01:25 volumio volumio[1314]: info: CoreCommandRouter::volumioRetrievevolume Dec 19 10:01:25 volumio volumio[1314]: info: VolumeController:: Volume=25 Mute =false Dec 19 10:01:25 volumio volumio[1314]: info: CoreStateMachine::pushState Dec 19 10:01:25 volumio volumio[1314]: info: CorePlayQueue::getTrack 0 Dec 19 10:01:25 volumio volumio[1314]: info: CoreCommandRouter::volumioPushState Dec 19 10:01:25 volumio volumio[1314]: info: CoreStateMachine::updateTrackBlock Dec 19 10:01:25 volumio volumio[1314]: info: CorePlayQueue::getTrackBlock Dec 19 10:01:25 volumio volumio[1314]: info: CoreCommandRouter::volumioRetrievevolume Dec 19 10:01:25 volumio volumio[1314]: info: VolumeController:: Volume=25 Mute =false Dec 19 10:01:25 volumio volumio[1314]: info: CoreStateMachine::pushState Dec 19 10:01:25 volumio volumio[1314]: info: CorePlayQueue::getTrack 0 Dec 19 10:01:25 volumio volumio[1314]: info: CoreCommandRouter::volumioPushState Dec 19 10:01:25 volumio sudo[3010]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 19 10:01:25 volumio sudo[3010]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:25 volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 19 10:01:25 volumio systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 19 10:01:25 volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 19 10:01:25 volumio sudo[3014]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 19 10:01:25 volumio sudo[3014]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:25 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 19 10:01:25 volumio mpd_monitor.sh[3015]: MPD Monitor Service: Starting MPD Monitor Service Dec 19 10:01:25 volumio sudo[3010]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:25 volumio volumio[1314]: info: Successfully started MPD Monitor Dec 19 10:01:25 volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 19 10:01:25 volumio systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 19 10:01:25 volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 19 10:01:25 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 19 10:01:25 volumio mpd_monitor.sh[3019]: MPD Monitor Service: Starting MPD Monitor Service Dec 19 10:01:25 volumio sudo[3014]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:25 volumio volumio[1314]: info: Successfully started MPD Monitor Dec 19 10:01:27 volumio sudo[2886]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:38 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: wizard , connectWirelessNetwork Dec 19 10:01:38 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: network , getWiredInfo Dec 19 10:01:38 volumio sudo[3051]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 19 10:01:38 volumio sudo[3051]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:38 volumio sudo[3051]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:38 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings Dec 19 10:01:38 volumio volumio[1314]: info: Saving new wireless network Dec 19 10:01:38 volumio sudo[3054]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf Dec 19 10:01:38 volumio sudo[3054]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:38 volumio sudo[3054]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:38 volumio volumio[1314]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Dec 19 10:01:38 volumio volumio[1314]: info: Discovery: Restarting Advertising due to device name change Dec 19 10:01:38 volumio sudo[3057]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Dec 19 10:01:38 volumio sudo[3057]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:38 volumio systemd[1]: Stopping wireless.service - Wireless Services... Dec 19 10:01:38 volumio systemd[1]: wireless.service: Deactivated successfully. Dec 19 10:01:38 volumio systemd[1]: Stopped wireless.service - Wireless Services. Dec 19 10:01:38 volumio systemd[1]: Starting wireless.service - Wireless Services... Dec 19 10:01:38 volumio wireless.js[3059]: WIRELESS.JS: Single Network Mode enabled, only one network device can be active at a time between ethernet and wireless Dec 19 10:01:38 volumio wireless.js[3059]: WIRELESS.JS: Wireless.js initializing wireless flow Dec 19 10:01:38 volumio wireless.js[3059]: WIRELESS.JS: Cleaning previous... Dec 19 10:01:38 volumio systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Dec 19 10:01:38 volumio dnsmasq[2082]: exiting on receipt of SIGTERM Dec 19 10:01:38 volumio systemd[1]: dnsmasq.service: Deactivated successfully. Dec 19 10:01:38 volumio systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Dec 19 10:01:38 volumio systemd[1]: Stopping hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Dec 19 10:01:38 volumio dhcpcd[1034]: wlan0: carrier lost Dec 19 10:01:38 volumio avahi-daemon[829]: Interface wlan0.IPv4 no longer relevant for mDNS. Dec 19 10:01:38 volumio avahi-daemon[829]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Dec 19 10:01:38 volumio avahi-daemon[829]: Withdrawing address record for 192.168.211.1 on wlan0. Dec 19 10:01:38 volumio volumio[1314]: info: Discovery: A device disappeared from network Dec 19 10:01:38 volumio volumio[1314]: info: Discovery: Browse raised the following error TypeError: Cannot read properties of undefined (reading 'toLowerCase') Dec 19 10:01:38 volumio kernel: iwlwifi 0000:01:00.0: Applying debug destination EXTERNAL_DRAM Dec 19 10:01:38 volumio kernel: iwlwifi 0000:01:00.0: Applying debug destination EXTERNAL_DRAM Dec 19 10:01:38 volumio kernel: iwlwifi 0000:01:00.0: FW already configured (0) - re-configuring Dec 19 10:01:38 volumio avahi-daemon[829]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Dec 19 10:01:38 volumio avahi-daemon[829]: New relevant interface wlan0.IPv4 for mDNS. Dec 19 10:01:38 volumio avahi-daemon[829]: Registering new address record for 192.168.211.1 on wlan0.IPv4. Dec 19 10:01:38 volumio systemd[1]: hostapd.service: Deactivated successfully. Dec 19 10:01:38 volumio systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Dec 19 10:01:38 volumio sudo[3093]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Dec 19 10:01:38 volumio sudo[3093]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 19 10:01:38 volumio avahi-daemon[829]: Withdrawing address record for 192.168.211.1 on wlan0. Dec 19 10:01:38 volumio avahi-daemon[829]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Dec 19 10:01:38 volumio avahi-daemon[829]: Interface wlan0.IPv4 no longer relevant for mDNS. Dec 19 10:01:38 volumio sudo[3093]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:38 volumio sudo[3096]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Dec 19 10:01:38 volumio sudo[3096]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 19 10:01:38 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Dec 19 10:01:38 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Dec 19 10:01:38 volumio systemd[1]: welcome.service: Deactivated successfully. Dec 19 10:01:38 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Dec 19 10:01:38 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Dec 19 10:01:38 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Dec 19 10:01:38 volumio sudo[3096]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:38 volumio welcome[3098]: Resolved ip:[0] Dec 19 10:01:38 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Dec 19 10:01:38 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Dec 19 10:01:38 volumio wireless.js[3059]: WIRELESS.JS: Stopped aP Dec 19 10:01:38 volumio sudo[3109]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 19 10:01:38 volumio sudo[3109]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:38 volumio kernel: iwlwifi 0000:01:00.0: Applying debug destination EXTERNAL_DRAM Dec 19 10:01:39 volumio kernel: iwlwifi 0000:01:00.0: Applying debug destination EXTERNAL_DRAM Dec 19 10:01:39 volumio kernel: iwlwifi 0000:01:00.0: FW already configured (0) - re-configuring Dec 19 10:01:39 volumio sudo[3109]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:39 volumio sudo[3111]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Dec 19 10:01:39 volumio sudo[3111]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:39 volumio sudo[3111]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:39 volumio sudo[3119]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 19 10:01:39 volumio sudo[3119]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:39 volumio sudo[3119]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:39 volumio sudo[3121]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Dec 19 10:01:39 volumio sudo[3121]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:39 volumio volumio[1314]: info: Discovery: A device disappeared from network Dec 19 10:01:39 volumio volumio[1314]: info: Discovery: Browse raised the following error TypeError: Cannot read properties of undefined (reading 'toLowerCase') Dec 19 10:01:39 volumio sudo[3126]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 10:01:39 volumio sudo[3126]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:39 volumio sudo[3126]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:40 volumio sudo[3130]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 10:01:40 volumio sudo[3130]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:40 volumio sudo[3130]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:40 volumio ntpd[1091]: IO: Deleting interface #4 wlan0, 192.168.211.1#123, interface stats: received=0, sent=0, dropped=0, active_time=147 secs Dec 19 10:01:41 volumio sudo[3134]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 10:01:41 volumio sudo[3134]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:41 volumio sudo[3134]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:42 volumio sudo[3138]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 10:01:42 volumio sudo[3138]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:42 volumio sudo[3138]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:42 volumio sudo[3121]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:42 volumio wireless.js[3059]: WIRELESS.JS: SETTING APPROPRIATE REG DOMAIN: CH Dec 19 10:01:42 volumio sudo[3143]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 19 10:01:42 volumio sudo[3143]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:42 volumio sudo[3143]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:42 volumio sudo[3145]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set CH Dec 19 10:01:42 volumio sudo[3145]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:42 volumio sudo[3145]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:42 volumio wireless.js[3059]: WIRELESS.JS: SUCCESSFULLY SET NEW REGDOMAIN: CH Dec 19 10:01:42 volumio wireless.js[3059]: WIRELESS.JS: Start wireless flow Dec 19 10:01:42 volumio wireless.js[3059]: WIRELESS.JS: Stopped hotspot (if there).. Dec 19 10:01:42 volumio sudo[3153]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Dec 19 10:01:42 volumio sudo[3153]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 19 10:01:42 volumio sudo[3153]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:42 volumio sudo[3155]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Dec 19 10:01:42 volumio sudo[3155]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 19 10:01:42 volumio sudo[3155]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:42 volumio wireless.js[3059]: WIRELESS.JS: DHCP IP fallback Dec 19 10:01:42 volumio wpa_supplicant[3160]: Successfully initialized wpa_supplicant Dec 19 10:01:42 volumio wireless.js[3059]: WIRELESS.JS: Start ap Dec 19 10:01:42 volumio kernel: iwlwifi 0000:01:00.0: Applying debug destination EXTERNAL_DRAM Dec 19 10:01:42 volumio kernel: iwlwifi 0000:01:00.0: Applying debug destination EXTERNAL_DRAM Dec 19 10:01:42 volumio kernel: iwlwifi 0000:01:00.0: FW already configured (0) - re-configuring Dec 19 10:01:43 volumio sudo[3161]: root : PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Dec 19 10:01:43 volumio sudo[3161]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 19 10:01:43 volumio dhcpcd[1034]: control command: /sbin/dhcpcd Dec 19 10:01:43 volumio dhcpcd[1034]: control_free: No such file or directory Dec 19 10:01:43 volumio sudo[3161]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:43 volumio dhcpcd[1034]: lo: IAID 00:00:00:00 Dec 19 10:01:43 volumio dhcpcd[1034]: lo: adding address fe80::d01a:31a3:c713:446b Dec 19 10:01:43 volumio dhcpcd[1034]: ipv6_addaddr1: Permission denied Dec 19 10:01:43 volumio systemd[1]: Reached target ip-changed@lo.target - IP Address changed on lo. Dec 19 10:01:43 volumio dhcpcd[1034]: lo: using static address 127.0.0.1/8 Dec 19 10:01:43 volumio wpa_supplicant[3176]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=DRIVER type=WORLD Dec 19 10:01:43 volumio dhcpcd[1034]: lo: adding route to 127.0.0.0/8 Dec 19 10:01:43 volumio volumio[1314]: info: Discovery: Started advertising with name: Volumio Dec 19 10:01:43 volumio sudo[3193]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 10:01:43 volumio sudo[3193]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:43 volumio sudo[3193]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:43 volumio wireless.js[3059]: WIRELESS.JS: trying... Dec 19 10:01:43 volumio sudo[3213]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 19 10:01:43 volumio sudo[3213]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:43 volumio sudo[3213]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:44 volumio volumio[1314]: info: Discovery: adding 9e9216bd-bff0-4900-9b86-21ac1873b2f6 Dec 19 10:01:44 volumio volumio[1314]: info: Discovery: Found device Volumio Dec 19 10:01:44 volumio volumio[1314]: info: CoreCommandRouter::volumioGetState Dec 19 10:01:44 volumio volumio[1314]: info: CorePlayQueue::getTrack 0 Dec 19 10:01:44 volumio sudo[3217]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 10:01:44 volumio sudo[3217]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:44 volumio sudo[3217]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:44 volumio wireless.js[3059]: WIRELESS.JS: trying... Dec 19 10:01:44 volumio sudo[3222]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 19 10:01:44 volumio sudo[3222]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:44 volumio sudo[3222]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:45 volumio sudo[3225]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 10:01:45 volumio sudo[3225]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:45 volumio sudo[3225]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:45 volumio wireless.js[3059]: WIRELESS.JS: trying... Dec 19 10:01:45 volumio sudo[3233]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 19 10:01:45 volumio sudo[3233]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:45 volumio sudo[3233]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:46 volumio sudo[3236]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 10:01:46 volumio sudo[3236]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:46 volumio sudo[3236]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:46 volumio wpa_supplicant[3176]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=DRIVER type=COUNTRY alpha2=CH Dec 19 10:01:46 volumio wpa_supplicant[3176]: wlan0: SME: Trying to authenticate with 48:5d:35:6b:d4:62 (SSID='LouisZ' freq=5180 MHz) Dec 19 10:01:46 volumio kernel: wlan0: authenticate with 48:5d:35:6b:d4:62 (local address=50:eb:71:ec:31:b9) Dec 19 10:01:46 volumio kernel: wlan0: send auth to 48:5d:35:6b:d4:62 (try 1/3) Dec 19 10:01:46 volumio wpa_supplicant[3176]: wlan0: Trying to associate with 48:5d:35:6b:d4:62 (SSID='LouisZ' freq=5180 MHz) Dec 19 10:01:46 volumio kernel: wlan0: authenticated Dec 19 10:01:46 volumio kernel: wlan0: associate with 48:5d:35:6b:d4:62 (try 1/3) Dec 19 10:01:46 volumio kernel: wlan0: RX AssocResp from 48:5d:35:6b:d4:62 (capab=0x1511 status=0 aid=3) Dec 19 10:01:46 volumio kernel: wlan0: associated Dec 19 10:01:46 volumio wpa_supplicant[3176]: wlan0: Associated with 48:5d:35:6b:d4:62 Dec 19 10:01:46 volumio wpa_supplicant[3176]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Dec 19 10:01:46 volumio wpa_supplicant[3176]: wlan0: WPA: Key negotiation completed with 48:5d:35:6b:d4:62 [PTK=CCMP GTK=CCMP] Dec 19 10:01:46 volumio wpa_supplicant[3176]: wlan0: CTRL-EVENT-CONNECTED - Connection to 48:5d:35:6b:d4:62 completed [id=0 id_str=] Dec 19 10:01:46 volumio dhcpcd[1034]: wlan0: carrier acquired Dec 19 10:01:46 volumio dhcpcd[1034]: wlan0: connected to Access Point: LouisZ Dec 19 10:01:46 volumio kernel: wlan0: Limiting TX power to 20 (23 - 3) dBm as advertised by 48:5d:35:6b:d4:62 Dec 19 10:01:46 volumio dhcpcd[1034]: wlan0: IAID 71:ec:31:b9 Dec 19 10:01:46 volumio wireless.js[3059]: WIRELESS.JS: trying... Dec 19 10:01:46 volumio sudo[3242]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 19 10:01:46 volumio sudo[3242]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:46 volumio sudo[3242]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:47 volumio sudo[3245]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 10:01:47 volumio sudo[3245]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:47 volumio sudo[3245]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:47 volumio dhcpcd[1034]: wlan0: soliciting an IPv6 router Dec 19 10:01:47 volumio dhcpcd[1034]: wlan0: soliciting a DHCP lease Dec 19 10:01:47 volumio dhcpcd[1034]: wlan0: offered 192.168.0.77 from 192.168.0.1 Dec 19 10:01:47 volumio dhcpcd[1034]: wlan0: probing address 192.168.0.77/16 Dec 19 10:01:47 volumio wireless.js[3059]: WIRELESS.JS: trying... Dec 19 10:01:47 volumio sudo[3252]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 19 10:01:47 volumio sudo[3252]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:47 volumio sudo[3252]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:48 volumio sudo[3255]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 10:01:48 volumio sudo[3255]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:48 volumio sudo[3255]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:48 volumio wireless.js[3059]: WIRELESS.JS: trying... Dec 19 10:01:48 volumio sudo[3260]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 19 10:01:48 volumio sudo[3260]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:48 volumio sudo[3260]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:49 volumio sudo[3263]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 10:01:49 volumio sudo[3263]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:49 volumio sudo[3263]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:49 volumio wireless.js[3059]: WIRELESS.JS: trying... Dec 19 10:01:49 volumio sudo[3268]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 19 10:01:49 volumio sudo[3268]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:49 volumio sudo[3268]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:50 volumio sudo[3271]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 10:01:50 volumio sudo[3271]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:50 volumio sudo[3271]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:50 volumio wireless.js[3059]: WIRELESS.JS: trying... Dec 19 10:01:50 volumio sudo[3276]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 19 10:01:50 volumio sudo[3276]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:50 volumio sudo[3276]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:51 volumio sudo[3279]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 10:01:51 volumio sudo[3279]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:51 volumio sudo[3279]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:51 volumio wireless.js[3059]: WIRELESS.JS: trying... Dec 19 10:01:51 volumio sudo[3284]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 19 10:01:51 volumio sudo[3284]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:51 volumio sudo[3284]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:52 volumio sudo[3287]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 10:01:52 volumio sudo[3287]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:52 volumio sudo[3287]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:52 volumio wireless.js[3059]: WIRELESS.JS: trying... Dec 19 10:01:52 volumio sudo[3292]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 19 10:01:52 volumio sudo[3292]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:52 volumio sudo[3292]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:53 volumio sudo[3295]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 10:01:53 volumio sudo[3295]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 19 10:01:53 volumio sudo[3295]: pam_unix(sudo:session): session closed for user root Dec 19 10:01:53 volumio dhcpcd[1034]: wlan0: leased 192.168.0.77 for 864000 seconds Dec 19 10:01:53 volumio dhcpcd[1034]: wlan0: adding route to 192.168.0.0/16 Dec 19 10:01:53 volumio avahi-daemon[829]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.77. Dec 19 10:01:53 volumio avahi-daemon[829]: New relevant interface wlan0.IPv4 for mDNS. Dec 19 10:01:53 volumio avahi-daemon[829]: Registering new address record for 192.168.0.77 on wlan0.IPv4. Dec 19 10:01:53 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Dec 19 10:01:53 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Dec 19 10:01:53 volumio systemd[1]: welcome.service: Deactivated successfully. Dec 19 10:01:53 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Dec 19 10:01:53 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Dec 19 10:01:53 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Dec 19 10:01:53 volumio dhcpcd[1034]: wlan0: adding default route via 192.168.0.1 Dec 19 10:01:53 volumio welcome[3309]: Resolved ip:[1] 192.168.0.77 Dec 19 10:01:53 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Dec 19 10:01:53 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Dec 19 10:01:53 volumio volumio[1314]: info: Volumio Network Manager: Network status updated: 2 Dec 19 10:01:53 volumio volumio[1314]: compat.c: read() failed: Resource temporarily unavailable Dec 19 10:01:53 volumio volumio[1314]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 19 10:01:53 volumio volumio[1314]: Error: dns service error: unknown Dec 19 10:01:53 volumio volumio[1314]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Dec 19 10:01:53 volumio volumio[1314]: errorCode: -65537 Dec 19 10:01:53 volumio volumio[1314]: } Dec 19 10:01:53 volumio volumio[1314]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 19 10:01:53 volumio sudo[3354]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-19 10:00' Dec 19 10:01:53 volumio sudo[3354]: 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"