-- Logs begin at Thu 2019-02-14 13:11:59 MSK, end at Mon 2024-04-08 20:36:38 MSK. -- Apr 08 20:35:00 volumio ntpd[689]: Soliciting pool server 2a00:ab00:203:9::1000:6 Apr 08 20:35:05 volumio kernel: hwmon hwmon1: Undervoltage detected! Apr 08 20:35:08 volumio ntpd[689]: Soliciting pool server 195.3.218.2 Apr 08 20:35:09 volumio ntpd[689]: Soliciting pool server 85.21.78.23 Apr 08 20:35:10 volumio ntpd[689]: Soliciting pool server 185.209.85.222 Apr 08 20:35:17 volumio kernel: hwmon hwmon1: Voltage normalised Apr 08 20:35:23 volumio volumio[778]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::volumioGetState Apr 08 20:35:23 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:35:23 volumio volumio[778]: info: Restoring Previous Volume level: 12 false true Apr 08 20:35:23 volumio volumio[778]: info: VolumeController::SetAlsaVolume100 Apr 08 20:35:23 volumio volumio[778]: info: Enable softmixer device for audio device number 2 Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::volumioStop Apr 08 20:35:23 volumio volumio[778]: info: CoreStateMachine::stop Apr 08 20:35:23 volumio volumio[778]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 08 20:35:23 volumio volumio[778]: info: Enable softmixer device for audio device undefined Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 08 20:35:23 volumio volumio[778]: info: Updating Volume Controller Parameters: Device: 2 Name: Generic I2S DAC Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 08 20:35:23 volumio volumio[778]: info: Disabling external Volume Control Apr 08 20:35:23 volumio volumio[778]: info: Output device has changed, restarting MPD Apr 08 20:35:23 volumio sudo[2150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 08 20:35:23 volumio sudo[2150]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 20:35:23 volumio volumio[778]: info: Output device has changed, restarting Shairport Sync Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:23 volumio sudo[2150]: pam_unix(sudo:session): session closed for user root Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 08 20:35:23 volumio sudo[2153]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 08 20:35:23 volumio sudo[2153]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 20:35:23 volumio systemd[1]: Stopping Music Player Daemon... Apr 08 20:35:23 volumio volumio[778]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 08 20:35:23 volumio volumio[778]: info: Volume configurations have been set Apr 08 20:35:23 volumio systemd[1]: mpd.service: Succeeded. Apr 08 20:35:23 volumio systemd[1]: Stopped Music Player Daemon. Apr 08 20:35:23 volumio systemd[1]: Starting Music Player Daemon... Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 08 20:35:23 volumio volumio[778]: info: Updating Volume Controller Parameters: Device: 2 Name: Generic I2S DAC Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 08 20:35:23 volumio volumio[778]: info: Disabling external Volume Control Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 08 20:35:23 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:35:23 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:35:23 volumio volumio[778]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 08 20:35:23 volumio volumio[778]: info: MPD Permissions set Apr 08 20:35:23 volumio volumio[778]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 08 20:35:23 volumio volumio[778]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 08 20:35:23 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:35:23 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:35:23 volumio volumio[778]: info: Software Volume ALSA configuration written Apr 08 20:35:23 volumio volumio[778]: info: Preparing to generate the ALSA configuration file Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:23 volumio volumio[778]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Apr 08 20:35:23 volumio volumio[778]: info: Reading ALSA contributions from plugins. Apr 08 20:35:23 volumio kernel: hwmon hwmon1: Undervoltage detected! Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 08 20:35:23 volumio volumio[778]: info: Getting Alsa Cards List without I2S DAC Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Apr 08 20:35:23 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 08 20:35:24 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 08 20:35:24 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 08 20:35:24 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 08 20:35:24 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 08 20:35:24 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 08 20:35:24 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 08 20:35:24 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 08 20:35:24 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 08 20:35:24 volumio volumio[778]: info: VolumeController:: Volume=undefined Mute =false Apr 08 20:35:24 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:35:24 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:35:24 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 08 20:35:24 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:35:24 volumio volumio[778]: info: Starting Shairport Sync Apr 08 20:35:24 volumio volumio[778]: info: Asound.conf file written Apr 08 20:35:24 volumio sudo[2183]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 08 20:35:24 volumio sudo[2183]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 20:35:24 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 08 20:35:24 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 08 20:35:24 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 08 20:35:24 volumio sudo[2186]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 08 20:35:24 volumio sudo[2186]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 20:35:24 volumio sudo[2186]: pam_unix(sudo:session): session closed for user root Apr 08 20:35:24 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 08 20:35:24 volumio sudo[2183]: pam_unix(sudo:session): session closed for user root Apr 08 20:35:24 volumio volumio[778]: No state is present for card b1 Apr 08 20:35:24 volumio volumio[778]: /usr/share/alsa/init/bcm2835:14: control element not found Apr 08 20:35:24 volumio volumio[778]: No state is present for card b1 Apr 08 20:35:24 volumio volumio[778]: No state is present for card Headphones Apr 08 20:35:24 volumio volumio[778]: /usr/share/alsa/init/bcm2835:20: control element not found Apr 08 20:35:24 volumio volumio[778]: No state is present for card Headphones Apr 08 20:35:24 volumio volumio[778]: No state is present for card sndrpihifiberry Apr 08 20:35:24 volumio volumio[778]: Found hardware: "RPi-simple" "" "" "" "" Apr 08 20:35:24 volumio volumio[778]: Hardware is initialized using a generic method Apr 08 20:35:24 volumio volumio[778]: No state is present for card sndrpihifiberry Apr 08 20:35:24 volumio volumio[778]: info: Output device has changed, restarting MPD Apr 08 20:35:24 volumio volumio[778]: info: Output device has changed, restarting Shairport Sync Apr 08 20:35:24 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:24 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 08 20:35:24 volumio sudo[2193]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 08 20:35:24 volumio sudo[2193]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 20:35:24 volumio sudo[2193]: pam_unix(sudo:session): session closed for user root Apr 08 20:35:24 volumio sudo[2196]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 08 20:35:24 volumio sudo[2196]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 20:35:24 volumio volumio[778]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 08 20:35:24 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 08 20:35:24 volumio systemd[1]: mpd.service: Succeeded. Apr 08 20:35:24 volumio systemd[1]: Stopped Music Player Daemon. Apr 08 20:35:24 volumio systemd[1]: Starting Music Player Daemon... Apr 08 20:35:26 volumio volumio[778]: Playing WAVE '/volumio/app/silence.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Apr 08 20:35:26 volumio volumio[778]: No state is present for card b1 Apr 08 20:35:26 volumio volumio[778]: /usr/share/alsa/init/bcm2835:14: control element not found Apr 08 20:35:26 volumio volumio[778]: No state is present for card b1 Apr 08 20:35:26 volumio volumio[778]: No state is present for card Headphones Apr 08 20:35:26 volumio volumio[778]: /usr/share/alsa/init/bcm2835:20: control element not found Apr 08 20:35:26 volumio volumio[778]: No state is present for card Headphones Apr 08 20:35:26 volumio volumio[778]: No state is present for card sndrpihifiberry Apr 08 20:35:26 volumio volumio[778]: Found hardware: "RPi-simple" "" "" "" "" Apr 08 20:35:26 volumio volumio[778]: Hardware is initialized using a generic method Apr 08 20:35:26 volumio volumio[778]: No state is present for card sndrpihifiberry Apr 08 20:35:26 volumio volumio[778]: info: Output device has changed, restarting MPD Apr 08 20:35:26 volumio volumio[778]: info: Output device has changed, restarting Shairport Sync Apr 08 20:35:26 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:26 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 08 20:35:26 volumio sudo[2208]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 08 20:35:26 volumio sudo[2208]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 20:35:26 volumio sudo[2208]: pam_unix(sudo:session): session closed for user root Apr 08 20:35:26 volumio sudo[2210]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 08 20:35:26 volumio sudo[2210]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 20:35:26 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 08 20:35:26 volumio systemd[1]: mpd.service: Succeeded. Apr 08 20:35:26 volumio systemd[1]: Stopped Music Player Daemon. Apr 08 20:35:26 volumio volumio[778]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 08 20:35:26 volumio systemd[1]: Starting Music Player Daemon... Apr 08 20:35:26 volumio volumio[778]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 08 20:35:26 volumio volumio[778]: info: Updating Volume Controller Parameters: Device: 2 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 08 20:35:26 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 08 20:35:26 volumio volumio[778]: info: Disabling external Volume Control Apr 08 20:35:26 volumio volumio[778]: info: MPD Permissions set Apr 08 20:35:26 volumio volumio[778]: info: MPD Permissions set Apr 08 20:35:26 volumio volumio[778]: info: Shairport-Sync Started Apr 08 20:35:26 volumio volumio[778]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 08 20:35:26 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:26 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:26 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:26 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:26 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:26 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:26 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:26 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:26 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 08 20:35:26 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:26 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:26 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:26 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:26 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:26 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:26 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:26 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:26 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:26 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 08 20:35:26 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 08 20:35:26 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:35:26 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:35:26 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 08 20:35:26 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:35:26 volumio volumio[778]: info: Starting Shairport Sync Apr 08 20:35:26 volumio volumio[778]: info: Starting Shairport Sync Apr 08 20:35:26 volumio sudo[2235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 08 20:35:26 volumio sudo[2235]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 20:35:26 volumio sudo[2237]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 08 20:35:26 volumio sudo[2237]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 20:35:26 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 08 20:35:26 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 08 20:35:26 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 08 20:35:27 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 08 20:35:27 volumio sudo[2235]: pam_unix(sudo:session): session closed for user root Apr 08 20:35:27 volumio volumio[778]: info: Shairport-Sync Started Apr 08 20:35:27 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 08 20:35:27 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 08 20:35:27 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 08 20:35:27 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 08 20:35:27 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 08 20:35:27 volumio sudo[2237]: pam_unix(sudo:session): session closed for user root Apr 08 20:35:27 volumio volumio[778]: info: Shairport-Sync Started Apr 08 20:35:27 volumio volumio[778]: info: VolumeController::SetAlsaVolume12 Apr 08 20:35:27 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:35:27 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:35:27 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 08 20:35:27 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:35:28 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Apr 08 20:35:28 volumio sudo[2247]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 08 20:35:28 volumio sudo[2247]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 20:35:28 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 08 20:35:28 volumio systemd[1]: mpd.service: Succeeded. Apr 08 20:35:28 volumio systemd[1]: Stopped Music Player Daemon. Apr 08 20:35:28 volumio systemd[1]: Starting Music Player Daemon... Apr 08 20:35:30 volumio mpd[2249]: Apr 08 20:35 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 08 20:35:30 volumio systemd[1]: Started Music Player Daemon. Apr 08 20:35:30 volumio sudo[2153]: pam_unix(sudo:session): session closed for user root Apr 08 20:35:30 volumio sudo[2247]: pam_unix(sudo:session): session closed for user root Apr 08 20:35:30 volumio sudo[2196]: pam_unix(sudo:session): session closed for user root Apr 08 20:35:30 volumio sudo[2210]: pam_unix(sudo:session): session closed for user root Apr 08 20:35:30 volumio volumio[778]: error: MPD error: The expression evaluated to a falsy value: Apr 08 20:35:30 volumio volumio[778]: assert.ok(self.idling) Apr 08 20:35:30 volumio volumio[778]: error: The expression evaluated to a falsy value: Apr 08 20:35:30 volumio volumio[778]: assert.ok(self.idling) Apr 08 20:35:30 volumio volumio[778]: error: MPD error: The expression evaluated to a falsy value: Apr 08 20:35:30 volumio volumio[778]: assert.ok(self.idling) Apr 08 20:35:30 volumio volumio[778]: error: The expression evaluated to a falsy value: Apr 08 20:35:30 volumio volumio[778]: assert.ok(self.idling) Apr 08 20:35:30 volumio volumio[778]: error: MPD error: The expression evaluated to a falsy value: Apr 08 20:35:30 volumio volumio[778]: assert.ok(self.idling) Apr 08 20:35:30 volumio volumio[778]: error: The expression evaluated to a falsy value: Apr 08 20:35:30 volumio volumio[778]: assert.ok(self.idling) Apr 08 20:35:30 volumio volumio[778]: error: updateQueue error: null Apr 08 20:35:35 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 08 20:35:35 volumio volumio[778]: info: CURURI: music-library/USB Apr 08 20:35:35 volumio volumio[778]: info: Preload queue cleared Apr 08 20:35:36 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 08 20:35:36 volumio volumio[778]: info: CURURI: music-library/USB/GSP1RMCENXV Apr 08 20:35:36 volumio volumio[778]: info: Preload queue cleared Apr 08 20:35:36 volumio volumio[778]: info: Preloading song: music-library/USB/GSP1RMCENXV/Cheburashka.2022.WEB-DL.1080p.ELEKTRI4KA.UNIONGANG.mkv Apr 08 20:35:36 volumio volumio[778]: info: Exploding uri music-library/USB/GSP1RMCENXV/Cheburashka.2022.WEB-DL.1080p.ELEKTRI4KA.UNIONGANG.mkv in service mpd Apr 08 20:35:36 volumio volumio[778]: info: ALBUMART /albumart?cacheid=579&web=//extralarge&path=%2Fmnt%2FUSB%2FGSP1RMCENXV%2FCheburashka.2022.WEB-DL.1080p.ELEKTRI4KA.UNIONGANG.mkv&metadata=false Apr 08 20:35:36 volumio volumio[778]: info: URI /mnt/USB/GSP1RMCENXV/Cheburashka.2022.WEB-DL.1080p.ELEKTRI4KA.UNIONGANG.mkv Apr 08 20:35:42 volumio kernel: hwmon hwmon1: Voltage normalised Apr 08 20:35:43 volumio volumio[778]: info: VolumeController::SetAlsaVolume11 Apr 08 20:35:43 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:35:43 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:35:43 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 08 20:35:43 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:35:44 volumio volumio[778]: info: VolumeController::SetAlsaVolume2 Apr 08 20:35:44 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:35:44 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:35:44 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 08 20:35:44 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:35:45 volumio volumio[778]: info: VolumeController::SetAlsaVolume87 Apr 08 20:35:45 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:35:45 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:35:45 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 08 20:35:45 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:35:49 volumio volumio[778]: info: VolumeController::SetAlsaVolume0 Apr 08 20:35:49 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:35:49 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:35:49 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 08 20:35:49 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:35:50 volumio kernel: hwmon hwmon1: Undervoltage detected! Apr 08 20:35:57 volumio kernel: hwmon hwmon1: Voltage normalised Apr 08 20:36:28 volumio kernel: usb 1-1.2: USB disconnect, device number 4 Apr 08 20:36:28 volumio volumio[778]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.2/1-1.2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda4","ACTION":"remove","DEVLINKS":"/dev/disk/by-path/platform-3f980000.usb-usb-0:1.2:1.0-scsi-0:0:0:0-part4 /dev/disk/by-partuuid/cad4ebea-04 /dev/disk/by-uuid/EE668BCB668B92CF /dev/disk/by-id/ata-MT-64_979121870265-part4 /dev/disk/by-label/GSP1RMCENXV","DEVNAME":"/dev/sda4","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.2/1-1.2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda4","DEVTYPE":"partition","DISKSEQ":"27","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_APM":"1","ID_ATA_FEATURE_SET_APM_ENABLED":"0","ID_ATA_FEATURE_SET_HPA":"1","ID_ATA_FEATURE_SET_HPA_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ENHANCED_ERASE_UNIT_MIN":"2","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"2","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_ROTATION_RATE_RPM":"0","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_SATA_SIGNAL_RATE_GEN2":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_FS_LABEL":"GSP1RMCENXV","ID_FS_LABEL_ENC":"GSP1RMCENXV","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"EE668BCB668B92CF","ID_FS_UUID_ENC":"EE668BCB668B92CF","ID_MODEL":"MT-64","ID_MODEL_ENC":"MT-64\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_FLAGS":"0x80","ID_PART_ENTRY_NUMBER":"4","ID_PART_ENTRY_OFFSET":"256","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"123731711","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"cad4ebea-04","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"cad4ebea","ID_PATH":"platform-3f980000.usb-usb-0:1.2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_2_1_0-scsi-0_0_0_0","ID_REVISION":"Q0927A","ID_SERIAL":"MT-64_979121870265","ID_SERIAL_SHORT":"979121870265","ID_TYPE":"disk","MAJOR":"8","MINOR":"4","PARTN":"4","SEQNUM":"1493","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"377036835"} Apr 08 20:36:28 volumio sudo[2307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda4 Apr 08 20:36:28 volumio sudo[2307]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 20:36:28 volumio ntfs-3g[2029]: Unmounting /dev/sda4 (GSP1RMCENXV) Apr 08 20:36:28 volumio ntfs-3g[2029]: Failed to sync device /dev/sda4: Input/output error Apr 08 20:36:28 volumio ntfs-3g[2029]: Failed to close volume /dev/sda4: Input/output error Apr 08 20:36:28 volumio sudo[2307]: pam_unix(sudo:session): session closed for user root Apr 08 20:36:28 volumio systemd[1]: media-GSP1RMCENXV.mount: Succeeded. Apr 08 20:36:28 volumio kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache Apr 08 20:36:28 volumio kernel: sd 0:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x01 driverbyte=DRIVER_OK Apr 08 20:36:30 volumio kernel: usb 1-1.2: new high-speed USB device number 5 using dwc_otg Apr 08 20:36:30 volumio kernel: usb 1-1.2: New USB device found, idVendor=13fd, idProduct=3960, bcdDevice= 1.10 Apr 08 20:36:30 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Apr 08 20:36:30 volumio kernel: usb 1-1.2: Product: External Apr 08 20:36:30 volumio kernel: usb 1-1.2: Manufacturer: Generic Apr 08 20:36:30 volumio kernel: usb 1-1.2: SerialNumber: 3937393132313837303236352020202020202020 Apr 08 20:36:30 volumio kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected Apr 08 20:36:30 volumio kernel: scsi host0: usb-storage 1-1.2:1.0 Apr 08 20:36:31 volumio kernel: scsi 0:0:0:0: Direct-Access Generic External 0110 PQ: 0 ANSI: 6 Apr 08 20:36:31 volumio kernel: sd 0:0:0:0: [sda] 123731967 512-byte logical blocks: (63.4 GB/59.0 GiB) Apr 08 20:36:31 volumio kernel: sd 0:0:0:0: [sda] Write Protect is off Apr 08 20:36:31 volumio kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Apr 08 20:36:31 volumio kernel: sd 0:0:0:0: [sda] Mode Sense: 1f 00 10 08 Apr 08 20:36:31 volumio kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, supports DPO and FUA Apr 08 20:36:31 volumio kernel: sda: sda4 Apr 08 20:36:31 volumio kernel: sd 0:0:0:0: [sda] Attached SCSI disk Apr 08 20:36:31 volumio volumio[778]: info: Mounting Device GSP1RMCENXV Apr 08 20:36:31 volumio sudo[2320]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda4 /mnt/USB/GSP1RMCENXV -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 08 20:36:31 volumio sudo[2320]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 08 20:36:32 volumio ntfs-3g[2323]: Version 2017.3.23AR.3 integrated FUSE 28 Apr 08 20:36:32 volumio ntfs-3g[2323]: Mounted /dev/sda4 (Read-Write, label "GSP1RMCENXV", NTFS 3.1) Apr 08 20:36:32 volumio ntfs-3g[2323]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 08 20:36:32 volumio ntfs-3g[2323]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda4,blkdev,blksize=4096 Apr 08 20:36:32 volumio ntfs-3g[2323]: Global ownership and permissions enforced, configuration type 7 Apr 08 20:36:32 volumio sudo[2320]: pam_unix(sudo:session): session closed for user root Apr 08 20:36:32 volumio volumio[778]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/GSP1RMCENXV Apr 08 20:36:33 volumio volumio[778]: info: Scanning removed location : "USB/GSP1RMCENXV" Apr 08 20:36:33 volumio volumio[778]: verbose: ControllerMpd::sendMpdCommand status Apr 08 20:36:33 volumio volumio[778]: info: Apr 08 20:36:33 volumio volumio[778]: ---------------------------- MPD announces state update: update Apr 08 20:36:33 volumio volumio[778]: info: ControllerMpd::getState Apr 08 20:36:33 volumio volumio[778]: verbose: ControllerMpd::sendMpdCommand status Apr 08 20:36:33 volumio volumio[778]: verbose: ControllerMpd::sendMpdCommand status Apr 08 20:36:33 volumio volumio[778]: info: Apr 08 20:36:33 volumio volumio[778]: ---------------------------- MPD announces state update: update Apr 08 20:36:33 volumio volumio[778]: info: ControllerMpd::getState Apr 08 20:36:33 volumio volumio[778]: verbose: ControllerMpd::sendMpdCommand status Apr 08 20:36:33 volumio volumio[778]: verbose: ControllerMpd::sendMpdCommand status Apr 08 20:36:33 volumio volumio[778]: info: Apr 08 20:36:33 volumio volumio[778]: ---------------------------- MPD announces state update: update Apr 08 20:36:33 volumio volumio[778]: info: ControllerMpd::getState Apr 08 20:36:33 volumio volumio[778]: verbose: ControllerMpd::sendMpdCommand status Apr 08 20:36:33 volumio volumio[778]: verbose: ControllerMpd::sendMpdCommand status Apr 08 20:36:33 volumio volumio[778]: info: Apr 08 20:36:33 volumio volumio[778]: ---------------------------- MPD announces state update: update Apr 08 20:36:33 volumio volumio[778]: info: ControllerMpd::getState Apr 08 20:36:33 volumio volumio[778]: verbose: ControllerMpd::sendMpdCommand status Apr 08 20:36:33 volumio volumio[778]: info: sendMpdCommand status took 17 milliseconds Apr 08 20:36:33 volumio volumio[778]: info: sendMpdCommand status took 15 milliseconds Apr 08 20:36:33 volumio volumio[778]: info: sendMpdCommand status took 15 milliseconds Apr 08 20:36:33 volumio volumio[778]: info: sendMpdCommand status took 13 milliseconds Apr 08 20:36:33 volumio volumio[778]: info: sendMpdCommand status took 12 milliseconds Apr 08 20:36:33 volumio volumio[778]: info: sendMpdCommand status took 10 milliseconds Apr 08 20:36:33 volumio volumio[778]: info: sendMpdCommand status took 9 milliseconds Apr 08 20:36:33 volumio volumio[778]: info: sendMpdCommand status took 7 milliseconds Apr 08 20:36:33 volumio volumio[778]: verbose: ControllerMpd::parseState Apr 08 20:36:33 volumio volumio[778]: info: Command Router : Notfying DB Updatetrue Apr 08 20:36:33 volumio volumio[778]: info: CoreCommandRouter::Close All Modals sent Apr 08 20:36:33 volumio volumio[778]: verbose: ControllerMpd::parseState Apr 08 20:36:33 volumio volumio[778]: verbose: ControllerMpd::parseState Apr 08 20:36:33 volumio volumio[778]: info: Command Router : Notfying DB Updatetrue Apr 08 20:36:33 volumio volumio[778]: info: CoreCommandRouter::Close All Modals sent Apr 08 20:36:33 volumio volumio[778]: verbose: ControllerMpd::parseState Apr 08 20:36:33 volumio volumio[778]: verbose: ControllerMpd::parseState Apr 08 20:36:33 volumio volumio[778]: info: Command Router : Notfying DB Updatetrue Apr 08 20:36:33 volumio volumio[778]: info: CoreCommandRouter::Close All Modals sent Apr 08 20:36:33 volumio volumio[778]: verbose: ControllerMpd::parseState Apr 08 20:36:33 volumio volumio[778]: verbose: ControllerMpd::parseState Apr 08 20:36:33 volumio volumio[778]: info: Command Router : Notfying DB Updatetrue Apr 08 20:36:33 volumio volumio[778]: info: CoreCommandRouter::Close All Modals sent Apr 08 20:36:33 volumio volumio[778]: verbose: ControllerMpd::parseState Apr 08 20:36:33 volumio volumio[778]: info: ControllerMpd::pushState Apr 08 20:36:33 volumio volumio[778]: info: CoreCommandRouter::servicePushState Apr 08 20:36:33 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:33 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:33 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:33 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:33 volumio volumio[778]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 08 20:36:33 volumio volumio[778]: verbose: CURRENT POSITION 0 Apr 08 20:36:33 volumio volumio[778]: info: CoreStateMachine::syncState stateService stop Apr 08 20:36:33 volumio volumio[778]: info: CoreStateMachine::syncState currentStatus stop Apr 08 20:36:33 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:33 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:33 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 08 20:36:33 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:33 volumio volumio[778]: info: No code Apr 08 20:36:33 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:33 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:33 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:33 volumio volumio[778]: info: ControllerMpd::pushState Apr 08 20:36:33 volumio volumio[778]: info: CoreCommandRouter::servicePushState Apr 08 20:36:33 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:33 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:33 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:33 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:33 volumio volumio[778]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 08 20:36:33 volumio volumio[778]: verbose: CURRENT POSITION 0 Apr 08 20:36:33 volumio volumio[778]: info: CoreStateMachine::syncState stateService stop Apr 08 20:36:33 volumio volumio[778]: info: CoreStateMachine::syncState currentStatus stop Apr 08 20:36:33 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:33 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:33 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:33 volumio volumio[778]: info: No code Apr 08 20:36:33 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:33 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:33 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:33 volumio volumio[778]: info: ControllerMpd::pushState Apr 08 20:36:33 volumio volumio[778]: info: CoreCommandRouter::servicePushState Apr 08 20:36:33 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:33 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:33 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:33 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:33 volumio volumio[778]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 08 20:36:33 volumio volumio[778]: verbose: CURRENT POSITION 0 Apr 08 20:36:33 volumio volumio[778]: info: CoreStateMachine::syncState stateService stop Apr 08 20:36:33 volumio volumio[778]: info: CoreStateMachine::syncState currentStatus stop Apr 08 20:36:33 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:33 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:33 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:33 volumio volumio[778]: info: No code Apr 08 20:36:33 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:33 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:33 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:33 volumio volumio[778]: info: ControllerMpd::pushState Apr 08 20:36:33 volumio volumio[778]: info: CoreCommandRouter::servicePushState Apr 08 20:36:33 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:33 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:33 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:33 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:33 volumio volumio[778]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 08 20:36:33 volumio volumio[778]: verbose: CURRENT POSITION 0 Apr 08 20:36:33 volumio volumio[778]: info: CoreStateMachine::syncState stateService stop Apr 08 20:36:33 volumio volumio[778]: info: CoreStateMachine::syncState currentStatus stop Apr 08 20:36:33 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:33 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:33 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:33 volumio volumio[778]: info: No code Apr 08 20:36:33 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:33 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:33 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:33 volumio volumio[778]: info: ------------------------------ 313ms Apr 08 20:36:33 volumio volumio[778]: info: ------------------------------ 310ms Apr 08 20:36:33 volumio volumio[778]: info: ------------------------------ 308ms Apr 08 20:36:33 volumio volumio[778]: info: ------------------------------ 306ms Apr 08 20:36:33 volumio volumio[778]: info: MPD Database updated - AlbumList cache refreshed Apr 08 20:36:33 volumio volumio[778]: info: Apr 08 20:36:33 volumio volumio[778]: ---------------------------- MPD announces state update: database Apr 08 20:36:33 volumio volumio[778]: verbose: ControllerMpd::sendMpdCommand status Apr 08 20:36:33 volumio volumio[778]: info: Apr 08 20:36:33 volumio volumio[778]: ---------------------------- MPD announces state update: update Apr 08 20:36:33 volumio volumio[778]: info: ControllerMpd::getState Apr 08 20:36:33 volumio volumio[778]: verbose: ControllerMpd::sendMpdCommand status Apr 08 20:36:33 volumio volumio[778]: info: ControllerMpd::getState Apr 08 20:36:33 volumio volumio[778]: verbose: ControllerMpd::sendMpdCommand status Apr 08 20:36:33 volumio volumio[778]: info: MPD Database updated - AlbumList cache refreshed Apr 08 20:36:33 volumio volumio[778]: info: Apr 08 20:36:33 volumio volumio[778]: ---------------------------- MPD announces state update: database Apr 08 20:36:33 volumio volumio[778]: verbose: ControllerMpd::sendMpdCommand status Apr 08 20:36:33 volumio volumio[778]: info: Apr 08 20:36:33 volumio volumio[778]: ---------------------------- MPD announces state update: update Apr 08 20:36:33 volumio volumio[778]: info: ControllerMpd::getState Apr 08 20:36:33 volumio volumio[778]: verbose: ControllerMpd::sendMpdCommand status Apr 08 20:36:33 volumio volumio[778]: info: ControllerMpd::getState Apr 08 20:36:33 volumio volumio[778]: verbose: ControllerMpd::sendMpdCommand status Apr 08 20:36:33 volumio volumio[778]: info: MPD Database updated - AlbumList cache refreshed Apr 08 20:36:33 volumio volumio[778]: info: Apr 08 20:36:33 volumio volumio[778]: ---------------------------- MPD announces state update: database Apr 08 20:36:33 volumio volumio[778]: verbose: ControllerMpd::sendMpdCommand status Apr 08 20:36:33 volumio volumio[778]: info: Apr 08 20:36:33 volumio volumio[778]: ---------------------------- MPD announces state update: update Apr 08 20:36:33 volumio volumio[778]: info: ControllerMpd::getState Apr 08 20:36:33 volumio volumio[778]: verbose: ControllerMpd::sendMpdCommand status Apr 08 20:36:33 volumio volumio[778]: info: ControllerMpd::getState Apr 08 20:36:33 volumio volumio[778]: verbose: ControllerMpd::sendMpdCommand status Apr 08 20:36:33 volumio volumio[778]: info: MPD Database updated - AlbumList cache refreshed Apr 08 20:36:33 volumio volumio[778]: info: Apr 08 20:36:33 volumio volumio[778]: ---------------------------- MPD announces state update: database Apr 08 20:36:33 volumio volumio[778]: verbose: ControllerMpd::sendMpdCommand status Apr 08 20:36:33 volumio volumio[778]: info: Apr 08 20:36:33 volumio volumio[778]: ---------------------------- MPD announces state update: update Apr 08 20:36:33 volumio volumio[778]: info: ControllerMpd::getState Apr 08 20:36:34 volumio volumio[778]: verbose: ControllerMpd::sendMpdCommand status Apr 08 20:36:34 volumio volumio[778]: info: ControllerMpd::getState Apr 08 20:36:34 volumio volumio[778]: verbose: ControllerMpd::sendMpdCommand status Apr 08 20:36:34 volumio volumio[778]: info: sendMpdCommand status took 79 milliseconds Apr 08 20:36:34 volumio volumio[778]: info: sendMpdCommand status took 78 milliseconds Apr 08 20:36:34 volumio volumio[778]: info: sendMpdCommand status took 78 milliseconds Apr 08 20:36:34 volumio volumio[778]: verbose: ControllerMpd::parseState Apr 08 20:36:34 volumio volumio[778]: info: Command Router : Notfying DB Updatefalse Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::Close All Modals sent Apr 08 20:36:34 volumio volumio[778]: verbose: ControllerMpd::parseState Apr 08 20:36:34 volumio volumio[778]: verbose: ControllerMpd::parseState Apr 08 20:36:34 volumio volumio[778]: info: ControllerMpd::pushState Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::servicePushState Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 08 20:36:34 volumio volumio[778]: verbose: CURRENT POSITION 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::syncState stateService stop Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::syncState currentStatus stop Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:34 volumio volumio[778]: info: No code Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:34 volumio volumio[778]: info: ControllerMpd::pushState Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::servicePushState Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 08 20:36:34 volumio volumio[778]: verbose: CURRENT POSITION 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::syncState stateService stop Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::syncState currentStatus stop Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:34 volumio volumio[778]: info: No code Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:34 volumio volumio[778]: info: ------------------------------ 183ms Apr 08 20:36:34 volumio volumio[778]: info: ------------------------------ 184ms Apr 08 20:36:34 volumio volumio[778]: info: sendMpdCommand status took 166 milliseconds Apr 08 20:36:34 volumio volumio[778]: info: sendMpdCommand status took 163 milliseconds Apr 08 20:36:34 volumio volumio[778]: info: sendMpdCommand status took 163 milliseconds Apr 08 20:36:34 volumio volumio[778]: info: sendMpdCommand status took 158 milliseconds Apr 08 20:36:34 volumio volumio[778]: info: sendMpdCommand status took 156 milliseconds Apr 08 20:36:34 volumio volumio[778]: info: sendMpdCommand status took 156 milliseconds Apr 08 20:36:34 volumio volumio[778]: verbose: ControllerMpd::parseState Apr 08 20:36:34 volumio volumio[778]: info: Command Router : Notfying DB Updatefalse Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::Close All Modals sent Apr 08 20:36:34 volumio volumio[778]: verbose: ControllerMpd::parseState Apr 08 20:36:34 volumio volumio[778]: verbose: ControllerMpd::parseState Apr 08 20:36:34 volumio volumio[778]: verbose: ControllerMpd::parseState Apr 08 20:36:34 volumio volumio[778]: info: Command Router : Notfying DB Updatefalse Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::Close All Modals sent Apr 08 20:36:34 volumio volumio[778]: verbose: ControllerMpd::parseState Apr 08 20:36:34 volumio volumio[778]: verbose: ControllerMpd::parseState Apr 08 20:36:34 volumio volumio[778]: info: ControllerMpd::pushState Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::servicePushState Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 08 20:36:34 volumio volumio[778]: verbose: CURRENT POSITION 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::syncState stateService stop Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::syncState currentStatus stop Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:34 volumio volumio[778]: info: No code Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:34 volumio volumio[778]: info: ControllerMpd::pushState Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::servicePushState Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 08 20:36:34 volumio volumio[778]: verbose: CURRENT POSITION 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::syncState stateService stop Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::syncState currentStatus stop Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:34 volumio volumio[778]: info: No code Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:34 volumio volumio[778]: info: ControllerMpd::pushState Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::servicePushState Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 08 20:36:34 volumio volumio[778]: verbose: CURRENT POSITION 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::syncState stateService stop Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::syncState currentStatus stop Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:34 volumio volumio[778]: info: No code Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:34 volumio volumio[778]: info: ControllerMpd::pushState Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::servicePushState Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 08 20:36:34 volumio volumio[778]: verbose: CURRENT POSITION 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::syncState stateService stop Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::syncState currentStatus stop Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:34 volumio volumio[778]: info: No code Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:34 volumio volumio[778]: info: ------------------------------ 351ms Apr 08 20:36:34 volumio volumio[778]: info: ------------------------------ 353ms Apr 08 20:36:34 volumio volumio[778]: info: ------------------------------ 347ms Apr 08 20:36:34 volumio volumio[778]: info: ------------------------------ 345ms Apr 08 20:36:34 volumio volumio[778]: info: sendMpdCommand status took 353 milliseconds Apr 08 20:36:34 volumio volumio[778]: info: sendMpdCommand status took 351 milliseconds Apr 08 20:36:34 volumio volumio[778]: info: sendMpdCommand status took 351 milliseconds Apr 08 20:36:34 volumio volumio[778]: verbose: ControllerMpd::parseState Apr 08 20:36:34 volumio volumio[778]: info: Command Router : Notfying DB Updatefalse Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::Close All Modals sent Apr 08 20:36:34 volumio volumio[778]: verbose: ControllerMpd::parseState Apr 08 20:36:34 volumio volumio[778]: verbose: ControllerMpd::parseState Apr 08 20:36:34 volumio volumio[778]: info: ControllerMpd::pushState Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::servicePushState Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 08 20:36:34 volumio volumio[778]: verbose: CURRENT POSITION 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::syncState stateService stop Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::syncState currentStatus stop Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:34 volumio volumio[778]: info: No code Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:34 volumio volumio[778]: info: ControllerMpd::pushState Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::servicePushState Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 08 20:36:34 volumio volumio[778]: verbose: CURRENT POSITION 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::syncState stateService stop Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::syncState currentStatus stop Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:34 volumio volumio[778]: info: No code Apr 08 20:36:34 volumio volumio[778]: info: CoreStateMachine::pushState Apr 08 20:36:34 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:34 volumio volumio[778]: info: CoreCommandRouter::volumioPushState Apr 08 20:36:34 volumio volumio[778]: info: ------------------------------ 465ms Apr 08 20:36:34 volumio volumio[778]: info: ------------------------------ 466ms Apr 08 20:36:38 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 08 20:36:38 volumio volumio[778]: info: CURURI: music-library/USB/GSP1RMCENXV/Helene Segara en duo avec Joe Dassin' 2013 - Et si tu n'existais pas Apr 08 20:36:38 volumio volumio[778]: info: Preload queue cleared Apr 08 20:36:38 volumio volumio[778]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 08 20:36:38 volumio volumio[778]: info: CoreStateMachine::ClearQueue Apr 08 20:36:38 volumio volumio[778]: info: CoreStateMachine::stop Apr 08 20:36:38 volumio volumio[778]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 08 20:36:38 volumio volumio[778]: info: CorePlayQueue::clearPlayQueue Apr 08 20:36:38 volumio volumio[778]: info: CorePlayQueue::saveQueue Apr 08 20:36:38 volumio volumio[778]: info: CoreCommandRouter::volumioPushQueue Apr 08 20:36:38 volumio volumio[778]: info: CoreStateMachine::addQueueItems Apr 08 20:36:38 volumio volumio[778]: info: CorePlayQueue::addQueueItems Apr 08 20:36:38 volumio volumio[778]: info: Preload queue cleared Apr 08 20:36:38 volumio volumio[778]: info: Adding Item to queue: music-library/USB/GSP1RMCENXV/Helene Segara en duo avec Joe Dassin' 2013 - Et si tu n'existais pas Apr 08 20:36:38 volumio volumio[778]: info: Exploding uri music-library/USB/GSP1RMCENXV/Helene Segara en duo avec Joe Dassin' 2013 - Et si tu n'existais pas in service mpd Apr 08 20:36:38 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 08 20:36:38 volumio volumio[778]: info: CURURI: music-library/USB/GSP1RMCENXV/Helene Segara en duo avec Joe Dassin' 2013 - Et si tu n'existais pas Apr 08 20:36:38 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 08 20:36:38 volumio volumio[778]: info: CURURI: music-library/USB/GSP1RMCENXV/Helene Segara en duo avec Joe Dassin' 2013 - Et si tu n'existais pas Apr 08 20:36:38 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 08 20:36:38 volumio volumio[778]: info: CURURI: music-library/USB/GSP1RMCENXV/Helene Segara en duo avec Joe Dassin' 2013 - Et si tu n'existais pas Apr 08 20:36:38 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 08 20:36:38 volumio volumio[778]: info: CURURI: music-library/USB/GSP1RMCENXV/Helene Segara en duo avec Joe Dassin' 2013 - Et si tu n'existais pas Apr 08 20:36:38 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 08 20:36:38 volumio volumio[778]: info: CURURI: music-library/USB/GSP1RMCENXV/Helene Segara en duo avec Joe Dassin' 2013 - Et si tu n'existais pas Apr 08 20:36:38 volumio volumio[778]: info: CoreCommandRouter::volumioPlay Apr 08 20:36:38 volumio volumio[778]: info: CoreStateMachine::play index undefined Apr 08 20:36:38 volumio volumio[778]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 08 20:36:38 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 08 20:36:38 volumio volumio[778]: info: CURURI: music-library/USB/GSP1RMCENXV/Focal №7 Apr 08 20:36:38 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 08 20:36:38 volumio volumio[778]: info: CURURI: music-library/USB/GSP1RMCENXV/Helene Segara en duo avec Joe Dassin' 2013 - Et si tu n'existais pas Apr 08 20:36:38 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 08 20:36:38 volumio volumio[778]: info: CURURI: music-library/USB/GSP1RMCENXV/Helene Segara en duo avec Joe Dassin' 2013 - Et si tu n'existais pas Apr 08 20:36:38 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 08 20:36:38 volumio volumio[778]: info: CURURI: music-library Apr 08 20:36:38 volumio volumio[778]: info: CorePlayQueue::getTrack 0 Apr 08 20:36:38 volumio volumio[778]: info: Preload queue cleared Apr 08 20:36:38 volumio volumio[778]: info: ALBUMART /albumart?cacheid=579&web=//extralarge&path=%2Fmnt%2FUSB%2FGSP1RMCENXV%2FHelene%20Segara%20en%20duo%20avec%20Joe%20Dassin'%202013%20-%20Et%20si%20tu%20n'existais%20pas%2FHelene%20Segara%20en%20duo%20avec%20Joe%20Dassin%20-%20Et%20si%20tu%20n'existais%20pas.ape&metadata=false Apr 08 20:36:38 volumio volumio[778]: info: URI /mnt/USB/GSP1RMCENXV/Helene Segara en duo avec Joe Dassin' 2013 - Et si tu n'existais pas/Helene Segara en duo avec Joe Dassin - Et si tu n'existais pas.ape Apr 08 20:36:38 volumio volumio[778]: info: ALBUMART /albumart?cacheid=579&web=Helene%20Segara%20en%20duo%20avec%20Joe%20Dassin/Et%20si%20tu%20n'existais%20pas/extralarge&path=%2Fmnt%2FUSB%2FGSP1RMCENXV%2FHelene%20Segara%20en%20duo%20avec%20Joe%20Dassin'%202013%20-%20Et%20si%20tu%20n'existais%20pas%2FHelene%20Segara%20en%20duo%20avec%20Joe%20Dassin%20-%20Et%20si%20tu%20n'existais%20pas.cue&metadata=false Apr 08 20:36:38 volumio volumio[778]: info: URI /mnt/USB/GSP1RMCENXV/Helene Segara en duo avec Joe Dassin' 2013 - Et si tu n'existais pas/Helene Segara en duo avec Joe Dassin - Et si tu n'existais pas.cue Apr 08 20:36:38 volumio volumio[778]: info: ALBUMART /albumart?cacheid=579&web=Helene%20Segara%20en%20duo%20avec%20Joe%20Dassin/Et%20si%20tu%20n'existais%20pas/extralarge&path=%2Fmnt%2FUSB%2FGSP1RMCENXV%2FHelene%20Segara%20en%20duo%20avec%20Joe%20Dassin'%202013%20-%20Et%20si%20tu%20n'existais%20pas%2FHelene%20Segara%20en%20duo%20avec%20Joe%20Dassin%20-%20Et%20si%20tu%20n'existais%20pas.cue&metadata=false Apr 08 20:36:38 volumio volumio[778]: info: URI /mnt/USB/GSP1RMCENXV/Helene Segara en duo avec Joe Dassin' 2013 - Et si tu n'existais pas/Helene Segara en duo avec Joe Dassin - Et si tu n'existais pas.cue Apr 08 20:36:38 volumio volumio[778]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 08 20:36:38 volumio volumio[778]: Error: Unable to resolve or reject the same promise twice Apr 08 20:36:38 volumio volumio[778]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Apr 08 20:36:38 volumio volumio[778]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Apr 08 20:36:38 volumio volumio[778]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Apr 08 20:36:38 volumio volumio[778]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Apr 08 20:36:38 volumio volumio[778]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Apr 08 20:36:38 volumio volumio[778]: at Socket.emit (events.js:315:20) Apr 08 20:36:38 volumio volumio[778]: at addChunk (internal/streams/readable.js:309:12) Apr 08 20:36:38 volumio volumio[778]: at readableAddChunk (internal/streams/readable.js:280:11) Apr 08 20:36:38 volumio volumio[778]: at Socket.Readable.push (internal/streams/readable.js:223:10) Apr 08 20:36:38 volumio volumio[778]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Apr 08 20:36:38 volumio volumio[778]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 08 20:36:38 volumio sudo[2352]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-08 20:35 Apr 08 20:36:38 volumio sudo[2352]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"