Dec 05 19:11:07 volumiomac volumio[1427]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:07 volumiomac volumio[1427]: info: Restoring Previous Volume level: 100 false false Dec 05 19:11:07 volumiomac volumio[1427]: info: Volume configurations have been set Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 05 19:11:07 volumiomac volumio[1427]: info: Updating Volume Controller Parameters: Device: 5 Name: Logitech Speakerphone P710e Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Dec 05 19:11:07 volumiomac volumio[1427]: info: Disabling external Volume Control Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 05 19:11:07 volumiomac volumio[1427]: info: VolumeController:: Volume=35 Mute =false Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreCommandRouter::servicePushState Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreCommandRouter::servicePushState Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreCommandRouter::servicePushState Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:07 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:11 volumiomac volumio[1427]: info: VolumeController::SetAlsaVolume100 Dec 05 19:11:11 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:11 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:11 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 19:11:11 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:11 volumiomac volumio[1427]: info: CoreCommandRouter::servicePushState Dec 05 19:11:11 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:11 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 19:11:11 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:12 volumiomac volumio[1427]: info: CoreCommandRouter::servicePushState Dec 05 19:11:12 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:12 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:12 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:12 volumiomac volumio[1427]: info: CoreCommandRouter::servicePushState Dec 05 19:11:12 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:12 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:12 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:22 volumiomac volumio[1427]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:22 volumiomac volumio[1427]: info: Restoring Previous Volume level: 100 false false Dec 05 19:11:22 volumiomac volumio[1427]: info: Volume configurations have been set Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 05 19:11:22 volumiomac volumio[1427]: info: Updating Volume Controller Parameters: Device: 5 Name: Logitech Speakerphone P710e Mixer: Auto Gain Control Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Dec 05 19:11:22 volumiomac volumio[1427]: info: Disabling external Volume Control Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 05 19:11:22 volumiomac volumio[1427]: Unable to parse: Dec 05 19:11:22 volumiomac volumio[1427]: Simple mixer control 'Auto Gain Control',0 Dec 05 19:11:22 volumiomac volumio[1427]: Capabilities: pswitch pswitch-joined Dec 05 19:11:22 volumiomac volumio[1427]: Playback channels: Mono Dec 05 19:11:22 volumiomac volumio[1427]: Mono: Playback [off] Dec 05 19:11:22 volumiomac volumio[1427]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Dec 05 19:11:22 volumiomac volumio[1427]: Unable to parse: Dec 05 19:11:22 volumiomac volumio[1427]: Simple mixer control 'Auto Gain Control',0 Dec 05 19:11:22 volumiomac volumio[1427]: Capabilities: pswitch pswitch-joined Dec 05 19:11:22 volumiomac volumio[1427]: Playback channels: Mono Dec 05 19:11:22 volumiomac volumio[1427]: Mono: Playback [off] Dec 05 19:11:22 volumiomac volumio[1427]: info: VolumeController:: Volume=undefined Mute =false Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreCommandRouter::servicePushState Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreCommandRouter::servicePushState Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreCommandRouter::servicePushState Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:22 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:26 volumiomac volumio[1427]: info: VolumeController::SetAlsaVolume100 Dec 05 19:11:26 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:26 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:26 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:26 volumiomac volumio[1427]: info: CoreCommandRouter::servicePushState Dec 05 19:11:26 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:26 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 19:11:26 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:26 volumiomac volumio[1427]: info: CoreCommandRouter::servicePushState Dec 05 19:11:26 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:26 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:26 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:26 volumiomac volumio[1427]: info: CoreCommandRouter::servicePushState Dec 05 19:11:26 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:26 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:36 volumiomac volumio[1427]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Dec 05 19:11:36 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Dec 05 19:11:36 volumiomac sudo[5931]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 05 19:11:36 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:36 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:36 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:36 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:36 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:36 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:36 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:36 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:36 volumiomac sudo[5931]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 19:11:36 volumiomac sudo[5931]: pam_unix(sudo:session): session closed for user root Dec 05 19:11:36 volumiomac sudo[5933]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 05 19:11:36 volumiomac sudo[5933]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 19:11:36 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 05 19:11:36 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 05 19:11:36 volumiomac systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 05 19:11:36 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:36 volumiomac volumio[1427]: info: MPD Permissions set Dec 05 19:11:36 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:36 volumiomac volumio[1427]: info: CoreCommandRouter::servicePushState Dec 05 19:11:36 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:36 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 19:11:36 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:36 volumiomac systemd[1]: mpd.service: Deactivated successfully. Dec 05 19:11:36 volumiomac systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 05 19:11:36 volumiomac systemd[1]: mpd.service: Consumed 3.264s CPU time. Dec 05 19:11:36 volumiomac systemd[1]: mpd.socket: Deactivated successfully. Dec 05 19:11:36 volumiomac systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 05 19:11:36 volumiomac systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 05 19:11:36 volumiomac volumio[1427]: error: [ytcr] Error connecting MPD: Dec 05 19:11:36 volumiomac volumio[1427]: (Error) connect ECONNRESET /run/mpd/socket Dec 05 19:11:36 volumiomac volumio[1427]: Error: connect ECONNRESET /run/mpd/socket Dec 05 19:11:36 volumiomac volumio[1427]: at PipeConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) Dec 05 19:11:36 volumiomac volumio[1427]: Retrying in 5 seconds... Dec 05 19:11:36 volumiomac systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 05 19:11:36 volumiomac systemd[1]: Starting mpd.service - Music Player Daemon... Dec 05 19:11:36 volumiomac sudo[5951]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 05 19:11:36 volumiomac sudo[5951]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 05 19:11:36 volumiomac sudo[5951]: pam_unix(sudo:session): session closed for user root Dec 05 19:11:37 volumiomac mpd[5956]: 2025-12-05T19:11:37 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 05 19:11:37 volumiomac systemd[1]: Started mpd.service - Music Player Daemon. Dec 05 19:11:37 volumiomac sudo[5933]: pam_unix(sudo:session): session closed for user root Dec 05 19:11:37 volumiomac volumio[1427]: error: updateQueue error: null Dec 05 19:11:40 volumiomac sudo[5965]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 05 19:11:40 volumiomac sudo[5965]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 19:11:40 volumiomac systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 05 19:11:40 volumiomac systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 05 19:11:40 volumiomac systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 05 19:11:40 volumiomac systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 05 19:11:40 volumiomac sudo[5965]: pam_unix(sudo:session): session closed for user root Dec 05 19:11:40 volumiomac mpd_monitor.sh[5967]: MPD Monitor Service: Starting MPD Monitor Service Dec 05 19:11:40 volumiomac volumio[1427]: info: Successfully started MPD Monitor Dec 05 19:11:42 volumiomac volumio[1427]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Dec 05 19:11:42 volumiomac volumio[1427]: info: Preparing to save Alsa Options, stopping services first Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPause Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreStateMachine::pause Dec 05 19:11:42 volumiomac volumio[1427]: info: Saving Audio Output to: {"output_device":{"value":"0,0","label":"Analog Out"}} Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 05 19:11:42 volumiomac volumio[1427]: info: Found match in Cards Database: setting mixer for card Analog Out Dec 05 19:11:42 volumiomac volumio[1427]: info: Setting mixer Master for card Analog Out Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 05 19:11:42 volumiomac volumio[1427]: info: Updating Volume Controller Parameters: Device: 0,0 Name: Analog Out Mixer: Master Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Dec 05 19:11:42 volumiomac volumio[1427]: info: Disabling external Volume Control Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 05 19:11:42 volumiomac volumio[1427]: info: Preparing to generate the ALSA configuration file Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 05 19:11:42 volumiomac volumio[1427]: info: VolumeController:: Volume=41 Mute =false Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::servicePushState Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:42 volumiomac volumio[1427]: info: Asound.conf file written Dec 05 19:11:42 volumiomac sudo[5995]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 05 19:11:42 volumiomac sudo[5995]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 19:11:42 volumiomac sudo[5995]: pam_unix(sudo:session): session closed for user root Dec 05 19:11:42 volumiomac volumio[1427]: No state is present for card PCH Dec 05 19:11:42 volumiomac volumio[1427]: Found hardware: "HDA-Intel" "Realtek Generic" "HDA:10ec0233,17aa30c9,00100003 HDA:80862883,80860101,00100000" "0x17aa" "0x30c9" Dec 05 19:11:42 volumiomac volumio[1427]: Hardware is initialized using a generic method Dec 05 19:11:42 volumiomac volumio[1427]: No state is present for card PCH Dec 05 19:11:42 volumiomac volumio[1427]: No state is present for card P710e Dec 05 19:11:42 volumiomac volumio[1427]: Found hardware: "USB-Audio" "USB Mixer" "USB046d:0a4e" "" "" Dec 05 19:11:42 volumiomac volumio[1427]: Hardware is initialized using a generic method Dec 05 19:11:42 volumiomac volumio[1427]: No state is present for card P710e Dec 05 19:11:42 volumiomac volumio[1427]: info: Output device has changed, restarting MPD Dec 05 19:11:42 volumiomac volumio[1427]: info: Output device has changed, restarting Shairport Sync Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 05 19:11:42 volumiomac sudo[6001]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 05 19:11:42 volumiomac sudo[6001]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 19:11:42 volumiomac sudo[6001]: pam_unix(sudo:session): session closed for user root Dec 05 19:11:42 volumiomac sudo[6004]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 05 19:11:42 volumiomac sudo[6004]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 19:11:42 volumiomac volumio[1427]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 05 19:11:42 volumiomac volumio[1427]: info: Output device has changed, restarting MPD Dec 05 19:11:42 volumiomac systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 05 19:11:42 volumiomac volumio[1427]: info: Output device has changed, restarting Shairport Sync Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 05 19:11:42 volumiomac sudo[6011]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 05 19:11:42 volumiomac sudo[6011]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 19:11:42 volumiomac sudo[6011]: pam_unix(sudo:session): session closed for user root Dec 05 19:11:42 volumiomac systemd[1]: mpd.service: Deactivated successfully. Dec 05 19:11:42 volumiomac systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 05 19:11:42 volumiomac sudo[6013]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 05 19:11:42 volumiomac sudo[6013]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 19:11:42 volumiomac systemd[1]: mpd.socket: Deactivated successfully. Dec 05 19:11:42 volumiomac systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 05 19:11:42 volumiomac systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 05 19:11:42 volumiomac volumio[1427]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 05 19:11:42 volumiomac volumio[1427]: info: MPD Permissions set Dec 05 19:11:42 volumiomac volumio[1427]: info: MPD Permissions set Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::servicePushState Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:42 volumiomac systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 05 19:11:42 volumiomac systemd[1]: Starting mpd.service - Music Player Daemon... Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 05 19:11:42 volumiomac systemd[1]: mpd.service: Deactivated successfully. Dec 05 19:11:42 volumiomac systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 05 19:11:42 volumiomac systemd[1]: mpd.socket: Deactivated successfully. Dec 05 19:11:42 volumiomac systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 05 19:11:42 volumiomac systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:42 volumiomac systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:42 volumiomac systemd[1]: Starting mpd.service - Music Player Daemon... Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 05 19:11:42 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:11:42 volumiomac volumio[1427]: error: [ytcr] Error connecting MPD: Dec 05 19:11:42 volumiomac volumio[1427]: (Error) read ECONNRESET Dec 05 19:11:42 volumiomac volumio[1427]: Error: read ECONNRESET Dec 05 19:11:42 volumiomac volumio[1427]: at Pipe.onStreamRead (node:internal/stream_base_commons:217:20) Dec 05 19:11:42 volumiomac volumio[1427]: Retrying in 5 seconds... Dec 05 19:11:42 volumiomac volumio[1427]: info: Starting Shairport Sync Dec 05 19:11:42 volumiomac volumio[1427]: info: Starting Shairport Sync Dec 05 19:11:42 volumiomac sudo[6044]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 05 19:11:42 volumiomac sudo[6044]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 19:11:42 volumiomac sudo[6046]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 05 19:11:42 volumiomac sudo[6046]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 19:11:42 volumiomac systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 05 19:11:42 volumiomac systemd[1]: shairport-sync.service: Deactivated successfully. Dec 05 19:11:42 volumiomac systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 05 19:11:42 volumiomac systemd[1]: shairport-sync.service: Consumed 2.540s CPU time. Dec 05 19:11:42 volumiomac sudo[6033]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 05 19:11:42 volumiomac sudo[6033]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 05 19:11:42 volumiomac sudo[6033]: pam_unix(sudo:session): session closed for user root Dec 05 19:11:42 volumiomac systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 05 19:11:42 volumiomac sudo[6044]: pam_unix(sudo:session): session closed for user root Dec 05 19:11:42 volumiomac volumio[1427]: info: Shairport-Sync Started Dec 05 19:11:42 volumiomac volumio[1427]: (node:1427) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pbeg listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Dec 05 19:11:42 volumiomac volumio[1427]: (Use `node --trace-warnings ...` to show where the warning was created) Dec 05 19:11:42 volumiomac volumio[1427]: (node:1427) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 meta listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Dec 05 19:11:42 volumiomac volumio[1427]: (node:1427) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 prgr listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Dec 05 19:11:42 volumiomac volumio[1427]: (node:1427) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pvol listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Dec 05 19:11:42 volumiomac volumio[1427]: (node:1427) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pend listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Dec 05 19:11:42 volumiomac systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 05 19:11:42 volumiomac systemd[1]: shairport-sync.service: Deactivated successfully. Dec 05 19:11:42 volumiomac systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 05 19:11:42 volumiomac systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 05 19:11:42 volumiomac sudo[6046]: pam_unix(sudo:session): session closed for user root Dec 05 19:11:42 volumiomac volumio[1427]: info: Shairport-Sync Started Dec 05 19:11:43 volumiomac mpd[6051]: 2025-12-05T19:11:43 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 05 19:11:43 volumiomac systemd[1]: Started mpd.service - Music Player Daemon. Dec 05 19:11:43 volumiomac sudo[6004]: pam_unix(sudo:session): session closed for user root Dec 05 19:11:43 volumiomac sudo[6013]: pam_unix(sudo:session): session closed for user root Dec 05 19:11:43 volumiomac volumio[1427]: error: MPD error: The expression evaluated to a falsy value: Dec 05 19:11:43 volumiomac volumio[1427]: assert.ok(self.idling) Dec 05 19:11:43 volumiomac volumio[1427]: error: The expression evaluated to a falsy value: Dec 05 19:11:43 volumiomac volumio[1427]: assert.ok(self.idling) Dec 05 19:11:43 volumiomac volumio[1427]: error: updateQueue error: null Dec 05 19:11:46 volumiomac volumio[1427]: info: VolumeController::SetAlsaVolume40 Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::servicePushState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:46 volumiomac volumio[1427]: info: VolumeController::SetAlsaVolume50 Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::servicePushState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:46 volumiomac volumio[1427]: info: VolumeController::SetAlsaVolume85 Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::servicePushState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreStateMachine::getcurrentVolume Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::volumioRetrievevolume Dec 05 19:11:46 volumiomac volumio[1427]: info: VolumeController:: Volume=85 Mute =false Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreStateMachine::updateTrackBlock Dec 05 19:11:46 volumiomac volumio[1427]: info: CorePlayQueue::getTrackBlock Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::volumioRetrievevolume Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::servicePushState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:46 volumiomac volumio[1427]: info: VolumeController:: Volume=85 Mute =false Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::servicePushState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:46 volumiomac volumio[1427]: info: VolumeController::SetAlsaVolume90 Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::servicePushState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:46 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:46 volumiomac sudo[6096]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 05 19:11:46 volumiomac sudo[6096]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 19:11:46 volumiomac sudo[6098]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 05 19:11:46 volumiomac sudo[6098]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 19:11:46 volumiomac systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 05 19:11:46 volumiomac systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 05 19:11:46 volumiomac systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 05 19:11:46 volumiomac systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 05 19:11:46 volumiomac sudo[6096]: pam_unix(sudo:session): session closed for user root Dec 05 19:11:46 volumiomac systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 05 19:11:46 volumiomac volumio[1427]: info: Successfully started MPD Monitor Dec 05 19:11:46 volumiomac systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 05 19:11:46 volumiomac systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 05 19:11:46 volumiomac systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 05 19:11:46 volumiomac sudo[6098]: pam_unix(sudo:session): session closed for user root Dec 05 19:11:46 volumiomac mpd_monitor.sh[6102]: MPD Monitor Service: Starting MPD Monitor Service Dec 05 19:11:46 volumiomac volumio[1427]: info: Successfully started MPD Monitor Dec 05 19:11:48 volumiomac volumio[1427]: info: CoreCommandRouter::volumioVolatilePlay Dec 05 19:11:48 volumiomac volumio[1427]: info: CoreStateMachine::volatilePlay Dec 05 19:11:48 volumiomac volumio[1427]: info: [yt-cast-receiver] Player.resume() Dec 05 19:11:48 volumiomac volumio[1427]: info: [yt-cast-receiver] Player.play(): j6cbFOMrB4Q @ 0s Dec 05 19:11:48 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:49 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:50 volumiomac volumio[1427]: info: [ytcr] (j6cbFOMrB4Q) fetching player data using TV client... Dec 05 19:11:50 volumiomac volumio[1427]: info: [ytcr] (Wonderful (From "Wicked" Original Broadway Cast Recording/2003 / Audio)) validating stream URL "https://rr5---sn-uhvcpax0n5-qxoz.googlevideo.com/videoplayback?expire=1764983510&ei=di4zadH4F4Sklu8P_4WKeA&ip=172.59.0.152&id=o-APf07v7QO9WHjfLVEOGBjbnMBOa3X1C56xu5SNyeaIkS&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=127&met=1764961910%2C&mh=C7&mm=31%2C29&mn=sn-uhvcpax0n5-qxoz%2Csn-qxoedn7k&ms=au%2Crdu&mv=m&mvi=5&pl=23&rms=au%2Cau&gcr=us&initcwndbps=1467500&siu=1&bui=AdEuB5RwwqlAaFSkewrZUAxB9QSd_Ua_HAfe9QFkshKke4nwrOhqfd_eebKiKGliXG_VmMszlA&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=gvgydIPClxXKQ3zswNv94QYQ&rqh=1&gir=yes&clen=5180930&dur=298.461&lmt=1761168937211257&mt=1764961532&fvip=4&keepalive=yes&lmw=1&fexp=51557447%2C51565116%2C51565682%2C51580970&c=TVHTML5&sefc=1&txp=5432534&n=w5BLdfIUs-StxA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cgcr%2Csiu%2Cbui%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgKV2_gDuFwnl1VLttq2JGEr3-JdUjGMer2FaXsQleCbcCIGw0gOQPrJhAQA8uNKoeTEpo4wR5ZoLBKM5UahKHvq-M&sig=AJfQdSswRQIhAPuaF_VHsohN7Ss_XV_Qwl_suPKeubBrfYgpRo4fbUopAiBlKbv4Gy-D7MFk82SGa2UPK1vHBcPcoFZ3_Ke4UQoNNA%3D%3D&pot=MlWS1TQsJ59McZLrdxwXkLjP_rzsyeg46m8nARSh9Nj0VJSUMlNq-SyKZ8bS1tw26XXNoUVEy3G4xkB_cTlQTP7TTio_KQvnC6WU9S30m8n3Ld3N-KNK&cver=7.20250219.14.00"... Dec 05 19:11:51 volumiomac volumio[1427]: info: [ytcr] (Wonderful (From "Wicked" Original Broadway Cast Recording/2003 / Audio)) stream validated in 0.175s. Dec 05 19:11:51 volumiomac volumio[1427]: info: Ignoring MPD Status Update Dec 05 19:11:51 volumiomac volumio[1427]: info: Ignoring MPD Status Update Dec 05 19:11:51 volumiomac volumio[1427]: info: Ignoring MPD Status Update Dec 05 19:11:51 volumiomac volumio[1427]: info: Ignoring MPD Status Update Dec 05 19:11:51 volumiomac volumio[1427]: info: Ignoring MPD Status Update Dec 05 19:11:51 volumiomac volumio[1427]: info: Ignoring MPD Status Update Dec 05 19:11:51 volumiomac volumio[1427]: info: Ignoring MPD Status Update Dec 05 19:11:51 volumiomac volumio[1427]: info: Ignoring MPD Status Update Dec 05 19:11:51 volumiomac volumio[1427]: info: Ignoring MPD Status Update Dec 05 19:11:51 volumiomac volumio[1427]: info: Ignoring MPD Status Update Dec 05 19:11:51 volumiomac volumio[1427]: info: Ignoring MPD Status Update Dec 05 19:11:51 volumiomac volumio[1427]: info: Ignoring MPD Status Update Dec 05 19:11:51 volumiomac volumio[1427]: info: Ignoring MPD Status Update Dec 05 19:11:51 volumiomac volumio[1427]: info: Ignoring MPD Status Update Dec 05 19:11:51 volumiomac volumio[1427]: info: Ignoring MPD Status Update Dec 05 19:11:51 volumiomac volumio[1427]: info: Ignoring MPD Status Update Dec 05 19:11:51 volumiomac volumio[1427]: info: Ignoring MPD Status Update Dec 05 19:11:51 volumiomac volumio[1427]: info: Ignoring MPD Status Update Dec 05 19:11:51 volumiomac volumio[1427]: info: Ignoring MPD Status Update Dec 05 19:11:51 volumiomac volumio[1427]: info: Ignoring MPD Status Update Dec 05 19:11:51 volumiomac volumio[1427]: info: Ignoring MPD Status Update Dec 05 19:11:51 volumiomac volumio[1427]: info: Ignoring MPD Status Update Dec 05 19:11:51 volumiomac volumio[1427]: info: Ignoring MPD Status Update Dec 05 19:11:51 volumiomac volumio[1427]: info: Ignoring MPD Status Update Dec 05 19:11:51 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:51 volumiomac volumio[1427]: info: CoreCommandRouter::servicePushState Dec 05 19:11:51 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:11:51 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 19:11:51 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:11:59 volumiomac volumio[1427]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Dec 05 19:11:59 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Dec 05 19:11:59 volumiomac volumio[1427]: info: Preparing to save Alsa Options, stopping services first Dec 05 19:11:59 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:11:59 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPause Dec 05 19:11:59 volumiomac volumio[1427]: info: CoreStateMachine::pause Dec 05 19:11:59 volumiomac volumio[1427]: info: CoreStateMachine::stPlaybackTimer Dec 05 19:11:59 volumiomac volumio[1427]: info: CoreStateMachine::servicePause Dec 05 19:11:59 volumiomac volumio[1427]: info: CoreCommandRouter::servicePause Dec 05 19:11:59 volumiomac volumio[1427]: info: [yt-cast-receiver] Player.pause() Dec 05 19:11:59 volumiomac volumio[1427]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"Logitech Speakerphone P710e"}} Dec 05 19:11:59 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 05 19:11:59 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 05 19:11:59 volumiomac volumio[1427]: info: Setting mixer PCM for card Logitech Speakerphone P710e Dec 05 19:11:59 volumiomac volumio[1427]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 05 19:11:59 volumiomac volumio[1427]: info: Updating Volume Controller Parameters: Device: 5 Name: Logitech Speakerphone P710e Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 05 19:11:59 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Dec 05 19:11:59 volumiomac volumio[1427]: info: Disabling external Volume Control Dec 05 19:11:59 volumiomac volumio[1427]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 05 19:11:59 volumiomac volumio[1427]: info: Preparing to generate the ALSA configuration file Dec 05 19:11:59 volumiomac volumio[1427]: info: Ignoring MPD Status Update Dec 05 19:11:59 volumiomac volumio[1427]: info: Ignoring MPD Status Update Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 05 19:12:00 volumiomac volumio[1427]: info: VolumeController:: Volume=35 Mute =false Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreCommandRouter::servicePushState Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreCommandRouter::servicePushState Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreCommandRouter::servicePushState Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreStateMachine::pushState Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreCommandRouter::volumioPushState Dec 05 19:12:00 volumiomac volumio[1427]: info: Asound.conf file written Dec 05 19:12:00 volumiomac sudo[6162]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 05 19:12:00 volumiomac sudo[6162]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 19:12:00 volumiomac sudo[6162]: pam_unix(sudo:session): session closed for user root Dec 05 19:12:00 volumiomac volumio[1427]: No state is present for card PCH Dec 05 19:12:00 volumiomac volumio[1427]: Found hardware: "HDA-Intel" "Realtek Generic" "HDA:10ec0233,17aa30c9,00100003 HDA:80862883,80860101,00100000" "0x17aa" "0x30c9" Dec 05 19:12:00 volumiomac volumio[1427]: Hardware is initialized using a generic method Dec 05 19:12:00 volumiomac volumio[1427]: No state is present for card PCH Dec 05 19:12:00 volumiomac volumio[1427]: No state is present for card P710e Dec 05 19:12:00 volumiomac volumio[1427]: Found hardware: "USB-Audio" "USB Mixer" "USB046d:0a4e" "" "" Dec 05 19:12:00 volumiomac volumio[1427]: Hardware is initialized using a generic method Dec 05 19:12:00 volumiomac volumio[1427]: No state is present for card P710e Dec 05 19:12:00 volumiomac volumio[1427]: info: Output device has changed, restarting MPD Dec 05 19:12:00 volumiomac volumio[1427]: info: Output device has changed, restarting Shairport Sync Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 05 19:12:00 volumiomac sudo[6169]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 05 19:12:00 volumiomac sudo[6169]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 19:12:00 volumiomac sudo[6169]: pam_unix(sudo:session): session closed for user root Dec 05 19:12:00 volumiomac sudo[6171]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 05 19:12:00 volumiomac sudo[6171]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 19:12:00 volumiomac volumio[1427]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 05 19:12:00 volumiomac volumio[1427]: info: Output device has changed, restarting MPD Dec 05 19:12:00 volumiomac systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 05 19:12:00 volumiomac volumio[1427]: info: Output device has changed, restarting Shairport Sync Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 05 19:12:00 volumiomac sudo[6179]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 05 19:12:00 volumiomac sudo[6179]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 19:12:00 volumiomac sudo[6179]: pam_unix(sudo:session): session closed for user root Dec 05 19:12:00 volumiomac sudo[6181]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 05 19:12:00 volumiomac sudo[6181]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 05 19:12:00 volumiomac volumio[1427]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 05 19:12:00 volumiomac volumio[1427]: info: CoreCommandRouter::volumioGetState Dec 05 19:12:00 volumiomac volumio[1427]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 05 19:12:00 volumiomac systemd[1]: mpd.service: Deactivated successfully. Dec 05 19:12:00 volumiomac systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 05 19:12:00 volumiomac systemd[1]: mpd.service: Consumed 1.745s CPU time. Dec 05 19:12:00 volumiomac systemd[1]: mpd.socket: Deactivated successfully. Dec 05 19:12:00 volumiomac systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 05 19:12:00 volumiomac systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 05 19:12:00 volumiomac volumio[1427]: MPDError: Not connected Dec 05 19:12:00 volumiomac volumio[1427]: at MPDClient.send (/data/plugins/music_service/ytcr/node_modules/mpd2/lib/index.js:101:13) Dec 05 19:12:00 volumiomac volumio[1427]: at MPDClient.sendCommand (/data/plugins/music_service/ytcr/node_modules/mpd2/lib/index.js:65:10) Dec 05 19:12:00 volumiomac volumio[1427]: at Object.get (/data/plugins/music_service/ytcr/node_modules/mpd-api/lib/api/index.js:60:16) Dec 05 19:12:00 volumiomac volumio[1427]: at MPDPlayer.getVolumioState (/data/plugins/music_service/ytcr/dist/lib/MPDPlayer.js:297:100) Dec 05 19:12:00 volumiomac volumio[1427]: at ControllerYTCR.pushState (/data/plugins/music_service/ytcr/dist/index.js:566:104) Dec 05 19:12:00 volumiomac volumio[1427]: at /data/plugins/music_service/ytcr/dist/index.js:337:36 Dec 05 19:12:00 volumiomac volumio[1427]: at MPDPlayer. (/data/plugins/music_service/ytcr/dist/index.js:340:15) Dec 05 19:12:00 volumiomac volumio[1427]: at MPDPlayer.emit (node:events:526:35) Dec 05 19:12:00 volumiomac volumio[1427]: at MPDPlayer._Player_setStatusAndEmit (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/Player.js:334:10) Dec 05 19:12:00 volumiomac volumio[1427]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Dec 05 19:12:00 volumiomac volumio[1427]: at async /data/plugins/music_service/ytcr/dist/index.js:311:17 { Dec 05 19:12:00 volumiomac volumio[1427]: code: 'ENOTCONNECTED' Dec 05 19:12:00 volumiomac volumio[1427]: } Dec 05 19:12:00 volumiomac volumio[1427]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 05 19:12:00 volumiomac systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 05 19:12:00 volumiomac systemd[1]: Starting mpd.service - Music Player Daemon... Dec 05 19:12:00 volumiomac systemd[1]: mpd.service: Deactivated successfully. Dec 05 19:12:00 volumiomac systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 05 19:12:00 volumiomac systemd[1]: mpd.socket: Deactivated successfully. Dec 05 19:12:00 volumiomac systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 05 19:12:00 volumiomac systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 05 19:12:00 volumiomac systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 05 19:12:00 volumiomac systemd[1]: Starting mpd.service - Music Player Daemon... Dec 05 19:12:00 volumiomac sudo[6202]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 05 19:12:00 volumiomac sudo[6202]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 05 19:12:00 volumiomac sudo[6202]: pam_unix(sudo:session): session closed for user root Dec 05 19:12:00 volumiomac sudo[6208]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-05 19:11' Dec 05 19:12:00 volumiomac sudo[6208]: 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="3a3cfe435f8bb2bc94a920662e91a4ef35bc8e7c" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="8bcc10c3dbcbcb349e9887dc0527d54876b32688" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Dec 2 12:15:37 UTC 2025" VOLUMIO_VERSION="4.072" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="3ca59a0b3ec3a926fd3274a2fb539106"