-- 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"