-- Logs begin at Wed 2022-07-13 14:55:24 UTC, end at Tue 2025-12-23 07:47:25 UTC. -- Dec 23 07:46:12 musical-fidelity volumio[10915]: info: Clearing queue after UPNP request Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CoreStateMachine::ClearQueue Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CoreStateMachine::stop Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 23 07:46:13 musical-fidelity volumio[10915]: verbose: UNSET VOLATILE Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CoreStateMachine::stPlaybackTimer Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CoreStateMachine::updateTrackBlock Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrackBlock Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrack 0 Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CoreStateMachine::serviceStop Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrack 0 Dec 23 07:46:13 musical-fidelity volumio[10915]: info: ControllerMpd::stop Dec 23 07:46:13 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand stop Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CorePlayQueue::clearPlayQueue Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CorePlayQueue::saveQueue Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushQueue Dec 23 07:46:13 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:46:13 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:46:13 musical-fidelity volumio[10915]: info: Dec 23 07:46:13 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:46:13 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:46:13 musical-fidelity volumio[10915]: info: Dec 23 07:46:13 musical-fidelity volumio[10915]: ---------------------------- MPD announces state update: player Dec 23 07:46:13 musical-fidelity volumio[10915]: info: ControllerMpd::getState Dec 23 07:46:13 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand status Dec 23 07:46:13 musical-fidelity volumio[10915]: info: sendMpdCommand stop took 35 milliseconds Dec 23 07:46:13 musical-fidelity volumio[10915]: error: updateQueue error: null Dec 23 07:46:13 musical-fidelity volumio[10915]: info: ------------------------------ 5ms Dec 23 07:46:13 musical-fidelity volumio[10915]: info: sendMpdCommand status took 3 milliseconds Dec 23 07:46:13 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseState Dec 23 07:46:13 musical-fidelity volumio[10915]: info: ControllerMpd::pushState Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CoreCommandRouter::servicePushState Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrack 0 Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrack 0 Dec 23 07:46:13 musical-fidelity volumio[10915]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 23 07:46:13 musical-fidelity volumio[10915]: verbose: CURRENT POSITION 0 Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState stateService stop Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState currentStatus stop Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrack 0 Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:46:13 musical-fidelity volumio[10915]: info: No code Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrack 0 Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:46:13 musical-fidelity volumio[10915]: info: ------------------------------ 38ms Dec 23 07:46:13 musical-fidelity volumio[10915]: info: Starting UPNP Playback Dec 23 07:46:13 musical-fidelity volumio[10915]: info: Preparing playback through UPNP Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioGetState Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrack 0 Dec 23 07:46:13 musical-fidelity volumio[10915]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 23 07:46:13 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:46:13 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:46:13 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:46:13 musical-fidelity volumio[10915]: info: Dec 23 07:46:13 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:46:13 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:46:13 musical-fidelity volumio[10915]: info: Dec 23 07:46:13 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:46:13 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:46:13 musical-fidelity volumio[10915]: info: ------------------------------ 4ms Dec 23 07:46:13 musical-fidelity volumio[10915]: info: ------------------------------ 2ms Dec 23 07:46:13 musical-fidelity volumio[10915]: info: Dec 23 07:46:13 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:46:13 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:46:13 musical-fidelity volumio[10915]: info: ------------------------------ 2ms Dec 23 07:46:13 musical-fidelity volumio[10915]: info: Dec 23 07:46:13 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:46:13 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:46:13 musical-fidelity volumio[10915]: info: ------------------------------ 3ms Dec 23 07:46:13 musical-fidelity volumio[10915]: info: Dec 23 07:46:13 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:46:13 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:46:13 musical-fidelity volumio[10915]: info: ------------------------------ 3ms Dec 23 07:46:13 musical-fidelity volumio[10915]: info: Dec 23 07:46:13 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:46:13 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:46:13 musical-fidelity volumio[10915]: info: ------------------------------ 2ms Dec 23 07:46:14 musical-fidelity volumio[10915]: info: Dec 23 07:46:14 musical-fidelity volumio[10915]: ---------------------------- MPD announces state update: player Dec 23 07:46:14 musical-fidelity volumio[10915]: info: ControllerMpd::getState Dec 23 07:46:14 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand status Dec 23 07:46:14 musical-fidelity volumio[10915]: info: Dec 23 07:46:14 musical-fidelity volumio[10915]: ---------------------------- MPD announces state update: player Dec 23 07:46:14 musical-fidelity volumio[10915]: info: ControllerMpd::getState Dec 23 07:46:14 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand status Dec 23 07:46:14 musical-fidelity volumio[10915]: info: sendMpdCommand status took 4 milliseconds Dec 23 07:46:14 musical-fidelity volumio[10915]: info: sendMpdCommand status took 2 milliseconds Dec 23 07:46:14 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseState Dec 23 07:46:14 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 07:46:14 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseState Dec 23 07:46:14 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 07:46:14 musical-fidelity volumio[10915]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 23 07:46:14 musical-fidelity volumio[10915]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 23 07:46:14 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseTrackInfo Dec 23 07:46:14 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseTrackInfo Dec 23 07:46:14 musical-fidelity volumio[10915]: info: ControllerMpd::pushState Dec 23 07:46:14 musical-fidelity volumio[10915]: info: CoreCommandRouter::servicePushState Dec 23 07:46:14 musical-fidelity volumio[10915]: verbose: In UPNP mode Dec 23 07:46:14 musical-fidelity volumio[10915]: verbose: STATE SERVICE {"status":"play","position":0,"seek":371,"duration":271,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"给自己的情书","artist":"陈洁丽","album":"爱的歌","uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEidmYmE5ZDliMDVkZjc5YWM4MzY5N2E2MzY0YjFmZTY1ZV82MS5tcDQ/0.flac?token=1766479572~YzkxNDUxYzcxNjE3Mjg5ZGNlYzkyYThjNDk5NTAzZWMxNmNmNGNhZQ==","trackType":"tidal"} Dec 23 07:46:14 musical-fidelity volumio[10915]: verbose: CURRENT POSITION 0 Dec 23 07:46:14 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState stateService play Dec 23 07:46:14 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState currentStatus stop Dec 23 07:46:14 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:46:14 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:46:14 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:46:14 musical-fidelity volumio[10915]: info: ControllerMpd::pushState Dec 23 07:46:14 musical-fidelity volumio[10915]: info: CoreCommandRouter::servicePushState Dec 23 07:46:14 musical-fidelity volumio[10915]: verbose: In UPNP mode Dec 23 07:46:14 musical-fidelity volumio[10915]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":271,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"155 Kbps","isStreaming":false,"title":"给自己的情书","artist":"陈洁丽","album":"爱的歌","uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEidmYmE5ZDliMDVkZjc5YWM4MzY5N2E2MzY0YjFmZTY1ZV82MS5tcDQ/0.flac?token=1766479572~YzkxNDUxYzcxNjE3Mjg5ZGNlYzkyYThjNDk5NTAzZWMxNmNmNGNhZQ==","trackType":"tidal"} Dec 23 07:46:14 musical-fidelity volumio[10915]: verbose: CURRENT POSITION 0 Dec 23 07:46:14 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState stateService play Dec 23 07:46:14 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState currentStatus play Dec 23 07:46:14 musical-fidelity volumio[10915]: info: Received an update from plugin. extracting info from payload Dec 23 07:46:14 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 23 07:46:14 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:46:14 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:46:14 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:46:14 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:46:14 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:46:14 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:46:14 musical-fidelity volumio[10915]: info: ------------------------------ 54ms Dec 23 07:46:14 musical-fidelity volumio[10915]: info: ------------------------------ 50ms Dec 23 07:46:14 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:46:14 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:46:14 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:46:14 musical-fidelity volumio[10915]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Tyla/Water/11e49db6-7d88-406c-80f3-f4ef6d2731b5.jpg' Dec 23 07:46:14 musical-fidelity volumio[10915]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%99%88%E6%B4%81%E4%B8%BD/%E7%88%B1%E7%9A%84%E6%AD%8C/3e0ae5f7-6d35-4f9c-b661-d6fdf871866c.jpg' Dec 23 07:46:23 musical-fidelity volumio[10915]: info: Clearing queue after UPNP request Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CoreStateMachine::ClearQueue Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CoreStateMachine::stop Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 23 07:46:23 musical-fidelity volumio[10915]: verbose: UNSET VOLATILE Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CoreStateMachine::stPlaybackTimer Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CoreStateMachine::updateTrackBlock Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrackBlock Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrack 0 Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CoreStateMachine::serviceStop Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrack 0 Dec 23 07:46:23 musical-fidelity volumio[10915]: info: ControllerMpd::stop Dec 23 07:46:23 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand stop Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CorePlayQueue::clearPlayQueue Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CorePlayQueue::saveQueue Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushQueue Dec 23 07:46:23 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:46:23 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:46:23 musical-fidelity volumio[10915]: info: Dec 23 07:46:23 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:46:23 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:46:23 musical-fidelity volumio[10915]: info: Dec 23 07:46:23 musical-fidelity volumio[10915]: ---------------------------- MPD announces state update: player Dec 23 07:46:23 musical-fidelity volumio[10915]: info: ControllerMpd::getState Dec 23 07:46:23 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand status Dec 23 07:46:23 musical-fidelity volumio[10915]: info: sendMpdCommand stop took 80 milliseconds Dec 23 07:46:23 musical-fidelity volumio[10915]: info: Starting UPNP Playback Dec 23 07:46:23 musical-fidelity volumio[10915]: info: Preparing playback through UPNP Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioGetState Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrack 0 Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 23 07:46:23 musical-fidelity volumio[10915]: error: updateQueue error: null Dec 23 07:46:23 musical-fidelity volumio[10915]: info: ------------------------------ 23ms Dec 23 07:46:23 musical-fidelity volumio[10915]: info: sendMpdCommand status took 15 milliseconds Dec 23 07:46:23 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseState Dec 23 07:46:23 musical-fidelity volumio[10915]: info: ControllerMpd::pushState Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CoreCommandRouter::servicePushState Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrack 0 Dec 23 07:46:23 musical-fidelity volumio[10915]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 23 07:46:23 musical-fidelity volumio[10915]: verbose: CURRENT POSITION 0 Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState stateService stop Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState currentStatus stop Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:46:23 musical-fidelity volumio[10915]: info: No code Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:46:23 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:46:23 musical-fidelity volumio[10915]: info: ------------------------------ 74ms Dec 23 07:46:23 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:46:23 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:46:23 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:46:24 musical-fidelity volumio[10915]: info: Dec 23 07:46:24 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:46:24 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:46:24 musical-fidelity volumio[10915]: info: Dec 23 07:46:24 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:46:24 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:46:24 musical-fidelity volumio[10915]: info: ------------------------------ 3ms Dec 23 07:46:24 musical-fidelity volumio[10915]: info: ------------------------------ 2ms Dec 23 07:46:24 musical-fidelity volumio[10915]: info: Dec 23 07:46:24 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:46:24 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:46:24 musical-fidelity volumio[10915]: info: Dec 23 07:46:24 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:46:24 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:46:24 musical-fidelity volumio[10915]: info: ------------------------------ 3ms Dec 23 07:46:24 musical-fidelity volumio[10915]: info: ------------------------------ 2ms Dec 23 07:46:24 musical-fidelity volumio[10915]: info: Dec 23 07:46:24 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:46:24 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:46:24 musical-fidelity volumio[10915]: info: Dec 23 07:46:24 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:46:24 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:46:24 musical-fidelity volumio[10915]: info: ------------------------------ 3ms Dec 23 07:46:24 musical-fidelity volumio[10915]: info: ------------------------------ 2ms Dec 23 07:46:24 musical-fidelity volumio[10915]: info: Dec 23 07:46:24 musical-fidelity volumio[10915]: ---------------------------- MPD announces state update: player Dec 23 07:46:24 musical-fidelity volumio[10915]: info: ControllerMpd::getState Dec 23 07:46:24 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand status Dec 23 07:46:24 musical-fidelity volumio[10915]: info: Dec 23 07:46:24 musical-fidelity volumio[10915]: ---------------------------- MPD announces state update: player Dec 23 07:46:24 musical-fidelity volumio[10915]: info: ControllerMpd::getState Dec 23 07:46:24 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand status Dec 23 07:46:24 musical-fidelity volumio[10915]: info: sendMpdCommand status took 2 milliseconds Dec 23 07:46:24 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseState Dec 23 07:46:24 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 07:46:24 musical-fidelity volumio[10915]: info: sendMpdCommand status took 3 milliseconds Dec 23 07:46:24 musical-fidelity volumio[10915]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 23 07:46:24 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseState Dec 23 07:46:24 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 07:46:24 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseTrackInfo Dec 23 07:46:24 musical-fidelity volumio[10915]: info: ControllerMpd::pushState Dec 23 07:46:24 musical-fidelity volumio[10915]: info: CoreCommandRouter::servicePushState Dec 23 07:46:24 musical-fidelity volumio[10915]: verbose: In UPNP mode Dec 23 07:46:24 musical-fidelity volumio[10915]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":224,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"311 Kbps","isStreaming":false,"title":"遇见","artist":"陈洁丽","album":"爱的歌","uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEicyMDUyOTRkMDdjOTM4MTEyM2NiOWFlYjk3MzIzZGFiYV82MS5tcDQ/0.flac?token=1766479583~M2E4MWQ5NGMxOTExYTVmYzFkM2U5YzM2Y2YwMTI5ZjczOTIyMGNhYQ==","trackType":"tidal"} Dec 23 07:46:24 musical-fidelity volumio[10915]: verbose: CURRENT POSITION 0 Dec 23 07:46:24 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState stateService play Dec 23 07:46:24 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState currentStatus stop Dec 23 07:46:24 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:46:24 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:46:24 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:46:24 musical-fidelity volumio[10915]: info: ------------------------------ 24ms Dec 23 07:46:24 musical-fidelity volumio[10915]: info: sendMpdCommand playlistinfo took 16 milliseconds Dec 23 07:46:24 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseTrackInfo Dec 23 07:46:24 musical-fidelity volumio[10915]: info: ControllerMpd::pushState Dec 23 07:46:24 musical-fidelity volumio[10915]: info: CoreCommandRouter::servicePushState Dec 23 07:46:24 musical-fidelity volumio[10915]: verbose: In UPNP mode Dec 23 07:46:24 musical-fidelity volumio[10915]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":224,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"311 Kbps","isStreaming":false,"title":"遇见","artist":"陈洁丽","album":"爱的歌","uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEicyMDUyOTRkMDdjOTM4MTEyM2NiOWFlYjk3MzIzZGFiYV82MS5tcDQ/0.flac?token=1766479583~M2E4MWQ5NGMxOTExYTVmYzFkM2U5YzM2Y2YwMTI5ZjczOTIyMGNhYQ==","trackType":"tidal"} Dec 23 07:46:24 musical-fidelity volumio[10915]: verbose: CURRENT POSITION 0 Dec 23 07:46:24 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState stateService play Dec 23 07:46:24 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState currentStatus play Dec 23 07:46:24 musical-fidelity volumio[10915]: info: Received an update from plugin. extracting info from payload Dec 23 07:46:24 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 23 07:46:24 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:46:24 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:46:24 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:46:24 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:46:24 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:46:24 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:46:24 musical-fidelity volumio[10915]: info: ------------------------------ 51ms Dec 23 07:46:24 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:46:24 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:46:24 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:47:05 musical-fidelity volumio[10915]: info: Clearing queue after UPNP request Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CoreStateMachine::ClearQueue Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CoreStateMachine::stop Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 23 07:47:05 musical-fidelity volumio[10915]: verbose: UNSET VOLATILE Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CoreStateMachine::stPlaybackTimer Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CoreStateMachine::updateTrackBlock Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrackBlock Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrack 0 Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CoreStateMachine::serviceStop Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrack 0 Dec 23 07:47:05 musical-fidelity volumio[10915]: info: ControllerMpd::stop Dec 23 07:47:05 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand stop Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CorePlayQueue::clearPlayQueue Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CorePlayQueue::saveQueue Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushQueue Dec 23 07:47:05 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:47:05 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:47:05 musical-fidelity volumio[10915]: info: Dec 23 07:47:05 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:47:05 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:47:05 musical-fidelity volumio[10915]: info: Dec 23 07:47:05 musical-fidelity volumio[10915]: ---------------------------- MPD announces state update: player Dec 23 07:47:05 musical-fidelity volumio[10915]: info: ControllerMpd::getState Dec 23 07:47:05 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand status Dec 23 07:47:05 musical-fidelity volumio[10915]: info: sendMpdCommand stop took 41 milliseconds Dec 23 07:47:05 musical-fidelity volumio[10915]: info: Starting UPNP Playback Dec 23 07:47:05 musical-fidelity volumio[10915]: info: Preparing playback through UPNP Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioGetState Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrack 0 Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 23 07:47:05 musical-fidelity volumio[10915]: error: updateQueue error: null Dec 23 07:47:05 musical-fidelity volumio[10915]: info: ------------------------------ 20ms Dec 23 07:47:05 musical-fidelity volumio[10915]: info: sendMpdCommand status took 19 milliseconds Dec 23 07:47:05 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseState Dec 23 07:47:05 musical-fidelity volumio[10915]: info: ControllerMpd::pushState Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CoreCommandRouter::servicePushState Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrack 0 Dec 23 07:47:05 musical-fidelity volumio[10915]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 23 07:47:05 musical-fidelity volumio[10915]: verbose: CURRENT POSITION 0 Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState stateService stop Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState currentStatus stop Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:47:05 musical-fidelity volumio[10915]: info: No code Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:47:05 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:47:05 musical-fidelity volumio[10915]: info: ------------------------------ 52ms Dec 23 07:47:05 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:47:05 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:47:05 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:47:06 musical-fidelity volumio[10915]: info: Dec 23 07:47:06 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:47:06 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:47:06 musical-fidelity volumio[10915]: info: ------------------------------ 4ms Dec 23 07:47:06 musical-fidelity volumio[10915]: info: Dec 23 07:47:06 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:47:06 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:47:06 musical-fidelity volumio[10915]: info: ------------------------------ 2ms Dec 23 07:47:06 musical-fidelity volumio[10915]: info: Dec 23 07:47:06 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:47:06 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:47:06 musical-fidelity volumio[10915]: info: Dec 23 07:47:06 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:47:06 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:47:06 musical-fidelity volumio[10915]: info: ------------------------------ 3ms Dec 23 07:47:06 musical-fidelity volumio[10915]: info: ------------------------------ 2ms Dec 23 07:47:06 musical-fidelity volumio[10915]: info: Dec 23 07:47:06 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:47:06 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:47:06 musical-fidelity volumio[10915]: info: Dec 23 07:47:06 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:47:06 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:47:06 musical-fidelity volumio[10915]: info: ------------------------------ 3ms Dec 23 07:47:06 musical-fidelity volumio[10915]: info: ------------------------------ 2ms Dec 23 07:47:06 musical-fidelity volumio[10915]: info: Dec 23 07:47:06 musical-fidelity volumio[10915]: ---------------------------- MPD announces state update: player Dec 23 07:47:06 musical-fidelity volumio[10915]: info: ControllerMpd::getState Dec 23 07:47:06 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand status Dec 23 07:47:06 musical-fidelity volumio[10915]: info: Dec 23 07:47:06 musical-fidelity volumio[10915]: ---------------------------- MPD announces state update: player Dec 23 07:47:06 musical-fidelity volumio[10915]: info: sendMpdCommand status took 4 milliseconds Dec 23 07:47:06 musical-fidelity volumio[10915]: info: ControllerMpd::getState Dec 23 07:47:06 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand status Dec 23 07:47:06 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseState Dec 23 07:47:06 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 07:47:06 musical-fidelity volumio[10915]: info: sendMpdCommand status took 4 milliseconds Dec 23 07:47:06 musical-fidelity volumio[10915]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 23 07:47:06 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseState Dec 23 07:47:06 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 07:47:06 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseTrackInfo Dec 23 07:47:06 musical-fidelity volumio[10915]: info: ControllerMpd::pushState Dec 23 07:47:06 musical-fidelity volumio[10915]: info: CoreCommandRouter::servicePushState Dec 23 07:47:06 musical-fidelity volumio[10915]: verbose: In UPNP mode Dec 23 07:47:06 musical-fidelity volumio[10915]: verbose: STATE SERVICE {"status":"play","position":0,"seek":441,"duration":224,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"遇见","artist":"陈洁丽","album":"爱的歌","uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEicyMDUyOTRkMDdjOTM4MTEyM2NiOWFlYjk3MzIzZGFiYV82MS5tcDQ/0.flac?token=1766479583~M2E4MWQ5NGMxOTExYTVmYzFkM2U5YzM2Y2YwMTI5ZjczOTIyMGNhYQ==","trackType":"tidal"} Dec 23 07:47:06 musical-fidelity volumio[10915]: verbose: CURRENT POSITION 0 Dec 23 07:47:06 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState stateService play Dec 23 07:47:06 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState currentStatus stop Dec 23 07:47:06 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:47:06 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:47:06 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:47:06 musical-fidelity volumio[10915]: info: ------------------------------ 23ms Dec 23 07:47:06 musical-fidelity volumio[10915]: info: sendMpdCommand playlistinfo took 13 milliseconds Dec 23 07:47:06 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseTrackInfo Dec 23 07:47:06 musical-fidelity volumio[10915]: info: ControllerMpd::pushState Dec 23 07:47:06 musical-fidelity volumio[10915]: info: CoreCommandRouter::servicePushState Dec 23 07:47:06 musical-fidelity volumio[10915]: verbose: In UPNP mode Dec 23 07:47:06 musical-fidelity volumio[10915]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":224,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"317 Kbps","isStreaming":false,"title":"遇见","artist":"陈洁丽","album":"爱的歌","uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEicyMDUyOTRkMDdjOTM4MTEyM2NiOWFlYjk3MzIzZGFiYV82MS5tcDQ/0.flac?token=1766479583~M2E4MWQ5NGMxOTExYTVmYzFkM2U5YzM2Y2YwMTI5ZjczOTIyMGNhYQ==","trackType":"tidal"} Dec 23 07:47:06 musical-fidelity volumio[10915]: verbose: CURRENT POSITION 0 Dec 23 07:47:06 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState stateService play Dec 23 07:47:06 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState currentStatus play Dec 23 07:47:06 musical-fidelity volumio[10915]: info: Received an update from plugin. extracting info from payload Dec 23 07:47:06 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 23 07:47:06 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:47:06 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:47:06 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:47:06 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:47:06 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:47:06 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:47:06 musical-fidelity volumio[10915]: info: ------------------------------ 45ms Dec 23 07:47:06 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:47:06 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:47:06 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:47:09 musical-fidelity volumio[10915]: info: Dec 23 07:47:09 musical-fidelity volumio[10915]: ---------------------------- MPD announces state update: player Dec 23 07:47:09 musical-fidelity volumio[10915]: info: ControllerMpd::getState Dec 23 07:47:09 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand status Dec 23 07:47:09 musical-fidelity volumio[10915]: info: sendMpdCommand status took 1 milliseconds Dec 23 07:47:09 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseState Dec 23 07:47:09 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 07:47:09 musical-fidelity volumio[10915]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 23 07:47:09 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseTrackInfo Dec 23 07:47:09 musical-fidelity volumio[10915]: info: ControllerMpd::pushState Dec 23 07:47:09 musical-fidelity volumio[10915]: info: CoreCommandRouter::servicePushState Dec 23 07:47:09 musical-fidelity volumio[10915]: verbose: In UPNP mode Dec 23 07:47:09 musical-fidelity volumio[10915]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":3459,"duration":224,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"505 Kbps","isStreaming":false,"title":"遇见","artist":"陈洁丽","album":"爱的歌","uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEicyMDUyOTRkMDdjOTM4MTEyM2NiOWFlYjk3MzIzZGFiYV82MS5tcDQ/0.flac?token=1766479583~M2E4MWQ5NGMxOTExYTVmYzFkM2U5YzM2Y2YwMTI5ZjczOTIyMGNhYQ==","trackType":"tidal"} Dec 23 07:47:09 musical-fidelity volumio[10915]: verbose: CURRENT POSITION 0 Dec 23 07:47:09 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState stateService pause Dec 23 07:47:09 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState currentStatus play Dec 23 07:47:09 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:47:09 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:47:09 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:47:09 musical-fidelity volumio[10915]: info: CoreStateMachine::stPlaybackTimer Dec 23 07:47:09 musical-fidelity volumio[10915]: info: ------------------------------ 14ms Dec 23 07:47:09 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:47:17 musical-fidelity volumio[10915]: info: Dec 23 07:47:17 musical-fidelity volumio[10915]: ---------------------------- MPD announces state update: player Dec 23 07:47:17 musical-fidelity volumio[10915]: info: ControllerMpd::getState Dec 23 07:47:17 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand status Dec 23 07:47:17 musical-fidelity volumio[10915]: info: sendMpdCommand status took 1 milliseconds Dec 23 07:47:17 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseState Dec 23 07:47:17 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 07:47:17 musical-fidelity volumio[10915]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 23 07:47:17 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseTrackInfo Dec 23 07:47:17 musical-fidelity volumio[10915]: info: ControllerMpd::pushState Dec 23 07:47:17 musical-fidelity volumio[10915]: info: CoreCommandRouter::servicePushState Dec 23 07:47:17 musical-fidelity volumio[10915]: verbose: In UPNP mode Dec 23 07:47:17 musical-fidelity volumio[10915]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3947,"duration":224,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"477 Kbps","isStreaming":false,"title":"遇见","artist":"陈洁丽","album":"爱的歌","uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEicyMDUyOTRkMDdjOTM4MTEyM2NiOWFlYjk3MzIzZGFiYV82MS5tcDQ/0.flac?token=1766479583~M2E4MWQ5NGMxOTExYTVmYzFkM2U5YzM2Y2YwMTI5ZjczOTIyMGNhYQ==","trackType":"tidal"} Dec 23 07:47:17 musical-fidelity volumio[10915]: verbose: CURRENT POSITION 0 Dec 23 07:47:17 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState stateService play Dec 23 07:47:17 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState currentStatus play Dec 23 07:47:17 musical-fidelity volumio[10915]: info: Received an update from plugin. extracting info from payload Dec 23 07:47:17 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 23 07:47:17 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:47:17 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:47:17 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:47:17 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:47:17 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:47:17 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:47:17 musical-fidelity volumio[10915]: info: ------------------------------ 29ms Dec 23 07:47:17 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:47:17 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:47:19 musical-fidelity volumio[10915]: info: Clearing queue after UPNP request Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CoreStateMachine::ClearQueue Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CoreStateMachine::stop Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 23 07:47:19 musical-fidelity volumio[10915]: verbose: UNSET VOLATILE Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CoreStateMachine::stPlaybackTimer Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CoreStateMachine::updateTrackBlock Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrackBlock Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrack 0 Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CoreStateMachine::serviceStop Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrack 0 Dec 23 07:47:19 musical-fidelity volumio[10915]: info: ControllerMpd::stop Dec 23 07:47:19 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand stop Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CorePlayQueue::clearPlayQueue Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CorePlayQueue::saveQueue Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushQueue Dec 23 07:47:19 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:47:19 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:47:19 musical-fidelity volumio[10915]: info: Dec 23 07:47:19 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:47:19 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:47:19 musical-fidelity volumio[10915]: info: Dec 23 07:47:19 musical-fidelity volumio[10915]: ---------------------------- MPD announces state update: player Dec 23 07:47:19 musical-fidelity volumio[10915]: info: ControllerMpd::getState Dec 23 07:47:19 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand status Dec 23 07:47:19 musical-fidelity volumio[10915]: info: sendMpdCommand stop took 115 milliseconds Dec 23 07:47:19 musical-fidelity volumio[10915]: error: updateQueue error: null Dec 23 07:47:19 musical-fidelity volumio[10915]: info: ------------------------------ 4ms Dec 23 07:47:19 musical-fidelity volumio[10915]: info: sendMpdCommand status took 3 milliseconds Dec 23 07:47:19 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseState Dec 23 07:47:19 musical-fidelity volumio[10915]: info: ControllerMpd::pushState Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CoreCommandRouter::servicePushState Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrack 0 Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrack 0 Dec 23 07:47:19 musical-fidelity volumio[10915]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 23 07:47:19 musical-fidelity volumio[10915]: verbose: CURRENT POSITION 0 Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState stateService stop Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState currentStatus stop Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrack 0 Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:47:19 musical-fidelity volumio[10915]: info: No code Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrack 0 Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:47:19 musical-fidelity volumio[10915]: info: ------------------------------ 25ms Dec 23 07:47:19 musical-fidelity volumio[10915]: info: Starting UPNP Playback Dec 23 07:47:19 musical-fidelity volumio[10915]: info: Preparing playback through UPNP Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioGetState Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrack 0 Dec 23 07:47:19 musical-fidelity volumio[10915]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 23 07:47:19 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:47:19 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:47:19 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:47:20 musical-fidelity volumio[10915]: info: Dec 23 07:47:20 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:47:20 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:47:20 musical-fidelity volumio[10915]: info: ------------------------------ 2ms Dec 23 07:47:20 musical-fidelity volumio[10915]: info: Dec 23 07:47:20 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:47:20 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:47:20 musical-fidelity volumio[10915]: info: ------------------------------ 2ms Dec 23 07:47:20 musical-fidelity volumio[10915]: info: Dec 23 07:47:20 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:47:20 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:47:20 musical-fidelity volumio[10915]: info: ------------------------------ 3ms Dec 23 07:47:20 musical-fidelity volumio[10915]: info: Dec 23 07:47:20 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:47:20 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:47:20 musical-fidelity volumio[10915]: info: ------------------------------ 2ms Dec 23 07:47:20 musical-fidelity volumio[10915]: info: Dec 23 07:47:20 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:47:20 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:47:20 musical-fidelity volumio[10915]: info: ------------------------------ 2ms Dec 23 07:47:20 musical-fidelity volumio[10915]: info: Dec 23 07:47:20 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:47:20 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:47:20 musical-fidelity volumio[10915]: info: ------------------------------ 3ms Dec 23 07:47:20 musical-fidelity volumio[10915]: info: Dec 23 07:47:20 musical-fidelity volumio[10915]: ---------------------------- MPD announces state update: player Dec 23 07:47:20 musical-fidelity volumio[10915]: info: ControllerMpd::getState Dec 23 07:47:20 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand status Dec 23 07:47:20 musical-fidelity volumio[10915]: info: Dec 23 07:47:20 musical-fidelity volumio[10915]: ---------------------------- MPD announces state update: player Dec 23 07:47:20 musical-fidelity volumio[10915]: info: ControllerMpd::getState Dec 23 07:47:20 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand status Dec 23 07:47:20 musical-fidelity volumio[10915]: info: sendMpdCommand status took 2 milliseconds Dec 23 07:47:20 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseState Dec 23 07:47:20 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 07:47:20 musical-fidelity volumio[10915]: info: sendMpdCommand status took 4 milliseconds Dec 23 07:47:20 musical-fidelity volumio[10915]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 23 07:47:20 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseState Dec 23 07:47:20 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 07:47:20 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseTrackInfo Dec 23 07:47:20 musical-fidelity volumio[10915]: info: ControllerMpd::pushState Dec 23 07:47:20 musical-fidelity volumio[10915]: info: CoreCommandRouter::servicePushState Dec 23 07:47:20 musical-fidelity volumio[10915]: verbose: In UPNP mode Dec 23 07:47:20 musical-fidelity volumio[10915]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":271,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"400 Kbps","isStreaming":false,"title":"给自己的情书","artist":"陈洁丽","album":"爱的歌","uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEidmYmE5ZDliMDVkZjc5YWM4MzY5N2E2MzY0YjFmZTY1ZV82MS5tcDQ/0.flac?token=1766479572~YzkxNDUxYzcxNjE3Mjg5ZGNlYzkyYThjNDk5NTAzZWMxNmNmNGNhZQ==","trackType":"tidal"} Dec 23 07:47:20 musical-fidelity volumio[10915]: verbose: CURRENT POSITION 0 Dec 23 07:47:20 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState stateService play Dec 23 07:47:20 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState currentStatus stop Dec 23 07:47:20 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:47:20 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:47:20 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:47:20 musical-fidelity volumio[10915]: info: ------------------------------ 30ms Dec 23 07:47:20 musical-fidelity volumio[10915]: info: sendMpdCommand playlistinfo took 15 milliseconds Dec 23 07:47:20 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseTrackInfo Dec 23 07:47:20 musical-fidelity volumio[10915]: info: ControllerMpd::pushState Dec 23 07:47:20 musical-fidelity volumio[10915]: info: CoreCommandRouter::servicePushState Dec 23 07:47:20 musical-fidelity volumio[10915]: verbose: In UPNP mode Dec 23 07:47:20 musical-fidelity volumio[10915]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":271,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"400 Kbps","isStreaming":false,"title":"给自己的情书","artist":"陈洁丽","album":"爱的歌","uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEidmYmE5ZDliMDVkZjc5YWM4MzY5N2E2MzY0YjFmZTY1ZV82MS5tcDQ/0.flac?token=1766479572~YzkxNDUxYzcxNjE3Mjg5ZGNlYzkyYThjNDk5NTAzZWMxNmNmNGNhZQ==","trackType":"tidal"} Dec 23 07:47:20 musical-fidelity volumio[10915]: verbose: CURRENT POSITION 0 Dec 23 07:47:20 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState stateService play Dec 23 07:47:20 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState currentStatus play Dec 23 07:47:20 musical-fidelity volumio[10915]: info: Received an update from plugin. extracting info from payload Dec 23 07:47:20 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 23 07:47:20 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:47:20 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:47:20 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:47:20 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:47:20 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:47:20 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:47:20 musical-fidelity volumio[10915]: info: ------------------------------ 51ms Dec 23 07:47:20 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:47:20 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:47:20 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:47:21 musical-fidelity volumio[10915]: info: Clearing queue after UPNP request Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CoreStateMachine::ClearQueue Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CoreStateMachine::stop Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 23 07:47:21 musical-fidelity volumio[10915]: verbose: UNSET VOLATILE Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CoreStateMachine::stPlaybackTimer Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CoreStateMachine::updateTrackBlock Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrackBlock Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrack 0 Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CoreStateMachine::serviceStop Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrack 0 Dec 23 07:47:21 musical-fidelity volumio[10915]: info: ControllerMpd::stop Dec 23 07:47:21 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand stop Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CorePlayQueue::clearPlayQueue Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CorePlayQueue::saveQueue Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushQueue Dec 23 07:47:21 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:47:21 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:47:21 musical-fidelity volumio[10915]: info: Dec 23 07:47:21 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:47:21 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:47:21 musical-fidelity volumio[10915]: info: Dec 23 07:47:21 musical-fidelity volumio[10915]: ---------------------------- MPD announces state update: player Dec 23 07:47:21 musical-fidelity volumio[10915]: info: ControllerMpd::getState Dec 23 07:47:21 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand status Dec 23 07:47:21 musical-fidelity volumio[10915]: info: sendMpdCommand stop took 74 milliseconds Dec 23 07:47:21 musical-fidelity volumio[10915]: info: Starting UPNP Playback Dec 23 07:47:21 musical-fidelity volumio[10915]: info: Preparing playback through UPNP Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioGetState Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrack 0 Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 23 07:47:21 musical-fidelity volumio[10915]: error: updateQueue error: null Dec 23 07:47:21 musical-fidelity volumio[10915]: info: ------------------------------ 6ms Dec 23 07:47:21 musical-fidelity volumio[10915]: info: sendMpdCommand status took 4 milliseconds Dec 23 07:47:21 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseState Dec 23 07:47:21 musical-fidelity volumio[10915]: info: ControllerMpd::pushState Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CoreCommandRouter::servicePushState Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CorePlayQueue::getTrack 0 Dec 23 07:47:21 musical-fidelity volumio[10915]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 23 07:47:21 musical-fidelity volumio[10915]: verbose: CURRENT POSITION 0 Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState stateService stop Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState currentStatus stop Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:47:21 musical-fidelity volumio[10915]: info: No code Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:47:21 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:47:21 musical-fidelity volumio[10915]: info: ------------------------------ 63ms Dec 23 07:47:21 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:47:21 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:47:21 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:47:22 musical-fidelity volumio[10915]: info: Dec 23 07:47:22 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:47:22 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:47:22 musical-fidelity volumio[10915]: info: ------------------------------ 2ms Dec 23 07:47:22 musical-fidelity volumio[10915]: info: Dec 23 07:47:22 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:47:22 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:47:22 musical-fidelity volumio[10915]: info: ------------------------------ 2ms Dec 23 07:47:22 musical-fidelity volumio[10915]: info: Dec 23 07:47:22 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:47:22 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:47:22 musical-fidelity volumio[10915]: info: ------------------------------ 3ms Dec 23 07:47:22 musical-fidelity volumio[10915]: info: Dec 23 07:47:22 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:47:22 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:47:22 musical-fidelity volumio[10915]: info: ------------------------------ 2ms Dec 23 07:47:22 musical-fidelity volumio[10915]: info: Dec 23 07:47:22 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:47:22 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:47:22 musical-fidelity volumio[10915]: info: ------------------------------ 3ms Dec 23 07:47:22 musical-fidelity volumio[10915]: info: Dec 23 07:47:22 musical-fidelity volumio[10915]: ---------------------------- MPD announces system playlist update Dec 23 07:47:22 musical-fidelity volumio[10915]: info: Ignoring MPD Status Update Dec 23 07:47:22 musical-fidelity volumio[10915]: info: ------------------------------ 2ms Dec 23 07:47:22 musical-fidelity volumio[10915]: info: Dec 23 07:47:22 musical-fidelity volumio[10915]: ---------------------------- MPD announces state update: player Dec 23 07:47:22 musical-fidelity volumio[10915]: info: ControllerMpd::getState Dec 23 07:47:22 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand status Dec 23 07:47:22 musical-fidelity volumio[10915]: info: Dec 23 07:47:22 musical-fidelity volumio[10915]: ---------------------------- MPD announces state update: player Dec 23 07:47:22 musical-fidelity volumio[10915]: info: ControllerMpd::getState Dec 23 07:47:22 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand status Dec 23 07:47:22 musical-fidelity volumio[10915]: info: sendMpdCommand status took 3 milliseconds Dec 23 07:47:22 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseState Dec 23 07:47:22 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 07:47:22 musical-fidelity volumio[10915]: info: sendMpdCommand status took 18 milliseconds Dec 23 07:47:22 musical-fidelity volumio[10915]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 23 07:47:22 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseState Dec 23 07:47:22 musical-fidelity volumio[10915]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 23 07:47:22 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseTrackInfo Dec 23 07:47:22 musical-fidelity volumio[10915]: info: ControllerMpd::pushState Dec 23 07:47:22 musical-fidelity volumio[10915]: info: CoreCommandRouter::servicePushState Dec 23 07:47:22 musical-fidelity volumio[10915]: verbose: In UPNP mode Dec 23 07:47:22 musical-fidelity volumio[10915]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":224,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"311 Kbps","isStreaming":false,"title":"遇见","artist":"陈洁丽","album":"爱的歌","uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEicyMDUyOTRkMDdjOTM4MTEyM2NiOWFlYjk3MzIzZGFiYV82MS5tcDQ/0.flac?token=1766479583~M2E4MWQ5NGMxOTExYTVmYzFkM2U5YzM2Y2YwMTI5ZjczOTIyMGNhYQ==","trackType":"tidal"} Dec 23 07:47:22 musical-fidelity volumio[10915]: verbose: CURRENT POSITION 0 Dec 23 07:47:22 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState stateService play Dec 23 07:47:22 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState currentStatus stop Dec 23 07:47:22 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:47:22 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:47:22 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:47:22 musical-fidelity volumio[10915]: info: ------------------------------ 42ms Dec 23 07:47:22 musical-fidelity volumio[10915]: info: sendMpdCommand playlistinfo took 21 milliseconds Dec 23 07:47:22 musical-fidelity volumio[10915]: verbose: ControllerMpd::parseTrackInfo Dec 23 07:47:22 musical-fidelity volumio[10915]: info: ControllerMpd::pushState Dec 23 07:47:22 musical-fidelity volumio[10915]: info: CoreCommandRouter::servicePushState Dec 23 07:47:22 musical-fidelity volumio[10915]: verbose: In UPNP mode Dec 23 07:47:22 musical-fidelity volumio[10915]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":224,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"317 Kbps","isStreaming":false,"title":"遇见","artist":"陈洁丽","album":"爱的歌","uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEicyMDUyOTRkMDdjOTM4MTEyM2NiOWFlYjk3MzIzZGFiYV82MS5tcDQ/0.flac?token=1766479583~M2E4MWQ5NGMxOTExYTVmYzFkM2U5YzM2Y2YwMTI5ZjczOTIyMGNhYQ==","trackType":"tidal"} Dec 23 07:47:22 musical-fidelity volumio[10915]: verbose: CURRENT POSITION 0 Dec 23 07:47:22 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState stateService play Dec 23 07:47:22 musical-fidelity volumio[10915]: info: CoreStateMachine::syncState currentStatus play Dec 23 07:47:22 musical-fidelity volumio[10915]: info: Received an update from plugin. extracting info from payload Dec 23 07:47:22 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 23 07:47:22 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:47:22 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:47:22 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:47:22 musical-fidelity volumio[10915]: info: CoreStateMachine::pushState Dec 23 07:47:22 musical-fidelity volumio[10915]: info: CoreCommandRouter::volumioPushState Dec 23 07:47:22 musical-fidelity volumio[10915]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 23 07:47:22 musical-fidelity volumio[10915]: info: ------------------------------ 72ms Dec 23 07:47:22 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:47:22 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:47:22 musical-fidelity volumio[10915]: info: Updating RAAT Signal Path Dec 23 07:47:24 musical-fidelity volumio[10915]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 23 07:47:24 musical-fidelity volumio[10915]: { Error: connect ETIMEDOUT 157.240.1.33:443 Dec 23 07:47:24 musical-fidelity volumio[10915]: at Object._errnoException (util.js:1022:11) Dec 23 07:47:24 musical-fidelity volumio[10915]: at _exceptionWithHostPort (util.js:1044:20) Dec 23 07:47:24 musical-fidelity volumio[10915]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Dec 23 07:47:24 musical-fidelity volumio[10915]: code: 'ETIMEDOUT', Dec 23 07:47:24 musical-fidelity volumio[10915]: errno: 'ETIMEDOUT', Dec 23 07:47:24 musical-fidelity volumio[10915]: syscall: 'connect', Dec 23 07:47:24 musical-fidelity volumio[10915]: address: '157.240.1.33', Dec 23 07:47:24 musical-fidelity volumio[10915]: port: 443 } Dec 23 07:47:24 musical-fidelity volumio[10915]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 23 07:47:25 musical-fidelity sudo[32366]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-23 07:46 Dec 23 07:47:25 musical-fidelity sudo[32366]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="6d9442f761618503268d0366db805a252514dec1" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="mf" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Jul 13 16:55:24 CEST 2022" VOLUMIO_VERSION="1.079" VOLUMIO_HARDWARE="pi" VOLUMIO_VENDOR="Musical Fidelity" VOLUMIO_MODEL="MX-Stream" VOLUMIO_VENDOR_MODEL="Musical Fidelity MX-Stream" VOLUMIO_HASH="feef4003d1cbcf074f611a1d9cb9a86e"