-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Fri 2024-10-25 18:11:23 CEST. -- Oct 25 18:10:00 volumio-3 volumio[811]: info: CoreCommandRouter::volumioGetVisibleSources Oct 25 18:10:00 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 25 18:10:00 volumio-3 volumio[811]: info: CoreCommandRouter::volumioGetState Oct 25 18:10:00 volumio-3 volumio[811]: info: CorePlayQueue::getTrack 0 Oct 25 18:10:00 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 25 18:10:00 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 25 18:10:00 volumio-3 volumio[811]: info: Received Get System Info Oct 25 18:10:00 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 25 18:10:00 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 25 18:10:00 volumio-3 volumio[811]: info: Discovery: Getting this device information Oct 25 18:10:00 volumio-3 volumio[811]: info: CoreCommandRouter::volumioGetState Oct 25 18:10:00 volumio-3 volumio[811]: info: CorePlayQueue::getTrack 0 Oct 25 18:10:00 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 25 18:10:00 volumio-3 volumio[811]: info: CoreCommandRouter::volumioGetState Oct 25 18:10:00 volumio-3 volumio[811]: info: CorePlayQueue::getTrack 0 Oct 25 18:10:00 volumio-3 volumio[811]: info: Listing playlists Oct 25 18:10:00 volumio-3 volumio[811]: info: CoreCommandRouter::volumioGetQueue Oct 25 18:10:00 volumio-3 volumio[811]: info: CoreStateMachine::getQueue Oct 25 18:10:00 volumio-3 volumio[811]: info: CorePlayQueue::getQueue Oct 25 18:10:00 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 25 18:10:10 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 25 18:10:10 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 25 18:10:15 volumio-3 volumio[811]: info: Enabling plugin audiophonicsonoff Oct 25 18:10:15 volumio-3 volumio[811]: info: Loading plugin "audiophonicsonoff"... Oct 25 18:10:15 volumio-3 volumio[811]: info: Applying required configuration parameters for plugin audiophonicsonoff Oct 25 18:10:15 volumio-3 volumio[811]: info: Audiophonics on/off initiated Oct 25 18:10:15 volumio-3 volumio[811]: info: PLUGIN START: audiophonicsonoff Oct 25 18:10:15 volumio-3 volumio[811]: info: Configuring GPIO pins Oct 25 18:10:15 volumio-3 volumio[811]: info: Error: Error: EBUSY: resource busy or locked, write Oct 25 18:10:17 volumio-3 volumio[811]: info: Enabling plugin audiophonicsonoff Oct 25 18:10:17 volumio-3 volumio[811]: info: Loading plugin "audiophonicsonoff"... Oct 25 18:10:17 volumio-3 volumio[811]: info: Applying required configuration parameters for plugin audiophonicsonoff Oct 25 18:10:17 volumio-3 volumio[811]: info: Audiophonics on/off initiated Oct 25 18:10:17 volumio-3 volumio[811]: info: PLUGIN START: audiophonicsonoff Oct 25 18:10:17 volumio-3 volumio[811]: info: Configuring GPIO pins Oct 25 18:10:17 volumio-3 volumio[811]: info: Error: Error: EBUSY: resource busy or locked, write Oct 25 18:10:20 volumio-3 volumio[811]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 25 18:10:20 volumio-3 volumio[811]: info: Loaded the previous config. Oct 25 18:10:20 volumio-3 volumio[811]: info: ## populating UI... Oct 25 18:10:20 volumio-3 volumio[811]: info: 1/1 settings loaded Oct 25 18:10:20 volumio-3 volumio[811]: info: Populated config screen. Oct 25 18:10:25 volumio-3 volumio[811]: info: CALLMETHOD: system_controller audiophonicsonoff updateButtonConfig [object Object] Oct 25 18:10:25 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: audiophonicsonoff , updateButtonConfig Oct 25 18:10:27 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 25 18:10:27 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 25 18:10:30 volumio-3 volumio[811]: info: Enabling plugin audiophonicsonoff Oct 25 18:10:30 volumio-3 volumio[811]: info: Loading plugin "audiophonicsonoff"... Oct 25 18:10:30 volumio-3 volumio[811]: info: Applying required configuration parameters for plugin audiophonicsonoff Oct 25 18:10:30 volumio-3 volumio[811]: info: Audiophonics on/off initiated Oct 25 18:10:30 volumio-3 volumio[811]: info: PLUGIN START: audiophonicsonoff Oct 25 18:10:30 volumio-3 volumio[811]: info: Configuring GPIO pins Oct 25 18:10:30 volumio-3 volumio[811]: info: Error: Error: EBUSY: resource busy or locked, write Oct 25 18:10:31 volumio-3 volumio[811]: info: Enabling plugin audiophonicsonoff Oct 25 18:10:31 volumio-3 volumio[811]: info: Loading plugin "audiophonicsonoff"... Oct 25 18:10:31 volumio-3 volumio[811]: info: Applying required configuration parameters for plugin audiophonicsonoff Oct 25 18:10:31 volumio-3 volumio[811]: info: Audiophonics on/off initiated Oct 25 18:10:31 volumio-3 volumio[811]: info: PLUGIN START: audiophonicsonoff Oct 25 18:10:31 volumio-3 volumio[811]: info: Configuring GPIO pins Oct 25 18:10:31 volumio-3 volumio[811]: info: Error: Error: EBUSY: resource busy or locked, write Oct 25 18:10:34 volumio-3 volumio[811]: info: Enabling plugin audiophonicsonoff Oct 25 18:10:34 volumio-3 volumio[811]: info: Loading plugin "audiophonicsonoff"... Oct 25 18:10:34 volumio-3 volumio[811]: info: Applying required configuration parameters for plugin audiophonicsonoff Oct 25 18:10:34 volumio-3 volumio[811]: info: Audiophonics on/off initiated Oct 25 18:10:34 volumio-3 volumio[811]: info: PLUGIN START: audiophonicsonoff Oct 25 18:10:34 volumio-3 volumio[811]: info: Configuring GPIO pins Oct 25 18:10:34 volumio-3 volumio[811]: info: Error: Error: EBUSY: resource busy or locked, write Oct 25 18:10:37 volumio-3 volumio[811]: info: Enabling plugin audiophonicsonoff Oct 25 18:10:37 volumio-3 volumio[811]: info: Loading plugin "audiophonicsonoff"... Oct 25 18:10:37 volumio-3 volumio[811]: info: Applying required configuration parameters for plugin audiophonicsonoff Oct 25 18:10:37 volumio-3 volumio[811]: info: Audiophonics on/off initiated Oct 25 18:10:37 volumio-3 volumio[811]: info: PLUGIN START: audiophonicsonoff Oct 25 18:10:37 volumio-3 volumio[811]: info: Configuring GPIO pins Oct 25 18:10:37 volumio-3 volumio[811]: info: Error: Error: EBUSY: resource busy or locked, write Oct 25 18:10:45 volumio-3 volumio[811]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 25 18:10:45 volumio-3 volumio[811]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 25 18:10:45 volumio-3 volumio[811]: info: Retrieving Cloud Streaming UI Oct 25 18:10:45 volumio-3 volumio[811]: info: Getting Tidal Cloud Configuration Oct 25 18:10:45 volumio-3 volumio[811]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 25 18:10:45 volumio-3 volumio[811]: info: Getting Qobuz Cloud Configuration Oct 25 18:10:45 volumio-3 volumio[811]: info: Asking plugin for UI Config Oct 25 18:10:45 volumio-3 volumio[811]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 25 18:10:45 volumio-3 volumio[811]: info: Getting Spotify Cloud Configuration Oct 25 18:10:45 volumio-3 volumio[811]: info: Asking plugin for UI Config Oct 25 18:10:45 volumio-3 volumio[811]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 25 18:10:45 volumio-3 volumio[811]: info: Saving Spotify Acccount Oct 25 18:10:45 volumio-3 volumio[811]: info: Got Tidal Cloud Configuration Oct 25 18:10:45 volumio-3 volumio[811]: info: Got it Oct 25 18:10:45 volumio-3 volumio[811]: info: Got it Oct 25 18:10:45 volumio-3 volumio[811]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 25 18:10:45 volumio-3 volumio[811]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 25 18:10:45 volumio-3 volumio[811]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Oct 25 18:10:45 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 25 18:10:45 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 25 18:10:45 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 25 18:10:45 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 25 18:10:45 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 25 18:10:45 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 25 18:10:45 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 25 18:10:45 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 25 18:10:45 volumio-3 volumio[811]: info: CoreCommandRouter::volumioGetBrowseSources Oct 25 18:10:45 volumio-3 volumio[811]: info: CoreCommandRouter::volumioGetBrowseSources Oct 25 18:10:45 volumio-3 volumio[811]: info: CoreCommandRouter::volumioGetBrowseSources Oct 25 18:10:45 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 25 18:10:45 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 25 18:10:51 volumio-3 volumio[811]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 25 18:10:51 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 25 18:10:51 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 25 18:10:51 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 25 18:10:51 volumio-3 volumio[811]: info: Getting Alsa Cards List without I2S DAC Oct 25 18:10:51 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Oct 25 18:10:51 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 25 18:10:52 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 25 18:10:52 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 25 18:10:52 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 25 18:10:52 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 25 18:10:52 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 25 18:10:52 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 25 18:10:52 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 25 18:10:52 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 25 18:10:52 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 25 18:10:54 volumio-3 volumiologrotate[628]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Oct 25 18:10:54 volumio-3 volumiologrotate[628]: ls: cannot access '3': No such file or directory Oct 25 18:11:19 volumio-3 volumio[811]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Oct 25 18:11:19 volumio-3 volumio[811]: info: Preparing to save Alsa Options, stopping services first Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::volumioGetState Oct 25 18:11:19 volumio-3 volumio[811]: info: CorePlayQueue::getTrack 0 Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::volumioPause Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreStateMachine::pause Oct 25 18:11:19 volumio-3 volumio[811]: info: Saving Audio Output to: {"output_device":{"value":"0","label":"HDMI Out"},"i2s":true,"i2sid":{"value":"rpi-dac","label":"R-PI DAC"}} Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 25 18:11:19 volumio-3 volumio[811]: info: Enabling I2S DAC: R-PI DAC Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , enableI2SDAC Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 25 18:11:19 volumio-3 sudo[1946]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Oct 25 18:11:19 volumio-3 sudo[1946]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 18:11:19 volumio-3 sudo[1946]: pam_unix(sudo:session): session closed for user root Oct 25 18:11:19 volumio-3 volumio[811]: info: No Overlays Loaded Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 25 18:11:19 volumio-3 sudo[1949]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rpi-dac Oct 25 18:11:19 volumio-3 sudo[1949]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 18:11:19 volumio-3 kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2s@7e203000/status Oct 25 18:11:19 volumio-3 kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/compatible Oct 25 18:11:19 volumio-3 kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/i2s-controller Oct 25 18:11:19 volumio-3 kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/status Oct 25 18:11:19 volumio-3 sudo[1949]: pam_unix(sudo:session): session closed for user root Oct 25 18:11:19 volumio-3 volumio[811]: warn: Unable to locate the device HDMI Out a reboot may be required. Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 25 18:11:19 volumio-3 volumio[811]: info: Found match in i2s Card Database: setting mixer Digital for card R-PI DAC Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 25 18:11:19 volumio-3 volumio[811]: info: Updating Volume Controller Parameters: Device: 2 Name: R-PI DAC Mixer: Digital Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 25 18:11:19 volumio-3 volumio[811]: info: Disabling external Volume Control Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Oct 25 18:11:19 volumio-3 volumio[811]: info: Preparing to generate the ALSA configuration file Oct 25 18:11:19 volumio-3 volumio[811]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control 'Digital',0 Oct 25 18:11:19 volumio-3 volumio[811]: info: I2S Param [object Object] successfully enabled Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 25 18:11:19 volumio-3 volumio[811]: info: Getting Alsa Cards List without I2S DAC Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 25 18:11:19 volumio-3 volumio[811]: info: VolumeController:: Volume=undefined Mute =false Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreStateMachine::pushState Oct 25 18:11:19 volumio-3 volumio[811]: info: CorePlayQueue::getTrack 0 Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::volumioPushState Oct 25 18:11:19 volumio-3 volumio[811]: info: Asound.conf file written Oct 25 18:11:19 volumio-3 sudo[1978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 25 18:11:19 volumio-3 sudo[1978]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 18:11:19 volumio-3 sudo[1978]: pam_unix(sudo:session): session closed for user root Oct 25 18:11:19 volumio-3 volumio[811]: No state is present for card MAX98357A Oct 25 18:11:19 volumio-3 volumio[811]: Found hardware: "simple-card" "" "" "" "" Oct 25 18:11:19 volumio-3 volumio[811]: Hardware is initialized using a generic method Oct 25 18:11:19 volumio-3 volumio[811]: No state is present for card MAX98357A Oct 25 18:11:19 volumio-3 volumio[811]: info: Output device has changed, restarting MPD Oct 25 18:11:19 volumio-3 sudo[1984]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 25 18:11:19 volumio-3 sudo[1984]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 18:11:19 volumio-3 volumio[811]: info: Output device has changed, restarting Shairport Sync Oct 25 18:11:19 volumio-3 sudo[1984]: pam_unix(sudo:session): session closed for user root Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 25 18:11:19 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 25 18:11:19 volumio-3 sudo[1987]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 25 18:11:19 volumio-3 sudo[1987]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 18:11:20 volumio-3 systemd[1]: Stopping Music Player Daemon... Oct 25 18:11:20 volumio-3 volumio[811]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 25 18:11:20 volumio-3 volumio[811]: info: Output device has changed, restarting MPD Oct 25 18:11:20 volumio-3 systemd[1]: mpd.service: Succeeded. Oct 25 18:11:20 volumio-3 systemd[1]: Stopped Music Player Daemon. Oct 25 18:11:20 volumio-3 sudo[1994]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 25 18:11:20 volumio-3 sudo[1994]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 18:11:20 volumio-3 volumio[811]: info: Output device has changed, restarting Shairport Sync Oct 25 18:11:20 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 25 18:11:20 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 25 18:11:20 volumio-3 sudo[1994]: pam_unix(sudo:session): session closed for user root Oct 25 18:11:20 volumio-3 systemd[1]: Starting Music Player Daemon... Oct 25 18:11:20 volumio-3 sudo[1997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 25 18:11:20 volumio-3 sudo[1997]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 18:11:20 volumio-3 systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Oct 25 18:11:20 volumio-3 systemd[1]: mpd.service: Succeeded. Oct 25 18:11:20 volumio-3 systemd[1]: Stopped Music Player Daemon. Oct 25 18:11:20 volumio-3 systemd[1]: Starting Music Player Daemon... Oct 25 18:11:20 volumio-3 volumio[811]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 25 18:11:20 volumio-3 volumio[811]: info: MPD Permissions set Oct 25 18:11:20 volumio-3 volumio[811]: info: MPD Permissions set Oct 25 18:11:20 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 25 18:11:20 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 25 18:11:20 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 25 18:11:20 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 25 18:11:20 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 25 18:11:20 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 25 18:11:20 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 25 18:11:20 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 25 18:11:20 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 25 18:11:20 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 25 18:11:20 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 25 18:11:20 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 25 18:11:20 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 25 18:11:20 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 25 18:11:20 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 25 18:11:20 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 25 18:11:20 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 25 18:11:20 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 25 18:11:20 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 25 18:11:20 volumio-3 volumio[811]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 25 18:11:20 volumio-3 sudo[2002]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 25 18:11:20 volumio-3 sudo[2002]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 18:11:20 volumio-3 volumio[811]: info: Starting Shairport Sync Oct 25 18:11:20 volumio-3 sudo[2002]: pam_unix(sudo:session): session closed for user root Oct 25 18:11:20 volumio-3 volumio[811]: info: Starting Shairport Sync Oct 25 18:11:20 volumio-3 sudo[2014]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 25 18:11:20 volumio-3 sudo[2014]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 18:11:20 volumio-3 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 25 18:11:20 volumio-3 sudo[2017]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 25 18:11:20 volumio-3 systemd[1]: shairport-sync.service: Succeeded. Oct 25 18:11:20 volumio-3 sudo[2017]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 18:11:20 volumio-3 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 25 18:11:20 volumio-3 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 25 18:11:20 volumio-3 sudo[2014]: pam_unix(sudo:session): session closed for user root Oct 25 18:11:20 volumio-3 volumio[811]: info: Shairport-Sync Started Oct 25 18:11:20 volumio-3 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 25 18:11:20 volumio-3 systemd[1]: shairport-sync.service: Succeeded. Oct 25 18:11:20 volumio-3 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 25 18:11:20 volumio-3 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 25 18:11:20 volumio-3 sudo[2017]: pam_unix(sudo:session): session closed for user root Oct 25 18:11:20 volumio-3 volumio[811]: info: Shairport-Sync Started Oct 25 18:11:20 volumio-3 mpd[2013]: Oct 25 18:11 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 25 18:11:20 volumio-3 systemd[1]: Started Music Player Daemon. Oct 25 18:11:20 volumio-3 sudo[1987]: pam_unix(sudo:session): session closed for user root Oct 25 18:11:20 volumio-3 sudo[1997]: pam_unix(sudo:session): session closed for user root Oct 25 18:11:20 volumio-3 volumio[811]: error: MPD error: The expression evaluated to a falsy value: Oct 25 18:11:20 volumio-3 volumio[811]: assert.ok(self.idling) Oct 25 18:11:20 volumio-3 volumio[811]: error: The expression evaluated to a falsy value: Oct 25 18:11:20 volumio-3 volumio[811]: assert.ok(self.idling) Oct 25 18:11:20 volumio-3 volumio[811]: error: updateQueue error: null Oct 25 18:11:23 volumio-3 volumio[811]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________ Oct 25 18:11:23 volumio-3 volumio[811]: info: PLUGIN onReboot : networkfs Oct 25 18:11:23 volumio-3 volumio[811]: info: PLUGIN onReboot : audiophonicsonoff Oct 25 18:11:23 volumio-3 volumio[811]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 25 18:11:23 volumio-3 volumio[811]: TypeError: Cannot read property 'writeSync' of undefined Oct 25 18:11:23 volumio-3 volumio[811]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_controller/audiophonicsonoff/index.js:35:25) Oct 25 18:11:23 volumio-3 volumio[811]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30) Oct 25 18:11:23 volumio-3 volumio[811]: at HashMap. (/volumio/app/pluginmanager.js:668:31) Oct 25 18:11:23 volumio-3 volumio[811]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Oct 25 18:11:23 volumio-3 volumio[811]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Oct 25 18:11:23 volumio-3 volumio[811]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20) Oct 25 18:11:23 volumio-3 volumio[811]: at CoreCommandRouter.reboot (/volumio/app/index.js:1331:22) Oct 25 18:11:23 volumio-3 volumio[811]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:864:33) Oct 25 18:11:23 volumio-3 volumio[811]: at Socket.emit (events.js:315:20) Oct 25 18:11:23 volumio-3 volumio[811]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Oct 25 18:11:23 volumio-3 volumio[811]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Oct 25 18:11:23 volumio-3 volumio[811]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 25 18:11:23 volumio-3 sudo[2035]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-25 18:10 Oct 25 18:11:23 volumio-3 sudo[2035]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"