-- Logs begin at Mon 2025-01-20 20:06:36 CET, end at Sun 2025-08-31 10:26:02 CEST. -- Aug 31 10:25:03 digione volumio[965]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Aug 31 10:25:03 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Aug 31 10:25:03 digione volumio[965]: info: Preparing to save Alsa Options, stopping services first Aug 31 10:25:03 digione volumio[965]: info: CoreCommandRouter::volumioGetState Aug 31 10:25:03 digione volumio[965]: info: CorePlayQueue::getTrack 0 Aug 31 10:25:03 digione volumio[965]: info: CoreCommandRouter::volumioPause Aug 31 10:25:03 digione volumio[965]: info: CoreStateMachine::pause Aug 31 10:25:03 digione volumio[965]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"McIntosh Labs USB Audio"},"i2s":false,"i2sid":{"value":"allo-digione","label":"Allo DigiOne"}} Aug 31 10:25:03 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 31 10:25:03 digione volumio[965]: info: Disabling I2S DAC: Aug 31 10:25:03 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , disableI2SDAC Aug 31 10:25:03 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 10:25:03 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 31 10:25:03 digione volumio[965]: info: Setting mixer Main Feature Controls for card McIntosh Labs USB Audio Aug 31 10:25:03 digione volumio[965]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 31 10:25:03 digione volumio[965]: info: Updating Volume Controller Parameters: Device: 5 Name: McIntosh Labs USB Audio Mixer: Main Feature Controls Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Aug 31 10:25:03 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Aug 31 10:25:03 digione volumio[965]: info: Disabling external Volume Control Aug 31 10:25:03 digione volumio[965]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 10:25:03 digione volumio[965]: info: Preparing to generate the ALSA configuration file Aug 31 10:25:03 digione volumio[965]: Unable to parse: Aug 31 10:25:03 digione volumio[965]: Simple mixer control 'Main Feature Controls',0 Aug 31 10:25:03 digione volumio[965]: Capabilities: pswitch pswitch-joined Aug 31 10:25:03 digione volumio[965]: Playback channels: Mono Aug 31 10:25:03 digione volumio[965]: Mono: Playback [on] Aug 31 10:25:03 digione volumio[965]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Aug 31 10:25:03 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 31 10:25:03 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 10:25:03 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 31 10:25:03 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:03 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:03 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:03 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:03 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:03 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:03 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:03 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 31 10:25:03 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 31 10:25:03 digione volumio[965]: Unable to parse: Aug 31 10:25:03 digione volumio[965]: Simple mixer control 'Main Feature Controls',0 Aug 31 10:25:03 digione volumio[965]: Capabilities: pswitch pswitch-joined Aug 31 10:25:03 digione volumio[965]: Playback channels: Mono Aug 31 10:25:03 digione volumio[965]: Mono: Playback [on] Aug 31 10:25:03 digione volumio[965]: info: VolumeController:: Volume=undefined Mute =false Aug 31 10:25:03 digione volumio[965]: info: CoreStateMachine::pushState Aug 31 10:25:03 digione volumio[965]: info: CorePlayQueue::getTrack 0 Aug 31 10:25:03 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 10:25:03 digione volumio[965]: info: CoreCommandRouter::volumioPushState Aug 31 10:25:03 digione sudo[1564]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Aug 31 10:25:03 digione sudo[1564]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 10:25:03 digione sudo[1564]: pam_unix(sudo:session): session closed for user root Aug 31 10:25:03 digione volumio[965]: info: No Overlays Loaded Aug 31 10:25:03 digione volumio[965]: info: Asound.conf file written Aug 31 10:25:03 digione sudo[1567]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Aug 31 10:25:03 digione sudo[1567]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 10:25:03 digione sudo[1567]: pam_unix(sudo:session): session closed for user root Aug 31 10:25:04 digione volumio[965]: info: Output device has changed, restarting MPD Aug 31 10:25:04 digione sudo[1572]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 31 10:25:04 digione sudo[1572]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 10:25:04 digione volumio[965]: info: Output device has changed, restarting Shairport Sync Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 10:25:04 digione sudo[1572]: pam_unix(sudo:session): session closed for user root Aug 31 10:25:04 digione sudo[1575]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 31 10:25:04 digione sudo[1575]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 10:25:04 digione systemd[1]: Stopping Music Player Daemon... Aug 31 10:25:04 digione volumio[965]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 31 10:25:04 digione volumio[965]: info: Output device has changed, restarting MPD Aug 31 10:25:04 digione volumio[965]: info: Output device has changed, restarting Shairport Sync Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 10:25:04 digione sudo[1581]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 31 10:25:04 digione sudo[1581]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 10:25:04 digione sudo[1583]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 31 10:25:04 digione sudo[1581]: pam_unix(sudo:session): session closed for user root Aug 31 10:25:04 digione sudo[1583]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 10:25:04 digione volumio[965]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 31 10:25:04 digione volumio[965]: info: VolumeController::SetAlsaVolume0 Aug 31 10:25:04 digione volumio[965]: info: CoreStateMachine::pushState Aug 31 10:25:04 digione volumio[965]: info: CorePlayQueue::getTrack 0 Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::volumioPushState Aug 31 10:25:04 digione volumio[965]: info: MPD Permissions set Aug 31 10:25:04 digione volumio[965]: info: MPD Permissions set Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 10:25:04 digione volumio[965]: info: Discovery: Getting this device information Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::volumioGetState Aug 31 10:25:04 digione volumio[965]: info: CorePlayQueue::getTrack 0 Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:04 digione systemd[1]: mpd.service: Succeeded. Aug 31 10:25:04 digione systemd[1]: Stopped Music Player Daemon. Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 10:25:04 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:04 digione volumio[965]: info: Starting Shairport Sync Aug 31 10:25:04 digione systemd[1]: Starting Music Player Daemon... Aug 31 10:25:04 digione volumio[965]: info: Starting Shairport Sync Aug 31 10:25:04 digione sudo[1600]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 31 10:25:04 digione sudo[1600]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 10:25:04 digione sudo[1602]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 31 10:25:04 digione sudo[1602]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 10:25:04 digione systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 31 10:25:04 digione systemd[1]: shairport-sync.service: Succeeded. Aug 31 10:25:04 digione systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 31 10:25:04 digione systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 31 10:25:04 digione sudo[1600]: pam_unix(sudo:session): session closed for user root Aug 31 10:25:04 digione volumio[965]: info: Shairport-Sync Started Aug 31 10:25:04 digione sudo[1602]: pam_unix(sudo:session): session closed for user root Aug 31 10:25:04 digione volumio[965]: info: Shairport-Sync Started Aug 31 10:25:04 digione sudo[1594]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 31 10:25:04 digione sudo[1594]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 10:25:04 digione sudo[1594]: pam_unix(sudo:session): session closed for user root Aug 31 10:25:05 digione volumio[965]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Aug 31 10:25:05 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Aug 31 10:25:05 digione volumio[965]: info: Preparing to save Alsa Options, stopping services first Aug 31 10:25:05 digione volumio[965]: info: CoreCommandRouter::volumioGetState Aug 31 10:25:05 digione volumio[965]: info: CorePlayQueue::getTrack 0 Aug 31 10:25:05 digione volumio[965]: info: CoreCommandRouter::volumioPause Aug 31 10:25:05 digione volumio[965]: info: CoreStateMachine::pause Aug 31 10:25:05 digione volumio[965]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"McIntosh Labs USB Audio"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Aug 31 10:25:05 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 31 10:25:06 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 31 10:25:06 digione volumio[965]: info: Setting mixer Main Feature Controls for card McIntosh Labs USB Audio Aug 31 10:25:06 digione volumio[965]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 31 10:25:06 digione volumio[965]: info: Updating Volume Controller Parameters: Device: 5 Name: McIntosh Labs USB Audio Mixer: Main Feature Controls Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Aug 31 10:25:06 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Aug 31 10:25:06 digione volumio[965]: info: Disabling external Volume Control Aug 31 10:25:06 digione volumio[965]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 10:25:06 digione volumio[965]: info: Preparing to generate the ALSA configuration file Aug 31 10:25:06 digione volumio[965]: Unable to parse: Aug 31 10:25:06 digione volumio[965]: Simple mixer control 'Main Feature Controls',0 Aug 31 10:25:06 digione volumio[965]: Capabilities: pswitch pswitch-joined Aug 31 10:25:06 digione volumio[965]: Playback channels: Mono Aug 31 10:25:06 digione volumio[965]: Mono: Playback [on] Aug 31 10:25:06 digione volumio[965]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Aug 31 10:25:06 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 31 10:25:06 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 10:25:06 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 31 10:25:06 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:06 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:06 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:06 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:06 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:06 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:06 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:06 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 31 10:25:06 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 31 10:25:06 digione volumio[965]: info: Asound.conf file unchanged, so no further update is needed Aug 31 10:25:06 digione volumio[965]: info: Output device has changed, restarting MPD Aug 31 10:25:06 digione volumio[965]: info: Output device has changed, restarting Shairport Sync Aug 31 10:25:06 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:06 digione sudo[1626]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 31 10:25:06 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 10:25:06 digione sudo[1626]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 10:25:06 digione sudo[1626]: pam_unix(sudo:session): session closed for user root Aug 31 10:25:06 digione sudo[1628]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 31 10:25:06 digione sudo[1628]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 10:25:06 digione systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 31 10:25:06 digione systemd[1]: mpd.service: Succeeded. Aug 31 10:25:06 digione systemd[1]: Stopped Music Player Daemon. Aug 31 10:25:06 digione volumio[965]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 31 10:25:06 digione volumio[965]: info: MPD Permissions set Aug 31 10:25:06 digione volumio[965]: Unable to parse: Aug 31 10:25:06 digione volumio[965]: Simple mixer control 'Main Feature Controls',0 Aug 31 10:25:06 digione volumio[965]: Capabilities: pswitch pswitch-joined Aug 31 10:25:06 digione volumio[965]: Playback channels: Mono Aug 31 10:25:06 digione volumio[965]: Mono: Playback [on] Aug 31 10:25:06 digione volumio[965]: info: VolumeController:: Volume=undefined Mute =false Aug 31 10:25:06 digione volumio[965]: info: CoreStateMachine::pushState Aug 31 10:25:06 digione volumio[965]: info: CorePlayQueue::getTrack 0 Aug 31 10:25:07 digione systemd[1]: Starting Music Player Daemon... Aug 31 10:25:07 digione sudo[1640]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 31 10:25:07 digione volumio[965]: info: CoreCommandRouter::volumioPushState Aug 31 10:25:07 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:07 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 10:25:07 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:07 digione volumio[965]: info: Starting Shairport Sync Aug 31 10:25:07 digione volumio[965]: info: Shairport-Sync Started Aug 31 10:25:07 digione systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 31 10:25:07 digione sudo[1640]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 10:25:07 digione systemd[1]: shairport-sync.service: Succeeded. Aug 31 10:25:07 digione sudo[1640]: pam_unix(sudo:session): session closed for user root Aug 31 10:25:07 digione systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 31 10:25:07 digione sudo[1634]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 31 10:25:07 digione systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 31 10:25:07 digione sudo[1634]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 10:25:07 digione sudo[1634]: pam_unix(sudo:session): session closed for user root Aug 31 10:25:07 digione volumio[965]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Aug 31 10:25:07 digione volumio[965]: info: CoreStateMachine::getcurrentVolume Aug 31 10:25:07 digione volumio[965]: info: CoreCommandRouter::volumioRetrievevolume Aug 31 10:25:07 digione volumio[965]: Unable to parse: Aug 31 10:25:07 digione volumio[965]: Simple mixer control 'Main Feature Controls',0 Aug 31 10:25:07 digione volumio[965]: Capabilities: pswitch pswitch-joined Aug 31 10:25:07 digione volumio[965]: Playback channels: Mono Aug 31 10:25:07 digione volumio[965]: Mono: Playback [on] Aug 31 10:25:07 digione volumio[965]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Aug 31 10:25:07 digione volumio[965]: Unable to parse: Aug 31 10:25:07 digione volumio[965]: Simple mixer control 'Main Feature Controls',0 Aug 31 10:25:07 digione volumio[965]: Capabilities: pswitch pswitch-joined Aug 31 10:25:07 digione volumio[965]: Playback channels: Mono Aug 31 10:25:07 digione volumio[965]: Mono: Playback [on] Aug 31 10:25:07 digione volumio[965]: info: VolumeController:: Volume=undefined Mute =false Aug 31 10:25:07 digione volumio[965]: info: CoreStateMachine::pushState Aug 31 10:25:07 digione volumio[965]: info: CorePlayQueue::getTrack 0 Aug 31 10:25:07 digione volumio[965]: info: CoreCommandRouter::volumioPushState Aug 31 10:25:07 digione volumio[965]: info: CoreStateMachine::updateTrackBlock Aug 31 10:25:07 digione volumio[965]: info: CorePlayQueue::getTrackBlock Aug 31 10:25:07 digione volumio[965]: info: CoreCommandRouter::volumioRetrievevolume Aug 31 10:25:07 digione volumio[965]: Unable to parse: Aug 31 10:25:07 digione volumio[965]: Simple mixer control 'Main Feature Controls',0 Aug 31 10:25:07 digione volumio[965]: Capabilities: pswitch pswitch-joined Aug 31 10:25:07 digione volumio[965]: Playback channels: Mono Aug 31 10:25:07 digione volumio[965]: Mono: Playback [on] Aug 31 10:25:07 digione volumio[965]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Aug 31 10:25:07 digione volumio[965]: Unable to parse: Aug 31 10:25:07 digione volumio[965]: Simple mixer control 'Main Feature Controls',0 Aug 31 10:25:07 digione volumio[965]: Capabilities: pswitch pswitch-joined Aug 31 10:25:07 digione volumio[965]: Playback channels: Mono Aug 31 10:25:07 digione volumio[965]: Mono: Playback [on] Aug 31 10:25:07 digione volumio[965]: info: VolumeController:: Volume=undefined Mute =false Aug 31 10:25:07 digione volumio[965]: info: CoreStateMachine::pushState Aug 31 10:25:07 digione volumio[965]: info: CorePlayQueue::getTrack 0 Aug 31 10:25:07 digione volumio[965]: info: CoreCommandRouter::volumioPushState Aug 31 10:25:08 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:08 digione volumio[965]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Aug 31 10:25:08 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Aug 31 10:25:08 digione volumio[965]: info: Preparing to save Alsa Options, stopping services first Aug 31 10:25:08 digione volumio[965]: info: CoreCommandRouter::volumioGetState Aug 31 10:25:08 digione volumio[965]: info: CorePlayQueue::getTrack 0 Aug 31 10:25:08 digione volumio[965]: info: CoreCommandRouter::volumioPause Aug 31 10:25:08 digione volumio[965]: info: CoreStateMachine::pause Aug 31 10:25:08 digione volumio[965]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"McIntosh Labs USB Audio"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Aug 31 10:25:08 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 31 10:25:08 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 31 10:25:08 digione volumio[965]: info: Setting mixer Main Feature Controls for card McIntosh Labs USB Audio Aug 31 10:25:08 digione volumio[965]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 31 10:25:08 digione volumio[965]: info: Updating Volume Controller Parameters: Device: 5 Name: McIntosh Labs USB Audio Mixer: Main Feature Controls Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Aug 31 10:25:08 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Aug 31 10:25:08 digione volumio[965]: info: Disabling external Volume Control Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 10:25:09 digione volumio[965]: info: Preparing to generate the ALSA configuration file Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 31 10:25:09 digione volumio[965]: info: Asound.conf file unchanged, so no further update is needed Aug 31 10:25:09 digione volumio[965]: info: Output device has changed, restarting MPD Aug 31 10:25:09 digione sudo[1665]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 31 10:25:09 digione volumio[965]: info: Output device has changed, restarting Shairport Sync Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 10:25:09 digione sudo[1665]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 10:25:09 digione sudo[1665]: pam_unix(sudo:session): session closed for user root Aug 31 10:25:09 digione sudo[1667]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 31 10:25:09 digione sudo[1667]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 10:25:09 digione volumio[965]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 31 10:25:09 digione systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 31 10:25:09 digione systemd[1]: mpd.service: Succeeded. Aug 31 10:25:09 digione systemd[1]: Stopped Music Player Daemon. Aug 31 10:25:09 digione volumio[965]: info: MPD Permissions set Aug 31 10:25:09 digione volumio[965]: Unable to parse: Aug 31 10:25:09 digione volumio[965]: Simple mixer control 'Main Feature Controls',0 Aug 31 10:25:09 digione volumio[965]: Capabilities: pswitch pswitch-joined Aug 31 10:25:09 digione volumio[965]: Playback channels: Mono Aug 31 10:25:09 digione volumio[965]: Mono: Playback [on] Aug 31 10:25:09 digione volumio[965]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:09 digione volumio[965]: Unable to parse: Aug 31 10:25:09 digione volumio[965]: Simple mixer control 'Main Feature Controls',0 Aug 31 10:25:09 digione volumio[965]: Capabilities: pswitch pswitch-joined Aug 31 10:25:09 digione volumio[965]: Playback channels: Mono Aug 31 10:25:09 digione volumio[965]: Mono: Playback [on] Aug 31 10:25:09 digione systemd[1]: Starting Music Player Daemon... Aug 31 10:25:09 digione volumio[965]: info: VolumeController:: Volume=undefined Mute =false Aug 31 10:25:09 digione volumio[965]: info: CoreStateMachine::pushState Aug 31 10:25:09 digione volumio[965]: info: CorePlayQueue::getTrack 0 Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::volumioPushState Aug 31 10:25:09 digione volumio[965]: info: Starting Shairport Sync Aug 31 10:25:09 digione volumio[965]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Aug 31 10:25:09 digione volumio[965]: info: Preparing to save Alsa Options, stopping services first Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::volumioGetState Aug 31 10:25:09 digione volumio[965]: info: CorePlayQueue::getTrack 0 Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::volumioPause Aug 31 10:25:09 digione volumio[965]: info: CoreStateMachine::pause Aug 31 10:25:09 digione volumio[965]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"McIntosh Labs USB Audio"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 31 10:25:09 digione sudo[1680]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 31 10:25:09 digione sudo[1680]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 10:25:09 digione systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 31 10:25:09 digione systemd[1]: shairport-sync.service: Succeeded. Aug 31 10:25:09 digione systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 31 10:25:09 digione systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 31 10:25:09 digione sudo[1680]: pam_unix(sudo:session): session closed for user root Aug 31 10:25:09 digione sudo[1673]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 31 10:25:09 digione sudo[1673]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 10:25:09 digione sudo[1673]: pam_unix(sudo:session): session closed for user root Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 31 10:25:09 digione volumio[965]: info: Setting mixer Main Feature Controls for card McIntosh Labs USB Audio Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 31 10:25:09 digione volumio[965]: info: Updating Volume Controller Parameters: Device: 5 Name: McIntosh Labs USB Audio Mixer: Main Feature Controls Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Aug 31 10:25:09 digione volumio[965]: info: Disabling external Volume Control Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 10:25:09 digione volumio[965]: info: Preparing to generate the ALSA configuration file Aug 31 10:25:09 digione volumio[965]: Unable to parse: Aug 31 10:25:09 digione volumio[965]: Simple mixer control 'Main Feature Controls',0 Aug 31 10:25:09 digione volumio[965]: Capabilities: pswitch pswitch-joined Aug 31 10:25:09 digione volumio[965]: Playback channels: Mono Aug 31 10:25:09 digione volumio[965]: Mono: Playback [on] Aug 31 10:25:09 digione volumio[965]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Aug 31 10:25:09 digione volumio[965]: info: Shairport-Sync Started Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 31 10:25:09 digione volumio[965]: info: Asound.conf file unchanged, so no further update is needed Aug 31 10:25:09 digione volumio[965]: info: Output device has changed, restarting MPD Aug 31 10:25:09 digione volumio[965]: info: Output device has changed, restarting Shairport Sync Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 10:25:09 digione sudo[1702]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 31 10:25:09 digione sudo[1702]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 10:25:09 digione sudo[1702]: pam_unix(sudo:session): session closed for user root Aug 31 10:25:09 digione sudo[1704]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 31 10:25:09 digione sudo[1704]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 10:25:09 digione systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 31 10:25:09 digione systemd[1]: mpd.service: Succeeded. Aug 31 10:25:09 digione systemd[1]: Stopped Music Player Daemon. Aug 31 10:25:09 digione volumio[965]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 31 10:25:09 digione volumio[965]: Unable to parse: Aug 31 10:25:09 digione volumio[965]: Simple mixer control 'Main Feature Controls',0 Aug 31 10:25:09 digione volumio[965]: Capabilities: pswitch pswitch-joined Aug 31 10:25:09 digione volumio[965]: Playback channels: Mono Aug 31 10:25:09 digione volumio[965]: Mono: Playback [on] Aug 31 10:25:09 digione volumio[965]: info: VolumeController:: Volume=undefined Mute =false Aug 31 10:25:09 digione volumio[965]: info: CoreStateMachine::pushState Aug 31 10:25:09 digione volumio[965]: info: CorePlayQueue::getTrack 0 Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::volumioPushState Aug 31 10:25:09 digione volumio[965]: info: MPD Permissions set Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:09 digione systemd[1]: Starting Music Player Daemon... Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:09 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:10 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 10:25:10 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 10:25:10 digione volumio[965]: info: Starting Shairport Sync Aug 31 10:25:10 digione sudo[1718]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 31 10:25:10 digione sudo[1718]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 10:25:10 digione systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 31 10:25:10 digione systemd[1]: shairport-sync.service: Succeeded. Aug 31 10:25:10 digione systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 31 10:25:10 digione sudo[1710]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 31 10:25:10 digione sudo[1710]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 10:25:10 digione systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 31 10:25:10 digione sudo[1710]: pam_unix(sudo:session): session closed for user root Aug 31 10:25:10 digione sudo[1718]: pam_unix(sudo:session): session closed for user root Aug 31 10:25:10 digione volumio[965]: info: Shairport-Sync Started Aug 31 10:25:10 digione volumio[965]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Aug 31 10:25:10 digione volumio[965]: info: CoreStateMachine::getcurrentVolume Aug 31 10:25:10 digione volumio[965]: info: CoreCommandRouter::volumioRetrievevolume Aug 31 10:25:10 digione volumio[965]: Unable to parse: Aug 31 10:25:10 digione volumio[965]: Simple mixer control 'Main Feature Controls',0 Aug 31 10:25:10 digione volumio[965]: Capabilities: pswitch pswitch-joined Aug 31 10:25:10 digione volumio[965]: Playback channels: Mono Aug 31 10:25:10 digione volumio[965]: Mono: Playback [on] Aug 31 10:25:10 digione volumio[965]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Aug 31 10:25:10 digione volumio[965]: Unable to parse: Aug 31 10:25:10 digione volumio[965]: Simple mixer control 'Main Feature Controls',0 Aug 31 10:25:10 digione volumio[965]: Capabilities: pswitch pswitch-joined Aug 31 10:25:10 digione volumio[965]: Playback channels: Mono Aug 31 10:25:10 digione volumio[965]: Mono: Playback [on] Aug 31 10:25:10 digione volumio[965]: info: VolumeController:: Volume=undefined Mute =false Aug 31 10:25:10 digione volumio[965]: info: CoreStateMachine::pushState Aug 31 10:25:10 digione volumio[965]: info: CorePlayQueue::getTrack 0 Aug 31 10:25:10 digione volumio[965]: info: CoreCommandRouter::volumioPushState Aug 31 10:25:10 digione volumio[965]: info: CoreStateMachine::updateTrackBlock Aug 31 10:25:10 digione volumio[965]: info: CorePlayQueue::getTrackBlock Aug 31 10:25:10 digione volumio[965]: info: CoreCommandRouter::volumioRetrievevolume Aug 31 10:25:10 digione volumio[965]: Unable to parse: Aug 31 10:25:10 digione volumio[965]: Simple mixer control 'Main Feature Controls',0 Aug 31 10:25:10 digione volumio[965]: Capabilities: pswitch pswitch-joined Aug 31 10:25:10 digione volumio[965]: Playback channels: Mono Aug 31 10:25:10 digione volumio[965]: Mono: Playback [on] Aug 31 10:25:10 digione volumio[965]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Aug 31 10:25:10 digione volumio[965]: Unable to parse: Aug 31 10:25:10 digione volumio[965]: Simple mixer control 'Main Feature Controls',0 Aug 31 10:25:10 digione volumio[965]: Capabilities: pswitch pswitch-joined Aug 31 10:25:10 digione volumio[965]: Playback channels: Mono Aug 31 10:25:10 digione volumio[965]: Mono: Playback [on] Aug 31 10:25:10 digione volumio[965]: info: VolumeController:: Volume=undefined Mute =false Aug 31 10:25:10 digione volumio[965]: info: CoreStateMachine::pushState Aug 31 10:25:10 digione volumio[965]: info: CorePlayQueue::getTrack 0 Aug 31 10:25:10 digione volumio[965]: info: CoreCommandRouter::volumioPushState Aug 31 10:25:11 digione mpd[1722]: Aug 31 10:25 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 31 10:25:11 digione systemd[1]: Started Music Player Daemon. Aug 31 10:25:11 digione sudo[1704]: pam_unix(sudo:session): session closed for user root Aug 31 10:25:11 digione sudo[1575]: pam_unix(sudo:session): session closed for user root Aug 31 10:25:11 digione sudo[1667]: pam_unix(sudo:session): session closed for user root Aug 31 10:25:11 digione sudo[1628]: pam_unix(sudo:session): session closed for user root Aug 31 10:25:11 digione sudo[1583]: pam_unix(sudo:session): session closed for user root Aug 31 10:25:11 digione volumio[965]: error: MPD error: The expression evaluated to a falsy value: Aug 31 10:25:11 digione volumio[965]: assert.ok(self.idling) Aug 31 10:25:11 digione volumio[965]: error: The expression evaluated to a falsy value: Aug 31 10:25:11 digione volumio[965]: assert.ok(self.idling) Aug 31 10:25:11 digione volumio[965]: error: MPD error: The expression evaluated to a falsy value: Aug 31 10:25:11 digione volumio[965]: assert.ok(self.idling) Aug 31 10:25:11 digione volumio[965]: error: The expression evaluated to a falsy value: Aug 31 10:25:11 digione volumio[965]: assert.ok(self.idling) Aug 31 10:25:11 digione volumio[965]: error: MPD error: The expression evaluated to a falsy value: Aug 31 10:25:11 digione volumio[965]: assert.ok(self.idling) Aug 31 10:25:11 digione volumio[965]: error: The expression evaluated to a falsy value: Aug 31 10:25:11 digione volumio[965]: assert.ok(self.idling) Aug 31 10:25:11 digione volumio[965]: error: MPD error: The expression evaluated to a falsy value: Aug 31 10:25:11 digione volumio[965]: assert.ok(self.idling) Aug 31 10:25:11 digione volumio[965]: error: The expression evaluated to a falsy value: Aug 31 10:25:11 digione volumio[965]: assert.ok(self.idling) Aug 31 10:25:11 digione volumio[965]: error: updateQueue error: null Aug 31 10:25:13 digione volumio[965]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Aug 31 10:25:13 digione volumio[965]: info: CoreStateMachine::getcurrentVolume Aug 31 10:25:13 digione volumio[965]: info: CoreCommandRouter::volumioRetrievevolume Aug 31 10:25:13 digione volumio[965]: Unable to parse: Aug 31 10:25:13 digione volumio[965]: Simple mixer control 'Main Feature Controls',0 Aug 31 10:25:13 digione volumio[965]: Capabilities: pswitch pswitch-joined Aug 31 10:25:13 digione volumio[965]: Playback channels: Mono Aug 31 10:25:13 digione volumio[965]: Mono: Playback [on] Aug 31 10:25:13 digione volumio[965]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Aug 31 10:25:13 digione volumio[965]: Unable to parse: Aug 31 10:25:13 digione volumio[965]: Simple mixer control 'Main Feature Controls',0 Aug 31 10:25:13 digione volumio[965]: Capabilities: pswitch pswitch-joined Aug 31 10:25:13 digione volumio[965]: Playback channels: Mono Aug 31 10:25:13 digione volumio[965]: Mono: Playback [on] Aug 31 10:25:13 digione volumio[965]: info: VolumeController:: Volume=undefined Mute =false Aug 31 10:25:13 digione volumio[965]: info: CoreStateMachine::pushState Aug 31 10:25:13 digione volumio[965]: info: CorePlayQueue::getTrack 0 Aug 31 10:25:13 digione volumio[965]: info: CoreCommandRouter::volumioPushState Aug 31 10:25:13 digione volumio[965]: info: CoreStateMachine::updateTrackBlock Aug 31 10:25:13 digione volumio[965]: info: CorePlayQueue::getTrackBlock Aug 31 10:25:13 digione volumio[965]: info: CoreCommandRouter::volumioRetrievevolume Aug 31 10:25:13 digione volumio[965]: Unable to parse: Aug 31 10:25:13 digione volumio[965]: Simple mixer control 'Main Feature Controls',0 Aug 31 10:25:13 digione volumio[965]: Capabilities: pswitch pswitch-joined Aug 31 10:25:13 digione volumio[965]: Playback channels: Mono Aug 31 10:25:13 digione volumio[965]: Mono: Playback [on] Aug 31 10:25:13 digione volumio[965]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Aug 31 10:25:13 digione volumio[965]: Unable to parse: Aug 31 10:25:13 digione volumio[965]: Simple mixer control 'Main Feature Controls',0 Aug 31 10:25:13 digione volumio[965]: Capabilities: pswitch pswitch-joined Aug 31 10:25:13 digione volumio[965]: Playback channels: Mono Aug 31 10:25:13 digione volumio[965]: Mono: Playback [on] Aug 31 10:25:13 digione volumio[965]: info: VolumeController:: Volume=undefined Mute =false Aug 31 10:25:13 digione volumio[965]: info: CoreStateMachine::pushState Aug 31 10:25:13 digione volumio[965]: info: CorePlayQueue::getTrack 0 Aug 31 10:25:13 digione volumio[965]: info: CoreCommandRouter::volumioPushState Aug 31 10:25:13 digione volumio[965]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Aug 31 10:25:13 digione volumio[965]: info: CoreStateMachine::getcurrentVolume Aug 31 10:25:13 digione volumio[965]: info: CoreCommandRouter::volumioRetrievevolume Aug 31 10:25:13 digione volumio[965]: Unable to parse: Aug 31 10:25:13 digione volumio[965]: Simple mixer control 'Main Feature Controls',0 Aug 31 10:25:13 digione volumio[965]: Capabilities: pswitch pswitch-joined Aug 31 10:25:13 digione volumio[965]: Playback channels: Mono Aug 31 10:25:13 digione volumio[965]: Mono: Playback [on] Aug 31 10:25:13 digione volumio[965]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Aug 31 10:25:13 digione volumio[965]: Unable to parse: Aug 31 10:25:13 digione volumio[965]: Simple mixer control 'Main Feature Controls',0 Aug 31 10:25:13 digione volumio[965]: Capabilities: pswitch pswitch-joined Aug 31 10:25:13 digione volumio[965]: Playback channels: Mono Aug 31 10:25:13 digione volumio[965]: Mono: Playback [on] Aug 31 10:25:13 digione volumio[965]: info: VolumeController:: Volume=undefined Mute =false Aug 31 10:25:13 digione volumio[965]: info: CoreStateMachine::pushState Aug 31 10:25:13 digione volumio[965]: info: CorePlayQueue::getTrack 0 Aug 31 10:25:13 digione volumio[965]: info: CoreCommandRouter::volumioPushState Aug 31 10:25:13 digione volumio[965]: info: CoreStateMachine::updateTrackBlock Aug 31 10:25:13 digione volumio[965]: info: CorePlayQueue::getTrackBlock Aug 31 10:25:13 digione volumio[965]: info: CoreCommandRouter::volumioRetrievevolume Aug 31 10:25:13 digione volumio[965]: Unable to parse: Aug 31 10:25:13 digione volumio[965]: Simple mixer control 'Main Feature Controls',0 Aug 31 10:25:13 digione volumio[965]: Capabilities: pswitch pswitch-joined Aug 31 10:25:13 digione volumio[965]: Playback channels: Mono Aug 31 10:25:13 digione volumio[965]: Mono: Playback [on] Aug 31 10:25:13 digione volumio[965]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Aug 31 10:25:13 digione volumio[965]: Unable to parse: Aug 31 10:25:13 digione volumio[965]: Simple mixer control 'Main Feature Controls',0 Aug 31 10:25:13 digione volumio[965]: Capabilities: pswitch pswitch-joined Aug 31 10:25:13 digione volumio[965]: Playback channels: Mono Aug 31 10:25:13 digione volumio[965]: Mono: Playback [on] Aug 31 10:25:13 digione volumio[965]: info: VolumeController:: Volume=undefined Mute =false Aug 31 10:25:13 digione volumio[965]: info: CoreStateMachine::pushState Aug 31 10:25:13 digione volumio[965]: info: CorePlayQueue::getTrack 0 Aug 31 10:25:13 digione volumio[965]: info: CoreCommandRouter::volumioPushState Aug 31 10:25:14 digione volumio[965]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 10:25:14 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 31 10:25:14 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 10:25:14 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 31 10:25:14 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:14 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:14 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:14 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:14 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:14 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:14 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 10:25:14 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 31 10:25:14 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 31 10:25:26 digione volumio[965]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 31 10:25:26 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 31 10:25:27 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 31 10:25:27 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 31 10:25:27 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Aug 31 10:25:27 digione volumio[965]: info: Received Get System Version Aug 31 10:25:27 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 31 10:25:29 digione volumio-remote-updater[533]: No test mode Aug 31 10:25:29 digione volumio-remote-updater[533]: No alpha test mode Aug 31 10:25:30 digione volumio[965]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

