-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Tue 2024-05-07 22:06:47 CEST. -- May 07 22:05:08 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 22:05:08 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 22:05:08 volumioholger2 volumio[596]: info: Discovery: Getting this device information May 07 22:05:08 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioGetState May 07 22:05:08 volumioholger2 volumio[596]: info: CorePlayQueue::getTrack 0 May 07 22:05:08 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 22:05:09 volumioholger2 volumio[596]: verbose: New Socket.io Connection to 192.168.178.36 from 192.168.178.24 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 5 May 07 22:05:09 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioGetVisibleSources May 07 22:05:09 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 22:05:09 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioGetVisibleSources May 07 22:05:09 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 22:05:09 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioGetVisibleSources May 07 22:05:09 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 22:05:09 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioGetVisibleSources May 07 22:05:09 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 22:05:09 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioGetVisibleSources May 07 22:05:09 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 22:05:09 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:09 volumioholger2 volumio[596]: info: Retrieving Cloud Streaming UI May 07 22:05:09 volumioholger2 volumio[596]: info: Getting Tidal Cloud Configuration May 07 22:05:09 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:09 volumioholger2 volumio[596]: info: Getting Qobuz Cloud Configuration May 07 22:05:09 volumioholger2 volumio[596]: info: Asking plugin for UI Config May 07 22:05:09 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:09 volumioholger2 volumio[596]: info: Getting Spotify Cloud Configuration May 07 22:05:09 volumioholger2 volumio[596]: info: Asking plugin for UI Config May 07 22:05:09 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:09 volumioholger2 volumio[596]: info: Saving Spotify Acccount May 07 22:05:09 volumioholger2 volumio[596]: info: Got Tidal Cloud Configuration May 07 22:05:09 volumioholger2 volumio[596]: info: Got it May 07 22:05:09 volumioholger2 volumio[596]: info: Got it May 07 22:05:09 volumioholger2 volumio[596]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 07 22:05:09 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:09 volumioholger2 volumio[596]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 07 22:05:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions May 07 22:05:11 volumioholger2 volumio[596]: info: Preparing to save Alsa Options, stopping services first May 07 22:05:11 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioGetState May 07 22:05:11 volumioholger2 volumio[596]: info: CorePlayQueue::getTrack 0 May 07 22:05:11 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioPause May 07 22:05:11 volumioholger2 volumio[596]: info: CoreStateMachine::pause May 07 22:05:11 volumioholger2 volumio[596]: info: Saving Audio Output to: {"i2s":true,"i2sid":{"value":"hifiberry-dacplus","label":"HiFiBerry DAC Plus"},"output_device":{"value":1,"label":"HiFiBerry DAC Plus"},"disallowPush":true} May 07 22:05:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 07 22:05:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber May 07 22:05:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:05:11 volumioholger2 volumio[596]: info: Enabling I2S DAC: HiFiBerry DAC Plus May 07 22:05:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , enableI2SDAC May 07 22:05:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:05:11 volumioholger2 sudo[2102]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l May 07 22:05:11 volumioholger2 sudo[2102]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:05:11 volumioholger2 sudo[2102]: pam_unix(sudo:session): session closed for user root May 07 22:05:11 volumioholger2 volumio[596]: info: No Overlays Loaded May 07 22:05:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:05:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName May 07 22:05:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:05:11 volumioholger2 sudo[2106]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay hifiberry-dacplus May 07 22:05:11 volumioholger2 sudo[2106]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:05:11 volumioholger2 kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2s@7e203000/status May 07 22:05:11 volumioholger2 kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2c@7e804000/status May 07 22:05:11 volumioholger2 kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/compatible May 07 22:05:11 volumioholger2 kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/i2s-controller May 07 22:05:11 volumioholger2 kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/status May 07 22:05:11 volumioholger2 sudo[2106]: pam_unix(sudo:session): session closed for user root May 07 22:05:11 volumioholger2 volumio[596]: warn: Unable to locate the device HiFiBerry DAC Plus a reboot may be required. May 07 22:05:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 07 22:05:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer May 07 22:05:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:05:11 volumioholger2 volumio[596]: info: Found match in i2s Card Database: setting mixer Digital for card HiFiBerry DAC Plus May 07 22:05:11 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 07 22:05:11 volumioholger2 volumio[596]: info: Updating Volume Controller Parameters: Device: 2 Name: HiFiBerry DAC Plus Mixer: Digital Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 May 07 22:05:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume May 07 22:05:11 volumioholger2 volumio[596]: info: Disabling external Volume Control May 07 22:05:11 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:11 volumioholger2 systemd-udevd[2122]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 2' failed with exit code 99. May 07 22:05:12 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction May 07 22:05:12 volumioholger2 volumio[596]: info: Preparing to generate the ALSA configuration file May 07 22:05:12 volumioholger2 volumio[596]: info: I2S Param [object Object] successfully enabled May 07 22:05:12 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:12 volumioholger2 volumio[596]: info: Retrieving Cloud Streaming UI May 07 22:05:12 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 07 22:05:12 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:05:12 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 07 22:05:12 volumioholger2 volumio[596]: info: Getting Alsa Cards List without I2S DAC May 07 22:05:12 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber May 07 22:05:12 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:05:12 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:05:12 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:05:12 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:05:12 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:05:12 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:05:12 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:05:12 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:05:12 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 07 22:05:12 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 07 22:05:12 volumioholger2 volumio[596]: info: VolumeController:: Volume=100 Mute =false May 07 22:05:12 volumioholger2 volumio[596]: info: CoreStateMachine::pushState May 07 22:05:12 volumioholger2 volumio[596]: info: CorePlayQueue::getTrack 0 May 07 22:05:12 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 07 22:05:12 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioPushState May 07 22:05:12 volumioholger2 volumio[596]: info: Asound.conf file written May 07 22:05:12 volumioholger2 sudo[2155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf May 07 22:05:12 volumioholger2 sudo[2155]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:05:12 volumioholger2 sudo[2155]: pam_unix(sudo:session): session closed for user root May 07 22:05:12 volumioholger2 volumio[596]: No state is present for card b1 May 07 22:05:12 volumioholger2 volumio[596]: /usr/share/alsa/init/bcm2835:14: control element not found May 07 22:05:12 volumioholger2 volumio[596]: No state is present for card b1 May 07 22:05:12 volumioholger2 volumio[596]: No state is present for card Headphones May 07 22:05:12 volumioholger2 volumio[596]: /usr/share/alsa/init/bcm2835:20: control element not found May 07 22:05:12 volumioholger2 volumio[596]: No state is present for card Headphones May 07 22:05:12 volumioholger2 volumio[596]: No state is present for card sndrpihifiberry May 07 22:05:12 volumioholger2 volumio[596]: Found hardware: "HifiberryDacp" "" "" "" "" May 07 22:05:12 volumioholger2 volumio[596]: Hardware is initialized using a generic method May 07 22:05:12 volumioholger2 volumio[596]: No state is present for card sndrpihifiberry May 07 22:05:12 volumioholger2 volumio[596]: info: Output device has changed, restarting MPD May 07 22:05:12 volumioholger2 sudo[2160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 07 22:05:12 volumioholger2 sudo[2160]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:05:12 volumioholger2 volumio[596]: info: Output device has changed, restarting Shairport Sync May 07 22:05:12 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:05:12 volumioholger2 sudo[2160]: pam_unix(sudo:session): session closed for user root May 07 22:05:12 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:05:12 volumioholger2 sudo[2163]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 07 22:05:12 volumioholger2 sudo[2163]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:05:12 volumioholger2 systemd[1]: Stopping Music Player Daemon... May 07 22:05:12 volumioholger2 volumio[596]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 07 22:05:12 volumioholger2 volumio[596]: info: Output device has changed, restarting MPD May 07 22:05:13 volumioholger2 volumio[596]: info: Output device has changed, restarting Shairport Sync May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:05:13 volumioholger2 sudo[2169]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 07 22:05:13 volumioholger2 sudo[2169]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:05:13 volumioholger2 sudo[2169]: pam_unix(sudo:session): session closed for user root May 07 22:05:13 volumioholger2 sudo[2171]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 07 22:05:13 volumioholger2 sudo[2171]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:05:13 volumioholger2 volumio[596]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 07 22:05:13 volumioholger2 volumio[596]: info: Getting Tidal Cloud Configuration May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:13 volumioholger2 volumio[596]: info: Getting Qobuz Cloud Configuration May 07 22:05:13 volumioholger2 volumio[596]: info: Asking plugin for UI Config May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:13 volumioholger2 volumio[596]: info: Getting Spotify Cloud Configuration May 07 22:05:13 volumioholger2 volumio[596]: info: Asking plugin for UI Config May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:13 volumioholger2 volumio[596]: info: Saving Spotify Acccount May 07 22:05:13 volumioholger2 volumio[596]: info: Got Tidal Cloud Configuration May 07 22:05:13 volumioholger2 volumio[596]: info: Got it May 07 22:05:13 volumioholger2 volumio[596]: info: Got it May 07 22:05:13 volumioholger2 volumio[596]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 07 22:05:13 volumioholger2 systemd[1]: mpd.service: Succeeded. May 07 22:05:13 volumioholger2 systemd[1]: Stopped Music Player Daemon. May 07 22:05:13 volumioholger2 volumio[596]: info: MPD Permissions set May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:05:13 volumioholger2 systemd[1]: Starting Music Player Daemon... May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:13 volumioholger2 volumio[596]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 07 22:05:13 volumioholger2 volumio[596]: info: Starting Shairport Sync May 07 22:05:13 volumioholger2 volumio[596]: info: Starting Shairport Sync May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:13 volumioholger2 volumio[596]: info: Retrieving Cloud Streaming UI May 07 22:05:13 volumioholger2 sudo[2188]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 07 22:05:13 volumioholger2 sudo[2188]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:05:13 volumioholger2 volumio[596]: info: Getting Tidal Cloud Configuration May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:13 volumioholger2 volumio[596]: info: Getting Qobuz Cloud Configuration May 07 22:05:13 volumioholger2 volumio[596]: info: Asking plugin for UI Config May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:13 volumioholger2 volumio[596]: info: Getting Spotify Cloud Configuration May 07 22:05:13 volumioholger2 volumio[596]: info: Asking plugin for UI Config May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:13 volumioholger2 sudo[2190]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 07 22:05:13 volumioholger2 volumio[596]: info: Saving Spotify Acccount May 07 22:05:13 volumioholger2 volumio[596]: info: Got Tidal Cloud Configuration May 07 22:05:13 volumioholger2 sudo[2190]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:05:13 volumioholger2 volumio[596]: info: Got it May 07 22:05:13 volumioholger2 volumio[596]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 07 22:05:13 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:13 volumioholger2 volumio[596]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 07 22:05:13 volumioholger2 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 07 22:05:13 volumioholger2 systemd[1]: shairport-sync.service: Succeeded. May 07 22:05:13 volumioholger2 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 07 22:05:13 volumioholger2 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 07 22:05:13 volumioholger2 sudo[2188]: pam_unix(sudo:session): session closed for user root May 07 22:05:13 volumioholger2 sudo[2190]: pam_unix(sudo:session): session closed for user root May 07 22:05:13 volumioholger2 volumio[596]: info: Shairport-Sync Started May 07 22:05:13 volumioholger2 volumio[596]: info: Shairport-Sync Started May 07 22:05:15 volumioholger2 mpd[2177]: May 07 22:05 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 07 22:05:15 volumioholger2 systemd[1]: Started Music Player Daemon. May 07 22:05:15 volumioholger2 sudo[2171]: pam_unix(sudo:session): session closed for user root May 07 22:05:15 volumioholger2 sudo[2163]: pam_unix(sudo:session): session closed for user root May 07 22:05:15 volumioholger2 volumio[596]: error: MPD error: The expression evaluated to a falsy value: May 07 22:05:15 volumioholger2 volumio[596]: assert.ok(self.idling) May 07 22:05:15 volumioholger2 volumio[596]: error: The expression evaluated to a falsy value: May 07 22:05:15 volumioholger2 volumio[596]: assert.ok(self.idling) May 07 22:05:15 volumioholger2 volumio[596]: error: updateQueue error: null May 07 22:05:15 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioRetrieveVolumeLevels May 07 22:05:15 volumioholger2 volumio[596]: info: CoreStateMachine::getcurrentVolume May 07 22:05:15 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioRetrievevolume May 07 22:05:16 volumioholger2 volumio[596]: info: VolumeController:: Volume=100 Mute =false May 07 22:05:16 volumioholger2 volumio[596]: info: CoreStateMachine::pushState May 07 22:05:16 volumioholger2 volumio[596]: info: CorePlayQueue::getTrack 0 May 07 22:05:16 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioPushState May 07 22:05:16 volumioholger2 volumio[596]: info: CoreStateMachine::updateTrackBlock May 07 22:05:16 volumioholger2 volumio[596]: info: CorePlayQueue::getTrackBlock May 07 22:05:16 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioRetrievevolume May 07 22:05:16 volumioholger2 volumio[596]: info: VolumeController:: Volume=100 Mute =false May 07 22:05:16 volumioholger2 volumio[596]: info: CoreStateMachine::pushState May 07 22:05:16 volumioholger2 volumio[596]: info: CorePlayQueue::getTrack 0 May 07 22:05:16 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioPushState May 07 22:05:26 volumioholger2 sudo[2247]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 07 22:05:26 volumioholger2 sudo[2247]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:05:26 volumioholger2 sudo[2247]: pam_unix(sudo:session): session closed for user root May 07 22:05:26 volumioholger2 sudo[2249]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 07 22:05:26 volumioholger2 sudo[2249]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:05:26 volumioholger2 sudo[2249]: pam_unix(sudo:session): session closed for user root May 07 22:05:26 volumioholger2 volumio[596]: verbose: New Socket.io Connection to 192.168.178.36 from 192.168.178.24 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 6 May 07 22:05:26 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioGetVisibleSources May 07 22:05:26 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 22:05:26 volumioholger2 volumio[596]: info: Received Get System Info May 07 22:05:26 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 22:05:26 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 22:05:26 volumioholger2 volumio[596]: info: Discovery: Getting this device information May 07 22:05:26 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioGetState May 07 22:05:26 volumioholger2 volumio[596]: info: CorePlayQueue::getTrack 0 May 07 22:05:26 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 22:05:31 volumioholger2 sudo[2255]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 07 22:05:31 volumioholger2 sudo[2255]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:05:31 volumioholger2 sudo[2255]: pam_unix(sudo:session): session closed for user root May 07 22:05:31 volumioholger2 sudo[2257]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 07 22:05:31 volumioholger2 sudo[2257]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:05:31 volumioholger2 sudo[2257]: pam_unix(sudo:session): session closed for user root May 07 22:05:31 volumioholger2 volumio[596]: verbose: New Socket.io Connection to 192.168.178.36 from 192.168.178.24 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 6 May 07 22:05:31 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioGetVisibleSources May 07 22:05:31 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 22:05:31 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps May 07 22:05:31 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode May 07 22:05:31 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages May 07 22:05:31 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones May 07 22:05:31 volumioholger2 volumio[596]: info: Received Get System Info May 07 22:05:31 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 22:05:31 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 22:05:31 volumioholger2 volumio[596]: info: Discovery: Getting this device information May 07 22:05:31 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioGetState May 07 22:05:31 volumioholger2 volumio[596]: info: CorePlayQueue::getTrack 0 May 07 22:05:31 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 22:05:31 volumioholger2 volumio-remote-updater[388]: No test mode May 07 22:05:31 volumioholger2 volumio-remote-updater[388]: No alpha test mode May 07 22:05:31 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:31 volumioholger2 volumio[596]: info: Retrieving Cloud Streaming UI May 07 22:05:32 volumioholger2 volumio[596]: info: Getting Tidal Cloud Configuration May 07 22:05:32 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:32 volumioholger2 volumio[596]: info: Getting Qobuz Cloud Configuration May 07 22:05:32 volumioholger2 volumio[596]: info: Asking plugin for UI Config May 07 22:05:32 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:32 volumioholger2 volumio[596]: info: Getting Spotify Cloud Configuration May 07 22:05:32 volumioholger2 volumio[596]: info: Asking plugin for UI Config May 07 22:05:32 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:32 volumioholger2 volumio[596]: info: Saving Spotify Acccount May 07 22:05:32 volumioholger2 volumio[596]: info: Got Tidal Cloud Configuration May 07 22:05:32 volumioholger2 volumio[596]: info: Got it May 07 22:05:32 volumioholger2 volumio[596]: info: Got it May 07 22:05:32 volumioholger2 volumio[596]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 07 22:05:32 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:32 volumioholger2 volumio[596]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 07 22:05:32 volumioholger2 volumio[596]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} May 07 22:05:32 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 07 22:05:33 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage May 07 22:05:33 volumioholger2 volumio[596]: info: Loading i18n strings for locale de May 07 22:05:33 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone May 07 22:05:33 volumioholger2 volumio[596]: info: Setting timezone to Europe/Berlin May 07 22:05:33 volumioholger2 sudo[2268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime May 07 22:05:33 volumioholger2 sudo[2268]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:05:33 volumioholger2 sudo[2268]: pam_unix(sudo:session): session closed for user root May 07 22:05:33 volumioholger2 sudo[2271]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Berlin /etc/localtime May 07 22:05:33 volumioholger2 sudo[2271]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:05:33 volumioholger2 sudo[2271]: pam_unix(sudo:session): session closed for user root May 07 22:05:33 volumioholger2 sudo[2274]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime May 07 22:05:33 volumioholger2 sudo[2274]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:05:33 volumioholger2 sudo[2274]: pam_unix(sudo:session): session closed for user root May 07 22:05:33 volumioholger2 sudo[2277]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Berlin May 07 22:05:33 volumioholger2 sudo[2277]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:05:33 volumioholger2 dbus-daemon[389]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.27' (uid=0 pid=2278 comm="/usr/bin/timedatectl set-timezone Europe/Berlin ") May 07 22:05:33 volumioholger2 systemd[1]: Starting Time & Date Service... May 07 22:05:33 volumioholger2 dbus-daemon[389]: [system] Successfully activated service 'org.freedesktop.timedate1' May 07 22:05:33 volumioholger2 systemd[1]: Started Time & Date Service. May 07 22:05:33 volumioholger2 sudo[2277]: pam_unix(sudo:session): session closed for user root May 07 22:05:33 volumioholger2 volumio[596]: info: Fetching Streaming Services browse cache May 07 22:05:33 volumioholger2 volumio[596]: Updating browse sources language May 07 22:05:33 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 22:05:40 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings May 07 22:05:40 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices May 07 22:05:40 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 07 22:05:40 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:05:40 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 07 22:05:42 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions May 07 22:05:42 volumioholger2 volumio[596]: info: Preparing to save Alsa Options, stopping services first May 07 22:05:42 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioGetState May 07 22:05:42 volumioholger2 volumio[596]: info: CorePlayQueue::getTrack 0 May 07 22:05:42 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioPause May 07 22:05:42 volumioholger2 volumio[596]: info: CoreStateMachine::pause May 07 22:05:42 volumioholger2 volumio[596]: info: Saving Audio Output to: {"i2s":true,"i2sid":{"label":"HiFiBerry DAC Plus"},"output_device":{"value":1,"label":"HiFiBerry DAC Plus"},"disallowPush":true} May 07 22:05:42 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 07 22:05:42 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber May 07 22:05:42 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:05:42 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName May 07 22:05:42 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:05:42 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 07 22:05:42 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer May 07 22:05:42 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:05:42 volumioholger2 volumio[596]: info: Found match in i2s Card Database: setting mixer Digital for card HiFiBerry DAC Plus May 07 22:05:42 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 07 22:05:42 volumioholger2 volumio[596]: info: Updating Volume Controller Parameters: Device: 2 Name: HiFiBerry DAC Plus Mixer: Digital Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 May 07 22:05:42 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume May 07 22:05:42 volumioholger2 volumio[596]: info: Disabling external Volume Control May 07 22:05:42 volumioholger2 ntpd[559]: 144.76.139.8 local addr 192.168.178.36 -> May 07 22:05:42 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:42 volumioholger2 volumio[596]: info: Preparing to generate the ALSA configuration file May 07 22:05:42 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:42 volumioholger2 volumio[596]: info: Retrieving Cloud Streaming UI May 07 22:05:42 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 07 22:05:42 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:05:42 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 07 22:05:42 volumioholger2 volumio[596]: info: Getting Alsa Cards List without I2S DAC May 07 22:05:42 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber May 07 22:05:42 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:05:43 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:05:43 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:05:43 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:05:43 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:05:43 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:05:43 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:05:43 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:05:43 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 07 22:05:43 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 07 22:05:43 volumioholger2 volumio[596]: info: Asound.conf file unchanged, so no further update is needed May 07 22:05:43 volumioholger2 volumio[596]: info: Output device has changed, restarting MPD May 07 22:05:43 volumioholger2 volumio[596]: info: Output device has changed, restarting Shairport Sync May 07 22:05:43 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:05:43 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:05:43 volumioholger2 sudo[2298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 07 22:05:43 volumioholger2 sudo[2298]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:05:43 volumioholger2 sudo[2298]: pam_unix(sudo:session): session closed for user root May 07 22:05:43 volumioholger2 sudo[2300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 07 22:05:43 volumioholger2 sudo[2300]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:05:43 volumioholger2 systemd[1]: Stopping Music Player Daemon... May 07 22:05:43 volumioholger2 volumio[596]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 07 22:05:43 volumioholger2 systemd[1]: mpd.service: Succeeded. May 07 22:05:43 volumioholger2 systemd[1]: Stopped Music Player Daemon. May 07 22:05:43 volumioholger2 volumio[596]: info: MPD Permissions set May 07 22:05:43 volumioholger2 volumio[596]: info: Getting Tidal Cloud Configuration May 07 22:05:43 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:43 volumioholger2 volumio[596]: info: Getting Qobuz Cloud Configuration May 07 22:05:43 volumioholger2 volumio[596]: info: Asking plugin for UI Config May 07 22:05:43 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:43 volumioholger2 volumio[596]: info: Getting Spotify Cloud Configuration May 07 22:05:43 volumioholger2 volumio[596]: info: Asking plugin for UI Config May 07 22:05:43 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:43 volumioholger2 volumio[596]: info: Saving Spotify Acccount May 07 22:05:43 volumioholger2 volumio[596]: info: Got Tidal Cloud Configuration May 07 22:05:43 volumioholger2 volumio[596]: info: Got it May 07 22:05:43 volumioholger2 volumio[596]: info: Got it May 07 22:05:43 volumioholger2 volumio[596]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 07 22:05:43 volumioholger2 systemd[1]: Starting Music Player Daemon... May 07 22:05:43 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:05:43 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:05:43 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:05:43 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:05:43 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:05:43 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:05:43 volumioholger2 volumio[596]: info: VolumeController:: Volume=100 Mute =false May 07 22:05:43 volumioholger2 volumio[596]: info: CoreStateMachine::pushState May 07 22:05:43 volumioholger2 volumio[596]: info: CorePlayQueue::getTrack 0 May 07 22:05:43 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioPushState May 07 22:05:43 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:43 volumioholger2 volumio[596]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 07 22:05:43 volumioholger2 volumio[596]: info: Starting Shairport Sync May 07 22:05:43 volumioholger2 sudo[2317]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 07 22:05:43 volumioholger2 sudo[2317]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:05:43 volumioholger2 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 07 22:05:43 volumioholger2 systemd[1]: shairport-sync.service: Succeeded. May 07 22:05:43 volumioholger2 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 07 22:05:43 volumioholger2 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 07 22:05:43 volumioholger2 sudo[2317]: pam_unix(sudo:session): session closed for user root May 07 22:05:43 volumioholger2 volumio[596]: info: Shairport-Sync Started May 07 22:05:45 volumioholger2 mpd[2306]: May 07 22:05 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 07 22:05:45 volumioholger2 systemd[1]: Started Music Player Daemon. May 07 22:05:45 volumioholger2 sudo[2300]: pam_unix(sudo:session): session closed for user root May 07 22:05:45 volumioholger2 volumio[596]: error: updateQueue error: null May 07 22:05:46 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioRetrieveVolumeLevels May 07 22:05:46 volumioholger2 volumio[596]: info: CoreStateMachine::getcurrentVolume May 07 22:05:46 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioRetrievevolume May 07 22:05:46 volumioholger2 volumio[596]: info: VolumeController:: Volume=100 Mute =false May 07 22:05:46 volumioholger2 volumio[596]: info: CoreStateMachine::pushState May 07 22:05:46 volumioholger2 volumio[596]: info: CorePlayQueue::getTrack 0 May 07 22:05:46 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioPushState May 07 22:05:46 volumioholger2 volumio[596]: info: CoreStateMachine::updateTrackBlock May 07 22:05:46 volumioholger2 volumio[596]: info: CorePlayQueue::getTrackBlock May 07 22:05:46 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioRetrievevolume May 07 22:05:46 volumioholger2 volumio[596]: info: VolumeController:: Volume=100 Mute =false May 07 22:05:46 volumioholger2 volumio[596]: info: CoreStateMachine::pushState May 07 22:05:46 volumioholger2 volumio[596]: info: CorePlayQueue::getTrack 0 May 07 22:05:46 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioPushState May 07 22:05:53 volumioholger2 sudo[2330]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 07 22:05:53 volumioholger2 sudo[2330]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:05:53 volumioholger2 sudo[2330]: pam_unix(sudo:session): session closed for user root May 07 22:05:53 volumioholger2 sudo[2332]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 07 22:05:53 volumioholger2 sudo[2332]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:05:53 volumioholger2 sudo[2332]: pam_unix(sudo:session): session closed for user root May 07 22:05:53 volumioholger2 volumio[596]: verbose: New Socket.io Connection to 192.168.178.36 from 192.168.178.24 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 6 May 07 22:05:53 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioGetVisibleSources May 07 22:05:53 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 22:05:53 volumioholger2 volumio[596]: info: Received Get System Info May 07 22:05:53 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 22:05:53 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 22:05:53 volumioholger2 volumio[596]: info: Discovery: Getting this device information May 07 22:05:53 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioGetState May 07 22:05:53 volumioholger2 volumio[596]: info: CorePlayQueue::getTrack 0 May 07 22:05:53 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 22:05:56 volumioholger2 sudo[2338]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 07 22:05:56 volumioholger2 sudo[2338]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:05:56 volumioholger2 sudo[2338]: pam_unix(sudo:session): session closed for user root May 07 22:05:56 volumioholger2 sudo[2340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 07 22:05:56 volumioholger2 sudo[2340]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:05:56 volumioholger2 sudo[2340]: pam_unix(sudo:session): session closed for user root May 07 22:05:56 volumioholger2 volumio[596]: verbose: New Socket.io Connection to 192.168.178.36 from 192.168.178.24 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 6 May 07 22:05:56 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioGetVisibleSources May 07 22:05:56 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 22:05:56 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps May 07 22:05:56 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode May 07 22:05:56 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages May 07 22:05:56 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones May 07 22:05:56 volumioholger2 volumio[596]: info: Received Get System Info May 07 22:05:56 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 22:05:56 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 22:05:56 volumioholger2 volumio[596]: info: Discovery: Getting this device information May 07 22:05:56 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioGetState May 07 22:05:56 volumioholger2 volumio[596]: info: CorePlayQueue::getTrack 0 May 07 22:05:56 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 22:05:56 volumioholger2 volumio-remote-updater[388]: No test mode May 07 22:05:56 volumioholger2 volumio-remote-updater[388]: No alpha test mode May 07 22:05:56 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:56 volumioholger2 volumio[596]: info: Retrieving Cloud Streaming UI May 07 22:05:56 volumioholger2 volumio[596]: info: Getting Tidal Cloud Configuration May 07 22:05:56 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:56 volumioholger2 volumio[596]: info: Getting Qobuz Cloud Configuration May 07 22:05:56 volumioholger2 volumio[596]: info: Asking plugin for UI Config May 07 22:05:56 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:56 volumioholger2 volumio[596]: info: Getting Spotify Cloud Configuration May 07 22:05:56 volumioholger2 volumio[596]: info: Asking plugin for UI Config May 07 22:05:56 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:56 volumioholger2 volumio[596]: info: Saving Spotify Acccount May 07 22:05:56 volumioholger2 volumio[596]: info: Got Tidal Cloud Configuration May 07 22:05:56 volumioholger2 volumio[596]: info: Got it May 07 22:05:56 volumioholger2 volumio[596]: info: Got it May 07 22:05:56 volumioholger2 volumio[596]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 07 22:05:56 volumioholger2 volumio[596]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} May 07 22:05:56 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 07 22:05:56 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:05:56 volumioholger2 volumio[596]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 07 22:05:57 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage May 07 22:05:57 volumioholger2 volumio[596]: info: Loading i18n strings for locale de May 07 22:05:57 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone May 07 22:05:57 volumioholger2 volumio[596]: info: Setting timezone to Europe/Berlin May 07 22:05:57 volumioholger2 sudo[2350]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime May 07 22:05:57 volumioholger2 sudo[2350]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:05:57 volumioholger2 sudo[2350]: pam_unix(sudo:session): session closed for user root May 07 22:05:57 volumioholger2 sudo[2353]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Berlin /etc/localtime May 07 22:05:57 volumioholger2 sudo[2353]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:05:57 volumioholger2 sudo[2353]: pam_unix(sudo:session): session closed for user root May 07 22:05:58 volumioholger2 sudo[2356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime May 07 22:05:58 volumioholger2 sudo[2356]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:05:58 volumioholger2 sudo[2356]: pam_unix(sudo:session): session closed for user root May 07 22:05:58 volumioholger2 sudo[2359]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Berlin May 07 22:05:58 volumioholger2 sudo[2359]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:05:58 volumioholger2 sudo[2359]: pam_unix(sudo:session): session closed for user root May 07 22:05:58 volumioholger2 volumio[596]: Updating browse sources language May 07 22:05:58 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 22:05:58 volumioholger2 volumio[596]: info: Fetching Streaming Services browse cache May 07 22:06:03 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule May 07 22:06:03 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 07 22:06:03 volumioholger2 volumio-remote-updater[388]: No test mode May 07 22:06:03 volumioholger2 volumio-remote-updater[388]: No alpha test mode May 07 22:06:03 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled May 07 22:06:04 volumioholger2 volumio[596]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} May 07 22:06:04 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 07 22:06:05 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings May 07 22:06:05 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices May 07 22:06:06 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 07 22:06:06 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:06:06 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 07 22:06:10 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions May 07 22:06:10 volumioholger2 volumio[596]: info: Preparing to save Alsa Options, stopping services first May 07 22:06:10 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioGetState May 07 22:06:10 volumioholger2 volumio[596]: info: CorePlayQueue::getTrack 0 May 07 22:06:10 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioPause May 07 22:06:10 volumioholger2 volumio[596]: info: CoreStateMachine::pause May 07 22:06:10 volumioholger2 volumio[596]: info: Saving Audio Output to: {"i2s":true,"i2sid":{"label":"HiFiBerry DAC Plus"},"output_device":{"value":1,"label":"HiFiBerry DAC Plus"},"disallowPush":true} May 07 22:06:10 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 07 22:06:10 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber May 07 22:06:10 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:06:10 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName May 07 22:06:10 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:06:10 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 07 22:06:10 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer May 07 22:06:10 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:06:10 volumioholger2 volumio[596]: info: Found match in i2s Card Database: setting mixer Digital for card HiFiBerry DAC Plus May 07 22:06:10 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 07 22:06:10 volumioholger2 volumio[596]: info: Updating Volume Controller Parameters: Device: 2 Name: HiFiBerry DAC Plus Mixer: Digital Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 May 07 22:06:10 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume May 07 22:06:10 volumioholger2 volumio[596]: info: Disabling external Volume Control May 07 22:06:10 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:06:10 volumioholger2 volumio[596]: info: Preparing to generate the ALSA configuration file May 07 22:06:10 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 07 22:06:10 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:06:10 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 07 22:06:10 volumioholger2 volumio[596]: info: Getting Alsa Cards List without I2S DAC May 07 22:06:10 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber May 07 22:06:10 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:06:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:06:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:06:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:06:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:06:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:06:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:06:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:06:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 07 22:06:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 07 22:06:11 volumioholger2 volumio[596]: info: Asound.conf file unchanged, so no further update is needed May 07 22:06:11 volumioholger2 volumio[596]: info: Output device has changed, restarting MPD May 07 22:06:11 volumioholger2 volumio[596]: info: Output device has changed, restarting Shairport Sync May 07 22:06:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:06:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:06:11 volumioholger2 sudo[2383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 07 22:06:11 volumioholger2 sudo[2383]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:06:11 volumioholger2 sudo[2383]: pam_unix(sudo:session): session closed for user root May 07 22:06:11 volumioholger2 sudo[2385]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 07 22:06:11 volumioholger2 sudo[2385]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:06:11 volumioholger2 systemd[1]: Stopping Music Player Daemon... May 07 22:06:11 volumioholger2 volumio[596]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 07 22:06:11 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:06:11 volumioholger2 volumio[596]: info: Retrieving Cloud Streaming UI May 07 22:06:11 volumioholger2 volumio[596]: info: MPD Permissions set May 07 22:06:11 volumioholger2 volumio[596]: info: VolumeController:: Volume=100 Mute =false May 07 22:06:11 volumioholger2 systemd[1]: mpd.service: Succeeded. May 07 22:06:11 volumioholger2 systemd[1]: Stopped Music Player Daemon. May 07 22:06:11 volumioholger2 volumio[596]: info: CoreStateMachine::pushState May 07 22:06:11 volumioholger2 volumio[596]: info: CorePlayQueue::getTrack 0 May 07 22:06:11 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioPushState May 07 22:06:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:06:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:06:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:06:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:06:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:06:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:06:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:06:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:06:11 volumioholger2 systemd[1]: Starting Music Player Daemon... May 07 22:06:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:06:11 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:06:11 volumioholger2 volumio[596]: info: Getting Tidal Cloud Configuration May 07 22:06:11 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:06:11 volumioholger2 volumio[596]: info: Getting Qobuz Cloud Configuration May 07 22:06:11 volumioholger2 volumio[596]: info: Asking plugin for UI Config May 07 22:06:11 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:06:11 volumioholger2 volumio[596]: info: Getting Spotify Cloud Configuration May 07 22:06:11 volumioholger2 volumio[596]: info: Asking plugin for UI Config May 07 22:06:11 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:06:11 volumioholger2 volumio[596]: info: Saving Spotify Acccount May 07 22:06:11 volumioholger2 volumio[596]: info: Got Tidal Cloud Configuration May 07 22:06:11 volumioholger2 volumio[596]: info: Got it May 07 22:06:11 volumioholger2 volumio[596]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 07 22:06:11 volumioholger2 volumio[596]: info: Starting Shairport Sync May 07 22:06:11 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:06:11 volumioholger2 volumio[596]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 07 22:06:11 volumioholger2 sudo[2398]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 07 22:06:11 volumioholger2 sudo[2398]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:06:11 volumioholger2 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 07 22:06:11 volumioholger2 systemd[1]: shairport-sync.service: Succeeded. May 07 22:06:11 volumioholger2 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 07 22:06:11 volumioholger2 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 07 22:06:11 volumioholger2 sudo[2398]: pam_unix(sudo:session): session closed for user root May 07 22:06:11 volumioholger2 volumio[596]: info: Shairport-Sync Started May 07 22:06:13 volumioholger2 mpd[2391]: May 07 22:06 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 07 22:06:13 volumioholger2 systemd[1]: Started Music Player Daemon. May 07 22:06:13 volumioholger2 sudo[2385]: pam_unix(sudo:session): session closed for user root May 07 22:06:13 volumioholger2 volumio[596]: error: updateQueue error: null May 07 22:06:14 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioRetrieveVolumeLevels May 07 22:06:14 volumioholger2 volumio[596]: info: CoreStateMachine::getcurrentVolume May 07 22:06:14 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioRetrievevolume May 07 22:06:14 volumioholger2 volumio[596]: info: VolumeController:: Volume=100 Mute =false May 07 22:06:14 volumioholger2 volumio[596]: info: CoreStateMachine::pushState May 07 22:06:14 volumioholger2 volumio[596]: info: CorePlayQueue::getTrack 0 May 07 22:06:14 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioPushState May 07 22:06:14 volumioholger2 volumio[596]: info: CoreStateMachine::updateTrackBlock May 07 22:06:14 volumioholger2 volumio[596]: info: CorePlayQueue::getTrackBlock May 07 22:06:14 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioRetrievevolume May 07 22:06:14 volumioholger2 volumio[596]: info: VolumeController:: Volume=100 Mute =false May 07 22:06:14 volumioholger2 volumio[596]: info: CoreStateMachine::pushState May 07 22:06:14 volumioholger2 volumio[596]: info: CorePlayQueue::getTrack 0 May 07 22:06:14 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioPushState May 07 22:06:18 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation May 07 22:06:18 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware May 07 22:06:18 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray May 07 22:06:18 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage May 07 22:06:18 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware May 07 22:06:26 volumioholger2 volumio[596]: info: CALLMETHOD: system_controller system saveUpdateSettings [object Object] May 07 22:06:26 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , saveUpdateSettings May 07 22:06:26 volumioholger2 volumio[596]: error: Failed callmethod call: TypeError: Cannot read property 'value' of undefined May 07 22:06:27 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction May 07 22:06:27 volumioholger2 volumio[596]: info: CoreCommandRouter::Reload Ui May 07 22:06:27 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard May 07 22:06:27 volumioholger2 volumio[596]: info: Wizard terminated Successfully May 07 22:06:27 volumioholger2 volumio[596]: info: CoreCommandRouter::volumiosetStartupVolume May 07 22:06:27 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 22:06:27 volumioholger2 volumio[596]: info: Player Reboot required after I2S DAC has been enabled in wizard May 07 22:06:28 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule May 07 22:06:28 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 07 22:06:28 volumioholger2 systemd[1]: systemd-timedated.service: Succeeded. May 07 22:06:28 volumioholger2 volumio-remote-updater[388]: No test mode May 07 22:06:28 volumioholger2 volumio-remote-updater[388]: No alpha test mode May 07 22:06:28 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled May 07 22:06:28 volumioholger2 volumio[596]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} May 07 22:06:28 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 07 22:06:28 volumioholger2 sudo[2464]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 07 22:06:28 volumioholger2 sudo[2464]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:06:29 volumioholger2 sudo[2464]: pam_unix(sudo:session): session closed for user root May 07 22:06:29 volumioholger2 sudo[2466]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 07 22:06:29 volumioholger2 sudo[2466]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:06:29 volumioholger2 sudo[2466]: pam_unix(sudo:session): session closed for user root May 07 22:06:29 volumioholger2 volumio[596]: verbose: New Socket.io Connection to 192.168.178.36 from 192.168.178.24 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 5 May 07 22:06:29 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 07 22:06:29 volumioholger2 sudo[2472]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 07 22:06:29 volumioholger2 sudo[2472]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:06:29 volumioholger2 sudo[2472]: pam_unix(sudo:session): session closed for user root May 07 22:06:29 volumioholger2 sudo[2474]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 07 22:06:29 volumioholger2 sudo[2474]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:06:29 volumioholger2 sudo[2474]: pam_unix(sudo:session): session closed for user root May 07 22:06:29 volumioholger2 volumio[596]: verbose: New Socket.io Connection to 192.168.178.36 from 192.168.178.24 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 6 May 07 22:06:29 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 07 22:06:29 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 07 22:06:29 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioGetVisibleSources May 07 22:06:29 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 22:06:29 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioGetState May 07 22:06:29 volumioholger2 volumio[596]: info: CorePlayQueue::getTrack 0 May 07 22:06:29 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 07 22:06:29 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 07 22:06:29 volumioholger2 volumio[596]: info: Received Get System Info May 07 22:06:29 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 22:06:29 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 22:06:29 volumioholger2 volumio[596]: info: Discovery: Getting this device information May 07 22:06:29 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioGetState May 07 22:06:29 volumioholger2 volumio[596]: info: CorePlayQueue::getTrack 0 May 07 22:06:29 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 22:06:29 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioGetState May 07 22:06:29 volumioholger2 volumio[596]: info: CorePlayQueue::getTrack 0 May 07 22:06:29 volumioholger2 volumio[596]: info: Listing playlists May 07 22:06:29 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 07 22:06:29 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 07 22:06:29 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 07 22:06:31 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 07 22:06:31 volumioholger2 volumio[596]: info: Received Get System Info May 07 22:06:31 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 22:06:31 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 22:06:31 volumioholger2 volumio[596]: info: Discovery: Getting this device information May 07 22:06:31 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioGetState May 07 22:06:31 volumioholger2 volumio[596]: info: CorePlayQueue::getTrack 0 May 07 22:06:31 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 22:06:32 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 07 22:06:32 volumioholger2 volumio[596]: info: Received Get System Info May 07 22:06:32 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 22:06:32 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 22:06:32 volumioholger2 volumio[596]: info: Discovery: Getting this device information May 07 22:06:32 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioGetState May 07 22:06:32 volumioholger2 volumio[596]: info: CorePlayQueue::getTrack 0 May 07 22:06:32 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 22:06:41 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:06:41 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:06:41 volumioholger2 volumio[596]: info: Retrieving Cloud Streaming UI May 07 22:06:41 volumioholger2 volumio[596]: info: Getting Tidal Cloud Configuration May 07 22:06:41 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:06:41 volumioholger2 volumio[596]: info: Getting Qobuz Cloud Configuration May 07 22:06:41 volumioholger2 volumio[596]: info: Asking plugin for UI Config May 07 22:06:41 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:06:41 volumioholger2 volumio[596]: info: Getting Spotify Cloud Configuration May 07 22:06:41 volumioholger2 volumio[596]: info: Asking plugin for UI Config May 07 22:06:41 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:06:41 volumioholger2 volumio[596]: info: Saving Spotify Acccount May 07 22:06:41 volumioholger2 volumio[596]: info: Got Tidal Cloud Configuration May 07 22:06:41 volumioholger2 volumio[596]: info: Got it May 07 22:06:41 volumioholger2 volumio[596]: info: Got it May 07 22:06:41 volumioholger2 volumio[596]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 07 22:06:41 volumioholger2 volumio[596]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:06:41 volumioholger2 volumio[596]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 07 22:06:41 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 07 22:06:41 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 07 22:06:41 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 07 22:06:41 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 07 22:06:41 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:06:41 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:06:41 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:06:41 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:06:41 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioGetBrowseSources May 07 22:06:41 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioGetBrowseSources May 07 22:06:41 volumioholger2 volumio[596]: info: CoreCommandRouter::volumioGetBrowseSources May 07 22:06:41 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 07 22:06:41 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 07 22:06:45 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 07 22:06:45 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares May 07 22:06:45 volumioholger2 volumio[596]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService May 07 22:06:46 volumioholger2 volumio[596]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 07 22:06:46 volumioholger2 volumio[596]: Error: dns service error: unknown May 07 22:06:46 volumioholger2 volumio[596]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) May 07 22:06:46 volumioholger2 volumio[596]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { May 07 22:06:46 volumioholger2 volumio[596]: errorCode: -65537 May 07 22:06:46 volumioholger2 volumio[596]: } May 07 22:06:46 volumioholger2 volumio[596]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 07 22:06:47 volumioholger2 sudo[2494]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-07 22:05 May 07 22:06:47 volumioholger2 sudo[2494]: 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="e7445fab547cd22e23d9bef72406cfb610bc1d7d" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:10:14 PM CEST" VOLUMIO_VERSION="3.661" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5bdefd4af4423fd17aacb83a8538bf1f"