Oct 26 02:53:06 volumio volumio[1341]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Oct 26 02:53:06 volumio volumio[1341]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 26 02:53:06 volumio volumio-remote-updater[863]: Test mode disabled Oct 26 02:53:06 volumio volumio-remote-updater[863]: Alpha mode disabled Oct 26 02:53:06 volumio volumio-remote-updater[863]: Alpha legacy test mode disabled Oct 26 02:53:06 volumio volumio[1341]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 26 02:53:06 volumio volumio[1341]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 26 02:53:06 volumio volumio[1341]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 26 02:53:10 volumio volumio[1341]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Oct 26 02:53:10 volumio volumio[1341]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 26 02:53:10 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Oct 26 02:53:10 volumio volumio-remote-updater[863]: Test mode disabled Oct 26 02:53:10 volumio volumio-remote-updater[863]: Alpha mode disabled Oct 26 02:53:10 volumio volumio-remote-updater[863]: Alpha legacy test mode disabled Oct 26 02:53:10 volumio volumio[1341]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 26 02:53:11 volumio volumio[1341]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 26 02:53:11 volumio volumio[1341]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 26 02:53:18 volumio volumio[1341]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Oct 26 02:53:18 volumio volumio[1341]: info: System name has changed, restarting Shairport Sync Oct 26 02:53:18 volumio volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:18 volumio volumio[1341]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 02:53:18 volumio volumio[1341]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 26 02:53:18 volumio volumio[1341]: info: Discovery: Restarting Advertising due to device name change Oct 26 02:53:18 volumio volumio[1341]: info: Starting Shairport Sync Oct 26 02:53:18 volumio sudo[3125]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Oct 26 02:53:18 volumio sudo[3125]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:53:18 volumio sudo[3127]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts Oct 26 02:53:18 volumio sudo[3127]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:53:18 volumio sudo[3127]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:18 volumio volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Oct 26 02:53:18 volumio sudo[3125]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:18 volumio sudo[3131]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 26 02:53:18 volumio sudo[3131]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:53:18 volumio volumio[1341]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 26 02:53:18 volumio volumio[1341]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 02:53:18 volumio volumio[1341]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 26 02:53:18 volumio volumio[1341]: info: Permissions for /etc/hosts set Oct 26 02:53:18 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 26 02:53:18 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Oct 26 02:53:18 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 26 02:53:18 volumio systemd[1]: shairport-sync.service: Consumed 2.064s CPU time. Oct 26 02:53:18 volumio volumio[1341]: info: Hostname now is volumio7 Oct 26 02:53:18 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 26 02:53:18 volumio sudo[3131]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:18 volumio volumio[1341]: info: Shairport-Sync Started Oct 26 02:53:18 volumio sudo[3137]: volumio : unable to resolve host volumio: System error Oct 26 02:53:18 volumio sudo[3140]: volumio : unable to resolve host volumio: System error Oct 26 02:53:18 volumio sudo[3137]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/hostname volumio7 Oct 26 02:53:18 volumio sudo[3137]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:53:18 volumio sudo[3140]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /etc/avahi/services/ Oct 26 02:53:18 volumio sudo[3140]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:53:18 volumio7 sudo[3137]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:18 volumio7 volumio[1341]: info: New hostname set Oct 26 02:53:18 volumio7 sudo[3140]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:18 volumio7 volumio[1341]: info: Permissions for /etc/avahi/services/volumio.service Oct 26 02:53:18 volumio7 avahi-daemon[845]: Files changed, reloading. Oct 26 02:53:18 volumio7 avahi-daemon[845]: Loading service file /services/volumio.service. Oct 26 02:53:18 volumio7 volumio[1341]: info: Avahi name changed to volumio7 Oct 26 02:53:18 volumio7 systemd[1]: upmpdcli.service: Deactivated successfully. Oct 26 02:53:19 volumio7 volumio[1341]: info: Discovery: A device disappeared from network Oct 26 02:53:19 volumio7 volumio[1341]: info: Discovery: Device volumio disappeared from network Oct 26 02:53:19 volumio7 volumio[1341]: info: Discovery: A device disappeared from network Oct 26 02:53:19 volumio7 avahi-daemon[845]: Service "Volumio7" (/services/volumio.service) successfully established. Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Oct 26 02:53:20 volumio7 volumio[1341]: info: Preparing to save Alsa Options, stopping services first Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::volumioGetState Oct 26 02:53:20 volumio7 volumio[1341]: info: CorePlayQueue::getTrack 0 Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::volumioPause Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreStateMachine::pause Oct 26 02:53:20 volumio7 volumio[1341]: info: Saving Audio Output to: {"i2s":false,"output_device":{"value":"0,3","label":"HDMI 0"},"disallowPush":true} Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 26 02:53:20 volumio7 volumio[1341]: info: Found match in Cards Database: setting mixer for card HDMI 0 Oct 26 02:53:20 volumio7 volumio[1341]: info: Setting mixer IEC958 for card HDMI 0 Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 26 02:53:20 volumio7 volumio[1341]: info: Updating Volume Controller Parameters: Device: 0,3 Name: HDMI 0 Mixer: IEC958 Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 26 02:53:20 volumio7 volumio[1341]: info: Disabling external Volume Control Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 26 02:53:20 volumio7 volumio[1341]: info: Preparing to generate the ALSA configuration file Oct 26 02:53:20 volumio7 volumio[1341]: Unable to parse: Oct 26 02:53:20 volumio7 volumio[1341]: Simple mixer control 'IEC958',0 Oct 26 02:53:20 volumio7 volumio[1341]: Capabilities: pswitch pswitch-joined Oct 26 02:53:20 volumio7 volumio[1341]: Playback channels: Mono Oct 26 02:53:20 volumio7 volumio[1341]: Mono: Playback [on] Oct 26 02:53:20 volumio7 volumio[1341]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Oct 26 02:53:20 volumio7 volumio[1341]: info: Asound.conf file unchanged, so no further update is needed Oct 26 02:53:20 volumio7 volumio[1341]: info: Output device has changed, restarting MPD Oct 26 02:53:20 volumio7 volumio[1341]: info: Output device has changed, restarting Shairport Sync Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 02:53:20 volumio7 sudo[3176]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 26 02:53:20 volumio7 sudo[3176]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:53:20 volumio7 sudo[3178]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 26 02:53:20 volumio7 sudo[3176]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:20 volumio7 sudo[3178]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:53:20 volumio7 volumio[1341]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 26 02:53:20 volumio7 volumio[1341]: info: MPD Permissions set Oct 26 02:53:20 volumio7 volumio[1341]: Unable to parse: Oct 26 02:53:20 volumio7 volumio[1341]: Simple mixer control 'IEC958',0 Oct 26 02:53:20 volumio7 volumio[1341]: Capabilities: pswitch pswitch-joined Oct 26 02:53:20 volumio7 volumio[1341]: Playback channels: Mono Oct 26 02:53:20 volumio7 volumio[1341]: Mono: Playback [on] Oct 26 02:53:20 volumio7 volumio[1341]: info: VolumeController:: Volume=undefined Mute =false Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreStateMachine::pushState Oct 26 02:53:20 volumio7 volumio[1341]: info: CorePlayQueue::getTrack 0 Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::volumioPushState Oct 26 02:53:20 volumio7 systemd[1]: Stopping mpd.service - Music Player Daemon... Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 26 02:53:20 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:20 volumio7 volumio[1341]: info: Starting Shairport Sync Oct 26 02:53:20 volumio7 sudo[3200]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 26 02:53:20 volumio7 sudo[3200]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:53:20 volumio7 systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 26 02:53:20 volumio7 systemd[1]: shairport-sync.service: Deactivated successfully. Oct 26 02:53:20 volumio7 systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 26 02:53:20 volumio7 systemd[1]: shairport-sync.service: Consumed 1.530s CPU time. Oct 26 02:53:20 volumio7 systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 26 02:53:20 volumio7 sudo[3200]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:20 volumio7 volumio[1341]: info: Shairport-Sync Started Oct 26 02:53:20 volumio7 systemd[1]: mpd.service: Deactivated successfully. Oct 26 02:53:20 volumio7 systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 26 02:53:20 volumio7 systemd[1]: mpd.service: Consumed 1.397s CPU time. Oct 26 02:53:20 volumio7 systemd[1]: mpd.socket: Deactivated successfully. Oct 26 02:53:20 volumio7 systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 26 02:53:20 volumio7 systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 26 02:53:20 volumio7 systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 26 02:53:20 volumio7 systemd[1]: Starting mpd.service - Music Player Daemon... Oct 26 02:53:20 volumio7 sudo[3204]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 26 02:53:20 volumio7 sudo[3204]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 26 02:53:20 volumio7 sudo[3204]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:21 volumio7 mpd[3220]: 2025-10-26T02:53:21 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 26 02:53:21 volumio7 systemd[1]: Started mpd.service - Music Player Daemon. Oct 26 02:53:21 volumio7 sudo[3178]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:21 volumio7 volumio[1341]: error: updateQueue error: null Oct 26 02:53:22 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Oct 26 02:53:22 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Oct 26 02:53:22 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 26 02:53:22 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 02:53:22 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 26 02:53:23 volumio7 volumio[1341]: info: Discovery: Started advertising with name: Volumio7 Oct 26 02:53:24 volumio7 sudo[3234]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Oct 26 02:53:24 volumio7 sudo[3234]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:53:24 volumio7 systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Oct 26 02:53:24 volumio7 systemd[1]: mpd_monitor.service: Deactivated successfully. Oct 26 02:53:24 volumio7 systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Oct 26 02:53:24 volumio7 systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Oct 26 02:53:24 volumio7 mpd_monitor.sh[3236]: MPD Monitor Service: Starting MPD Monitor Service Oct 26 02:53:24 volumio7 sudo[3234]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:24 volumio7 volumio[1341]: info: Successfully started MPD Monitor Oct 26 02:53:24 volumio7 volumio[1341]: info: Discovery: adding 088f18d0-2d3b-4abd-89b5-bb8f85ba6212 Oct 26 02:53:24 volumio7 volumio[1341]: info: Discovery: Found device Volumio7 Oct 26 02:53:24 volumio7 volumio[1341]: info: CoreCommandRouter::volumioGetState Oct 26 02:53:24 volumio7 volumio[1341]: info: CorePlayQueue::getTrack 0 Oct 26 02:53:24 volumio7 volumio[1341]: info: Discovery: this is already registered, 088f18d0-2d3b-4abd-89b5-bb8f85ba6212 Oct 26 02:53:24 volumio7 volumio[1341]: info: Discovery: Found device Volumio7 Oct 26 02:53:24 volumio7 volumio[1341]: info: CoreCommandRouter::volumioGetState Oct 26 02:53:24 volumio7 volumio[1341]: info: CorePlayQueue::getTrack 0 Oct 26 02:53:24 volumio7 volumio[1341]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Oct 26 02:53:24 volumio7 volumio[1341]: info: CoreStateMachine::getcurrentVolume Oct 26 02:53:24 volumio7 volumio[1341]: info: CoreCommandRouter::volumioRetrievevolume Oct 26 02:53:24 volumio7 volumio[1341]: Unable to parse: Oct 26 02:53:24 volumio7 volumio[1341]: Simple mixer control 'IEC958',0 Oct 26 02:53:24 volumio7 volumio[1341]: Capabilities: pswitch pswitch-joined Oct 26 02:53:24 volumio7 volumio[1341]: Playback channels: Mono Oct 26 02:53:24 volumio7 volumio[1341]: Mono: Playback [on] Oct 26 02:53:24 volumio7 volumio[1341]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Oct 26 02:53:24 volumio7 volumio[1341]: Unable to parse: Oct 26 02:53:24 volumio7 volumio[1341]: Simple mixer control 'IEC958',0 Oct 26 02:53:24 volumio7 volumio[1341]: Capabilities: pswitch pswitch-joined Oct 26 02:53:24 volumio7 volumio[1341]: Playback channels: Mono Oct 26 02:53:24 volumio7 volumio[1341]: Mono: Playback [on] Oct 26 02:53:24 volumio7 volumio[1341]: info: VolumeController:: Volume=undefined Mute =false Oct 26 02:53:24 volumio7 volumio[1341]: info: CoreStateMachine::pushState Oct 26 02:53:24 volumio7 volumio[1341]: info: CorePlayQueue::getTrack 0 Oct 26 02:53:24 volumio7 volumio[1341]: info: CoreCommandRouter::volumioPushState Oct 26 02:53:24 volumio7 volumio[1341]: info: CoreStateMachine::updateTrackBlock Oct 26 02:53:24 volumio7 volumio[1341]: info: CorePlayQueue::getTrackBlock Oct 26 02:53:24 volumio7 volumio[1341]: info: CoreCommandRouter::volumioRetrievevolume Oct 26 02:53:24 volumio7 volumio[1341]: Unable to parse: Oct 26 02:53:24 volumio7 volumio[1341]: Simple mixer control 'IEC958',0 Oct 26 02:53:24 volumio7 volumio[1341]: Capabilities: pswitch pswitch-joined Oct 26 02:53:24 volumio7 volumio[1341]: Playback channels: Mono Oct 26 02:53:24 volumio7 volumio[1341]: Mono: Playback [on] Oct 26 02:53:24 volumio7 volumio[1341]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Oct 26 02:53:24 volumio7 volumio[1341]: Unable to parse: Oct 26 02:53:24 volumio7 volumio[1341]: Simple mixer control 'IEC958',0 Oct 26 02:53:24 volumio7 volumio[1341]: Capabilities: pswitch pswitch-joined Oct 26 02:53:24 volumio7 volumio[1341]: Playback channels: Mono Oct 26 02:53:24 volumio7 volumio[1341]: Mono: Playback [on] Oct 26 02:53:24 volumio7 volumio[1341]: info: VolumeController:: Volume=undefined Mute =false Oct 26 02:53:24 volumio7 volumio[1341]: info: CoreStateMachine::pushState Oct 26 02:53:24 volumio7 volumio[1341]: info: CorePlayQueue::getTrack 0 Oct 26 02:53:24 volumio7 volumio[1341]: info: CoreCommandRouter::volumioPushState Oct 26 02:53:28 volumio7 sudo[3265]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/samba/smb.conf Oct 26 02:53:28 volumio7 sudo[3265]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:53:28 volumio7 sudo[3267]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /data/INTERNAL Oct 26 02:53:28 volumio7 sudo[3267]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:53:28 volumio7 sudo[3267]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:28 volumio7 sudo[3265]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:28 volumio7 volumio[1341]: info: smb.conf Permissions set Oct 26 02:53:28 volumio7 volumio[1341]: info: Internal perms successfully set Oct 26 02:53:28 volumio7 sudo[3271]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart nmbd.service Oct 26 02:53:28 volumio7 sudo[3271]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:53:28 volumio7 nmbd[1174]: [2025/10/26 02:53:28.521301, 0] ../../source3/nmbd/nmbd.c:59(terminate) Oct 26 02:53:28 volumio7 nmbd[1174]: Got SIGTERM: going down... Oct 26 02:53:28 volumio7 systemd[1]: Stopping nmbd.service - Samba NMB Daemon... Oct 26 02:53:28 volumio7 systemd[1]: nmbd.service: Deactivated successfully. Oct 26 02:53:28 volumio7 systemd[1]: Stopped nmbd.service - Samba NMB Daemon. Oct 26 02:53:28 volumio7 sudo[3275]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 26 02:53:28 volumio7 sudo[3275]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:53:28 volumio7 systemd[1]: Starting nmbd.service - Samba NMB Daemon... Oct 26 02:53:28 volumio7 sudo[3277]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 26 02:53:28 volumio7 sudo[3277]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:53:28 volumio7 sudo[3275]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:28 volumio7 sudo[3277]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:28 volumio7 sudo[3280]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 26 02:53:28 volumio7 sudo[3280]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:53:28 volumio7 systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 26 02:53:28 volumio7 sudo[3280]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:28 volumio7 volumio[1341]: info: Upmpdcli Daemon Started Oct 26 02:53:28 volumio7 upmpdcli[3301]: writing RSA key Oct 26 02:53:28 volumio7 nmbd[3306]: [2025/10/26 02:53:28.715471, 0] ../../source3/nmbd/nmbd.c:901(main) Oct 26 02:53:28 volumio7 nmbd[3306]: nmbd version 4.17.12-Debian started. Oct 26 02:53:28 volumio7 nmbd[3306]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Oct 26 02:53:28 volumio7 nmbd[3306]: [2025/10/26 02:53:28.717657, 0] ../../source3/nmbd/asyncdns.c:158(start_async_dns) Oct 26 02:53:28 volumio7 nmbd[3306]: started asyncdns process 3307 Oct 26 02:53:28 volumio7 systemd[1]: Started nmbd.service - Samba NMB Daemon. Oct 26 02:53:28 volumio7 sudo[3271]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:28 volumio7 sudo[3309]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart smbd.service Oct 26 02:53:28 volumio7 sudo[3309]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:53:28 volumio7 systemd[1]: Stopping smbd.service - Samba SMB Daemon... Oct 26 02:53:28 volumio7 systemd[1]: smbd.service: Deactivated successfully. Oct 26 02:53:28 volumio7 systemd[1]: Stopped smbd.service - Samba SMB Daemon. Oct 26 02:53:28 volumio7 systemd[1]: Starting smbd.service - Samba SMB Daemon... Oct 26 02:53:28 volumio7 smbd[3314]: [2025/10/26 02:53:28.891318, 0] ../../source3/smbd/server.c:1741(main) Oct 26 02:53:28 volumio7 smbd[3314]: smbd version 4.17.12-Debian started. Oct 26 02:53:28 volumio7 smbd[3314]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Oct 26 02:53:28 volumio7 systemd[1]: Started smbd.service - Samba SMB Daemon. Oct 26 02:53:28 volumio7 sudo[3309]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:28 volumio7 volumio[1341]: info: SAMBA Restarted Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Oct 26 02:53:31 volumio7 volumio[1341]: info: Preparing to save Alsa Options, stopping services first Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::volumioGetState Oct 26 02:53:31 volumio7 volumio[1341]: info: CorePlayQueue::getTrack 0 Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::volumioPause Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreStateMachine::pause Oct 26 02:53:31 volumio7 volumio[1341]: info: Saving Audio Output to: {"i2s":false,"output_device":{"value":"5","label":"Combo384 Amanero"},"disallowPush":true} Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 26 02:53:31 volumio7 volumio[1341]: info: Setting mixer PCM for card Combo384 Amanero Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 26 02:53:31 volumio7 volumio[1341]: info: Updating Volume Controller Parameters: Device: 5 Name: Combo384 Amanero Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 26 02:53:31 volumio7 volumio[1341]: info: Disabling external Volume Control Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 26 02:53:31 volumio7 volumio[1341]: info: Preparing to generate the ALSA configuration file Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Oct 26 02:53:31 volumio7 sudo[3335]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 26 02:53:31 volumio7 sudo[3335]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 26 02:53:31 volumio7 volumio[1341]: info: VolumeController:: Volume=46 Mute =false Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreStateMachine::pushState Oct 26 02:53:31 volumio7 volumio[1341]: info: CorePlayQueue::getTrack 0 Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::volumioPushState Oct 26 02:53:31 volumio7 volumio[1341]: info: Asound.conf file written Oct 26 02:53:31 volumio7 sudo[3349]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 26 02:53:31 volumio7 sudo[3337]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 26 02:53:31 volumio7 sudo[3349]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:53:31 volumio7 sudo[3337]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:53:31 volumio7 sudo[3337]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:31 volumio7 sudo[3349]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:31 volumio7 volumio[1341]: No state is present for card HDMI Oct 26 02:53:31 volumio7 volumio[1341]: Found hardware: "HDA-Intel" "Intel Haswell HDMI" "HDA:80862807,80860101,00100000" "0x17aa" "0x3978" Oct 26 02:53:31 volumio7 volumio[1341]: Hardware is initialized using a generic method Oct 26 02:53:31 volumio7 volumio[1341]: No state is present for card HDMI Oct 26 02:53:31 volumio7 volumio[1341]: No state is present for card PCH Oct 26 02:53:31 volumio7 volumio[1341]: Found hardware: "HDA-Intel" "Realtek ALC233" "HDA:10ec0233,17aa3817,00100003" "0x17aa" "0x3978" Oct 26 02:53:31 volumio7 volumio[1341]: Hardware is initialized using a generic method Oct 26 02:53:31 volumio7 volumio[1341]: No state is present for card PCH Oct 26 02:53:31 volumio7 volumio[1341]: No state is present for card Amanero Oct 26 02:53:31 volumio7 volumio[1341]: Found hardware: "USB-Audio" "USB Mixer" "USB16d0:071a" "" "" Oct 26 02:53:31 volumio7 volumio[1341]: Hardware is initialized using a generic method Oct 26 02:53:31 volumio7 volumio[1341]: No state is present for card Amanero Oct 26 02:53:31 volumio7 volumio[1341]: info: Output device has changed, restarting MPD Oct 26 02:53:31 volumio7 volumio[1341]: info: Output device has changed, restarting Shairport Sync Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 02:53:31 volumio7 sudo[3357]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 26 02:53:31 volumio7 sudo[3357]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:53:31 volumio7 sudo[3357]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:31 volumio7 volumio[1341]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 26 02:53:31 volumio7 volumio[1341]: info: Output device has changed, restarting MPD Oct 26 02:53:31 volumio7 sudo[3360]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 26 02:53:31 volumio7 sudo[3360]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:53:31 volumio7 volumio[1341]: info: Output device has changed, restarting Shairport Sync Oct 26 02:53:31 volumio7 systemd[1]: Stopping mpd.service - Music Player Daemon... Oct 26 02:53:31 volumio7 sudo[3368]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 26 02:53:31 volumio7 sudo[3368]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 02:53:31 volumio7 sudo[3369]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 26 02:53:31 volumio7 sudo[3369]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:53:31 volumio7 sudo[3368]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:31 volumio7 volumio[1341]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 26 02:53:31 volumio7 volumio[1341]: info: MPD Permissions set Oct 26 02:53:31 volumio7 volumio[1341]: info: MPD Permissions set Oct 26 02:53:31 volumio7 volumio[1341]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Oct 26 02:53:31 volumio7 volumio[1341]: wlan0 Interface doesn't support scanning : Device or resource busy Oct 26 02:53:31 volumio7 volumio[1341]: info: Cannot use regular scanning, forcing with ap-force Oct 26 02:53:31 volumio7 systemd[1]: mpd.service: Deactivated successfully. Oct 26 02:53:31 volumio7 systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 26 02:53:31 volumio7 systemd[1]: mpd.socket: Deactivated successfully. Oct 26 02:53:31 volumio7 systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 26 02:53:31 volumio7 systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 26 02:53:31 volumio7 sudo[3380]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Oct 26 02:53:31 volumio7 sudo[3380]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:53:31 volumio7 sudo[3380]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:31 volumio7 volumio[1341]: command failed: Device or resource busy (-16) Oct 26 02:53:31 volumio7 volumio[1341]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Oct 26 02:53:31 volumio7 volumio[1341]: command failed: Device or resource busy (-16) Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:31 volumio7 systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 26 02:53:31 volumio7 systemd[1]: Starting mpd.service - Music Player Daemon... Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 26 02:53:31 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 02:53:31 volumio7 volumio[1341]: info: Starting Shairport Sync Oct 26 02:53:31 volumio7 volumio[1341]: info: Starting Shairport Sync Oct 26 02:53:31 volumio7 sudo[3402]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 26 02:53:31 volumio7 sudo[3402]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:53:31 volumio7 sudo[3404]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 26 02:53:31 volumio7 sudo[3404]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:53:31 volumio7 sudo[3386]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 26 02:53:31 volumio7 sudo[3386]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 26 02:53:31 volumio7 sudo[3386]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:31 volumio7 systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 26 02:53:31 volumio7 systemd[1]: shairport-sync.service: Deactivated successfully. Oct 26 02:53:31 volumio7 systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 26 02:53:31 volumio7 systemd[1]: shairport-sync.service: Consumed 1.556s CPU time. Oct 26 02:53:31 volumio7 systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 26 02:53:31 volumio7 sudo[3402]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:31 volumio7 volumio[1341]: info: Shairport-Sync Started Oct 26 02:53:31 volumio7 sudo[3404]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:31 volumio7 volumio[1341]: info: Shairport-Sync Started Oct 26 02:53:32 volumio7 mpd[3408]: 2025-10-26T02:53:32 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 26 02:53:32 volumio7 systemd[1]: Started mpd.service - Music Player Daemon. Oct 26 02:53:32 volumio7 sudo[3369]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:32 volumio7 sudo[3360]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:32 volumio7 volumio[1341]: error: MPD error: The expression evaluated to a falsy value: Oct 26 02:53:32 volumio7 volumio[1341]: assert.ok(self.idling) Oct 26 02:53:32 volumio7 volumio[1341]: error: The expression evaluated to a falsy value: Oct 26 02:53:32 volumio7 volumio[1341]: assert.ok(self.idling) Oct 26 02:53:32 volumio7 volumio[1341]: error: updateQueue error: null Oct 26 02:53:32 volumio7 sudo[3335]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:35 volumio7 volumio[1341]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Oct 26 02:53:35 volumio7 volumio[1341]: info: CoreStateMachine::getcurrentVolume Oct 26 02:53:35 volumio7 volumio[1341]: info: CoreCommandRouter::volumioRetrievevolume Oct 26 02:53:35 volumio7 volumio[1341]: info: VolumeController:: Volume=46 Mute =false Oct 26 02:53:35 volumio7 volumio[1341]: info: CoreStateMachine::pushState Oct 26 02:53:35 volumio7 volumio[1341]: info: CorePlayQueue::getTrack 0 Oct 26 02:53:35 volumio7 volumio[1341]: info: CoreCommandRouter::volumioPushState Oct 26 02:53:35 volumio7 volumio[1341]: info: CoreStateMachine::updateTrackBlock Oct 26 02:53:35 volumio7 volumio[1341]: info: CorePlayQueue::getTrackBlock Oct 26 02:53:35 volumio7 volumio[1341]: info: CoreCommandRouter::volumioRetrievevolume Oct 26 02:53:35 volumio7 volumio[1341]: info: VolumeController:: Volume=46 Mute =false Oct 26 02:53:35 volumio7 volumio[1341]: info: CoreStateMachine::pushState Oct 26 02:53:35 volumio7 volumio[1341]: info: CorePlayQueue::getTrack 0 Oct 26 02:53:35 volumio7 volumio[1341]: info: CoreCommandRouter::volumioPushState Oct 26 02:53:35 volumio7 sudo[3454]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Oct 26 02:53:35 volumio7 sudo[3454]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:53:35 volumio7 sudo[3456]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Oct 26 02:53:35 volumio7 sudo[3456]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:53:35 volumio7 systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Oct 26 02:53:35 volumio7 systemd[1]: mpd_monitor.service: Deactivated successfully. Oct 26 02:53:35 volumio7 systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Oct 26 02:53:35 volumio7 systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Oct 26 02:53:35 volumio7 sudo[3454]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:35 volumio7 volumio[1341]: info: Successfully started MPD Monitor Oct 26 02:53:35 volumio7 mpd_monitor.sh[3459]: MPD Monitor Service: Starting MPD Monitor Service Oct 26 02:53:35 volumio7 systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Oct 26 02:53:35 volumio7 systemd[1]: mpd_monitor.service: Deactivated successfully. Oct 26 02:53:35 volumio7 systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Oct 26 02:53:35 volumio7 systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Oct 26 02:53:35 volumio7 sudo[3456]: pam_unix(sudo:session): session closed for user root Oct 26 02:53:35 volumio7 mpd_monitor.sh[3462]: MPD Monitor Service: Starting MPD Monitor Service Oct 26 02:53:35 volumio7 volumio[1341]: info: Successfully started MPD Monitor Oct 26 02:54:01 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: wizard , connectWirelessNetwork Oct 26 02:54:01 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: network , getWiredInfo Oct 26 02:54:01 volumio7 sudo[3536]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 26 02:54:01 volumio7 sudo[3536]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:54:01 volumio7 sudo[3536]: pam_unix(sudo:session): session closed for user root Oct 26 02:54:01 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings Oct 26 02:54:01 volumio7 volumio[1341]: info: Saving new wireless network Oct 26 02:54:01 volumio7 sudo[3539]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf Oct 26 02:54:01 volumio7 sudo[3539]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:54:01 volumio7 sudo[3539]: pam_unix(sudo:session): session closed for user root Oct 26 02:54:01 volumio7 volumio[1341]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Oct 26 02:54:01 volumio7 volumio[1341]: info: Discovery: Restarting Advertising due to device name change Oct 26 02:54:01 volumio7 sudo[3542]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Oct 26 02:54:01 volumio7 sudo[3542]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:54:01 volumio7 systemd[1]: Stopping wireless.service - Wireless Services... Oct 26 02:54:01 volumio7 systemd[1]: wireless.service: Deactivated successfully. Oct 26 02:54:01 volumio7 systemd[1]: Stopped wireless.service - Wireless Services. Oct 26 02:54:01 volumio7 systemd[1]: Starting wireless.service - Wireless Services... Oct 26 02:54:01 volumio7 wireless.js[3544]: WIRELESS.JS: Single Network Mode enabled, only one network device can be active at a time between ethernet and wireless Oct 26 02:54:01 volumio7 wireless.js[3544]: WIRELESS.JS: Wired network status changed to: ---connected--- Oct 26 02:54:01 volumio7 wireless.js[3544]: WIRELESS.JS: Wireless.js initializing wireless flow Oct 26 02:54:01 volumio7 wireless.js[3544]: WIRELESS.JS: Cleaning previous... Oct 26 02:54:01 volumio7 sudo[3563]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Oct 26 02:54:01 volumio7 sudo[3563]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 26 02:54:01 volumio7 sudo[3563]: pam_unix(sudo:session): session closed for user root Oct 26 02:54:01 volumio7 sudo[3565]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Oct 26 02:54:01 volumio7 sudo[3565]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 26 02:54:02 volumio7 sudo[3565]: pam_unix(sudo:session): session closed for user root Oct 26 02:54:02 volumio7 wireless.js[3544]: WIRELESS.JS: Stopped aP Oct 26 02:54:02 volumio7 sudo[3573]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Oct 26 02:54:02 volumio7 sudo[3573]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:54:02 volumio7 volumio[1341]: info: Discovery: A device disappeared from network Oct 26 02:54:02 volumio7 volumio[1341]: info: Discovery: A device disappeared from network Oct 26 02:54:02 volumio7 sudo[3573]: pam_unix(sudo:session): session closed for user root Oct 26 02:54:02 volumio7 sudo[3576]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 26 02:54:02 volumio7 sudo[3576]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:54:02 volumio7 sudo[3576]: pam_unix(sudo:session): session closed for user root Oct 26 02:54:02 volumio7 sudo[3578]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Oct 26 02:54:02 volumio7 sudo[3578]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:54:02 volumio7 sudo[3578]: pam_unix(sudo:session): session closed for user root Oct 26 02:54:02 volumio7 sudo[3587]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Oct 26 02:54:02 volumio7 sudo[3587]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:54:02 volumio7 sudo[3587]: pam_unix(sudo:session): session closed for user root Oct 26 02:54:02 volumio7 sudo[3589]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Oct 26 02:54:02 volumio7 sudo[3589]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:54:03 volumio7 sudo[3594]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 26 02:54:03 volumio7 sudo[3594]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:54:03 volumio7 sudo[3594]: pam_unix(sudo:session): session closed for user root Oct 26 02:54:03 volumio7 sudo[3589]: pam_unix(sudo:session): session closed for user root Oct 26 02:54:03 volumio7 wireless.js[3544]: WIRELESS.JS: SETTING APPROPRIATE REG DOMAIN: RU Oct 26 02:54:03 volumio7 sudo[3599]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Oct 26 02:54:03 volumio7 sudo[3599]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:54:03 volumio7 sudo[3599]: pam_unix(sudo:session): session closed for user root Oct 26 02:54:03 volumio7 sudo[3601]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set RU Oct 26 02:54:03 volumio7 sudo[3601]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:54:03 volumio7 sudo[3601]: pam_unix(sudo:session): session closed for user root Oct 26 02:54:03 volumio7 wireless.js[3544]: WIRELESS.JS: SUCCESSFULLY SET NEW REGDOMAIN: RU Oct 26 02:54:03 volumio7 wireless.js[3544]: WIRELESS.JS: Single Network Mode: Wired network active, not starting wireless flow Oct 26 02:54:03 volumio7 wireless.js[3544]: WIRELESS.JS: Notified systemd about wireless ready Oct 26 02:54:03 volumio7 systemd[1]: Started wireless.service - Wireless Services. Oct 26 02:54:03 volumio7 sudo[3542]: pam_unix(sudo:session): session closed for user root Oct 26 02:54:04 volumio7 sudo[3610]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 26 02:54:04 volumio7 sudo[3610]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:54:04 volumio7 sudo[3610]: pam_unix(sudo:session): session closed for user root Oct 26 02:54:05 volumio7 sudo[3628]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 26 02:54:05 volumio7 sudo[3628]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:54:05 volumio7 sudo[3628]: pam_unix(sudo:session): session closed for user root Oct 26 02:54:06 volumio7 volumio[1341]: info: Discovery: Started advertising with name: Volumio7 Oct 26 02:54:06 volumio7 sudo[3633]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 26 02:54:06 volumio7 sudo[3633]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 26 02:54:06 volumio7 sudo[3633]: pam_unix(sudo:session): session closed for user root Oct 26 02:54:07 volumio7 volumio[1341]: compat.c: read() failed: Resource temporarily unavailable Oct 26 02:54:07 volumio7 volumio[1341]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 26 02:54:07 volumio7 volumio[1341]: Error: dns service error: unknown Oct 26 02:54:07 volumio7 volumio[1341]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Oct 26 02:54:07 volumio7 volumio[1341]: errorCode: -65537 Oct 26 02:54:07 volumio7 volumio[1341]: } Oct 26 02:54:07 volumio7 volumio[1341]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 26 02:54:07 volumio7 sudo[3651]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-10-26 02:53' Oct 26 02:54:07 volumio7 sudo[3651]: 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="5ef3d56f987d109f3e21bfa246dbbb723cf6a917" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="7840f283c310c38bfe939a4c485727a6ff6a0ce1" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Oct 9 18:33:08 UTC 2025" VOLUMIO_VERSION="4.062" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="434a4f7d2e5f6acafabfcca26b8e5834"