-- Logs begin at Thu 2019-02-14 19:11:59 KST, end at Sun 2024-05-05 16:36:45 KST. --
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 05 16:35:00 volumio volumio[696]: info: Device 5 does not have any Mixer Control Available
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::volumioUpdateVolumeSettings
May 05 16:35:00 volumio volumio[696]: info: Updating Volume Controller Parameters: Device: 5 Name: DAC-A26 Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
May 05 16:35:00 volumio volumio[696]: info: Disabling external Volume Control
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::getUIConfigOnPlugin
May 05 16:35:00 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:00 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:00 volumio volumio[696]: info: Preparing to generate the ALSA configuration file
May 05 16:35:00 volumio volumio[696]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0
May 05 16:35:00 volumio volumio[696]: info: Asound.conf file unchanged, so no further update is needed
May 05 16:35:00 volumio volumio[696]: info: Output device has changed, restarting MPD
May 05 16:35:00 volumio sudo[3289]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 05 16:35:00 volumio sudo[3289]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 05 16:35:00 volumio volumio[696]: info: Output device has changed, restarting Shairport Sync
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 05 16:35:00 volumio sudo[3289]: pam_unix(sudo:session): session closed for user root
May 05 16:35:00 volumio sudo[3292]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 05 16:35:00 volumio sudo[3292]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 05 16:35:00 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
May 05 16:35:00 volumio systemd[1]: mpd.service: Succeeded.
May 05 16:35:00 volumio systemd[1]: Stopped Music Player Daemon.
May 05 16:35:00 volumio volumio[696]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 05 16:35:00 volumio systemd[1]: Starting Music Player Daemon...
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
May 05 16:35:00 volumio volumio[696]: info: MPD Permissions set
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 05 16:35:00 volumio volumio[696]: info: Starting Shairport Sync
May 05 16:35:00 volumio sudo[3307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 05 16:35:00 volumio sudo[3307]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 05 16:35:00 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
May 05 16:35:00 volumio systemd[1]: shairport-sync.service: Succeeded.
May 05 16:35:00 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
May 05 16:35:00 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
May 05 16:35:00 volumio sudo[3307]: pam_unix(sudo:session): session closed for user root
May 05 16:35:00 volumio volumio[696]: info: Shairport-Sync Started
May 05 16:35:00 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat
May 05 16:35:01 volumio mpd[3297]: May 05 16:35 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
May 05 16:35:01 volumio systemd[1]: Started Music Player Daemon.
May 05 16:35:01 volumio sudo[3248]: pam_unix(sudo:session): session closed for user root
May 05 16:35:01 volumio sudo[3292]: pam_unix(sudo:session): session closed for user root
May 05 16:35:01 volumio volumio[696]: error: MPD error: The expression evaluated to a falsy value:
May 05 16:35:01 volumio volumio[696]: assert.ok(self.idling)
May 05 16:35:01 volumio volumio[696]: error: The expression evaluated to a falsy value:
May 05 16:35:01 volumio volumio[696]: assert.ok(self.idling)
May 05 16:35:01 volumio volumio[696]: error: updateQueue error: null
May 05 16:35:03 volumio volumio[696]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
May 05 16:35:03 volumio volumio[696]: info: CoreStateMachine::getcurrentVolume
May 05 16:35:03 volumio volumio[696]: info: CoreCommandRouter::volumioRetrievevolume
May 05 16:35:03 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:03 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:35:03 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:04 volumio volumio[696]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
May 05 16:35:04 volumio volumio[696]: info: CoreStateMachine::getcurrentVolume
May 05 16:35:04 volumio volumio[696]: info: CoreCommandRouter::volumioRetrievevolume
May 05 16:35:04 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:04 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:35:04 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:13 volumio volumio[696]: info: Clearing queue after UPNP request
May 05 16:35:13 volumio volumio[696]: info: CoreStateMachine::ClearQueue
May 05 16:35:13 volumio volumio[696]: info: CoreStateMachine::stop
May 05 16:35:13 volumio volumio[696]: info: CoreStateMachine::setConsumeUpdateService undefined
May 05 16:35:13 volumio volumio[696]: info: CorePlayQueue::clearPlayQueue
May 05 16:35:13 volumio volumio[696]: info: CorePlayQueue::saveQueue
May 05 16:35:13 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:13 volumio volumio[696]: info: CoreCommandRouter::volumioPushQueue
May 05 16:35:13 volumio volumio[696]: error: Upnp client error: Error: This socket has been ended by the other party
May 05 16:35:15 volumio volumio[696]: info: Starting UPNP Playback
May 05 16:35:15 volumio volumio[696]: info: Preparing playback through UPNP
May 05 16:35:15 volumio volumio[696]: info: CoreCommandRouter::volumioGetState
May 05 16:35:15 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:35:15 volumio volumio[696]: info: CoreStateMachine::setConsumeUpdateService mpd
May 05 16:35:15 volumio volumio[696]: info:
May 05 16:35:15 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:15 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:15 volumio volumio[696]: info:
May 05 16:35:15 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:15 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:15 volumio volumio[696]: info:
May 05 16:35:15 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:15 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:15 volumio volumio[696]: info: ------------------------------ 5ms
May 05 16:35:15 volumio volumio[696]: info: ------------------------------ 4ms
May 05 16:35:15 volumio volumio[696]: info:
May 05 16:35:15 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:15 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:15 volumio volumio[696]: info: ------------------------------ 4ms
May 05 16:35:15 volumio volumio[696]: info: ------------------------------ 3ms
May 05 16:35:15 volumio volumio[696]: info:
May 05 16:35:15 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:15 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:15 volumio volumio[696]: info:
May 05 16:35:15 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:15 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:15 volumio volumio[696]: info: ------------------------------ 3ms
May 05 16:35:15 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:35:15 volumio volumio[696]: info:
May 05 16:35:15 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:15 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:15 volumio volumio[696]: info:
May 05 16:35:15 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:15 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:15 volumio volumio[696]: info: ------------------------------ 3ms
May 05 16:35:15 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:35:15 volumio volumio[696]: info:
May 05 16:35:15 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:15 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:15 volumio volumio[696]: info:
May 05 16:35:15 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:15 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:15 volumio volumio[696]: info: ------------------------------ 3ms
May 05 16:35:15 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:35:15 volumio volumio[696]: info:
May 05 16:35:15 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:15 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:15 volumio volumio[696]: info:
May 05 16:35:15 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:15 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:15 volumio volumio[696]: info: ------------------------------ 3ms
May 05 16:35:15 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:35:15 volumio volumio[696]: info:
May 05 16:35:15 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:35:15 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:35:15 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:35:15 volumio volumio[696]: info:
May 05 16:35:15 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:35:15 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:35:15 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:35:15 volumio volumio[696]: info: sendMpdCommand status took 3 milliseconds
May 05 16:35:15 volumio volumio[696]: info: sendMpdCommand status took 2 milliseconds
May 05 16:35:15 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:35:15 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:35:15 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:35:15 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:35:15 volumio volumio[696]: info: sendMpdCommand playlistinfo took 2 milliseconds
May 05 16:35:15 volumio volumio[696]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 05 16:35:15 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:35:15 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:35:15 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:35:15 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:35:15 volumio volumio[696]: verbose: In UPNP mode
May 05 16:35:15 volumio volumio[696]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"On The Street Where You Live","artist":"Mason Embry Trio","album":"Dinner Jazz","uri":"http://192.168.1.19:10949/tidal/132339702.flac","trackType":"tidal"}
May 05 16:35:15 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:35:15 volumio volumio[696]: info: CoreStateMachine::syncState stateService pause
May 05 16:35:15 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus stop
May 05 16:35:15 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:15 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 05 16:35:15 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:15 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:35:15 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:35:15 volumio volumio[696]: verbose: In UPNP mode
May 05 16:35:15 volumio volumio[696]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"On The Street Where You Live","artist":"Mason Embry Trio","album":"Dinner Jazz","uri":"http://192.168.1.19:10949/tidal/132339702.flac","trackType":"tidal"}
May 05 16:35:15 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:35:15 volumio volumio[696]: info: CoreStateMachine::syncState stateService pause
May 05 16:35:15 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus stop
May 05 16:35:15 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:15 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:15 volumio volumio[696]: info: ------------------------------ 29ms
May 05 16:35:15 volumio volumio[696]: info: ------------------------------ 28ms
May 05 16:35:16 volumio volumio[696]: info:
May 05 16:35:16 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:35:16 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:35:16 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:35:16 volumio volumio[696]: info:
May 05 16:35:16 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:35:16 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:35:16 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:35:16 volumio volumio[696]: info: sendMpdCommand status took 2 milliseconds
May 05 16:35:16 volumio volumio[696]: info: sendMpdCommand status took 1 milliseconds
May 05 16:35:16 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:35:16 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:35:16 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:35:16 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:35:16 volumio volumio[696]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 05 16:35:16 volumio volumio[696]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 05 16:35:16 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:35:16 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:35:16 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:35:16 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:35:16 volumio volumio[696]: verbose: In UPNP mode
May 05 16:35:16 volumio volumio[696]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":262,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"On The Street Where You Live","artist":"Mason Embry Trio","album":"Dinner Jazz","uri":"http://192.168.1.19:10949/tidal/132339702.flac","trackType":"tidal"}
May 05 16:35:16 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:35:16 volumio volumio[696]: info: CoreStateMachine::syncState stateService pause
May 05 16:35:16 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus stop
May 05 16:35:16 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:16 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:16 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:35:16 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:35:16 volumio volumio[696]: verbose: In UPNP mode
May 05 16:35:16 volumio volumio[696]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":262,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"On The Street Where You Live","artist":"Mason Embry Trio","album":"Dinner Jazz","uri":"http://192.168.1.19:10949/tidal/132339702.flac","trackType":"tidal"}
May 05 16:35:16 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:35:16 volumio volumio[696]: info: CoreStateMachine::syncState stateService pause
May 05 16:35:16 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus stop
May 05 16:35:16 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:16 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:16 volumio volumio[696]: info: ------------------------------ 17ms
May 05 16:35:16 volumio volumio[696]: info: ------------------------------ 15ms
May 05 16:35:30 volumio volumio[696]: info:
May 05 16:35:30 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:35:30 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:35:30 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:35:30 volumio volumio[696]: info:
May 05 16:35:30 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:35:30 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:35:30 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:35:30 volumio volumio[696]: info: sendMpdCommand status took 2 milliseconds
May 05 16:35:30 volumio volumio[696]: info: sendMpdCommand status took 1 milliseconds
May 05 16:35:30 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:35:30 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:35:30 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:35:30 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:35:30 volumio volumio[696]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 05 16:35:30 volumio volumio[696]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 05 16:35:30 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:35:30 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:35:30 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:35:30 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:35:30 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:30 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:30 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:35:30 volumio volumio[696]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"On The Street Where You Live","artist":"Mason Embry Trio","album":"Dinner Jazz","uri":"http://192.168.1.19:10949/tidal/132339702.flac","trackType":"tidal"}
May 05 16:35:30 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:35:30 volumio volumio[696]: info: CoreStateMachine::syncState stateService stop
May 05 16:35:30 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus stop
May 05 16:35:30 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:30 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:30 volumio volumio[696]: info: No code
May 05 16:35:30 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:30 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:30 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:35:30 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:35:30 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:30 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:30 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:35:30 volumio volumio[696]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"On The Street Where You Live","artist":"Mason Embry Trio","album":"Dinner Jazz","uri":"http://192.168.1.19:10949/tidal/132339702.flac","trackType":"tidal"}
May 05 16:35:30 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:35:30 volumio volumio[696]: info: CoreStateMachine::syncState stateService stop
May 05 16:35:30 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus stop
May 05 16:35:30 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:30 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:30 volumio volumio[696]: info: No code
May 05 16:35:30 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:30 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:30 volumio volumio[696]: info: ------------------------------ 34ms
May 05 16:35:30 volumio volumio[696]: info: ------------------------------ 33ms
May 05 16:35:31 volumio volumio[696]: info: Clearing queue after UPNP request
May 05 16:35:31 volumio volumio[696]: info: CoreStateMachine::ClearQueue
May 05 16:35:31 volumio volumio[696]: info: CoreStateMachine::stop
May 05 16:35:31 volumio volumio[696]: info: CoreStateMachine::setConsumeUpdateService undefined
May 05 16:35:31 volumio volumio[696]: info: CorePlayQueue::clearPlayQueue
May 05 16:35:31 volumio volumio[696]: info: CorePlayQueue::saveQueue
May 05 16:35:31 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:31 volumio volumio[696]: info: CoreCommandRouter::volumioPushQueue
May 05 16:35:31 volumio volumio[696]: info:
May 05 16:35:31 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:31 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:31 volumio volumio[696]: info:
May 05 16:35:31 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:31 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:31 volumio volumio[696]: error: updateQueue error: null
May 05 16:35:31 volumio volumio[696]: error: updateQueue error: null
May 05 16:35:31 volumio volumio[696]: info: ------------------------------ 3ms
May 05 16:35:31 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:35:31 volumio volumio[696]: info: Starting UPNP Playback
May 05 16:35:31 volumio volumio[696]: info: Preparing playback through UPNP
May 05 16:35:31 volumio volumio[696]: info: CoreCommandRouter::volumioGetState
May 05 16:35:31 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:35:31 volumio volumio[696]: info: CoreStateMachine::setConsumeUpdateService mpd
May 05 16:35:32 volumio volumio[696]: info:
May 05 16:35:32 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:32 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:32 volumio volumio[696]: info:
May 05 16:35:32 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:32 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:32 volumio volumio[696]: info:
May 05 16:35:32 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:32 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:32 volumio volumio[696]: info: ------------------------------ 3ms
May 05 16:35:32 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:35:32 volumio volumio[696]: info:
May 05 16:35:32 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:32 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:32 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:35:32 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:35:32 volumio volumio[696]: info:
May 05 16:35:32 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:32 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:32 volumio volumio[696]: info:
May 05 16:35:32 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:32 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:32 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:35:32 volumio volumio[696]: info: ------------------------------ 1ms
May 05 16:35:32 volumio volumio[696]: info:
May 05 16:35:32 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:32 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:32 volumio volumio[696]: info:
May 05 16:35:32 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:32 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:32 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:35:32 volumio volumio[696]: info: ------------------------------ 1ms
May 05 16:35:32 volumio volumio[696]: info:
May 05 16:35:32 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:32 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:32 volumio volumio[696]: info:
May 05 16:35:32 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:32 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:32 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:35:32 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:35:32 volumio volumio[696]: info:
May 05 16:35:32 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:32 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:32 volumio volumio[696]: info:
May 05 16:35:32 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:32 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:32 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:35:32 volumio volumio[696]: info: ------------------------------ 1ms
May 05 16:35:32 volumio volumio[696]: info:
May 05 16:35:32 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:35:32 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:35:32 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:35:32 volumio volumio[696]: info:
May 05 16:35:32 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:35:32 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:35:32 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:35:32 volumio volumio[696]: info: sendMpdCommand status took 27 milliseconds
May 05 16:35:32 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:35:32 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:35:32 volumio volumio[696]: info:
May 05 16:35:32 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:35:32 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:35:32 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:35:32 volumio volumio[696]: info: sendMpdCommand status took 27 milliseconds
May 05 16:35:32 volumio volumio[696]: info: sendMpdCommand playlistinfo took 2 milliseconds
May 05 16:35:32 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:35:32 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:35:32 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:35:32 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:35:32 volumio volumio[696]: verbose: In UPNP mode
May 05 16:35:32 volumio volumio[696]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"You And The Night And The Music","artist":"Lori Mechem","album":"Bossa Nova Romance: One Hour Of Romantic Instrumental Bossa Nova Music","uri":"http://192.168.1.19:10949/tidal/18807860.flac","trackType":"tidal"}
May 05 16:35:32 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::syncState stateService play
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus stop
May 05 16:35:32 volumio volumio[696]: info: ------------------------------ 32ms
May 05 16:35:32 volumio volumio[696]: info:
May 05 16:35:32 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:35:32 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:35:32 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:35:32 volumio volumio[696]: info: sendMpdCommand status took 5 milliseconds
May 05 16:35:32 volumio volumio[696]: info: sendMpdCommand playlistinfo took 4 milliseconds
May 05 16:35:32 volumio volumio[696]: info: sendMpdCommand status took 2 milliseconds
May 05 16:35:32 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:35:32 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:35:32 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:35:32 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:35:32 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:35:32 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:35:32 volumio volumio[696]: verbose: In UPNP mode
May 05 16:35:32 volumio volumio[696]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"912 Kbps","isStreaming":false,"title":"You And The Night And The Music","artist":"Lori Mechem","album":"Bossa Nova Romance: One Hour Of Romantic Instrumental Bossa Nova Music","uri":"http://192.168.1.19:10949/tidal/18807860.flac","trackType":"tidal"}
May 05 16:35:32 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::syncState stateService play
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus play
May 05 16:35:32 volumio volumio[696]: info: Received an update from plugin. extracting info from payload
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:32 volumio volumio[696]: info: ------------------------------ 49ms
May 05 16:35:32 volumio volumio[696]: info: sendMpdCommand playlistinfo took 16 milliseconds
May 05 16:35:32 volumio volumio[696]: info: sendMpdCommand playlistinfo took 16 milliseconds
May 05 16:35:32 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:35:32 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:35:32 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:35:32 volumio volumio[696]: verbose: In UPNP mode
May 05 16:35:32 volumio volumio[696]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"847 Kbps","isStreaming":false,"title":"You And The Night And The Music","artist":"Lori Mechem","album":"Bossa Nova Romance: One Hour Of Romantic Instrumental Bossa Nova Music","uri":"http://192.168.1.19:10949/tidal/18807860.flac","trackType":"tidal"}
May 05 16:35:32 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::syncState stateService play
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus play
May 05 16:35:32 volumio volumio[696]: info: Received an update from plugin. extracting info from payload
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:32 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:35:32 volumio volumio[696]: verbose: In UPNP mode
May 05 16:35:32 volumio volumio[696]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"836 Kbps","isStreaming":false,"title":"You And The Night And The Music","artist":"Lori Mechem","album":"Bossa Nova Romance: One Hour Of Romantic Instrumental Bossa Nova Music","uri":"http://192.168.1.19:10949/tidal/18807860.flac","trackType":"tidal"}
May 05 16:35:32 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::syncState stateService play
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus play
May 05 16:35:32 volumio volumio[696]: info: Received an update from plugin. extracting info from payload
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:32 volumio volumio[696]: info: ------------------------------ 52ms
May 05 16:35:32 volumio volumio[696]: info: ------------------------------ 49ms
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::volumioGetQueue
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::getQueue
May 05 16:35:32 volumio volumio[696]: info: CorePlayQueue::getQueue
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::volumioGetQueue
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::getQueue
May 05 16:35:32 volumio volumio[696]: info: CorePlayQueue::getQueue
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::volumioGetQueue
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::getQueue
May 05 16:35:32 volumio volumio[696]: info: CorePlayQueue::getQueue
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::volumioGetQueue
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::getQueue
May 05 16:35:32 volumio volumio[696]: info: CorePlayQueue::getQueue
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::volumioGetQueue
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::getQueue
May 05 16:35:32 volumio volumio[696]: info: CorePlayQueue::getQueue
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::volumioGetQueue
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::getQueue
May 05 16:35:32 volumio volumio[696]: info: CorePlayQueue::getQueue
May 05 16:35:32 volumio volumio[696]: info:
May 05 16:35:32 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:35:32 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:35:32 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:35:32 volumio volumio[696]: info:
May 05 16:35:32 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:35:32 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:35:32 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:35:32 volumio volumio[696]: info: sendMpdCommand status took 2 milliseconds
May 05 16:35:32 volumio volumio[696]: info: sendMpdCommand status took 2 milliseconds
May 05 16:35:32 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:35:32 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:35:32 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:35:32 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:35:32 volumio volumio[696]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 05 16:35:32 volumio volumio[696]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 05 16:35:32 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:35:32 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:35:32 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:32 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:35:32 volumio volumio[696]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"You And The Night And The Music","artist":"Lori Mechem","album":"Bossa Nova Romance: One Hour Of Romantic Instrumental Bossa Nova Music","uri":"http://192.168.1.19:10949/tidal/18807860.flac","trackType":"tidal"}
May 05 16:35:32 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::syncState stateService stop
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus play
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::play index undefined
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::setConsumeUpdateService undefined
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:32 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:32 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:32 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:32 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:35:32 volumio volumio[696]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"You And The Night And The Music","artist":"Lori Mechem","album":"Bossa Nova Romance: One Hour Of Romantic Instrumental Bossa Nova Music","uri":"http://192.168.1.19:10949/tidal/18807860.flac","trackType":"tidal"}
May 05 16:35:32 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::syncState stateService stop
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus stop
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:32 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:32 volumio volumio[696]: info: No code
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:32 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:32 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:35:32 volumio volumio[696]: info: ------------------------------ 42ms
May 05 16:35:32 volumio volumio[696]: info: ------------------------------ 41ms
May 05 16:35:32 volumio volumio[696]: info: CoreCommandRouter::volumioGetQueue
May 05 16:35:32 volumio volumio[696]: info: CoreStateMachine::getQueue
May 05 16:35:32 volumio volumio[696]: info: CorePlayQueue::getQueue
May 05 16:35:33 volumio volumio[696]: info: Clearing queue after UPNP request
May 05 16:35:33 volumio volumio[696]: info: CoreStateMachine::ClearQueue
May 05 16:35:33 volumio volumio[696]: info: CoreStateMachine::stop
May 05 16:35:33 volumio volumio[696]: info: CoreStateMachine::setConsumeUpdateService undefined
May 05 16:35:33 volumio volumio[696]: info: CorePlayQueue::clearPlayQueue
May 05 16:35:33 volumio volumio[696]: info: CorePlayQueue::saveQueue
May 05 16:35:33 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:33 volumio volumio[696]: info: CoreCommandRouter::volumioPushQueue
May 05 16:35:33 volumio volumio[696]: info:
May 05 16:35:33 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:33 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:33 volumio volumio[696]: info:
May 05 16:35:33 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:33 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:33 volumio volumio[696]: error: updateQueue error: null
May 05 16:35:33 volumio volumio[696]: error: updateQueue error: null
May 05 16:35:33 volumio volumio[696]: info: ------------------------------ 5ms
May 05 16:35:33 volumio volumio[696]: info: ------------------------------ 3ms
May 05 16:35:33 volumio volumio[696]: info: Starting UPNP Playback
May 05 16:35:33 volumio volumio[696]: info: Preparing playback through UPNP
May 05 16:35:33 volumio volumio[696]: info: CoreCommandRouter::volumioGetState
May 05 16:35:33 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:35:33 volumio volumio[696]: info: CoreStateMachine::setConsumeUpdateService mpd
May 05 16:35:34 volumio volumio[696]: info:
May 05 16:35:34 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:34 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:34 volumio volumio[696]: info:
May 05 16:35:34 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:34 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:34 volumio volumio[696]: info:
May 05 16:35:34 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:34 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:34 volumio volumio[696]: info: ------------------------------ 4ms
May 05 16:35:34 volumio volumio[696]: info: ------------------------------ 3ms
May 05 16:35:34 volumio volumio[696]: info:
May 05 16:35:34 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:34 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:34 volumio volumio[696]: info: ------------------------------ 4ms
May 05 16:35:34 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:35:34 volumio volumio[696]: info:
May 05 16:35:34 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:34 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:34 volumio volumio[696]: info:
May 05 16:35:34 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:34 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:34 volumio volumio[696]: info: ------------------------------ 3ms
May 05 16:35:34 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:35:34 volumio volumio[696]: info:
May 05 16:35:34 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:34 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:34 volumio volumio[696]: info:
May 05 16:35:34 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:34 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:34 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:35:34 volumio volumio[696]: info:
May 05 16:35:34 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:34 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:34 volumio volumio[696]: info: ------------------------------ 3ms
May 05 16:35:34 volumio volumio[696]: info:
May 05 16:35:34 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:34 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:34 volumio volumio[696]: info: ------------------------------ 3ms
May 05 16:35:34 volumio volumio[696]: info: ------------------------------ 1ms
May 05 16:35:34 volumio volumio[696]: info:
May 05 16:35:34 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:34 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:34 volumio volumio[696]: info:
May 05 16:35:34 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:34 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:34 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:35:34 volumio volumio[696]: info: ------------------------------ 1ms
May 05 16:35:34 volumio volumio[696]: info:
May 05 16:35:34 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:35:34 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:35:34 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:35:34 volumio volumio[696]: info:
May 05 16:35:34 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:35:34 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:35:34 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:35:34 volumio volumio[696]: info:
May 05 16:35:34 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:35:34 volumio volumio[696]: info: sendMpdCommand status took 4 milliseconds
May 05 16:35:34 volumio volumio[696]: info: sendMpdCommand status took 4 milliseconds
May 05 16:35:34 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:35:34 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:35:34 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:35:34 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:35:34 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:35:34 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:35:34 volumio volumio[696]: info:
May 05 16:35:34 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:35:34 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:35:34 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:35:34 volumio volumio[696]: info: sendMpdCommand status took 5 milliseconds
May 05 16:35:34 volumio volumio[696]: info: sendMpdCommand playlistinfo took 4 milliseconds
May 05 16:35:34 volumio volumio[696]: info: sendMpdCommand playlistinfo took 3 milliseconds
May 05 16:35:34 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:35:34 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:35:34 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:35:34 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:35:34 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:35:34 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:35:34 volumio volumio[696]: verbose: In UPNP mode
May 05 16:35:34 volumio volumio[696]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":199,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I've Got You Under My Skin","artist":"Beegie Adair","album":"Cocktail Party Jazz: An Intoxicating Collection Of Instrumental Jazz For Entertaining","uri":"http://192.168.1.19:10949/tidal/6649066.flac","trackType":"tidal"}
May 05 16:35:34 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:35:34 volumio volumio[696]: info: CoreStateMachine::syncState stateService play
May 05 16:35:34 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus stop
May 05 16:35:34 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:35:34 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:35:34 volumio volumio[696]: verbose: In UPNP mode
May 05 16:35:34 volumio volumio[696]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":199,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I've Got You Under My Skin","artist":"Beegie Adair","album":"Cocktail Party Jazz: An Intoxicating Collection Of Instrumental Jazz For Entertaining","uri":"http://192.168.1.19:10949/tidal/6649066.flac","trackType":"tidal"}
May 05 16:35:34 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:35:34 volumio volumio[696]: info: CoreStateMachine::syncState stateService play
May 05 16:35:34 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus play
May 05 16:35:34 volumio volumio[696]: info: Received an update from plugin. extracting info from payload
May 05 16:35:34 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
May 05 16:35:34 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:34 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 05 16:35:34 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:34 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:34 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:34 volumio volumio[696]: info: ------------------------------ 25ms
May 05 16:35:34 volumio volumio[696]: info: ------------------------------ 32ms
May 05 16:35:34 volumio volumio[696]: info: sendMpdCommand status took 23 milliseconds
May 05 16:35:34 volumio volumio[696]: info: sendMpdCommand playlistinfo took 21 milliseconds
May 05 16:35:34 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:35:34 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:35:34 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:35:34 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:35:34 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:35:34 volumio volumio[696]: verbose: In UPNP mode
May 05 16:35:34 volumio volumio[696]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":199,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"539 Kbps","isStreaming":false,"title":"I've Got You Under My Skin","artist":"Beegie Adair","album":"Cocktail Party Jazz: An Intoxicating Collection Of Instrumental Jazz For Entertaining","uri":"http://192.168.1.19:10949/tidal/6649066.flac","trackType":"tidal"}
May 05 16:35:34 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:35:34 volumio volumio[696]: info: CoreStateMachine::syncState stateService play
May 05 16:35:34 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus play
May 05 16:35:34 volumio volumio[696]: info: Received an update from plugin. extracting info from payload
May 05 16:35:34 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
May 05 16:35:34 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:34 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 05 16:35:34 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:34 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:34 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:34 volumio volumio[696]: info: ------------------------------ 47ms
May 05 16:35:34 volumio volumio[696]: info: CoreCommandRouter::volumioGetQueue
May 05 16:35:34 volumio volumio[696]: info: CoreStateMachine::getQueue
May 05 16:35:34 volumio volumio[696]: info: CorePlayQueue::getQueue
May 05 16:35:34 volumio volumio[696]: info: CoreCommandRouter::volumioGetQueue
May 05 16:35:34 volumio volumio[696]: info: CoreStateMachine::getQueue
May 05 16:35:34 volumio volumio[696]: info: CorePlayQueue::getQueue
May 05 16:35:34 volumio volumio[696]: info: CoreCommandRouter::volumioGetQueue
May 05 16:35:34 volumio volumio[696]: info: CoreStateMachine::getQueue
May 05 16:35:34 volumio volumio[696]: info: CorePlayQueue::getQueue
May 05 16:35:34 volumio volumio[696]: info: CoreCommandRouter::volumioGetQueue
May 05 16:35:34 volumio volumio[696]: info: CoreStateMachine::getQueue
May 05 16:35:34 volumio volumio[696]: info: CorePlayQueue::getQueue
May 05 16:35:34 volumio volumio[696]: info: sendMpdCommand playlistinfo took 30 milliseconds
May 05 16:35:34 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:35:34 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:35:34 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:35:34 volumio volumio[696]: verbose: In UPNP mode
May 05 16:35:34 volumio volumio[696]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":199,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"578 Kbps","isStreaming":false,"title":"I've Got You Under My Skin","artist":"Beegie Adair","album":"Cocktail Party Jazz: An Intoxicating Collection Of Instrumental Jazz For Entertaining","uri":"http://192.168.1.19:10949/tidal/6649066.flac","trackType":"tidal"}
May 05 16:35:34 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:35:34 volumio volumio[696]: info: CoreStateMachine::syncState stateService play
May 05 16:35:34 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus play
May 05 16:35:34 volumio volumio[696]: info: Received an update from plugin. extracting info from payload
May 05 16:35:34 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
May 05 16:35:34 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:34 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 05 16:35:34 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:34 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:34 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:34 volumio volumio[696]: info: ------------------------------ 70ms
May 05 16:35:34 volumio volumio[696]: info: CoreCommandRouter::volumioGetQueue
May 05 16:35:34 volumio volumio[696]: info: CoreStateMachine::getQueue
May 05 16:35:34 volumio volumio[696]: info: CorePlayQueue::getQueue
May 05 16:35:34 volumio volumio[696]: info: CoreCommandRouter::volumioGetQueue
May 05 16:35:34 volumio volumio[696]: info: CoreStateMachine::getQueue
May 05 16:35:34 volumio volumio[696]: info: CorePlayQueue::getQueue
May 05 16:35:37 volumio volumio[696]: info:
May 05 16:35:37 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:35:37 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:35:37 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:35:37 volumio volumio[696]: info:
May 05 16:35:37 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:35:37 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:35:37 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:35:37 volumio volumio[696]: info: sendMpdCommand status took 1 milliseconds
May 05 16:35:37 volumio volumio[696]: info: sendMpdCommand status took 1 milliseconds
May 05 16:35:37 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:35:37 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:35:37 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:35:37 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:35:37 volumio volumio[696]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 05 16:35:37 volumio volumio[696]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 05 16:35:37 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:35:37 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:35:37 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:35:37 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:35:37 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:37 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:37 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:35:37 volumio volumio[696]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I've Got You Under My Skin","artist":"Beegie Adair","album":"Cocktail Party Jazz: An Intoxicating Collection Of Instrumental Jazz For Entertaining","uri":"http://192.168.1.19:10949/tidal/6649066.flac","trackType":"tidal"}
May 05 16:35:37 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:35:37 volumio volumio[696]: info: CoreStateMachine::syncState stateService stop
May 05 16:35:37 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus play
May 05 16:35:37 volumio volumio[696]: info: CoreStateMachine::play index undefined
May 05 16:35:37 volumio volumio[696]: info: CoreStateMachine::setConsumeUpdateService undefined
May 05 16:35:37 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:37 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:35:37 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 05 16:35:37 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:37 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:35:37 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:35:37 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:37 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:35:37 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:37 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:35:37 volumio volumio[696]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I've Got You Under My Skin","artist":"Beegie Adair","album":"Cocktail Party Jazz: An Intoxicating Collection Of Instrumental Jazz For Entertaining","uri":"http://192.168.1.19:10949/tidal/6649066.flac","trackType":"tidal"}
May 05 16:35:37 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:35:37 volumio volumio[696]: info: CoreStateMachine::syncState stateService stop
May 05 16:35:37 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus stop
May 05 16:35:37 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:37 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:35:37 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:37 volumio volumio[696]: info: No code
May 05 16:35:37 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:37 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:35:37 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:37 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:35:37 volumio volumio[696]: info: ------------------------------ 31ms
May 05 16:35:37 volumio volumio[696]: info: ------------------------------ 31ms
May 05 16:35:37 volumio volumio[696]: info: CoreCommandRouter::volumioGetQueue
May 05 16:35:37 volumio volumio[696]: info: CoreStateMachine::getQueue
May 05 16:35:37 volumio volumio[696]: info: CorePlayQueue::getQueue
May 05 16:35:38 volumio volumio[696]: info: Clearing queue after UPNP request
May 05 16:35:39 volumio volumio[696]: info: CoreStateMachine::ClearQueue
May 05 16:35:39 volumio volumio[696]: info: CoreStateMachine::stop
May 05 16:35:39 volumio volumio[696]: info: CoreStateMachine::setConsumeUpdateService undefined
May 05 16:35:39 volumio volumio[696]: info: CorePlayQueue::clearPlayQueue
May 05 16:35:39 volumio volumio[696]: info: CorePlayQueue::saveQueue
May 05 16:35:39 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:39 volumio volumio[696]: info: CoreCommandRouter::volumioPushQueue
May 05 16:35:39 volumio volumio[696]: info:
May 05 16:35:39 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:39 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:39 volumio volumio[696]: info:
May 05 16:35:39 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:39 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:39 volumio volumio[696]: error: updateQueue error: null
May 05 16:35:39 volumio volumio[696]: error: updateQueue error: null
May 05 16:35:39 volumio volumio[696]: info: ------------------------------ 3ms
May 05 16:35:39 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:35:39 volumio volumio[696]: info: Starting UPNP Playback
May 05 16:35:39 volumio volumio[696]: info: Preparing playback through UPNP
May 05 16:35:39 volumio volumio[696]: info: CoreCommandRouter::volumioGetState
May 05 16:35:39 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:35:39 volumio volumio[696]: info: CoreStateMachine::setConsumeUpdateService mpd
May 05 16:35:39 volumio volumio[696]: info:
May 05 16:35:39 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:39 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:39 volumio volumio[696]: info:
May 05 16:35:39 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:39 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:39 volumio volumio[696]: info:
May 05 16:35:39 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:39 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:39 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:35:39 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:35:39 volumio volumio[696]: info:
May 05 16:35:39 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:39 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:39 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:35:39 volumio volumio[696]: info: ------------------------------ 1ms
May 05 16:35:39 volumio volumio[696]: info:
May 05 16:35:39 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:39 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:39 volumio volumio[696]: info:
May 05 16:35:39 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:39 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:39 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:35:39 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:35:39 volumio volumio[696]: info:
May 05 16:35:39 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:39 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:39 volumio volumio[696]: info:
May 05 16:35:39 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:39 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:39 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:35:39 volumio volumio[696]: info: ------------------------------ 1ms
May 05 16:35:39 volumio volumio[696]: info:
May 05 16:35:39 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:39 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:39 volumio volumio[696]: info:
May 05 16:35:39 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:39 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:39 volumio volumio[696]: info: ------------------------------ 1ms
May 05 16:35:39 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:35:39 volumio volumio[696]: info:
May 05 16:35:39 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:39 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:39 volumio volumio[696]: info:
May 05 16:35:39 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:35:39 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:35:39 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:35:39 volumio volumio[696]: info: ------------------------------ 1ms
May 05 16:35:39 volumio volumio[696]: info:
May 05 16:35:39 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:35:39 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:35:39 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:35:39 volumio volumio[696]: info:
May 05 16:35:39 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:35:39 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:35:39 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:35:39 volumio volumio[696]: info:
May 05 16:35:39 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:35:39 volumio volumio[696]: info: sendMpdCommand status took 4 milliseconds
May 05 16:35:39 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:35:39 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:35:39 volumio volumio[696]: info: sendMpdCommand status took 3 milliseconds
May 05 16:35:39 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:35:39 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:35:39 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:35:39 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:35:39 volumio volumio[696]: info:
May 05 16:35:39 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:35:39 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:35:39 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:35:39 volumio volumio[696]: info: sendMpdCommand status took 6 milliseconds
May 05 16:35:39 volumio volumio[696]: info: sendMpdCommand playlistinfo took 5 milliseconds
May 05 16:35:39 volumio volumio[696]: info: sendMpdCommand playlistinfo took 5 milliseconds
May 05 16:35:39 volumio volumio[696]: info: sendMpdCommand status took 3 milliseconds
May 05 16:35:39 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:35:39 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:35:39 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:35:39 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:35:39 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:35:39 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:35:39 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:35:39 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:35:39 volumio volumio[696]: verbose: In UPNP mode
May 05 16:35:39 volumio volumio[696]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"You And The Night And The Music","artist":"Lori Mechem","album":"Bossa Nova Romance: One Hour Of Romantic Instrumental Bossa Nova Music","uri":"http://192.168.1.19:10949/tidal/18807860.flac","trackType":"tidal"}
May 05 16:35:39 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:35:39 volumio volumio[696]: info: CoreStateMachine::syncState stateService play
May 05 16:35:39 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus stop
May 05 16:35:39 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:35:39 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:35:39 volumio volumio[696]: verbose: In UPNP mode
May 05 16:35:39 volumio volumio[696]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"You And The Night And The Music","artist":"Lori Mechem","album":"Bossa Nova Romance: One Hour Of Romantic Instrumental Bossa Nova Music","uri":"http://192.168.1.19:10949/tidal/18807860.flac","trackType":"tidal"}
May 05 16:35:39 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:35:39 volumio volumio[696]: info: CoreStateMachine::syncState stateService play
May 05 16:35:39 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus play
May 05 16:35:39 volumio volumio[696]: info: Received an update from plugin. extracting info from payload
May 05 16:35:39 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
May 05 16:35:39 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:39 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 05 16:35:39 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:39 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:39 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:39 volumio volumio[696]: info: ------------------------------ 34ms
May 05 16:35:39 volumio volumio[696]: info: ------------------------------ 47ms
May 05 16:35:39 volumio volumio[696]: info: sendMpdCommand playlistinfo took 35 milliseconds
May 05 16:35:39 volumio volumio[696]: info: sendMpdCommand playlistinfo took 34 milliseconds
May 05 16:35:39 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:35:39 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:35:39 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:35:39 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:35:39 volumio volumio[696]: verbose: In UPNP mode
May 05 16:35:39 volumio volumio[696]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"You And The Night And The Music","artist":"Lori Mechem","album":"Bossa Nova Romance: One Hour Of Romantic Instrumental Bossa Nova Music","uri":"http://192.168.1.19:10949/tidal/18807860.flac","trackType":"tidal"}
May 05 16:35:39 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:35:39 volumio volumio[696]: info: CoreStateMachine::syncState stateService play
May 05 16:35:39 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus play
May 05 16:35:39 volumio volumio[696]: info: Received an update from plugin. extracting info from payload
May 05 16:35:39 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
May 05 16:35:39 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:39 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:39 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:39 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:39 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:35:39 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:35:39 volumio volumio[696]: verbose: In UPNP mode
May 05 16:35:39 volumio volumio[696]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":242,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"You And The Night And The Music","artist":"Lori Mechem","album":"Bossa Nova Romance: One Hour Of Romantic Instrumental Bossa Nova Music","uri":"http://192.168.1.19:10949/tidal/18807860.flac","trackType":"tidal"}
May 05 16:35:39 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:35:39 volumio volumio[696]: info: CoreStateMachine::syncState stateService play
May 05 16:35:39 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus play
May 05 16:35:39 volumio volumio[696]: info: Received an update from plugin. extracting info from payload
May 05 16:35:39 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
May 05 16:35:39 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:39 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:39 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:35:39 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:35:39 volumio volumio[696]: info: ------------------------------ 92ms
May 05 16:35:39 volumio volumio[696]: info: ------------------------------ 88ms
May 05 16:35:39 volumio volumio[696]: info: CoreCommandRouter::volumioGetQueue
May 05 16:35:39 volumio volumio[696]: info: CoreStateMachine::getQueue
May 05 16:35:39 volumio volumio[696]: info: CorePlayQueue::getQueue
May 05 16:35:39 volumio volumio[696]: info: CoreCommandRouter::volumioGetQueue
May 05 16:35:39 volumio volumio[696]: info: CoreStateMachine::getQueue
May 05 16:35:39 volumio volumio[696]: info: CorePlayQueue::getQueue
May 05 16:35:39 volumio volumio[696]: info: CoreCommandRouter::volumioGetQueue
May 05 16:35:39 volumio volumio[696]: info: CoreStateMachine::getQueue
May 05 16:35:39 volumio volumio[696]: info: CorePlayQueue::getQueue
May 05 16:35:39 volumio volumio[696]: info: CoreCommandRouter::volumioGetQueue
May 05 16:35:39 volumio volumio[696]: info: CoreStateMachine::getQueue
May 05 16:35:39 volumio volumio[696]: info: CorePlayQueue::getQueue
May 05 16:35:39 volumio volumio[696]: info: CoreCommandRouter::volumioGetQueue
May 05 16:35:39 volumio volumio[696]: info: CoreStateMachine::getQueue
May 05 16:35:39 volumio volumio[696]: info: CorePlayQueue::getQueue
May 05 16:35:39 volumio volumio[696]: info: CoreCommandRouter::volumioGetQueue
May 05 16:35:39 volumio volumio[696]: info: CoreStateMachine::getQueue
May 05 16:35:39 volumio volumio[696]: info: CorePlayQueue::getQueue
May 05 16:36:06 volumio volumio[696]: info:
May 05 16:36:06 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:36:06 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:36:06 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:36:06 volumio volumio[696]: info:
May 05 16:36:06 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:36:06 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:36:06 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:36:06 volumio volumio[696]: info: sendMpdCommand status took 2 milliseconds
May 05 16:36:06 volumio volumio[696]: info: sendMpdCommand status took 1 milliseconds
May 05 16:36:06 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:36:06 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:36:06 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:36:06 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:36:06 volumio volumio[696]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 05 16:36:06 volumio volumio[696]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 05 16:36:06 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:36:06 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:36:06 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:36:06 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:36:06 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:36:06 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:36:06 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:36:06 volumio volumio[696]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"You And The Night And The Music","artist":"Lori Mechem","album":"Bossa Nova Romance: One Hour Of Romantic Instrumental Bossa Nova Music","uri":"http://192.168.1.19:10949/tidal/18807860.flac","trackType":"tidal"}
May 05 16:36:06 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:36:06 volumio volumio[696]: info: CoreStateMachine::syncState stateService stop
May 05 16:36:06 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus play
May 05 16:36:06 volumio volumio[696]: info: CoreStateMachine::play index undefined
May 05 16:36:06 volumio volumio[696]: info: CoreStateMachine::setConsumeUpdateService undefined
May 05 16:36:06 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:36:06 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:36:06 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 05 16:36:06 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:36:06 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:36:06 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:36:06 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:36:06 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:36:06 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:36:06 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:36:06 volumio volumio[696]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"You And The Night And The Music","artist":"Lori Mechem","album":"Bossa Nova Romance: One Hour Of Romantic Instrumental Bossa Nova Music","uri":"http://192.168.1.19:10949/tidal/18807860.flac","trackType":"tidal"}
May 05 16:36:06 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:36:06 volumio volumio[696]: info: CoreStateMachine::syncState stateService stop
May 05 16:36:06 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus stop
May 05 16:36:06 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:36:06 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:36:06 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:36:06 volumio volumio[696]: info: No code
May 05 16:36:06 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:36:06 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:36:06 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:36:06 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:36:06 volumio volumio[696]: info: ------------------------------ 26ms
May 05 16:36:06 volumio volumio[696]: info: ------------------------------ 26ms
May 05 16:36:06 volumio volumio[696]: info: CoreCommandRouter::volumioGetQueue
May 05 16:36:06 volumio volumio[696]: info: CoreStateMachine::getQueue
May 05 16:36:06 volumio volumio[696]: info: CorePlayQueue::getQueue
May 05 16:36:06 volumio volumio[696]: info: Clearing queue after UPNP request
May 05 16:36:07 volumio volumio[696]: info: CoreStateMachine::ClearQueue
May 05 16:36:07 volumio volumio[696]: info: CoreStateMachine::stop
May 05 16:36:07 volumio volumio[696]: info: CoreStateMachine::setConsumeUpdateService undefined
May 05 16:36:07 volumio volumio[696]: info: CorePlayQueue::clearPlayQueue
May 05 16:36:07 volumio volumio[696]: info: CorePlayQueue::saveQueue
May 05 16:36:07 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:36:07 volumio volumio[696]: info: CoreCommandRouter::volumioPushQueue
May 05 16:36:07 volumio volumio[696]: info:
May 05 16:36:07 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:36:07 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:36:07 volumio volumio[696]: info:
May 05 16:36:07 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:36:07 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:36:07 volumio volumio[696]: error: updateQueue error: null
May 05 16:36:07 volumio volumio[696]: error: updateQueue error: null
May 05 16:36:07 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:36:07 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:36:07 volumio volumio[696]: info: Starting UPNP Playback
May 05 16:36:07 volumio volumio[696]: info: Preparing playback through UPNP
May 05 16:36:07 volumio volumio[696]: info: CoreCommandRouter::volumioGetState
May 05 16:36:07 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:36:07 volumio volumio[696]: info: CoreStateMachine::setConsumeUpdateService mpd
May 05 16:36:07 volumio volumio[696]: info:
May 05 16:36:07 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:36:07 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:36:07 volumio volumio[696]: info:
May 05 16:36:07 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:36:07 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:36:07 volumio volumio[696]: info:
May 05 16:36:07 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:36:07 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:36:07 volumio volumio[696]: info: ------------------------------ 3ms
May 05 16:36:07 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:36:07 volumio volumio[696]: info:
May 05 16:36:07 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:36:07 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:36:07 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:36:07 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:36:07 volumio volumio[696]: info:
May 05 16:36:07 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:36:07 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:36:07 volumio volumio[696]: info:
May 05 16:36:07 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:36:07 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:36:07 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:36:07 volumio volumio[696]: info: ------------------------------ 1ms
May 05 16:36:07 volumio volumio[696]: info:
May 05 16:36:07 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:36:07 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:36:07 volumio volumio[696]: info:
May 05 16:36:07 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:36:07 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:36:07 volumio volumio[696]: info: ------------------------------ 1ms
May 05 16:36:07 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:36:07 volumio volumio[696]: info:
May 05 16:36:07 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:36:07 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:36:07 volumio volumio[696]: info:
May 05 16:36:07 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:36:07 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:36:07 volumio volumio[696]: info: ------------------------------ 2ms
May 05 16:36:07 volumio volumio[696]: info: ------------------------------ 1ms
May 05 16:36:07 volumio volumio[696]: info:
May 05 16:36:07 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:36:07 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:36:07 volumio volumio[696]: info:
May 05 16:36:07 volumio volumio[696]: ---------------------------- MPD announces system playlist update
May 05 16:36:07 volumio volumio[696]: info: Ignoring MPD Status Update
May 05 16:36:07 volumio volumio[696]: info: ------------------------------ 1ms
May 05 16:36:07 volumio volumio[696]: info: ------------------------------ 1ms
May 05 16:36:07 volumio volumio[696]: info:
May 05 16:36:07 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:36:07 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:36:07 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:36:07 volumio volumio[696]: info:
May 05 16:36:07 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:36:07 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:36:07 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:36:07 volumio volumio[696]: info:
May 05 16:36:07 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:36:07 volumio volumio[696]: info: sendMpdCommand status took 4 milliseconds
May 05 16:36:07 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:36:07 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:36:07 volumio volumio[696]: info: sendMpdCommand status took 4 milliseconds
May 05 16:36:07 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:36:07 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:36:07 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:36:07 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:36:07 volumio volumio[696]: info:
May 05 16:36:07 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:36:07 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:36:07 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:36:07 volumio volumio[696]: info: sendMpdCommand status took 8 milliseconds
May 05 16:36:07 volumio volumio[696]: info: sendMpdCommand playlistinfo took 6 milliseconds
May 05 16:36:07 volumio volumio[696]: info: sendMpdCommand playlistinfo took 6 milliseconds
May 05 16:36:07 volumio volumio[696]: info: sendMpdCommand status took 3 milliseconds
May 05 16:36:07 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:36:07 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:36:07 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:36:07 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:36:07 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:36:07 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:36:07 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:36:07 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:36:07 volumio volumio[696]: verbose: In UPNP mode
May 05 16:36:07 volumio volumio[696]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Unforgettable","artist":"Leif Shires","album":"Jazzy Cocktails","uri":"http://192.168.1.19:10949/tidal/85055670.flac","trackType":"tidal"}
May 05 16:36:07 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:36:07 volumio volumio[696]: info: CoreStateMachine::syncState stateService play
May 05 16:36:07 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus stop
May 05 16:36:07 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:36:07 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:36:07 volumio volumio[696]: verbose: In UPNP mode
May 05 16:36:07 volumio volumio[696]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Unforgettable","artist":"Leif Shires","album":"Jazzy Cocktails","uri":"http://192.168.1.19:10949/tidal/85055670.flac","trackType":"tidal"}
May 05 16:36:07 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:36:07 volumio volumio[696]: info: CoreStateMachine::syncState stateService play
May 05 16:36:07 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus play
May 05 16:36:07 volumio volumio[696]: info: Received an update from plugin. extracting info from payload
May 05 16:36:07 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
May 05 16:36:07 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:36:07 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 05 16:36:07 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:36:07 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:36:07 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:36:07 volumio volumio[696]: info: ------------------------------ 33ms
May 05 16:36:07 volumio volumio[696]: info: ------------------------------ 40ms
May 05 16:36:07 volumio volumio[696]: info: sendMpdCommand playlistinfo took 26 milliseconds
May 05 16:36:07 volumio volumio[696]: info: sendMpdCommand playlistinfo took 26 milliseconds
May 05 16:36:07 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:36:07 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:36:07 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:36:07 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:36:07 volumio volumio[696]: verbose: In UPNP mode
May 05 16:36:07 volumio volumio[696]: verbose: STATE SERVICE {"status":"play","position":0,"seek":57,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Unforgettable","artist":"Leif Shires","album":"Jazzy Cocktails","uri":"http://192.168.1.19:10949/tidal/85055670.flac","trackType":"tidal"}
May 05 16:36:07 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:36:07 volumio volumio[696]: info: CoreStateMachine::syncState stateService play
May 05 16:36:07 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus play
May 05 16:36:07 volumio volumio[696]: info: Received an update from plugin. extracting info from payload
May 05 16:36:07 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
May 05 16:36:07 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:36:07 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:36:07 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:36:07 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:36:07 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:36:07 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:36:07 volumio volumio[696]: verbose: In UPNP mode
May 05 16:36:07 volumio volumio[696]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"856 Kbps","isStreaming":false,"title":"Unforgettable","artist":"Leif Shires","album":"Jazzy Cocktails","uri":"http://192.168.1.19:10949/tidal/85055670.flac","trackType":"tidal"}
May 05 16:36:07 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:36:07 volumio volumio[696]: info: CoreStateMachine::syncState stateService play
May 05 16:36:07 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus play
May 05 16:36:07 volumio volumio[696]: info: Received an update from plugin. extracting info from payload
May 05 16:36:07 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
May 05 16:36:07 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:36:07 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 05 16:36:07 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:36:07 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:36:07 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:36:07 volumio volumio[696]: info: ------------------------------ 68ms
May 05 16:36:07 volumio volumio[696]: info: ------------------------------ 63ms
May 05 16:36:07 volumio volumio[696]: info: CoreCommandRouter::volumioGetQueue
May 05 16:36:07 volumio volumio[696]: info: CoreStateMachine::getQueue
May 05 16:36:07 volumio volumio[696]: info: CorePlayQueue::getQueue
May 05 16:36:07 volumio volumio[696]: info: CoreCommandRouter::volumioGetQueue
May 05 16:36:07 volumio volumio[696]: info: CoreStateMachine::getQueue
May 05 16:36:07 volumio volumio[696]: info: CorePlayQueue::getQueue
May 05 16:36:07 volumio volumio[696]: info: CoreCommandRouter::volumioGetQueue
May 05 16:36:07 volumio volumio[696]: info: CoreStateMachine::getQueue
May 05 16:36:07 volumio volumio[696]: info: CorePlayQueue::getQueue
May 05 16:36:07 volumio volumio[696]: info: CoreCommandRouter::volumioGetQueue
May 05 16:36:07 volumio volumio[696]: info: CoreStateMachine::getQueue
May 05 16:36:07 volumio volumio[696]: info: CorePlayQueue::getQueue
May 05 16:36:07 volumio volumio[696]: info: CoreCommandRouter::volumioGetQueue
May 05 16:36:07 volumio volumio[696]: info: CoreStateMachine::getQueue
May 05 16:36:07 volumio volumio[696]: info: CorePlayQueue::getQueue
May 05 16:36:07 volumio volumio[696]: info: CoreCommandRouter::volumioGetQueue
May 05 16:36:07 volumio volumio[696]: info: CoreStateMachine::getQueue
May 05 16:36:07 volumio volumio[696]: info: CorePlayQueue::getQueue
May 05 16:36:16 volumio volumio[696]: info:
May 05 16:36:16 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:36:16 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:36:16 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:36:16 volumio volumio[696]: info:
May 05 16:36:16 volumio volumio[696]: ---------------------------- MPD announces state update: player
May 05 16:36:16 volumio volumio[696]: info: ControllerMpd::getState
May 05 16:36:16 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand status
May 05 16:36:16 volumio volumio[696]: info: sendMpdCommand status took 2 milliseconds
May 05 16:36:16 volumio volumio[696]: info: sendMpdCommand status took 1 milliseconds
May 05 16:36:16 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:36:16 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:36:16 volumio volumio[696]: verbose: ControllerMpd::parseState
May 05 16:36:16 volumio volumio[696]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 05 16:36:16 volumio volumio[696]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 05 16:36:16 volumio volumio[696]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 05 16:36:16 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:36:16 volumio volumio[696]: verbose: ControllerMpd::parseTrackInfo
May 05 16:36:16 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:36:16 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:36:16 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:36:16 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:36:16 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:36:16 volumio volumio[696]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Unforgettable","artist":"Leif Shires","album":"Jazzy Cocktails","uri":"http://192.168.1.19:10949/tidal/85055670.flac","trackType":"tidal"}
May 05 16:36:16 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:36:16 volumio volumio[696]: info: CoreStateMachine::syncState stateService stop
May 05 16:36:16 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus play
May 05 16:36:16 volumio volumio[696]: info: CoreStateMachine::play index undefined
May 05 16:36:16 volumio volumio[696]: info: CoreStateMachine::setConsumeUpdateService undefined
May 05 16:36:16 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:36:16 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:36:16 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 05 16:36:16 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:36:16 volumio volumio[696]: info: ControllerMpd::pushState
May 05 16:36:16 volumio volumio[696]: info: CoreCommandRouter::servicePushState
May 05 16:36:16 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:36:16 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:36:16 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:36:16 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:36:16 volumio volumio[696]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Unforgettable","artist":"Leif Shires","album":"Jazzy Cocktails","uri":"http://192.168.1.19:10949/tidal/85055670.flac","trackType":"tidal"}
May 05 16:36:16 volumio volumio[696]: verbose: CURRENT POSITION 0
May 05 16:36:16 volumio volumio[696]: info: CoreStateMachine::syncState stateService stop
May 05 16:36:16 volumio volumio[696]: info: CoreStateMachine::syncState currentStatus stop
May 05 16:36:16 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:36:16 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:36:16 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:36:16 volumio volumio[696]: info: No code
May 05 16:36:16 volumio volumio[696]: info: CoreStateMachine::pushState
May 05 16:36:16 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:36:16 volumio volumio[696]: info: CoreCommandRouter::volumioPushState
May 05 16:36:16 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:36:16 volumio volumio[696]: info: ------------------------------ 29ms
May 05 16:36:16 volumio volumio[696]: info: ------------------------------ 28ms
May 05 16:36:16 volumio volumio[696]: info: CoreCommandRouter::volumioGetQueue
May 05 16:36:16 volumio volumio[696]: info: CoreStateMachine::getQueue
May 05 16:36:16 volumio volumio[696]: info: CorePlayQueue::getQueue
May 05 16:36:22 volumio volumio[696]: verbose: New Socket.io Connection to 192.168.1.70 from 192.168.1.19 UA: unknown Total Clients: 4
May 05 16:36:22 volumio volumio[696]: info: CoreCommandRouter::volumioGetState
May 05 16:36:22 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:36:22 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
May 05 16:36:22 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
May 05 16:36:23 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 05 16:36:23 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 05 16:36:23 volumio volumio[696]: info: Discovery: Getting this device information
May 05 16:36:23 volumio volumio[696]: info: CoreCommandRouter::volumioGetState
May 05 16:36:23 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:36:23 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 05 16:36:24 volumio volumio[696]: verbose: New Socket.io Connection to 192.168.1.70 from 192.168.1.19 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Total Clients: 5
May 05 16:36:24 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
May 05 16:36:24 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 05 16:36:24 volumio volumio[696]: info: CoreCommandRouter::volumioGetVisibleSources
May 05 16:36:24 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 05 16:36:24 volumio volumio[696]: info: CoreCommandRouter::volumioGetState
May 05 16:36:24 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:36:24 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
May 05 16:36:24 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 05 16:36:24 volumio volumio[696]: info: Received Get System Info
May 05 16:36:24 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 05 16:36:24 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 05 16:36:24 volumio volumio[696]: info: Discovery: Getting this device information
May 05 16:36:24 volumio volumio[696]: info: CoreCommandRouter::volumioGetState
May 05 16:36:24 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:36:24 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 05 16:36:24 volumio volumio[696]: info: CoreCommandRouter::volumioGetState
May 05 16:36:24 volumio volumio[696]: info: CorePlayQueue::getTrack 0
May 05 16:36:24 volumio volumio[696]: info: Listing playlists
May 05 16:36:24 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
May 05 16:36:28 volumio volumio[696]: info: CoreCommandRouter::getUIConfigOnPlugin
May 05 16:36:28 volumio volumio[696]: info: CoreCommandRouter::getUIConfigOnPlugin
May 05 16:36:28 volumio volumio[696]: info: Retrieving Cloud Streaming UI
May 05 16:36:28 volumio volumio[696]: info: Getting Tidal Cloud Configuration
May 05 16:36:28 volumio volumio[696]: info: CoreCommandRouter::getUIConfigOnPlugin
May 05 16:36:28 volumio volumio[696]: info: Getting Qobuz Cloud Configuration
May 05 16:36:28 volumio volumio[696]: info: Asking plugin for UI Config
May 05 16:36:28 volumio volumio[696]: info: CoreCommandRouter::getUIConfigOnPlugin
May 05 16:36:28 volumio volumio[696]: info: Getting Spotify Cloud Configuration
May 05 16:36:28 volumio volumio[696]: info: Asking plugin for UI Config
May 05 16:36:28 volumio volumio[696]: info: CoreCommandRouter::getUIConfigOnPlugin
May 05 16:36:28 volumio volumio[696]: info: Saving Spotify Acccount
May 05 16:36:28 volumio volumio[696]: info: Got Tidal Cloud Configuration
May 05 16:36:28 volumio volumio[696]: info: Got it
May 05 16:36:28 volumio volumio[696]: info: Got it
May 05 16:36:28 volumio volumio[696]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 05 16:36:28 volumio volumio[696]: info: CoreCommandRouter::getUIConfigOnPlugin
May 05 16:36:28 volumio volumio[696]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
May 05 16:36:28 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
May 05 16:36:28 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 05 16:36:28 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 05 16:36:28 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 05 16:36:28 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 05 16:36:28 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 05 16:36:28 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 05 16:36:28 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 05 16:36:28 volumio volumio[696]: info: CoreCommandRouter::volumioGetBrowseSources
May 05 16:36:28 volumio volumio[696]: info: CoreCommandRouter::volumioGetBrowseSources
May 05 16:36:28 volumio volumio[696]: info: CoreCommandRouter::volumioGetBrowseSources
May 05 16:36:28 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 05 16:36:28 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
May 05 16:36:29 volumio volumio[696]: info: Disabling MyMusic plugin upnp
May 05 16:36:30 volumio sudo[3534]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service
May 05 16:36:30 volumio sudo[3534]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 05 16:36:30 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD...
May 05 16:36:30 volumio volumio[696]: error: Upnp client error: Error: This socket has been ended by the other party
May 05 16:36:32 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 05 16:36:40 volumio volumio[696]: info: CoreCommandRouter::getUIConfigOnPlugin
May 05 16:36:40 volumio volumio[696]: info: CoreCommandRouter::getUIConfigOnPlugin
May 05 16:36:40 volumio volumio[696]: info: Retrieving Cloud Streaming UI
May 05 16:36:40 volumio volumio[696]: info: Getting Tidal Cloud Configuration
May 05 16:36:40 volumio volumio[696]: info: CoreCommandRouter::getUIConfigOnPlugin
May 05 16:36:40 volumio volumio[696]: info: Getting Qobuz Cloud Configuration
May 05 16:36:40 volumio volumio[696]: info: Asking plugin for UI Config
May 05 16:36:40 volumio volumio[696]: info: CoreCommandRouter::getUIConfigOnPlugin
May 05 16:36:40 volumio volumio[696]: info: Getting Spotify Cloud Configuration
May 05 16:36:40 volumio volumio[696]: info: Asking plugin for UI Config
May 05 16:36:40 volumio volumio[696]: info: CoreCommandRouter::getUIConfigOnPlugin
May 05 16:36:40 volumio volumio[696]: info: Saving Spotify Acccount
May 05 16:36:40 volumio volumio[696]: info: Got Tidal Cloud Configuration
May 05 16:36:40 volumio volumio[696]: info: Got it
May 05 16:36:40 volumio volumio[696]: info: Got it
May 05 16:36:40 volumio volumio[696]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 05 16:36:40 volumio volumio[696]: info: CoreCommandRouter::getUIConfigOnPlugin
May 05 16:36:40 volumio volumio[696]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
May 05 16:36:40 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
May 05 16:36:40 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 05 16:36:40 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 05 16:36:40 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 05 16:36:40 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 05 16:36:40 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 05 16:36:40 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 05 16:36:40 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 05 16:36:40 volumio volumio[696]: info: CoreCommandRouter::volumioGetBrowseSources
May 05 16:36:40 volumio volumio[696]: info: CoreCommandRouter::volumioGetBrowseSources
May 05 16:36:40 volumio volumio[696]: info: CoreCommandRouter::volumioGetBrowseSources
May 05 16:36:40 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 05 16:36:40 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
May 05 16:36:42 volumio volumio[696]: info: Disabling MyMusic plugin upnp
May 05 16:36:42 volumio sudo[3579]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service
May 05 16:36:42 volumio sudo[3579]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 05 16:36:44 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 05 16:36:45 volumio volumio[696]: info: Enabling MyMusic plugin upnp
May 05 16:36:45 volumio volumio[696]: info: Enabling plugin upnp
May 05 16:36:45 volumio volumio[696]: info: Loading plugin "upnp"...
May 05 16:36:45 volumio volumio[696]: info: [1714894605609] Starting Upmpd Daemon
May 05 16:36:45 volumio volumio[696]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 05 16:36:45 volumio volumio[696]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 05 16:36:45 volumio volumio[696]: Error: listen EADDRINUSE: address already in use :::6599
May 05 16:36:45 volumio volumio[696]: at Server.setupListenHandle [as _listen2] (net.js:1318:16)
May 05 16:36:45 volumio volumio[696]: at listenInCluster (net.js:1366:12)
May 05 16:36:45 volumio volumio[696]: at Server.listen (net.js:1452:7)
May 05 16:36:45 volumio volumio[696]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17)
May 05 16:36:45 volumio volumio[696]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38)
May 05 16:36:45 volumio volumio[696]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19)
May 05 16:36:45 volumio volumio[696]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
May 05 16:36:45 volumio volumio[696]: at processTicksAndRejections (internal/process/task_queues.js:75:11) {
May 05 16:36:45 volumio volumio[696]: code: 'EADDRINUSE',
May 05 16:36:45 volumio volumio[696]: errno: -98,
May 05 16:36:45 volumio volumio[696]: syscall: 'listen',
May 05 16:36:45 volumio volumio[696]: address: '::',
May 05 16:36:45 volumio volumio[696]: port: 6599
May 05 16:36:45 volumio volumio[696]: }
May 05 16:36:45 volumio volumio[696]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 05 16:36:45 volumio sudo[3590]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-05 16:35
May 05 16:36:45 volumio sudo[3590]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="e7445fab547cd22e23d9bef72406cfb610bc1d7d"
VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee"
VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623"
VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:10:14 PM CEST"
VOLUMIO_VERSION="3.661"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="5bdefd4af4423fd17aacb83a8538bf1f"