May 11 10:20:02 volumio volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 10:20:02 volumio volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 10:20:02 volumio volumio[1307]: info: Discovery: Getting this device information May 11 10:20:02 volumio volumio[1307]: info: CoreCommandRouter::volumioGetState May 11 10:20:02 volumio volumio[1307]: info: CorePlayQueue::getTrack 0 May 11 10:20:02 volumio volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 10:20:08 volumio volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings May 11 10:20:08 volumio volumio[1307]: info: System name has changed, restarting Shairport Sync May 11 10:20:08 volumio volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 10:20:08 volumio volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 10:20:08 volumio volumio[1307]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 11 10:20:08 volumio volumio[1307]: info: Updating MyVolumio device info May 11 10:20:08 volumio volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 10:20:08 volumio volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 10:20:08 volumio volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 10:20:08 volumio volumio[1307]: info: Discovery: Restarting Advertising due to device name change May 11 10:20:08 volumio volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices May 11 10:20:08 volumio sudo[2797]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli May 11 10:20:08 volumio sudo[2797]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:08 volumio sudo[2797]: pam_unix(sudo:session): session closed for user root May 11 10:20:08 volumio systemd[1]: upmpdcli.service: Deactivated successfully. May 11 10:20:08 volumio systemd[1]: upmpdcli.service: Consumed 8.637s CPU time. May 11 10:20:08 volumio volumio[1307]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 11 10:20:08 volumio volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 10:20:08 volumio volumio[1307]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 11 10:20:08 volumio sudo[2805]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts May 11 10:20:08 volumio sudo[2805]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:08 volumio volumio[1307]: info: Starting Shairport Sync May 11 10:20:08 volumio sudo[2808]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 11 10:20:08 volumio sudo[2808]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:08 volumio sudo[2805]: pam_unix(sudo:session): session closed for user root May 11 10:20:08 volumio volumio[1307]: info: Permissions for /etc/hosts set May 11 10:20:08 volumio volumio[1307]: info: Hostname now is volumio-spare May 11 10:20:08 volumio sudo[2811]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/hostname volumio-spare May 11 10:20:08 volumio sudo[2811]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:08 volumio-spare sudo[2811]: pam_unix(sudo:session): session closed for user root May 11 10:20:08 volumio-spare volumio[1307]: info: New hostname set May 11 10:20:08 volumio-spare sudo[2813]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /etc/avahi/services/ May 11 10:20:08 volumio-spare sudo[2813]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:08 volumio-spare volumio[1307]: info: Permissions for /etc/avahi/services/volumio.service May 11 10:20:08 volumio-spare volumio[1307]: info: Avahi name changed to volumio-spare May 11 10:20:08 volumio-spare sudo[2813]: pam_unix(sudo:session): session closed for user root May 11 10:20:08 volumio-spare avahi-daemon[900]: Files changed, reloading. May 11 10:20:08 volumio-spare systemd[1]: Starting fix-alpha-hosts.service - Fix /etc/hosts and ensure test sentinels... May 11 10:20:08 volumio-spare avahi-daemon[900]: Loading service file /services/volumio.service. May 11 10:20:08 volumio-spare systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... May 11 10:20:08 volumio-spare systemd[1]: shairport-sync.service: Deactivated successfully. May 11 10:20:08 volumio-spare systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 11 10:20:08 volumio-spare systemd[1]: shairport-sync.service: Consumed 1.510s CPU time. May 11 10:20:08 volumio-spare systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 11 10:20:08 volumio-spare sudo[2808]: pam_unix(sudo:session): session closed for user root May 11 10:20:08 volumio-spare systemd[1]: fix-alpha-hosts.service: Deactivated successfully. May 11 10:20:08 volumio-spare volumio[1307]: info: Shairport-Sync Started May 11 10:20:08 volumio-spare systemd[1]: Finished fix-alpha-hosts.service - Fix /etc/hosts and ensure test sentinels. May 11 10:20:08 volumio-spare volumio[1307]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} May 11 10:20:08 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule May 11 10:20:08 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 11 10:20:08 volumio-spare volumio-remote-updater[913]: No test mode May 11 10:20:08 volumio-spare volumio-remote-updater[913]: Alpha test mode enabled May 11 10:20:08 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled May 11 10:20:09 volumio-spare volumio[1307]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

NEW ADDITIONS 🚀