\n\n

NEW ADDITIONS

\n\n","title":"Update v3.832","updateavailable":true} Aug 31 10:25:30 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Aug 31 10:25:33 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 10:25:33 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 10:25:33 digione volumio[965]: info: Discovery: Getting this device information Aug 31 10:25:33 digione volumio[965]: info: CoreCommandRouter::volumioGetState Aug 31 10:25:33 digione volumio[965]: info: CorePlayQueue::getTrack 0 Aug 31 10:25:33 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 10:25:39 digione volumio[965]: info: CoreCommandRouter::Close All Modals sent Aug 31 10:25:45 digione volumio[965]: info: CoreCommandRouter::volumioClearQueue Aug 31 10:25:45 digione volumio[965]: info: CoreStateMachine::ClearQueue Aug 31 10:25:45 digione volumio[965]: info: CoreStateMachine::stop Aug 31 10:25:45 digione volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 10:25:45 digione volumio[965]: info: CorePlayQueue::clearPlayQueue Aug 31 10:25:45 digione volumio[965]: info: CorePlayQueue::saveQueue Aug 31 10:25:45 digione volumio[965]: info: CoreCommandRouter::volumioPushState Aug 31 10:25:45 digione volumio[965]: info: CoreCommandRouter::volumioPushQueue Aug 31 10:25:50 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 31 10:25:50 digione volumio[965]: info: CURURI: music-library Aug 31 10:25:50 digione volumio[965]: error: Failed LSINFO: null Aug 31 10:25:51 digione volumio[965]: info: Preload queue cleared Aug 31 10:25:54 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Aug 31 10:25:54 digione volumio[965]: info: Preload queue cleared Aug 31 10:25:54 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Aug 31 10:25:55 digione volumio[965]: info: Preload queue cleared Aug 31 10:25:57 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Aug 31 10:25:57 digione volumio[965]: info: Preload queue cleared Aug 31 10:25:58 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Aug 31 10:25:59 digione volumio[965]: info: Preload queue cleared Aug 31 10:25:59 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Aug 31 10:26:00 digione volumio[965]: info: Preload queue cleared Aug 31 10:26:00 digione volumio[965]: info: Preloading song: upnp/http://192.168.1.79:9791/61b21be5-a053-4fcc-8891-44e79dbcfe24/upnp.org-ContentDirectory-1/control@0$folders$f451$f455$*i6262 Aug 31 10:26:00 digione volumio[965]: info: Preloading song: upnp/http://192.168.1.79:9791/61b21be5-a053-4fcc-8891-44e79dbcfe24/upnp.org-ContentDirectory-1/control@0$folders$f451$f455$*i4499 Aug 31 10:26:00 digione volumio[965]: info: Preloading song: upnp/http://192.168.1.79:9791/61b21be5-a053-4fcc-8891-44e79dbcfe24/upnp.org-ContentDirectory-1/control@0$folders$f451$f455$*i5485 Aug 31 10:26:00 digione volumio[965]: info: Preloading song: upnp/http://192.168.1.79:9791/61b21be5-a053-4fcc-8891-44e79dbcfe24/upnp.org-ContentDirectory-1/control@0$folders$f451$f455$*i5661 Aug 31 10:26:00 digione volumio[965]: info: Preloading song: upnp/http://192.168.1.79:9791/61b21be5-a053-4fcc-8891-44e79dbcfe24/upnp.org-ContentDirectory-1/control@0$folders$f451$f455$*i5947 Aug 31 10:26:00 digione volumio[965]: info: Preloading song: upnp/http://192.168.1.79:9791/61b21be5-a053-4fcc-8891-44e79dbcfe24/upnp.org-ContentDirectory-1/control@0$folders$f451$f455$*i13049 Aug 31 10:26:00 digione volumio[965]: info: Preloading song: upnp/http://192.168.1.79:9791/61b21be5-a053-4fcc-8891-44e79dbcfe24/upnp.org-ContentDirectory-1/control@0$folders$f451$f455$*i7594 Aug 31 10:26:00 digione volumio[965]: info: Preloading song: upnp/http://192.168.1.79:9791/61b21be5-a053-4fcc-8891-44e79dbcfe24/upnp.org-ContentDirectory-1/control@0$folders$f451$f455$*i15261 Aug 31 10:26:00 digione volumio[965]: info: Preloading song: upnp/http://192.168.1.79:9791/61b21be5-a053-4fcc-8891-44e79dbcfe24/upnp.org-ContentDirectory-1/control@0$folders$f451$f455$*i12767 Aug 31 10:26:00 digione volumio[965]: info: Preloading song: upnp/http://192.168.1.79:9791/61b21be5-a053-4fcc-8891-44e79dbcfe24/upnp.org-ContentDirectory-1/control@0$folders$f451$f455$*i13554 Aug 31 10:26:00 digione volumio[965]: info: Preloading song: upnp/http://192.168.1.79:9791/61b21be5-a053-4fcc-8891-44e79dbcfe24/upnp.org-ContentDirectory-1/control@0$folders$f451$f455$*i19058 Aug 31 10:26:00 digione volumio[965]: info: Preloading song: upnp/http://192.168.1.79:9791/61b21be5-a053-4fcc-8891-44e79dbcfe24/upnp.org-ContentDirectory-1/control@0$folders$f451$f455$*i9292 Aug 31 10:26:00 digione volumio[965]: info: Exploding uri upnp/http://192.168.1.79:9791/61b21be5-a053-4fcc-8891-44e79dbcfe24/upnp.org-ContentDirectory-1/control@0$folders$f451$f455$*i6262 in service upnp_browser Aug 31 10:26:00 digione volumio[965]: info: Exploding uri upnp/http://192.168.1.79:9791/61b21be5-a053-4fcc-8891-44e79dbcfe24/upnp.org-ContentDirectory-1/control@0$folders$f451$f455$*i4499 in service upnp_browser Aug 31 10:26:00 digione volumio[965]: info: Exploding uri upnp/http://192.168.1.79:9791/61b21be5-a053-4fcc-8891-44e79dbcfe24/upnp.org-ContentDirectory-1/control@0$folders$f451$f455$*i5485 in service upnp_browser Aug 31 10:26:00 digione volumio[965]: info: Exploding uri upnp/http://192.168.1.79:9791/61b21be5-a053-4fcc-8891-44e79dbcfe24/upnp.org-ContentDirectory-1/control@0$folders$f451$f455$*i5661 in service upnp_browser Aug 31 10:26:00 digione volumio[965]: info: Exploding uri upnp/http://192.168.1.79:9791/61b21be5-a053-4fcc-8891-44e79dbcfe24/upnp.org-ContentDirectory-1/control@0$folders$f451$f455$*i5947 in service upnp_browser Aug 31 10:26:00 digione volumio[965]: info: Exploding uri upnp/http://192.168.1.79:9791/61b21be5-a053-4fcc-8891-44e79dbcfe24/upnp.org-ContentDirectory-1/control@0$folders$f451$f455$*i13049 in service upnp_browser Aug 31 10:26:00 digione volumio[965]: info: Exploding uri upnp/http://192.168.1.79:9791/61b21be5-a053-4fcc-8891-44e79dbcfe24/upnp.org-ContentDirectory-1/control@0$folders$f451$f455$*i7594 in service upnp_browser Aug 31 10:26:00 digione volumio[965]: info: Exploding uri upnp/http://192.168.1.79:9791/61b21be5-a053-4fcc-8891-44e79dbcfe24/upnp.org-ContentDirectory-1/control@0$folders$f451$f455$*i15261 in service upnp_browser Aug 31 10:26:00 digione volumio[965]: info: Exploding uri upnp/http://192.168.1.79:9791/61b21be5-a053-4fcc-8891-44e79dbcfe24/upnp.org-ContentDirectory-1/control@0$folders$f451$f455$*i12767 in service upnp_browser Aug 31 10:26:00 digione volumio[965]: info: Exploding uri upnp/http://192.168.1.79:9791/61b21be5-a053-4fcc-8891-44e79dbcfe24/upnp.org-ContentDirectory-1/control@0$folders$f451$f455$*i13554 in service upnp_browser Aug 31 10:26:00 digione volumio[965]: info: Exploding uri upnp/http://192.168.1.79:9791/61b21be5-a053-4fcc-8891-44e79dbcfe24/upnp.org-ContentDirectory-1/control@0$folders$f451$f455$*i19058 in service upnp_browser Aug 31 10:26:00 digione volumio[965]: info: Exploding uri upnp/http://192.168.1.79:9791/61b21be5-a053-4fcc-8891-44e79dbcfe24/upnp.org-ContentDirectory-1/control@0$folders$f451$f455$*i9292 in service upnp_browser Aug 31 10:26:01 digione volumio[965]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Aug 31 10:26:01 digione volumio[965]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 10:26:01 digione volumio[965]: TypeError: Cannot read property 'length' of undefined Aug 31 10:26:01 digione volumio[965]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Aug 31 10:26:01 digione volumio[965]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Aug 31 10:26:01 digione volumio[965]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Aug 31 10:26:01 digione volumio[965]: at Parser.emit (events.js:315:20) Aug 31 10:26:01 digione volumio[965]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Aug 31 10:26:01 digione volumio[965]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Aug 31 10:26:01 digione volumio[965]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Aug 31 10:26:01 digione volumio[965]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Aug 31 10:26:01 digione volumio[965]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Aug 31 10:26:01 digione volumio[965]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Aug 31 10:26:01 digione volumio[965]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Aug 31 10:26:01 digione volumio[965]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Aug 31 10:26:01 digione volumio[965]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Aug 31 10:26:01 digione volumio[965]: at IncomingMessage.emit (events.js:327:22) Aug 31 10:26:01 digione volumio[965]: at endReadableNT (internal/streams/readable.js:1327:12) Aug 31 10:26:01 digione volumio[965]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Aug 31 10:26:01 digione volumio[965]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 10:26:02 digione sudo[1905]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-08-31 10:25 Aug 31 10:26:02 digione sudo[1905]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"