\n\n","title":"Update v0.065","updateavailable":true} May 11 10:20:09 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 11 10:20:09 volumio-spare volumio[1307]: info: Discovery: A device disappeared from network May 11 10:20:09 volumio-spare volumio[1307]: info: Discovery: Device volumio disappeared from network May 11 10:20:09 volumio-spare volumio[1307]: info: Discovery: A device disappeared from network May 11 10:20:09 volumio-spare volumio[1307]: info: Discovery: A device disappeared from network May 11 10:20:09 volumio-spare avahi-daemon[900]: Service "Volumio Spare" (/services/volumio.service) successfully established. May 11 10:20:13 volumio-spare volumio[1307]: info: Discovery: Started advertising with name: Volumio Spare May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions May 11 10:20:14 volumio-spare volumio[1307]: info: Preparing to save Alsa Options, stopping services first May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioGetState May 11 10:20:14 volumio-spare volumio[1307]: info: CorePlayQueue::getTrack 0 May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioPause May 11 10:20:14 volumio-spare volumio[1307]: info: CoreStateMachine::pause May 11 10:20:14 volumio-spare volumio[1307]: info: Saving Audio Output to: {"i2s":false,"output_device":{"value":"0","label":"HDMI 0 Out"},"disallowPush":true} May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 11 10:20:14 volumio-spare volumio[1307]: info: Found match in Cards Database: setting mixer for card HDMI 0 Out May 11 10:20:14 volumio-spare volumio[1307]: info: Device 0 does not have any Mixer Control Available May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 11 10:20:14 volumio-spare volumio[1307]: info: Updating Volume Controller Parameters: Device: 0 Name: HDMI 0 Out Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume May 11 10:20:14 volumio-spare volumio[1307]: info: Disabling external Volume Control May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 10:20:14 volumio-spare volumio[1307]: info: CoreStateMachine::pushState May 11 10:20:14 volumio-spare volumio[1307]: info: CorePlayQueue::getTrack 0 May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioPushState May 11 10:20:14 volumio-spare volumio[1307]: info: Preparing to generate the ALSA configuration file May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks May 11 10:20:14 volumio-spare sudo[2871]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 11 10:20:14 volumio-spare sudo[2871]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:14 volumio-spare volumio[1307]: info: Asound.conf file unchanged, so no further update is needed May 11 10:20:14 volumio-spare volumio[1307]: info: Output device has changed, restarting MPD May 11 10:20:14 volumio-spare volumio[1307]: info: Output device has changed, restarting Shairport Sync May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 10:20:14 volumio-spare sudo[2873]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 11 10:20:14 volumio-spare sudo[2876]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 11 10:20:14 volumio-spare sudo[2878]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 11 10:20:14 volumio-spare sudo[2876]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:14 volumio-spare sudo[2878]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:14 volumio-spare sudo[2873]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:14 volumio-spare sudo[2876]: pam_unix(sudo:session): session closed for user root May 11 10:20:14 volumio-spare sudo[2873]: pam_unix(sudo:session): session closed for user root May 11 10:20:14 volumio-spare volumio[1307]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 11 10:20:14 volumio-spare volumio[1307]: info: MPD Permissions set May 11 10:20:14 volumio-spare volumio[1307]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan May 11 10:20:14 volumio-spare volumio[1307]: wlan0 Interface doesn't support scanning : Device or resource busy May 11 10:20:14 volumio-spare volumio[1307]: info: Cannot use regular scanning, forcing with ap-force May 11 10:20:14 volumio-spare systemd[1]: Stopping mpd.service - Music Player Daemon... May 11 10:20:14 volumio-spare sudo[2888]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force May 11 10:20:14 volumio-spare sudo[2888]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:14 volumio-spare sudo[2888]: pam_unix(sudo:session): session closed for user root May 11 10:20:14 volumio-spare volumio[1307]: command failed: Device or resource busy (-16) May 11 10:20:14 volumio-spare volumio[1307]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force May 11 10:20:14 volumio-spare volumio[1307]: command failed: Device or resource busy (-16) May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 10:20:14 volumio-spare volumio[1307]: info: Discovery: adding 42a2b5a2-91c7-4f54-a2ff-d8107b64883b May 11 10:20:14 volumio-spare volumio[1307]: info: Discovery: Found device Volumio Spare May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioGetState May 11 10:20:14 volumio-spare volumio[1307]: info: CorePlayQueue::getTrack 0 May 11 10:20:14 volumio-spare volumio[1307]: verbose: New Socket.io Connection to 192.168.0.242:3000 from 192.168.0.229 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 May 11 10:20:14 volumio-spare volumio[1307]: verbose: New Socket.io Connection to 192.168.0.242:3000 from 192.168.0.229 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 11 10:20:14 volumio-spare volumio[1307]: info: Starting Shairport Sync May 11 10:20:14 volumio-spare volumio[1307]: info: Discovery: this is already registered, 42a2b5a2-91c7-4f54-a2ff-d8107b64883b May 11 10:20:14 volumio-spare volumio[1307]: info: Discovery: Found device Volumio Spare May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioGetState May 11 10:20:14 volumio-spare volumio[1307]: info: CorePlayQueue::getTrack 0 May 11 10:20:14 volumio-spare sudo[2906]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 11 10:20:14 volumio-spare sudo[2906]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:14 volumio-spare volumio[1307]: info: Discovery: this is already registered, 42a2b5a2-91c7-4f54-a2ff-d8107b64883b May 11 10:20:14 volumio-spare volumio[1307]: info: Discovery: Found device Volumio Spare May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioGetState May 11 10:20:14 volumio-spare volumio[1307]: info: CorePlayQueue::getTrack 0 May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioGetState May 11 10:20:14 volumio-spare volumio[1307]: info: CorePlayQueue::getTrack 0 May 11 10:20:14 volumio-spare systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 10:20:14 volumio-spare volumio[1307]: info: Discovery: Getting this device information May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioGetState May 11 10:20:14 volumio-spare volumio[1307]: info: CorePlayQueue::getTrack 0 May 11 10:20:14 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 10:20:14 volumio-spare systemd[1]: shairport-sync.service: Deactivated successfully. May 11 10:20:14 volumio-spare systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 11 10:20:14 volumio-spare systemd[1]: shairport-sync.service: Consumed 1.525s CPU time. May 11 10:20:14 volumio-spare systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 11 10:20:14 volumio-spare systemd[1]: mpd.service: Deactivated successfully. May 11 10:20:14 volumio-spare systemd[1]: Stopped mpd.service - Music Player Daemon. May 11 10:20:14 volumio-spare systemd[1]: mpd.service: Consumed 1.272s CPU time. May 11 10:20:14 volumio-spare systemd[1]: mpd.socket: Deactivated successfully. May 11 10:20:14 volumio-spare systemd[1]: Closed mpd.socket - Music Player Daemon Socket. May 11 10:20:14 volumio-spare systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... May 11 10:20:14 volumio-spare sudo[2906]: pam_unix(sudo:session): session closed for user root May 11 10:20:14 volumio-spare volumio[1307]: info: Shairport-Sync Started May 11 10:20:14 volumio-spare systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. May 11 10:20:14 volumio-spare systemd[1]: Starting mpd.service - Music Player Daemon... May 11 10:20:14 volumio-spare sudo[2912]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 11 10:20:14 volumio-spare sudo[2912]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 11 10:20:14 volumio-spare sudo[2912]: pam_unix(sudo:session): session closed for user root May 11 10:20:15 volumio-spare mpd[2928]: 2025-05-11T10:20:14 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 11 10:20:15 volumio-spare systemd[1]: Started mpd.service - Music Player Daemon. May 11 10:20:15 volumio-spare sudo[2878]: pam_unix(sudo:session): session closed for user root May 11 10:20:15 volumio-spare volumio[1307]: error: updateQueue error: null May 11 10:20:18 volumio-spare sudo[2871]: pam_unix(sudo:session): session closed for user root May 11 10:20:18 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioRetrieveVolumeLevels May 11 10:20:18 volumio-spare volumio[1307]: info: CoreStateMachine::getcurrentVolume May 11 10:20:18 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioRetrievevolume May 11 10:20:18 volumio-spare volumio[1307]: info: CoreStateMachine::pushState May 11 10:20:18 volumio-spare volumio[1307]: info: CorePlayQueue::getTrack 0 May 11 10:20:18 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioPushState May 11 10:20:18 volumio-spare sudo[2932]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/samba/smb.conf May 11 10:20:18 volumio-spare sudo[2932]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:18 volumio-spare sudo[2934]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /data/INTERNAL May 11 10:20:18 volumio-spare sudo[2934]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:18 volumio-spare sudo[2934]: pam_unix(sudo:session): session closed for user root May 11 10:20:18 volumio-spare volumio[1307]: info: Internal perms successfully set May 11 10:20:18 volumio-spare sudo[2932]: pam_unix(sudo:session): session closed for user root May 11 10:20:18 volumio-spare volumio[1307]: info: smb.conf Permissions set May 11 10:20:18 volumio-spare sudo[2938]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 11 10:20:18 volumio-spare sudo[2938]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:18 volumio-spare sudo[2938]: pam_unix(sudo:session): session closed for user root May 11 10:20:18 volumio-spare sudo[2940]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 11 10:20:18 volumio-spare sudo[2940]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:18 volumio-spare sudo[2940]: pam_unix(sudo:session): session closed for user root May 11 10:20:18 volumio-spare sudo[2944]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart nmbd.service May 11 10:20:18 volumio-spare sudo[2944]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:18 volumio-spare sudo[2946]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 11 10:20:18 volumio-spare sudo[2946]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:18 volumio-spare nmbd[1209]: [2025/05/11 10:20:18.472232, 0] ../../source3/nmbd/nmbd.c:59(terminate) May 11 10:20:18 volumio-spare nmbd[1209]: Got SIGTERM: going down... May 11 10:20:18 volumio-spare systemd[1]: Stopping nmbd.service - Samba NMB Daemon... May 11 10:20:18 volumio-spare systemd[1]: nmbd.service: Deactivated successfully. May 11 10:20:18 volumio-spare systemd[1]: Stopped nmbd.service - Samba NMB Daemon. May 11 10:20:18 volumio-spare systemd[1]: Starting nmbd.service - Samba NMB Daemon... May 11 10:20:18 volumio-spare systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. May 11 10:20:18 volumio-spare sudo[2946]: pam_unix(sudo:session): session closed for user root May 11 10:20:18 volumio-spare volumio[1307]: info: Upmpdcli Daemon Started May 11 10:20:18 volumio-spare upmpdcli[2968]: writing RSA key May 11 10:20:18 volumio-spare nmbd[2973]: [2025/05/11 10:20:18.612496, 0] ../../source3/nmbd/nmbd.c:901(main) May 11 10:20:18 volumio-spare nmbd[2973]: nmbd version 4.17.8-Raspbian started. May 11 10:20:18 volumio-spare nmbd[2973]: Copyright Andrew Tridgell and the Samba Team 1992-2022 May 11 10:20:18 volumio-spare nmbd[2973]: [2025/05/11 10:20:18.613780, 0] ../../source3/nmbd/asyncdns.c:158(start_async_dns) May 11 10:20:18 volumio-spare nmbd[2973]: started asyncdns process 2974 May 11 10:20:18 volumio-spare systemd[1]: Started nmbd.service - Samba NMB Daemon. May 11 10:20:18 volumio-spare sudo[2944]: pam_unix(sudo:session): session closed for user root May 11 10:20:18 volumio-spare sudo[2976]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart smbd.service May 11 10:20:18 volumio-spare sudo[2976]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:18 volumio-spare systemd[1]: Stopping smbd.service - Samba SMB Daemon... May 11 10:20:18 volumio-spare systemd[1]: smbd.service: Deactivated successfully. May 11 10:20:18 volumio-spare systemd[1]: Stopped smbd.service - Samba SMB Daemon. May 11 10:20:18 volumio-spare systemd[1]: Starting smbd.service - Samba SMB Daemon... May 11 10:20:18 volumio-spare smbd[2981]: [2025/05/11 10:20:18.722373, 0] ../../source3/smbd/server.c:1741(main) May 11 10:20:18 volumio-spare smbd[2981]: smbd version 4.17.8-Raspbian started. May 11 10:20:18 volumio-spare smbd[2981]: Copyright Andrew Tridgell and the Samba Team 1992-2022 May 11 10:20:18 volumio-spare systemd[1]: Started smbd.service - Samba SMB Daemon. May 11 10:20:18 volumio-spare sudo[2976]: pam_unix(sudo:session): session closed for user root May 11 10:20:18 volumio-spare volumio[1307]: info: SAMBA Restarted May 11 10:20:26 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule May 11 10:20:26 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 11 10:20:26 volumio-spare systemd[1]: systemd-timedated.service: Deactivated successfully. May 11 10:20:26 volumio-spare volumio-remote-updater[913]: No test mode May 11 10:20:26 volumio-spare volumio-remote-updater[913]: Alpha test mode enabled May 11 10:20:26 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled May 11 10:20:26 volumio-spare volumio[1307]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

NEW ADDITIONS 🚀

\n\n","title":"Update v0.065","updateavailable":true} May 11 10:20:26 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 11 10:20:27 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: wizard , connectWirelessNetwork May 11 10:20:27 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , getWiredInfo May 11 10:20:27 volumio-spare sudo[3003]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 11 10:20:27 volumio-spare sudo[3003]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:27 volumio-spare sudo[3003]: pam_unix(sudo:session): session closed for user root May 11 10:20:27 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings May 11 10:20:27 volumio-spare volumio[1307]: info: Saving new wireless network May 11 10:20:27 volumio-spare sudo[3006]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf May 11 10:20:27 volumio-spare sudo[3006]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:27 volumio-spare sudo[3006]: pam_unix(sudo:session): session closed for user root May 11 10:20:27 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart May 11 10:20:27 volumio-spare volumio[1307]: info: Discovery: Restarting Advertising due to device name change May 11 10:20:27 volumio-spare sudo[3009]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service May 11 10:20:27 volumio-spare sudo[3009]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:27 volumio-spare systemd[1]: Starting wireless.service - Wireless Services... May 11 10:20:27 volumio-spare wireless.js[3011]: Cleaning previous... May 11 10:20:27 volumio-spare systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... May 11 10:20:27 volumio-spare dnsmasq[2038]: exiting on receipt of SIGTERM May 11 10:20:27 volumio-spare systemd[1]: dnsmasq.service: Deactivated successfully. May 11 10:20:27 volumio-spare systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. May 11 10:20:27 volumio-spare systemd[1]: Stopping hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... May 11 10:20:27 volumio-spare dhcpcd[968]: wlan0: carrier lost May 11 10:20:27 volumio-spare avahi-daemon[900]: Withdrawing address record for 169.254.41.14 on wlan0. May 11 10:20:27 volumio-spare dhcpcd[968]: wlan0: deleting route to 169.254.0.0/16 May 11 10:20:27 volumio-spare systemd[1]: hostapd.service: Deactivated successfully. May 11 10:20:27 volumio-spare systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. May 11 10:20:27 volumio-spare systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. May 11 10:20:27 volumio-spare systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... May 11 10:20:27 volumio-spare systemd[1]: welcome.service: Deactivated successfully. May 11 10:20:27 volumio-spare systemd[1]: Stopped welcome.service - Show a welcome message on console. May 11 10:20:27 volumio-spare systemd[1]: Stopping welcome.service - Show a welcome message on console... May 11 10:20:27 volumio-spare sudo[3060]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 May 11 10:20:27 volumio-spare sudo[3060]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 11 10:20:27 volumio-spare systemd[1]: Starting welcome.service - Show a welcome message on console... May 11 10:20:27 volumio-spare volumio[1307]: info: Discovery: A device disappeared from network May 11 10:20:27 volumio-spare avahi-daemon[900]: Withdrawing address record for 192.168.211.1 on wlan0. May 11 10:20:27 volumio-spare avahi-daemon[900]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. May 11 10:20:27 volumio-spare avahi-daemon[900]: Interface wlan0.IPv4 no longer relevant for mDNS. May 11 10:20:27 volumio-spare sudo[3060]: pam_unix(sudo:session): session closed for user root May 11 10:20:27 volumio-spare welcome[3058]: Resolved ip:[1] 192.168.0.242 May 11 10:20:27 volumio-spare sudo[3075]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down May 11 10:20:27 volumio-spare sudo[3075]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 11 10:20:27 volumio-spare systemd[1]: Finished welcome.service - Show a welcome message on console. May 11 10:20:27 volumio-spare systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. May 11 10:20:28 volumio-spare systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. May 11 10:20:28 volumio-spare systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... May 11 10:20:28 volumio-spare systemd[1]: welcome.service: Deactivated successfully. May 11 10:20:28 volumio-spare systemd[1]: Stopped welcome.service - Show a welcome message on console. May 11 10:20:28 volumio-spare systemd[1]: Stopping welcome.service - Show a welcome message on console... May 11 10:20:28 volumio-spare systemd[1]: Starting welcome.service - Show a welcome message on console... May 11 10:20:28 volumio-spare volumio[1307]: info: Discovery: A device disappeared from network May 11 10:20:28 volumio-spare volumio[1307]: info: Discovery: A device disappeared from network May 11 10:20:28 volumio-spare welcome[3084]: Resolved ip:[1] 192.168.0.242 May 11 10:20:28 volumio-spare sudo[3075]: pam_unix(sudo:session): session closed for user root May 11 10:20:28 volumio-spare systemd[1]: Finished welcome.service - Show a welcome message on console. May 11 10:20:28 volumio-spare systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. May 11 10:20:28 volumio-spare wireless.js[3011]: Stopped aP May 11 10:20:28 volumio-spare sudo[3095]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 11 10:20:28 volumio-spare sudo[3095]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:28 volumio-spare kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 11 10:20:28 volumio-spare sudo[3095]: pam_unix(sudo:session): session closed for user root May 11 10:20:28 volumio-spare sudo[3097]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get May 11 10:20:28 volumio-spare sudo[3097]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:28 volumio-spare sudo[3097]: pam_unix(sudo:session): session closed for user root May 11 10:20:28 volumio-spare sudo[3105]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 11 10:20:28 volumio-spare sudo[3105]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:28 volumio-spare sudo[3105]: pam_unix(sudo:session): session closed for user root May 11 10:20:28 volumio-spare sudo[3107]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan May 11 10:20:28 volumio-spare sudo[3107]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:30 volumio-spare ntpd[1080]: IO: Deleting interface #5 wlan0, 192.168.211.1#123, interface stats: received=0, sent=0, dropped=0, active_time=380 secs May 11 10:20:30 volumio-spare ntpd[1080]: IO: Deleting interface #6 wlan0, 169.254.41.14#123, interface stats: received=0, sent=0, dropped=0, active_time=369 secs May 11 10:20:30 volumio-spare nmbd[2973]: [2025/05/11 10:20:30.637654, 0] ../../source3/libsmb/nmblib.c:923(send_udp) May 11 10:20:30 volumio-spare nmbd[2973]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable May 11 10:20:30 volumio-spare nmbd[2973]: [2025/05/11 10:20:30.637742, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) May 11 10:20:30 volumio-spare nmbd[2973]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed May 11 10:20:30 volumio-spare nmbd[2973]: [2025/05/11 10:20:30.637756, 0] ../../source3/nmbd/nmbd_nameregister.c:344(multihomed_register_one) May 11 10:20:30 volumio-spare nmbd[2973]: multihomed_register_one: Failed to send packet trying to register name VOLUMIO SPARE<20> IP 192.168.211.1 May 11 10:20:30 volumio-spare nmbd[2973]: [2025/05/11 10:20:30.637791, 0] ../../source3/libsmb/nmblib.c:923(send_udp) May 11 10:20:30 volumio-spare nmbd[2973]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable May 11 10:20:30 volumio-spare nmbd[2973]: [2025/05/11 10:20:30.637805, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) May 11 10:20:30 volumio-spare nmbd[2973]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed May 11 10:20:30 volumio-spare nmbd[2973]: [2025/05/11 10:20:30.637817, 0] ../../source3/nmbd/nmbd_nameregister.c:344(multihomed_register_one) May 11 10:20:30 volumio-spare nmbd[2973]: multihomed_register_one: Failed to send packet trying to register name VOLUMIO SPARE<03> IP 192.168.211.1 May 11 10:20:30 volumio-spare nmbd[2973]: [2025/05/11 10:20:30.637838, 0] ../../source3/libsmb/nmblib.c:923(send_udp) May 11 10:20:30 volumio-spare nmbd[2973]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable May 11 10:20:30 volumio-spare nmbd[2973]: [2025/05/11 10:20:30.637850, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) May 11 10:20:30 volumio-spare nmbd[2973]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed May 11 10:20:30 volumio-spare nmbd[2973]: [2025/05/11 10:20:30.637869, 0] ../../source3/nmbd/nmbd_nameregister.c:344(multihomed_register_one) May 11 10:20:30 volumio-spare nmbd[2973]: multihomed_register_one: Failed to send packet trying to register name VOLUMIO SPARE<00> IP 192.168.211.1 May 11 10:20:31 volumio-spare sudo[3107]: pam_unix(sudo:session): session closed for user root May 11 10:20:31 volumio-spare wireless.js[3011]: SETTING APPROPRIATE REG DOMAIN: DE May 11 10:20:31 volumio-spare sudo[3113]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 11 10:20:31 volumio-spare sudo[3113]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:31 volumio-spare sudo[3113]: pam_unix(sudo:session): session closed for user root May 11 10:20:31 volumio-spare sudo[3115]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set DE May 11 10:20:31 volumio-spare sudo[3115]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:31 volumio-spare sudo[3115]: pam_unix(sudo:session): session closed for user root May 11 10:20:31 volumio-spare wireless.js[3011]: SUCCESSFULLY SET NEW REGDOMAIN: DE May 11 10:20:31 volumio-spare wireless.js[3011]: Start wireless flow May 11 10:20:31 volumio-spare wireless.js[3011]: Stopped hotspot (if there).. May 11 10:20:31 volumio-spare sudo[3120]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 May 11 10:20:31 volumio-spare sudo[3120]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 11 10:20:31 volumio-spare sudo[3120]: pam_unix(sudo:session): session closed for user root May 11 10:20:31 volumio-spare sudo[3122]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down May 11 10:20:31 volumio-spare sudo[3122]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 11 10:20:31 volumio-spare sudo[3122]: pam_unix(sudo:session): session closed for user root May 11 10:20:31 volumio-spare wireless.js[3011]: DHCP IP May 11 10:20:31 volumio-spare wireless.js[3011]: Start ap May 11 10:20:31 volumio-spare wpa_supplicant[3124]: Successfully initialized wpa_supplicant May 11 10:20:31 volumio-spare sudo[3125]: root : PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd May 11 10:20:31 volumio-spare sudo[3125]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 11 10:20:31 volumio-spare dhcpcd[968]: control_free: No such file or directory May 11 10:20:31 volumio-spare dhcpcd[968]: control command: /sbin/dhcpcd May 11 10:20:31 volumio-spare sudo[3125]: pam_unix(sudo:session): session closed for user root May 11 10:20:31 volumio-spare kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 11 10:20:31 volumio-spare dhcpcd[968]: lo: IAID 00:00:00:00 May 11 10:20:31 volumio-spare dhcpcd[968]: lo: adding address fe80::1d26:12e6:8a13:cc3c May 11 10:20:31 volumio-spare dhcpcd[968]: ipv6_addaddr1: Permission denied May 11 10:20:31 volumio-spare dhcpcd[968]: lo: using static address 127.0.0.1/8 May 11 10:20:31 volumio-spare dhcpcd[968]: lo: adding route to 127.0.0.0/8 May 11 10:20:31 volumio-spare systemd[1]: Reached target ip-changed@lo.target - IP Address changed on lo. May 11 10:20:31 volumio-spare systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. May 11 10:20:31 volumio-spare systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... May 11 10:20:31 volumio-spare systemd[1]: welcome.service: Deactivated successfully. May 11 10:20:31 volumio-spare systemd[1]: Stopped welcome.service - Show a welcome message on console. May 11 10:20:31 volumio-spare systemd[1]: Stopping welcome.service - Show a welcome message on console... May 11 10:20:31 volumio-spare systemd[1]: Starting welcome.service - Show a welcome message on console... May 11 10:20:31 volumio-spare welcome[3162]: Resolved ip:[1] 192.168.0.242 May 11 10:20:31 volumio-spare wpa_supplicant[3124]: nl80211: kernel reports: Registration to specific type not supported May 11 10:20:31 volumio-spare systemd[1]: Finished welcome.service - Show a welcome message on console. May 11 10:20:31 volumio-spare systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. May 11 10:20:32 volumio-spare volumio[1307]: info: Discovery: Started advertising with name: Volumio Spare May 11 10:20:32 volumio-spare wireless.js[3011]: trying... May 11 10:20:32 volumio-spare sudo[3217]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 10:20:32 volumio-spare sudo[3217]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:32 volumio-spare sudo[3217]: pam_unix(sudo:session): session closed for user root May 11 10:20:33 volumio-spare volumio[1307]: info: Discovery: adding 42a2b5a2-91c7-4f54-a2ff-d8107b64883b May 11 10:20:33 volumio-spare volumio[1307]: info: Discovery: Found device Volumio Spare May 11 10:20:33 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioGetState May 11 10:20:33 volumio-spare volumio[1307]: info: CorePlayQueue::getTrack 0 May 11 10:20:33 volumio-spare volumio[1307]: info: Discovery: this is already registered, 42a2b5a2-91c7-4f54-a2ff-d8107b64883b May 11 10:20:33 volumio-spare volumio[1307]: info: Discovery: Found device Volumio Spare May 11 10:20:33 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioGetState May 11 10:20:33 volumio-spare volumio[1307]: info: CorePlayQueue::getTrack 0 May 11 10:20:33 volumio-spare wireless.js[3011]: trying... May 11 10:20:33 volumio-spare sudo[3223]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 10:20:33 volumio-spare sudo[3223]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:33 volumio-spare sudo[3223]: pam_unix(sudo:session): session closed for user root May 11 10:20:34 volumio-spare wpa_supplicant[3199]: MBO: Disable MBO/OCE due to misbehaving AP not having enabled PMF May 11 10:20:34 volumio-spare wpa_supplicant[3199]: wlan0: Trying to associate with 40:3f:8c:ec:ba:8c (SSID='OramNet' freq=5500 MHz) May 11 10:20:34 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 10:20:34 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 10:20:34 volumio-spare volumio[1307]: info: Discovery: Getting this device information May 11 10:20:34 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioGetState May 11 10:20:34 volumio-spare volumio[1307]: info: CorePlayQueue::getTrack 0 May 11 10:20:34 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 10:20:34 volumio-spare wpa_supplicant[3199]: wlan0: Associated with 40:3f:8c:ec:ba:8c May 11 10:20:34 volumio-spare wpa_supplicant[3199]: MBO: Disable MBO/OCE due to misbehaving AP not having enabled PMF May 11 10:20:34 volumio-spare wpa_supplicant[3199]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 May 11 10:20:34 volumio-spare wpa_supplicant[3199]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=DE May 11 10:20:34 volumio-spare wpa_supplicant[3199]: wlan0: WPA: Key negotiation completed with 40:3f:8c:ec:ba:8c [PTK=CCMP GTK=TKIP] May 11 10:20:34 volumio-spare wpa_supplicant[3199]: wlan0: CTRL-EVENT-CONNECTED - Connection to 40:3f:8c:ec:ba:8c completed [id=0 id_str=] May 11 10:20:34 volumio-spare dhcpcd[968]: wlan0: carrier acquired May 11 10:20:34 volumio-spare dhcpcd[968]: wlan0: connected to Access Point: OramNet May 11 10:20:34 volumio-spare dhcpcd[968]: wlan0: IAID dd:eb:47:ca May 11 10:20:34 volumio-spare wireless.js[3011]: trying... May 11 10:20:34 volumio-spare sudo[3228]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 10:20:34 volumio-spare sudo[3228]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:34 volumio-spare sudo[3228]: pam_unix(sudo:session): session closed for user root May 11 10:20:34 volumio-spare dhcpcd[968]: wlan0: soliciting an IPv6 router May 11 10:20:34 volumio-spare dhcpcd[968]: wlan0: soliciting a DHCP lease May 11 10:20:35 volumio-spare wpa_supplicant[3199]: RRM: Ignoring radio measurement request: Not RRM network May 11 10:20:35 volumio-spare wireless.js[3011]: trying... May 11 10:20:35 volumio-spare sudo[3233]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 10:20:35 volumio-spare sudo[3233]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:35 volumio-spare sudo[3233]: pam_unix(sudo:session): session closed for user root May 11 10:20:36 volumio-spare wireless.js[3011]: trying... May 11 10:20:36 volumio-spare sudo[3237]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 10:20:36 volumio-spare sudo[3237]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:36 volumio-spare sudo[3237]: pam_unix(sudo:session): session closed for user root May 11 10:20:37 volumio-spare wireless.js[3011]: trying... May 11 10:20:37 volumio-spare sudo[3241]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 10:20:37 volumio-spare sudo[3241]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:37 volumio-spare sudo[3241]: pam_unix(sudo:session): session closed for user root May 11 10:20:38 volumio-spare wireless.js[3011]: trying... May 11 10:20:38 volumio-spare sudo[3245]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 10:20:38 volumio-spare sudo[3245]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:38 volumio-spare sudo[3245]: pam_unix(sudo:session): session closed for user root May 11 10:20:38 volumio-spare dhcpcd[968]: wlan0: offered 192.168.0.248 from 192.168.0.1 May 11 10:20:38 volumio-spare dhcpcd[968]: wlan0: probing address 192.168.0.248/24 May 11 10:20:39 volumio-spare wireless.js[3011]: trying... May 11 10:20:39 volumio-spare sudo[3250]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 10:20:39 volumio-spare sudo[3250]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:39 volumio-spare sudo[3250]: pam_unix(sudo:session): session closed for user root May 11 10:20:40 volumio-spare wireless.js[3011]: trying... May 11 10:20:40 volumio-spare sudo[3254]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 10:20:40 volumio-spare sudo[3254]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:40 volumio-spare sudo[3254]: pam_unix(sudo:session): session closed for user root May 11 10:20:41 volumio-spare wpa_supplicant[3199]: RRM: Ignoring radio measurement request: Not RRM network May 11 10:20:41 volumio-spare wireless.js[3011]: trying... May 11 10:20:41 volumio-spare sudo[3258]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 10:20:41 volumio-spare sudo[3258]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:41 volumio-spare sudo[3258]: pam_unix(sudo:session): session closed for user root May 11 10:20:42 volumio-spare wireless.js[3011]: trying... May 11 10:20:42 volumio-spare sudo[3276]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 10:20:42 volumio-spare sudo[3276]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:42 volumio-spare sudo[3276]: pam_unix(sudo:session): session closed for user root May 11 10:20:42 volumio-spare dhcpcd[968]: wlan0: leased 192.168.0.248 for 7200 seconds May 11 10:20:42 volumio-spare avahi-daemon[900]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.248. May 11 10:20:42 volumio-spare dhcpcd[968]: wlan0: adding route to 192.168.0.0/24 May 11 10:20:42 volumio-spare avahi-daemon[900]: New relevant interface wlan0.IPv4 for mDNS. May 11 10:20:42 volumio-spare dhcpcd[968]: wlan0: adding default route via 192.168.0.1 May 11 10:20:42 volumio-spare avahi-daemon[900]: Registering new address record for 192.168.0.248 on wlan0.IPv4. May 11 10:20:42 volumio-spare systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. May 11 10:20:42 volumio-spare systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... May 11 10:20:42 volumio-spare systemd[1]: welcome.service: Deactivated successfully. May 11 10:20:42 volumio-spare systemd[1]: Stopped welcome.service - Show a welcome message on console. May 11 10:20:42 volumio-spare systemd[1]: Stopping welcome.service - Show a welcome message on console... May 11 10:20:42 volumio-spare systemd[1]: Starting welcome.service - Show a welcome message on console... May 11 10:20:42 volumio-spare welcome[3290]: Resolved ip:[2] 192.168.0.242 192.168.0.248 May 11 10:20:42 volumio-spare systemd[1]: Finished welcome.service - Show a welcome message on console. May 11 10:20:42 volumio-spare systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. May 11 10:20:43 volumio-spare volumio[1307]: info: Discovery: adding 42726e1c-0f86-42b7-a80c-f768d91e4d78 May 11 10:20:43 volumio-spare volumio[1307]: info: Discovery: Found device Volumio May 11 10:20:43 volumio-spare volumio[1307]: info: Discovery: Connecting to remote: 192.168.0.231 May 11 10:20:43 volumio-spare volumio[1307]: info: Discovery: Connected to remote: 192.168.0.231 May 11 10:20:43 volumio-spare wireless.js[3011]: trying... May 11 10:20:43 volumio-spare sudo[3306]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 10:20:43 volumio-spare sudo[3306]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:43 volumio-spare sudo[3306]: pam_unix(sudo:session): session closed for user root May 11 10:20:43 volumio-spare wireless.js[3011]: Connected to: ----OramNet May 11 10:20:43 volumio-spare wireless.js[3011]: ---- May 11 10:20:43 volumio-spare sudo[3309]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 11 10:20:43 volumio-spare sudo[3309]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 11 10:20:43 volumio-spare volumio[1307]: info: Discovery: this is already registered, 42a2b5a2-91c7-4f54-a2ff-d8107b64883b May 11 10:20:43 volumio-spare volumio[1307]: info: Discovery: Found device Volumio Spare May 11 10:20:43 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioGetState May 11 10:20:43 volumio-spare volumio[1307]: info: CorePlayQueue::getTrack 0 May 11 10:20:43 volumio-spare sudo[3309]: pam_unix(sudo:session): session closed for user root May 11 10:20:43 volumio-spare wireless.js[3011]: ... joined AP, wlan0 IPv4 is 192.168.0.248, ipV6 is undefined May 11 10:20:43 volumio-spare wireless.js[3011]: It's done! AP May 11 10:20:43 volumio-spare kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 11 10:20:43 volumio-spare systemd[1]: Started wireless.service - Wireless Services. May 11 10:20:43 volumio-spare sudo[3009]: pam_unix(sudo:session): session closed for user root May 11 10:20:44 volumio-spare ntpd[1080]: IO: Listen normally on 7 wlan0 192.168.0.248:123 May 11 10:20:44 volumio-spare ntpd[1080]: IO: new interface(s) found: waking up resolver May 11 10:20:47 volumio-spare wpa_supplicant[3199]: RRM: Ignoring radio measurement request: Not RRM network May 11 10:20:48 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection May 11 10:20:48 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo May 11 10:20:48 volumio-spare sudo[3315]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 11 10:20:48 volumio-spare sudo[3315]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:48 volumio-spare sudo[3315]: pam_unix(sudo:session): session closed for user root May 11 10:20:48 volumio-spare sudo[3319]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 11 10:20:48 volumio-spare sudo[3319]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:48 volumio-spare sudo[3319]: pam_unix(sudo:session): session closed for user root May 11 10:20:49 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 10:20:49 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 10:20:49 volumio-spare volumio[1307]: info: Discovery: Getting this device information May 11 10:20:49 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioGetState May 11 10:20:49 volumio-spare volumio[1307]: info: CorePlayQueue::getTrack 0 May 11 10:20:49 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 10:20:52 volumio-spare volumio[1307]: info: Volumio Network Manager: Network status updated: 3 May 11 10:20:53 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart May 11 10:20:53 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart May 11 10:20:53 volumio-spare volumio[1307]: info: Refreshing Cached IP Addresses May 11 10:20:53 volumio-spare sudo[3338]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli May 11 10:20:53 volumio-spare sudo[3338]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:53 volumio-spare sudo[3340]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 11 10:20:53 volumio-spare sudo[3340]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:53 volumio-spare sudo[3342]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 11 10:20:53 volumio-spare sudo[3342]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:20:53 volumio-spare sudo[3340]: pam_unix(sudo:session): session closed for user root May 11 10:20:53 volumio-spare sudo[3342]: pam_unix(sudo:session): session closed for user root May 11 10:20:53 volumio-spare sudo[3338]: pam_unix(sudo:session): session closed for user root May 11 10:20:53 volumio-spare systemd[1]: upmpdcli.service: Deactivated successfully. May 11 10:21:00 volumio-spare volumio[1307]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 10:21:00 volumio-spare volumio[1307]: info: Retrieving Cloud Streaming UI May 11 10:21:00 volumio-spare volumio[1307]: info: Getting Tidal Cloud Configuration May 11 10:21:00 volumio-spare volumio[1307]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 10:21:00 volumio-spare volumio[1307]: info: Getting Qobuz Cloud Configuration May 11 10:21:00 volumio-spare volumio[1307]: info: Asking plugin for UI Config May 11 10:21:00 volumio-spare volumio[1307]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 10:21:00 volumio-spare volumio[1307]: info: Getting Spotify Cloud Configuration May 11 10:21:00 volumio-spare volumio[1307]: info: Asking plugin for UI Config May 11 10:21:00 volumio-spare volumio[1307]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 10:21:00 volumio-spare volumio[1307]: info: Saving Spotify Acccount May 11 10:21:00 volumio-spare volumio[1307]: info: Got Tidal Cloud Configuration May 11 10:21:00 volumio-spare volumio[1307]: info: Got it May 11 10:21:00 volumio-spare volumio[1307]: info: Got it May 11 10:21:00 volumio-spare volumio[1307]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 11 10:21:00 volumio-spare volumio[1307]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 10:21:00 volumio-spare volumio[1307]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') May 11 10:21:02 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation May 11 10:21:02 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware May 11 10:21:02 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray May 11 10:21:02 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage May 11 10:21:02 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware May 11 10:21:03 volumio-spare sudo[3369]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 11 10:21:03 volumio-spare sudo[3369]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:21:03 volumio-spare sudo[3369]: pam_unix(sudo:session): session closed for user root May 11 10:21:03 volumio-spare sudo[3371]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 11 10:21:03 volumio-spare sudo[3371]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:21:03 volumio-spare sudo[3371]: pam_unix(sudo:session): session closed for user root May 11 10:21:03 volumio-spare sudo[3375]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 11 10:21:03 volumio-spare sudo[3375]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:21:03 volumio-spare systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. May 11 10:21:03 volumio-spare sudo[3375]: pam_unix(sudo:session): session closed for user root May 11 10:21:03 volumio-spare volumio[1307]: info: Upmpdcli Daemon Started May 11 10:21:03 volumio-spare upmpdcli[3393]: writing RSA key May 11 10:21:06 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction May 11 10:21:06 volumio-spare volumio[1307]: info: CoreCommandRouter::Reload Ui May 11 10:21:06 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard May 11 10:21:06 volumio-spare volumio[1307]: info: Wizard terminated Successfully May 11 10:21:06 volumio-spare volumio[1307]: info: CoreCommandRouter::volumiosetStartupVolume May 11 10:21:06 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 10:21:07 volumio-spare sudo[3401]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 11 10:21:07 volumio-spare sudo[3401]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:21:07 volumio-spare sudo[3401]: pam_unix(sudo:session): session closed for user root May 11 10:21:07 volumio-spare sudo[3403]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 11 10:21:07 volumio-spare sudo[3403]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:21:07 volumio-spare sudo[3403]: pam_unix(sudo:session): session closed for user root May 11 10:21:07 volumio-spare volumio[1307]: verbose: New Socket.io Connection to 192.168.0.242 from 192.168.0.238 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 May 11 10:21:07 volumio-spare sudo[3407]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 11 10:21:07 volumio-spare sudo[3407]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:21:07 volumio-spare sudo[3407]: pam_unix(sudo:session): session closed for user root May 11 10:21:07 volumio-spare sudo[3409]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 11 10:21:07 volumio-spare sudo[3409]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:21:07 volumio-spare sudo[3409]: pam_unix(sudo:session): session closed for user root May 11 10:21:07 volumio-spare volumio[1307]: verbose: New Socket.io Connection to 192.168.0.242 from 192.168.0.238 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 May 11 10:21:07 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 11 10:21:07 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioGetVisibleSources May 11 10:21:07 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 11 10:21:07 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioGetState May 11 10:21:07 volumio-spare volumio[1307]: info: CorePlayQueue::getTrack 0 May 11 10:21:07 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 11 10:21:07 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 11 10:21:07 volumio-spare volumio[1307]: info: Received Get System Info May 11 10:21:07 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 10:21:07 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 10:21:07 volumio-spare volumio[1307]: info: Discovery: Getting this device information May 11 10:21:07 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioGetState May 11 10:21:07 volumio-spare volumio[1307]: info: CorePlayQueue::getTrack 0 May 11 10:21:07 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 10:21:07 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioGetState May 11 10:21:07 volumio-spare volumio[1307]: info: CorePlayQueue::getTrack 0 May 11 10:21:07 volumio-spare volumio[1307]: info: Listing playlists May 11 10:21:07 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 11 10:21:07 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 11 10:21:07 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 11 10:21:08 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioGetState May 11 10:21:08 volumio-spare volumio[1307]: info: CorePlayQueue::getTrack 0 May 11 10:21:09 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 11 10:21:09 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 11 10:21:09 volumio-spare volumio[1307]: info: Received Get System Info May 11 10:21:09 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 10:21:09 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 10:21:09 volumio-spare volumio[1307]: info: Discovery: Getting this device information May 11 10:21:09 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioGetState May 11 10:21:09 volumio-spare volumio[1307]: info: CorePlayQueue::getTrack 0 May 11 10:21:09 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 10:21:10 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 11 10:21:10 volumio-spare volumio[1307]: info: Received Get System Info May 11 10:21:10 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 10:21:10 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 10:21:10 volumio-spare volumio[1307]: info: Discovery: Getting this device information May 11 10:21:10 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioGetState May 11 10:21:10 volumio-spare volumio[1307]: info: CorePlayQueue::getTrack 0 May 11 10:21:10 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 10:21:13 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse May 11 10:21:13 volumio-spare wpa_supplicant[3199]: RRM: Ignoring radio measurement request: Not RRM network May 11 10:21:17 volumio-spare wpa_supplicant[3199]: RRM: Ignoring radio measurement request: Not RRM network May 11 10:21:17 volumio-spare volumio[1307]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 10:21:17 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 11 10:21:17 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 11 10:21:17 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 11 10:21:17 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs May 11 10:21:17 volumio-spare volumio[1307]: info: Received Get System Version May 11 10:21:17 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 11 10:21:17 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 11 10:21:19 volumio-spare volumio[1307]: info: CoreCommandRouter::Close All Modals sent May 11 10:21:19 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: appearance , setTOSAccepted May 11 10:21:25 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 11 10:21:25 volumio-spare volumio[1307]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 11 10:21:25 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 11 10:21:25 volumio-spare volumio[1307]: info: Received Get System Version May 11 10:21:25 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 11 10:21:25 volumio-spare volumio[1307]: info: Received Get System Info May 11 10:21:25 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 10:21:25 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 10:21:25 volumio-spare volumio[1307]: info: Discovery: Getting this device information May 11 10:21:25 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioGetState May 11 10:21:25 volumio-spare volumio[1307]: info: CorePlayQueue::getTrack 0 May 11 10:21:25 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 10:21:26 volumio-spare volumio[1307]: info: CALLMETHOD: miscellanea appearance setVolumio3UI [object Object] May 11 10:21:26 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: appearance , setVolumio3UI May 11 10:21:26 volumio-spare volumio[1307]: info: Setting active UI to: {"uiPrettyName":"Contemporary","uiName":"contemporary","uiPath":"/volumio/http/www3"} May 11 10:21:27 volumio-spare volumio[1307]: info: CoreCommandRouter::Reload Ui May 11 10:21:27 volumio-spare sudo[3462]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 11 10:21:27 volumio-spare sudo[3462]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:21:27 volumio-spare sudo[3464]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 11 10:21:27 volumio-spare sudo[3464]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 11 10:21:27 volumio-spare sudo[3462]: pam_unix(sudo:session): session closed for user root May 11 10:21:27 volumio-spare sudo[3464]: pam_unix(sudo:session): session closed for user root May 11 10:21:27 volumio-spare volumio[1307]: verbose: New Socket.io Connection to 192.168.0.242 from 192.168.0.238 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 May 11 10:21:27 volumio-spare volumio[1307]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 10:21:27 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 11 10:21:27 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 11 10:21:27 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 11 10:21:27 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs May 11 10:21:27 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 11 10:21:27 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioGetState May 11 10:21:27 volumio-spare volumio[1307]: info: CorePlayQueue::getTrack 0 May 11 10:21:27 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioGetVisibleSources May 11 10:21:27 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 11 10:21:27 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 11 10:21:27 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 11 10:21:27 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 11 10:21:27 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 11 10:21:27 volumio-spare volumio[1307]: info: Received Get System Version May 11 10:21:27 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 11 10:21:27 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds May 11 10:21:28 volumio-spare wpa_supplicant[3199]: RRM: Ignoring radio measurement request: Not RRM network May 11 10:21:29 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 11 10:21:29 volumio-spare volumio[1307]: info: Received Get System Info May 11 10:21:29 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 10:21:29 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 10:21:29 volumio-spare volumio[1307]: info: Discovery: Getting this device information May 11 10:21:29 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioGetState May 11 10:21:29 volumio-spare volumio[1307]: info: CorePlayQueue::getTrack 0 May 11 10:21:29 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 10:21:30 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 11 10:21:30 volumio-spare volumio[1307]: info: Received Get System Info May 11 10:21:30 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 10:21:30 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 10:21:30 volumio-spare volumio[1307]: info: Discovery: Getting this device information May 11 10:21:30 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioGetState May 11 10:21:30 volumio-spare volumio[1307]: info: CorePlayQueue::getTrack 0 May 11 10:21:30 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 10:21:31 volumio-spare wpa_supplicant[3199]: RRM: Ignoring radio measurement request: Not RRM network May 11 10:21:32 volumio-spare nmbd[2973]: [2025/05/11 10:21:32.426637, 0] ../../source3/libsmb/nmblib.c:923(send_udp) May 11 10:21:32 volumio-spare nmbd[2973]: Packet send failed to 169.254.255.255(138) ERRNO=Network is unreachable May 11 10:21:32 volumio-spare nmbd[2973]: [2025/05/11 10:21:32.426776, 0] ../../source3/libsmb/nmblib.c:923(send_udp) May 11 10:21:32 volumio-spare nmbd[2973]: Packet send failed to 192.168.211.255(138) ERRNO=Network is unreachable May 11 10:21:36 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: appearance , setBackgrounds May 11 10:21:36 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds May 11 10:21:36 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 11 10:21:44 volumio-spare wpa_supplicant[3199]: RRM: Ignoring radio measurement request: Not RRM network May 11 10:21:45 volumio-spare volumio[1307]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 10:21:45 volumio-spare volumio[1307]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 10:21:45 volumio-spare volumio[1307]: info: Retrieving Cloud Streaming UI May 11 10:21:45 volumio-spare volumio[1307]: info: Getting Tidal Cloud Configuration May 11 10:21:45 volumio-spare volumio[1307]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 10:21:45 volumio-spare volumio[1307]: info: Getting Qobuz Cloud Configuration May 11 10:21:45 volumio-spare volumio[1307]: info: Asking plugin for UI Config May 11 10:21:45 volumio-spare volumio[1307]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 10:21:45 volumio-spare volumio[1307]: info: Getting Spotify Cloud Configuration May 11 10:21:45 volumio-spare volumio[1307]: info: Asking plugin for UI Config May 11 10:21:45 volumio-spare volumio[1307]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 10:21:45 volumio-spare volumio[1307]: info: Saving Spotify Acccount May 11 10:21:45 volumio-spare volumio[1307]: info: Got Tidal Cloud Configuration May 11 10:21:45 volumio-spare volumio[1307]: info: Got it May 11 10:21:45 volumio-spare volumio[1307]: info: Got it May 11 10:21:45 volumio-spare volumio[1307]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 11 10:21:45 volumio-spare volumio[1307]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 10:21:45 volumio-spare volumio[1307]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') May 11 10:21:45 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 11 10:21:45 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 11 10:21:45 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 11 10:21:45 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 11 10:21:45 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 10:21:45 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 10:21:45 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 10:21:45 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 10:21:45 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioGetBrowseSources May 11 10:21:45 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioGetBrowseSources May 11 10:21:45 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioGetBrowseSources May 11 10:21:45 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 11 10:21:45 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 11 10:21:45 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 11 10:21:45 volumio-spare volumio[1307]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 11 10:21:45 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 11 10:21:45 volumio-spare volumio[1307]: info: Received Get System Version May 11 10:21:45 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 11 10:21:45 volumio-spare volumio[1307]: info: Received Get System Info May 11 10:21:45 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 10:21:45 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 10:21:45 volumio-spare volumio[1307]: info: Discovery: Getting this device information May 11 10:21:45 volumio-spare volumio[1307]: info: CoreCommandRouter::volumioGetState May 11 10:21:45 volumio-spare volumio[1307]: info: CorePlayQueue::getTrack 0 May 11 10:21:45 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 10:21:47 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares May 11 10:21:47 volumio-spare volumio[1307]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService May 11 10:21:47 volumio-spare volumio[1307]: compat.c: read() failed: Resource temporarily unavailable May 11 10:21:47 volumio-spare volumio[1307]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 11 10:21:47 volumio-spare volumio[1307]: Error: dns service error: unknown May 11 10:21:47 volumio-spare volumio[1307]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { May 11 10:21:47 volumio-spare volumio[1307]: errorCode: -65537 May 11 10:21:47 volumio-spare volumio[1307]: } May 11 10:21:47 volumio-spare volumio[1307]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 11 10:21:47 volumio-spare sudo[3532]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-05-11 10:20' May 11 10:21:47 volumio-spare sudo[3532]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="5431d94b4ec10a9432d7232ad6f9406bf7be8de2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Apr 24 12:55:04 UTC 2025" VOLUMIO_VERSION="0.060" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="96943b9514b750671d63915838f6ba9a"