-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sat 2024-03-30 09:59:48 CET. -- Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreCommandRouter::volumioNext Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreStateMachine::next Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreStateMachine::stop Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreStateMachine::stPlaybackTimer Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreStateMachine::updateTrackBlock Mar 30 09:58:47 volumiostudio volumio[713]: info: CorePlayQueue::getTrackBlock Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:47 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 1 Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreStateMachine::serviceStop Mar 30 09:58:47 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 1 Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreCommandRouter::serviceStop Mar 30 09:58:47 volumiostudio volumio[713]: info: ControllerMpd::stop Mar 30 09:58:47 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand stop Mar 30 09:58:47 volumiostudio volumio[713]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 30 09:58:47 volumiostudio volumio[713]: info: sendMpdCommand stop took 276 milliseconds Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreStateMachine::play index undefined Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 30 09:58:47 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 2 Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreStateMachine::startPlaybackTimer Mar 30 09:58:47 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 2 Mar 30 09:58:47 volumiostudio volumio[713]: verbose: ControllerMpd::clearAddPlayTracks NAS/NasMyHome/Best Audiophile Voices/(03) Alison Krauss_It Wouldnt Have Made a Difference.ape Mar 30 09:58:47 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand stop Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreStateMachine::updateTrackBlock Mar 30 09:58:47 volumiostudio volumio[713]: info: CorePlayQueue::getTrackBlock Mar 30 09:58:47 volumiostudio volumio[713]: info: Mar 30 09:58:47 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:47 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:47 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:47 volumiostudio volumio[713]: info: sendMpdCommand stop took 3 milliseconds Mar 30 09:58:47 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand clear Mar 30 09:58:47 volumiostudio volumio[713]: info: Mar 30 09:58:47 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:47 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:47 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:47 volumiostudio volumio[713]: info: Mar 30 09:58:47 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:47 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:47 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:47 volumiostudio volumio[713]: info: Mar 30 09:58:47 volumiostudio volumio[713]: ---------------------------- MPD announces system playlist update Mar 30 09:58:47 volumiostudio volumio[713]: info: Ignoring MPD Status Update Mar 30 09:58:47 volumiostudio volumio[713]: info: sendMpdCommand status took 6 milliseconds Mar 30 09:58:47 volumiostudio volumio[713]: info: sendMpdCommand clear took 6 milliseconds Mar 30 09:58:47 volumiostudio volumio[713]: info: sendMpdCommand status took 4 milliseconds Mar 30 09:58:47 volumiostudio volumio[713]: info: sendMpdCommand status took 3 milliseconds Mar 30 09:58:47 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:47 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:47 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand add "NAS/NasMyHome/Best Audiophile Voices/(03) Alison Krauss_It Wouldnt Have Made a Difference.ape" Mar 30 09:58:47 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:47 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:47 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:47 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 2 Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:47 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 2 Mar 30 09:58:47 volumiostudio volumio[713]: 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} Mar 30 09:58:47 volumiostudio volumio[713]: verbose: CURRENT POSITION 2 Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService stop Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus stop Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:47 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 2 Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:47 volumiostudio volumio[713]: info: No code Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:47 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 2 Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:47 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:47 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 2 Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:47 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 2 Mar 30 09:58:47 volumiostudio volumio[713]: 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} Mar 30 09:58:47 volumiostudio volumio[713]: verbose: CURRENT POSITION 2 Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService stop Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus stop Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:47 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 2 Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:47 volumiostudio volumio[713]: info: No code Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:47 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 2 Mar 30 09:58:47 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:47 volumiostudio volumio[713]: info: ------------------------------ 54ms Mar 30 09:58:47 volumiostudio volumio[713]: info: ------------------------------ 54ms Mar 30 09:58:47 volumiostudio volumio[713]: info: Mar 30 09:58:47 volumiostudio volumio[713]: ---------------------------- MPD announces system playlist update Mar 30 09:58:47 volumiostudio volumio[713]: info: Ignoring MPD Status Update Mar 30 09:58:47 volumiostudio volumio[713]: info: Mar 30 09:58:47 volumiostudio volumio[713]: ---------------------------- MPD announces system playlist update Mar 30 09:58:47 volumiostudio volumio[713]: info: Ignoring MPD Status Update Mar 30 09:58:47 volumiostudio volumio[713]: error: updateQueue error: null Mar 30 09:58:47 volumiostudio volumio[713]: info: Mar 30 09:58:47 volumiostudio volumio[713]: ---------------------------- MPD announces system playlist update Mar 30 09:58:47 volumiostudio volumio[713]: info: Ignoring MPD Status Update Mar 30 09:58:47 volumiostudio volumio[713]: info: ------------------------------ 84ms Mar 30 09:58:47 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 83 milliseconds Mar 30 09:58:47 volumiostudio volumio[713]: info: sendMpdCommand add "NAS/NasMyHome/Best Audiophile Voices/(03) Alison Krauss_It Wouldnt Have Made a Difference.ape" took 82 milliseconds Mar 30 09:58:47 volumiostudio volumio[713]: info: ------------------------------ 33ms Mar 30 09:58:47 volumiostudio volumio[713]: info: ------------------------------ 32ms Mar 30 09:58:47 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:47 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand play Mar 30 09:58:47 volumiostudio volumio[713]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 30 09:58:47 volumiostudio volumio[713]: info: ------------------------------ 148ms Mar 30 09:58:47 volumiostudio volumio[713]: info: Mar 30 09:58:47 volumiostudio volumio[713]: ---------------------------- MPD announces system playlist update Mar 30 09:58:47 volumiostudio volumio[713]: info: Ignoring MPD Status Update Mar 30 09:58:47 volumiostudio volumio[713]: info: Mar 30 09:58:47 volumiostudio volumio[713]: ---------------------------- MPD announces system playlist update Mar 30 09:58:47 volumiostudio volumio[713]: info: Ignoring MPD Status Update Mar 30 09:58:47 volumiostudio volumio[713]: info: ------------------------------ 110ms Mar 30 09:58:47 volumiostudio volumio[713]: info: sendMpdCommand play took 29 milliseconds Mar 30 09:58:47 volumiostudio volumio[713]: info: ------------------------------ 27ms Mar 30 09:58:47 volumiostudio volumio[713]: info: ------------------------------ 26ms Mar 30 09:58:47 volumiostudio volumio[713]: info: Mar 30 09:58:47 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:47 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:47 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:47 volumiostudio volumio[713]: info: Mar 30 09:58:47 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:47 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:47 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:47 volumiostudio volumio[713]: info: Mar 30 09:58:47 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:47 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:47 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:48 volumiostudio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Mar 30 09:58:48 volumiostudio volumio[713]: info: Mar 30 09:58:48 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:48 volumiostudio volumio[713]: info: sendMpdCommand status took 87 milliseconds Mar 30 09:58:48 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:48 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:48 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:48 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:48 volumiostudio volumio[713]: info: sendMpdCommand status took 90 milliseconds Mar 30 09:58:48 volumiostudio volumio[713]: info: sendMpdCommand status took 87 milliseconds Mar 30 09:58:48 volumiostudio volumio[713]: info: sendMpdCommand status took 4 milliseconds Mar 30 09:58:48 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 30 09:58:48 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:48 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:48 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:48 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:48 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:48 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:48 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:48 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:48 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 2 Mar 30 09:58:48 volumiostudio volumio[713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Alison Krauss / It Wouldn't Have Made Any Difference","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(03) Alison Krauss_It Wouldnt Have Made a Difference.ape","trackType":"ape"} Mar 30 09:58:48 volumiostudio volumio[713]: verbose: CURRENT POSITION 2 Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService play Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus stop Mar 30 09:58:48 volumiostudio volumio[713]: info: ------------------------------ 108ms Mar 30 09:58:48 volumiostudio volumio[713]: info: Mar 30 09:58:48 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:48 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:48 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:48 volumiostudio volumio[713]: info: Mar 30 09:58:48 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:48 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:48 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:48 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 18 milliseconds Mar 30 09:58:48 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 17 milliseconds Mar 30 09:58:48 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 17 milliseconds Mar 30 09:58:48 volumiostudio volumio[713]: info: sendMpdCommand status took 4 milliseconds Mar 30 09:58:48 volumiostudio volumio[713]: info: sendMpdCommand status took 3 milliseconds Mar 30 09:58:48 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:48 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:48 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:48 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:48 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:48 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:48 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:48 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:48 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 2 Mar 30 09:58:48 volumiostudio volumio[713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Alison Krauss / It Wouldn't Have Made Any Difference","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(03) Alison Krauss_It Wouldnt Have Made a Difference.ape","trackType":"ape"} Mar 30 09:58:48 volumiostudio volumio[713]: verbose: CURRENT POSITION 2 Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService play Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus play Mar 30 09:58:48 volumiostudio volumio[713]: info: Received an update from plugin. extracting info from payload Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:48 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 2 Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:48 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 2 Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:48 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:48 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 2 Mar 30 09:58:48 volumiostudio volumio[713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":480,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Alison Krauss / It Wouldn't Have Made Any Difference","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(03) Alison Krauss_It Wouldnt Have Made a Difference.ape","trackType":"ape"} Mar 30 09:58:48 volumiostudio volumio[713]: verbose: CURRENT POSITION 2 Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService play Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus play Mar 30 09:58:48 volumiostudio volumio[713]: info: Received an update from plugin. extracting info from payload Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:48 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 2 Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:48 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 2 Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:48 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:48 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 2 Mar 30 09:58:48 volumiostudio volumio[713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Alison Krauss / It Wouldn't Have Made Any Difference","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(03) Alison Krauss_It Wouldnt Have Made a Difference.ape","trackType":"ape"} Mar 30 09:58:48 volumiostudio volumio[713]: verbose: CURRENT POSITION 2 Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService play Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus play Mar 30 09:58:48 volumiostudio volumio[713]: info: Received an update from plugin. extracting info from payload Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:48 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 2 Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:48 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 2 Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:48 volumiostudio volumio[713]: info: ------------------------------ 166ms Mar 30 09:58:48 volumiostudio volumio[713]: info: ------------------------------ 165ms Mar 30 09:58:48 volumiostudio volumio[713]: info: ------------------------------ 131ms Mar 30 09:58:48 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 131 milliseconds Mar 30 09:58:48 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 131 milliseconds Mar 30 09:58:48 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:48 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:48 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:48 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 2 Mar 30 09:58:48 volumiostudio volumio[713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Alison Krauss / It Wouldn't Have Made Any Difference","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(03) Alison Krauss_It Wouldnt Have Made a Difference.ape","trackType":"ape"} Mar 30 09:58:48 volumiostudio volumio[713]: verbose: CURRENT POSITION 2 Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService play Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus play Mar 30 09:58:48 volumiostudio volumio[713]: info: Received an update from plugin. extracting info from payload Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:48 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 2 Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:48 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 2 Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:48 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:48 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 2 Mar 30 09:58:48 volumiostudio volumio[713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Alison Krauss / It Wouldn't Have Made Any Difference","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(03) Alison Krauss_It Wouldnt Have Made a Difference.ape","trackType":"ape"} Mar 30 09:58:48 volumiostudio volumio[713]: verbose: CURRENT POSITION 2 Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService play Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus play Mar 30 09:58:48 volumiostudio volumio[713]: info: Received an update from plugin. extracting info from payload Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:48 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 2 Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:48 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 2 Mar 30 09:58:48 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:48 volumiostudio volumio[713]: info: ------------------------------ 189ms Mar 30 09:58:48 volumiostudio volumio[713]: info: ------------------------------ 190ms Mar 30 09:58:48 volumiostudio volumio[713]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 30 09:58:51 volumiostudio volumio[713]: info: CoreCommandRouter::volumioNext Mar 30 09:58:51 volumiostudio volumio[713]: info: CoreStateMachine::next Mar 30 09:58:51 volumiostudio volumio[713]: info: CoreStateMachine::stop Mar 30 09:58:51 volumiostudio volumio[713]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 30 09:58:51 volumiostudio volumio[713]: info: CoreStateMachine::stPlaybackTimer Mar 30 09:58:51 volumiostudio volumio[713]: info: CoreStateMachine::updateTrackBlock Mar 30 09:58:51 volumiostudio volumio[713]: info: CorePlayQueue::getTrackBlock Mar 30 09:58:51 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:51 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 2 Mar 30 09:58:51 volumiostudio volumio[713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 09:58:51 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:51 volumiostudio volumio[713]: info: CoreStateMachine::serviceStop Mar 30 09:58:51 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 2 Mar 30 09:58:51 volumiostudio volumio[713]: info: CoreCommandRouter::serviceStop Mar 30 09:58:51 volumiostudio volumio[713]: info: ControllerMpd::stop Mar 30 09:58:51 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand stop Mar 30 09:58:51 volumiostudio volumio[713]: info: Mar 30 09:58:51 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:51 volumiostudio volumio[713]: info: sendMpdCommand stop took 43 milliseconds Mar 30 09:58:51 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:51 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:51 volumiostudio volumio[713]: info: CoreStateMachine::play index undefined Mar 30 09:58:51 volumiostudio volumio[713]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 30 09:58:51 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 3 Mar 30 09:58:51 volumiostudio volumio[713]: info: CoreStateMachine::startPlaybackTimer Mar 30 09:58:51 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 3 Mar 30 09:58:51 volumiostudio volumio[713]: verbose: ControllerMpd::clearAddPlayTracks NAS/NasMyHome/Best Audiophile Voices/(04) Stacey Kent and Jim Tomlinson_So Nice.ape Mar 30 09:58:51 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand stop Mar 30 09:58:51 volumiostudio volumio[713]: info: CoreStateMachine::updateTrackBlock Mar 30 09:58:51 volumiostudio volumio[713]: info: CorePlayQueue::getTrackBlock Mar 30 09:58:51 volumiostudio volumio[713]: info: Mar 30 09:58:51 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:52 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:52 volumiostudio volumio[713]: info: Mar 30 09:58:52 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:52 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:52 volumiostudio volumio[713]: info: sendMpdCommand status took 14 milliseconds Mar 30 09:58:52 volumiostudio volumio[713]: info: sendMpdCommand stop took 11 milliseconds Mar 30 09:58:52 volumiostudio volumio[713]: info: sendMpdCommand status took 5 milliseconds Mar 30 09:58:52 volumiostudio volumio[713]: info: sendMpdCommand status took 3 milliseconds Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand clear Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:52 volumiostudio volumio[713]: info: Mar 30 09:58:52 volumiostudio volumio[713]: ---------------------------- MPD announces system playlist update Mar 30 09:58:52 volumiostudio volumio[713]: info: Ignoring MPD Status Update Mar 30 09:58:52 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 30 09:58:52 volumiostudio volumio[713]: info: sendMpdCommand clear took 7 milliseconds Mar 30 09:58:52 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 30 09:58:52 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand add "NAS/NasMyHome/Best Audiophile Voices/(04) Stacey Kent and Jim Tomlinson_So Nice.ape" Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:52 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 3 Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 3 Mar 30 09:58:52 volumiostudio volumio[713]: 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":"Alison Krauss / It Wouldn't Have Made Any Difference","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(03) Alison Krauss_It Wouldnt Have Made a Difference.ape","trackType":"ape"} Mar 30 09:58:52 volumiostudio volumio[713]: verbose: CURRENT POSITION 3 Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService stop Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus stop Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 3 Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:52 volumiostudio volumio[713]: info: No code Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 3 Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:52 volumiostudio volumio[713]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 30 09:58:52 volumiostudio volumio[713]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 30 09:58:52 volumiostudio volumio[713]: info: ------------------------------ 60ms Mar 30 09:58:52 volumiostudio volumio[713]: info: ------------------------------ 50ms Mar 30 09:58:52 volumiostudio volumio[713]: info: ------------------------------ 47ms Mar 30 09:58:52 volumiostudio volumio[713]: info: Mar 30 09:58:52 volumiostudio volumio[713]: ---------------------------- MPD announces system playlist update Mar 30 09:58:52 volumiostudio volumio[713]: info: Ignoring MPD Status Update Mar 30 09:58:52 volumiostudio volumio[713]: info: Mar 30 09:58:52 volumiostudio volumio[713]: ---------------------------- MPD announces system playlist update Mar 30 09:58:52 volumiostudio volumio[713]: info: Ignoring MPD Status Update Mar 30 09:58:52 volumiostudio volumio[713]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 30 09:58:52 volumiostudio volumio[713]: error: updateQueue error: null Mar 30 09:58:52 volumiostudio volumio[713]: info: Mar 30 09:58:52 volumiostudio volumio[713]: ---------------------------- MPD announces system playlist update Mar 30 09:58:52 volumiostudio volumio[713]: info: Ignoring MPD Status Update Mar 30 09:58:52 volumiostudio volumio[713]: info: ------------------------------ 44ms Mar 30 09:58:52 volumiostudio volumio[713]: info: sendMpdCommand add "NAS/NasMyHome/Best Audiophile Voices/(04) Stacey Kent and Jim Tomlinson_So Nice.ape" took 42 milliseconds Mar 30 09:58:52 volumiostudio volumio[713]: info: ------------------------------ 14ms Mar 30 09:58:52 volumiostudio volumio[713]: info: ------------------------------ 12ms Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand play Mar 30 09:58:52 volumiostudio volumio[713]: info: Mar 30 09:58:52 volumiostudio volumio[713]: ---------------------------- MPD announces system playlist update Mar 30 09:58:52 volumiostudio volumio[713]: info: Ignoring MPD Status Update Mar 30 09:58:52 volumiostudio volumio[713]: info: Mar 30 09:58:52 volumiostudio volumio[713]: ---------------------------- MPD announces system playlist update Mar 30 09:58:52 volumiostudio volumio[713]: info: Ignoring MPD Status Update Mar 30 09:58:52 volumiostudio volumio[713]: info: ------------------------------ 40ms Mar 30 09:58:52 volumiostudio volumio[713]: info: sendMpdCommand play took 36 milliseconds Mar 30 09:58:52 volumiostudio volumio[713]: info: ------------------------------ 36ms Mar 30 09:58:52 volumiostudio volumio[713]: info: ------------------------------ 36ms Mar 30 09:58:52 volumiostudio volumio[713]: info: Mar 30 09:58:52 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:52 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:52 volumiostudio volumio[713]: info: Mar 30 09:58:52 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:52 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:52 volumiostudio volumio[713]: info: Mar 30 09:58:52 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:52 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:52 volumiostudio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Mar 30 09:58:52 volumiostudio volumio[713]: info: sendMpdCommand status took 45 milliseconds Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:52 volumiostudio volumio[713]: info: Mar 30 09:58:52 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:52 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:52 volumiostudio volumio[713]: info: sendMpdCommand status took 46 milliseconds Mar 30 09:58:52 volumiostudio volumio[713]: info: sendMpdCommand status took 44 milliseconds Mar 30 09:58:52 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 10 milliseconds Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:52 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 3 Mar 30 09:58:52 volumiostudio volumio[713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":270,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Stacey Kent And Jim Tomlinson / So Nice","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(04) Stacey Kent and Jim Tomlinson_So Nice.ape","trackType":"ape"} Mar 30 09:58:52 volumiostudio volumio[713]: verbose: CURRENT POSITION 3 Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService play Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus stop Mar 30 09:58:52 volumiostudio volumio[713]: info: ------------------------------ 69ms Mar 30 09:58:52 volumiostudio volumio[713]: info: Mar 30 09:58:52 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:52 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:52 volumiostudio volumio[713]: info: Mar 30 09:58:52 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:52 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:52 volumiostudio volumio[713]: info: sendMpdCommand status took 16 milliseconds Mar 30 09:58:52 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 10 milliseconds Mar 30 09:58:52 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 30 09:58:52 volumiostudio volumio[713]: info: sendMpdCommand status took 3 milliseconds Mar 30 09:58:52 volumiostudio volumio[713]: info: sendMpdCommand status took 3 milliseconds Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:52 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 3 Mar 30 09:58:52 volumiostudio volumio[713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":270,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Stacey Kent And Jim Tomlinson / So Nice","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(04) Stacey Kent and Jim Tomlinson_So Nice.ape","trackType":"ape"} Mar 30 09:58:52 volumiostudio volumio[713]: verbose: CURRENT POSITION 3 Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService play Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus play Mar 30 09:58:52 volumiostudio volumio[713]: info: Received an update from plugin. extracting info from payload Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 3 Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 3 Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:52 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 3 Mar 30 09:58:52 volumiostudio volumio[713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":91,"duration":270,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Stacey Kent And Jim Tomlinson / So Nice","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(04) Stacey Kent and Jim Tomlinson_So Nice.ape","trackType":"ape"} Mar 30 09:58:52 volumiostudio volumio[713]: verbose: CURRENT POSITION 3 Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService play Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus play Mar 30 09:58:52 volumiostudio volumio[713]: info: Received an update from plugin. extracting info from payload Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 3 Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 3 Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:52 volumiostudio volumio[713]: info: ------------------------------ 133ms Mar 30 09:58:52 volumiostudio volumio[713]: info: ------------------------------ 132ms Mar 30 09:58:52 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 74 milliseconds Mar 30 09:58:52 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 75 milliseconds Mar 30 09:58:52 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 74 milliseconds Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:52 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:52 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 3 Mar 30 09:58:52 volumiostudio volumio[713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":270,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Stacey Kent And Jim Tomlinson / So Nice","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(04) Stacey Kent and Jim Tomlinson_So Nice.ape","trackType":"ape"} Mar 30 09:58:52 volumiostudio volumio[713]: verbose: CURRENT POSITION 3 Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService play Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus play Mar 30 09:58:52 volumiostudio volumio[713]: info: Received an update from plugin. extracting info from payload Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 3 Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 3 Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:52 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 3 Mar 30 09:58:52 volumiostudio volumio[713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":270,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Stacey Kent And Jim Tomlinson / So Nice","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(04) Stacey Kent and Jim Tomlinson_So Nice.ape","trackType":"ape"} Mar 30 09:58:52 volumiostudio volumio[713]: verbose: CURRENT POSITION 3 Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService play Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus play Mar 30 09:58:52 volumiostudio volumio[713]: info: Received an update from plugin. extracting info from payload Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 3 Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 3 Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:52 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 3 Mar 30 09:58:52 volumiostudio volumio[713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":270,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Stacey Kent And Jim Tomlinson / So Nice","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(04) Stacey Kent and Jim Tomlinson_So Nice.ape","trackType":"ape"} Mar 30 09:58:52 volumiostudio volumio[713]: verbose: CURRENT POSITION 3 Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService play Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus play Mar 30 09:58:52 volumiostudio volumio[713]: info: Received an update from plugin. extracting info from payload Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 3 Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:52 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 3 Mar 30 09:58:52 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:52 volumiostudio volumio[713]: info: ------------------------------ 240ms Mar 30 09:58:52 volumiostudio volumio[713]: info: ------------------------------ 224ms Mar 30 09:58:52 volumiostudio volumio[713]: info: ------------------------------ 224ms Mar 30 09:58:52 volumiostudio volumio[713]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreCommandRouter::volumioNext Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::next Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::stop Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::stPlaybackTimer Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::updateTrackBlock Mar 30 09:58:54 volumiostudio volumio[713]: info: CorePlayQueue::getTrackBlock Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 3 Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::serviceStop Mar 30 09:58:54 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 3 Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreCommandRouter::serviceStop Mar 30 09:58:54 volumiostudio volumio[713]: info: ControllerMpd::stop Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand stop Mar 30 09:58:54 volumiostudio volumio[713]: info: Mar 30 09:58:54 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:54 volumiostudio volumio[713]: info: sendMpdCommand stop took 34 milliseconds Mar 30 09:58:54 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::play index undefined Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 30 09:58:54 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 4 Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::startPlaybackTimer Mar 30 09:58:54 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 4 Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::clearAddPlayTracks NAS/NasMyHome/Best Audiophile Voices/(05) Carol Kidd_When I Dream.ape Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand stop Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::updateTrackBlock Mar 30 09:58:54 volumiostudio volumio[713]: info: CorePlayQueue::getTrackBlock Mar 30 09:58:54 volumiostudio volumio[713]: info: Mar 30 09:58:54 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:54 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:54 volumiostudio volumio[713]: info: Mar 30 09:58:54 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:54 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:54 volumiostudio volumio[713]: info: sendMpdCommand status took 14 milliseconds Mar 30 09:58:54 volumiostudio volumio[713]: info: sendMpdCommand stop took 11 milliseconds Mar 30 09:58:54 volumiostudio volumio[713]: info: sendMpdCommand status took 7 milliseconds Mar 30 09:58:54 volumiostudio volumio[713]: info: sendMpdCommand status took 4 milliseconds Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand clear Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:54 volumiostudio volumio[713]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 30 09:58:54 volumiostudio volumio[713]: info: Mar 30 09:58:54 volumiostudio volumio[713]: ---------------------------- MPD announces system playlist update Mar 30 09:58:54 volumiostudio volumio[713]: info: Ignoring MPD Status Update Mar 30 09:58:54 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 12 milliseconds Mar 30 09:58:54 volumiostudio volumio[713]: info: sendMpdCommand clear took 13 milliseconds Mar 30 09:58:54 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 11 milliseconds Mar 30 09:58:54 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 10 milliseconds Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand add "NAS/NasMyHome/Best Audiophile Voices/(05) Carol Kidd_When I Dream.ape" Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:54 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 4 Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 4 Mar 30 09:58:54 volumiostudio volumio[713]: 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":"Stacey Kent And Jim Tomlinson / So Nice","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(04) Stacey Kent and Jim Tomlinson_So Nice.ape","trackType":"ape"} Mar 30 09:58:54 volumiostudio volumio[713]: verbose: CURRENT POSITION 4 Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService stop Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus stop Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 4 Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:54 volumiostudio volumio[713]: info: No code Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 4 Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:54 volumiostudio volumio[713]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 30 09:58:54 volumiostudio volumio[713]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 30 09:58:54 volumiostudio volumio[713]: info: ------------------------------ 55ms Mar 30 09:58:54 volumiostudio volumio[713]: info: ------------------------------ 46ms Mar 30 09:58:54 volumiostudio volumio[713]: info: ------------------------------ 43ms Mar 30 09:58:54 volumiostudio volumio[713]: info: Mar 30 09:58:54 volumiostudio volumio[713]: ---------------------------- MPD announces system playlist update Mar 30 09:58:54 volumiostudio volumio[713]: info: Ignoring MPD Status Update Mar 30 09:58:54 volumiostudio volumio[713]: info: Mar 30 09:58:54 volumiostudio volumio[713]: ---------------------------- MPD announces system playlist update Mar 30 09:58:54 volumiostudio volumio[713]: info: Ignoring MPD Status Update Mar 30 09:58:54 volumiostudio volumio[713]: error: updateQueue error: null Mar 30 09:58:54 volumiostudio volumio[713]: info: Mar 30 09:58:54 volumiostudio volumio[713]: ---------------------------- MPD announces system playlist update Mar 30 09:58:54 volumiostudio volumio[713]: info: Ignoring MPD Status Update Mar 30 09:58:54 volumiostudio volumio[713]: info: ------------------------------ 40ms Mar 30 09:58:54 volumiostudio volumio[713]: info: sendMpdCommand add "NAS/NasMyHome/Best Audiophile Voices/(05) Carol Kidd_When I Dream.ape" took 33 milliseconds Mar 30 09:58:54 volumiostudio volumio[713]: info: ------------------------------ 8ms Mar 30 09:58:54 volumiostudio volumio[713]: info: ------------------------------ 7ms Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand play Mar 30 09:58:54 volumiostudio volumio[713]: info: Mar 30 09:58:54 volumiostudio volumio[713]: ---------------------------- MPD announces system playlist update Mar 30 09:58:54 volumiostudio volumio[713]: info: Ignoring MPD Status Update Mar 30 09:58:54 volumiostudio volumio[713]: info: Mar 30 09:58:54 volumiostudio volumio[713]: ---------------------------- MPD announces system playlist update Mar 30 09:58:54 volumiostudio volumio[713]: info: Ignoring MPD Status Update Mar 30 09:58:54 volumiostudio volumio[713]: info: ------------------------------ 41ms Mar 30 09:58:54 volumiostudio volumio[713]: info: sendMpdCommand play took 39 milliseconds Mar 30 09:58:54 volumiostudio volumio[713]: info: ------------------------------ 38ms Mar 30 09:58:54 volumiostudio volumio[713]: info: ------------------------------ 37ms Mar 30 09:58:54 volumiostudio volumio[713]: info: Mar 30 09:58:54 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:54 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:54 volumiostudio volumio[713]: info: Mar 30 09:58:54 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:54 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:54 volumiostudio volumio[713]: info: Mar 30 09:58:54 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:54 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:54 volumiostudio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Mar 30 09:58:54 volumiostudio volumio[713]: info: Mar 30 09:58:54 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:54 volumiostudio volumio[713]: info: sendMpdCommand status took 18 milliseconds Mar 30 09:58:54 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:54 volumiostudio volumio[713]: info: sendMpdCommand status took 28 milliseconds Mar 30 09:58:54 volumiostudio volumio[713]: info: sendMpdCommand status took 28 milliseconds Mar 30 09:58:54 volumiostudio volumio[713]: info: sendMpdCommand status took 5 milliseconds Mar 30 09:58:54 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:54 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 4 Mar 30 09:58:54 volumiostudio volumio[713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":270,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Carol Kidd / When I Dream","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(05) Carol Kidd_When I Dream.ape","trackType":"ape"} Mar 30 09:58:54 volumiostudio volumio[713]: verbose: CURRENT POSITION 4 Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService play Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus stop Mar 30 09:58:54 volumiostudio volumio[713]: info: ------------------------------ 44ms Mar 30 09:58:54 volumiostudio volumio[713]: info: Mar 30 09:58:54 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:54 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:54 volumiostudio volumio[713]: info: Mar 30 09:58:54 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:54 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:54 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 23 milliseconds Mar 30 09:58:54 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 22 milliseconds Mar 30 09:58:54 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 20 milliseconds Mar 30 09:58:54 volumiostudio volumio[713]: info: sendMpdCommand status took 7 milliseconds Mar 30 09:58:54 volumiostudio volumio[713]: info: sendMpdCommand status took 5 milliseconds Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:54 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 4 Mar 30 09:58:54 volumiostudio volumio[713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":270,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Carol Kidd / When I Dream","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(05) Carol Kidd_When I Dream.ape","trackType":"ape"} Mar 30 09:58:54 volumiostudio volumio[713]: verbose: CURRENT POSITION 4 Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService play Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus play Mar 30 09:58:54 volumiostudio volumio[713]: info: Received an update from plugin. extracting info from payload Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 4 Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 4 Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:54 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 4 Mar 30 09:58:54 volumiostudio volumio[713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":270,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Carol Kidd / When I Dream","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(05) Carol Kidd_When I Dream.ape","trackType":"ape"} Mar 30 09:58:54 volumiostudio volumio[713]: verbose: CURRENT POSITION 4 Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService play Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus play Mar 30 09:58:54 volumiostudio volumio[713]: info: Received an update from plugin. extracting info from payload Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 4 Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 4 Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:54 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 4 Mar 30 09:58:54 volumiostudio volumio[713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":270,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Carol Kidd / When I Dream","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(05) Carol Kidd_When I Dream.ape","trackType":"ape"} Mar 30 09:58:54 volumiostudio volumio[713]: verbose: CURRENT POSITION 4 Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService play Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus play Mar 30 09:58:54 volumiostudio volumio[713]: info: Received an update from plugin. extracting info from payload Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 4 Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 4 Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:54 volumiostudio volumio[713]: info: ------------------------------ 119ms Mar 30 09:58:54 volumiostudio volumio[713]: info: ------------------------------ 121ms Mar 30 09:58:54 volumiostudio volumio[713]: info: ------------------------------ 110ms Mar 30 09:58:54 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 62 milliseconds Mar 30 09:58:54 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 62 milliseconds Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:54 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:54 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 4 Mar 30 09:58:54 volumiostudio volumio[713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":270,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Carol Kidd / When I Dream","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(05) Carol Kidd_When I Dream.ape","trackType":"ape"} Mar 30 09:58:54 volumiostudio volumio[713]: verbose: CURRENT POSITION 4 Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService play Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus play Mar 30 09:58:54 volumiostudio volumio[713]: info: Received an update from plugin. extracting info from payload Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 4 Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 4 Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:54 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 4 Mar 30 09:58:54 volumiostudio volumio[713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":270,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Carol Kidd / When I Dream","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(05) Carol Kidd_When I Dream.ape","trackType":"ape"} Mar 30 09:58:54 volumiostudio volumio[713]: verbose: CURRENT POSITION 4 Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService play Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus play Mar 30 09:58:54 volumiostudio volumio[713]: info: Received an update from plugin. extracting info from payload Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 4 Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:54 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 4 Mar 30 09:58:54 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:54 volumiostudio volumio[713]: info: ------------------------------ 150ms Mar 30 09:58:54 volumiostudio volumio[713]: info: ------------------------------ 142ms Mar 30 09:58:55 volumiostudio volumio[713]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 30 09:58:57 volumiostudio volumio[713]: info: CoreCommandRouter::volumioNext Mar 30 09:58:57 volumiostudio volumio[713]: info: CoreStateMachine::next Mar 30 09:58:57 volumiostudio volumio[713]: info: CoreStateMachine::stop Mar 30 09:58:57 volumiostudio volumio[713]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 30 09:58:57 volumiostudio volumio[713]: info: CoreStateMachine::stPlaybackTimer Mar 30 09:58:57 volumiostudio volumio[713]: info: CoreStateMachine::updateTrackBlock Mar 30 09:58:57 volumiostudio volumio[713]: info: CorePlayQueue::getTrackBlock Mar 30 09:58:57 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:57 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 4 Mar 30 09:58:57 volumiostudio volumio[713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 09:58:57 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:57 volumiostudio volumio[713]: info: CoreStateMachine::serviceStop Mar 30 09:58:57 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 4 Mar 30 09:58:57 volumiostudio volumio[713]: info: CoreCommandRouter::serviceStop Mar 30 09:58:57 volumiostudio volumio[713]: info: ControllerMpd::stop Mar 30 09:58:57 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand stop Mar 30 09:58:57 volumiostudio volumio[713]: info: Mar 30 09:58:57 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:57 volumiostudio volumio[713]: info: sendMpdCommand stop took 33 milliseconds Mar 30 09:58:57 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:57 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:57 volumiostudio volumio[713]: info: CoreStateMachine::play index undefined Mar 30 09:58:57 volumiostudio volumio[713]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 30 09:58:57 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:58:57 volumiostudio volumio[713]: info: CoreStateMachine::startPlaybackTimer Mar 30 09:58:57 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:58:57 volumiostudio volumio[713]: verbose: ControllerMpd::clearAddPlayTracks NAS/NasMyHome/Best Audiophile Voices/(06) Jheena Lodwick_Perhaps Love.ape Mar 30 09:58:57 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand stop Mar 30 09:58:57 volumiostudio volumio[713]: info: CoreStateMachine::updateTrackBlock Mar 30 09:58:57 volumiostudio volumio[713]: info: CorePlayQueue::getTrackBlock Mar 30 09:58:57 volumiostudio volumio[713]: info: Mar 30 09:58:57 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:57 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:57 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:57 volumiostudio volumio[713]: info: Mar 30 09:58:57 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:57 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:57 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:57 volumiostudio volumio[713]: info: sendMpdCommand status took 12 milliseconds Mar 30 09:58:57 volumiostudio volumio[713]: info: sendMpdCommand stop took 8 milliseconds Mar 30 09:58:57 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:57 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:57 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand clear Mar 30 09:58:57 volumiostudio volumio[713]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 30 09:58:57 volumiostudio volumio[713]: info: Mar 30 09:58:57 volumiostudio volumio[713]: ---------------------------- MPD announces system playlist update Mar 30 09:58:57 volumiostudio volumio[713]: info: Ignoring MPD Status Update Mar 30 09:58:57 volumiostudio volumio[713]: info: sendMpdCommand status took 18 milliseconds Mar 30 09:58:57 volumiostudio volumio[713]: info: sendMpdCommand status took 16 milliseconds Mar 30 09:58:57 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 13 milliseconds Mar 30 09:58:57 volumiostudio volumio[713]: info: sendMpdCommand clear took 12 milliseconds Mar 30 09:58:57 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:57 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:57 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:57 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:57 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:57 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand add "NAS/NasMyHome/Best Audiophile Voices/(06) Jheena Lodwick_Perhaps Love.ape" Mar 30 09:58:57 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:57 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:57 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:57 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:58:57 volumiostudio volumio[713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 09:58:57 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:57 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:58:57 volumiostudio volumio[713]: 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":"Carol Kidd / When I Dream","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(05) Carol Kidd_When I Dream.ape","trackType":"ape"} Mar 30 09:58:57 volumiostudio volumio[713]: verbose: CURRENT POSITION 5 Mar 30 09:58:57 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService stop Mar 30 09:58:57 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus stop Mar 30 09:58:57 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:57 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:58:57 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:57 volumiostudio volumio[713]: info: No code Mar 30 09:58:57 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:57 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:58:57 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:57 volumiostudio volumio[713]: info: ------------------------------ 51ms Mar 30 09:58:57 volumiostudio volumio[713]: info: Mar 30 09:58:57 volumiostudio volumio[713]: ---------------------------- MPD announces system playlist update Mar 30 09:58:57 volumiostudio volumio[713]: info: Ignoring MPD Status Update Mar 30 09:58:57 volumiostudio volumio[713]: info: Mar 30 09:58:57 volumiostudio volumio[713]: ---------------------------- MPD announces system playlist update Mar 30 09:58:57 volumiostudio volumio[713]: info: Ignoring MPD Status Update Mar 30 09:58:57 volumiostudio volumio[713]: error: updateQueue error: null Mar 30 09:58:57 volumiostudio volumio[713]: info: Mar 30 09:58:57 volumiostudio volumio[713]: ---------------------------- MPD announces system playlist update Mar 30 09:58:57 volumiostudio volumio[713]: info: Ignoring MPD Status Update Mar 30 09:58:57 volumiostudio volumio[713]: info: ------------------------------ 37ms Mar 30 09:58:57 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 34 milliseconds Mar 30 09:58:57 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 35 milliseconds Mar 30 09:58:57 volumiostudio volumio[713]: info: sendMpdCommand add "NAS/NasMyHome/Best Audiophile Voices/(06) Jheena Lodwick_Perhaps Love.ape" took 36 milliseconds Mar 30 09:58:57 volumiostudio volumio[713]: info: ------------------------------ 15ms Mar 30 09:58:57 volumiostudio volumio[713]: info: ------------------------------ 14ms Mar 30 09:58:57 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:57 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand play Mar 30 09:58:57 volumiostudio volumio[713]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 30 09:58:57 volumiostudio volumio[713]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 30 09:58:57 volumiostudio volumio[713]: info: ------------------------------ 65ms Mar 30 09:58:57 volumiostudio volumio[713]: info: ------------------------------ 63ms Mar 30 09:58:57 volumiostudio volumio[713]: info: Mar 30 09:58:57 volumiostudio volumio[713]: ---------------------------- MPD announces system playlist update Mar 30 09:58:57 volumiostudio volumio[713]: info: Ignoring MPD Status Update Mar 30 09:58:57 volumiostudio volumio[713]: info: Mar 30 09:58:57 volumiostudio volumio[713]: ---------------------------- MPD announces system playlist update Mar 30 09:58:58 volumiostudio volumio[713]: info: Ignoring MPD Status Update Mar 30 09:58:58 volumiostudio volumio[713]: info: ------------------------------ 40ms Mar 30 09:58:58 volumiostudio volumio[713]: info: sendMpdCommand play took 32 milliseconds Mar 30 09:58:58 volumiostudio volumio[713]: info: ------------------------------ 26ms Mar 30 09:58:58 volumiostudio volumio[713]: info: ------------------------------ 23ms Mar 30 09:58:58 volumiostudio volumio[713]: info: Mar 30 09:58:58 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:58 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:58 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:58 volumiostudio volumio[713]: info: Mar 30 09:58:58 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:58 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:58 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:58 volumiostudio volumio[713]: info: Mar 30 09:58:58 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:58 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:58 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:58 volumiostudio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Mar 30 09:58:58 volumiostudio volumio[713]: info: sendMpdCommand status took 44 milliseconds Mar 30 09:58:58 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:58 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:58 volumiostudio volumio[713]: info: Mar 30 09:58:58 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:58 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:58 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:58 volumiostudio volumio[713]: info: sendMpdCommand status took 45 milliseconds Mar 30 09:58:58 volumiostudio volumio[713]: info: sendMpdCommand status took 42 milliseconds Mar 30 09:58:58 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:58 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:58 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:58 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:58 volumiostudio volumio[713]: info: Mar 30 09:58:58 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:58 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:58 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:58 volumiostudio volumio[713]: info: Mar 30 09:58:58 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:58:58 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:58:58 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:58:58 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 16 milliseconds Mar 30 09:58:58 volumiostudio volumio[713]: info: sendMpdCommand status took 15 milliseconds Mar 30 09:58:58 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 14 milliseconds Mar 30 09:58:58 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 14 milliseconds Mar 30 09:58:58 volumiostudio volumio[713]: info: sendMpdCommand status took 13 milliseconds Mar 30 09:58:58 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:58 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:58 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:58 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:58 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:58 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:58 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:58 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:58 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:58:58 volumiostudio volumio[713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":293,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Jheena Lodwick / Perhaps Love","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(06) Jheena Lodwick_Perhaps Love.ape","trackType":"ape"} Mar 30 09:58:58 volumiostudio volumio[713]: verbose: CURRENT POSITION 5 Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService play Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus stop Mar 30 09:58:58 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:58 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:58:58 volumiostudio volumio[713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":457,"duration":293,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Jheena Lodwick / Perhaps Love","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(06) Jheena Lodwick_Perhaps Love.ape","trackType":"ape"} Mar 30 09:58:58 volumiostudio volumio[713]: verbose: CURRENT POSITION 5 Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService play Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus play Mar 30 09:58:58 volumiostudio volumio[713]: info: Received an update from plugin. extracting info from payload Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:58 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:58 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:58 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:58 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:58:58 volumiostudio volumio[713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":293,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Jheena Lodwick / Perhaps Love","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(06) Jheena Lodwick_Perhaps Love.ape","trackType":"ape"} Mar 30 09:58:58 volumiostudio volumio[713]: verbose: CURRENT POSITION 5 Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService play Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus play Mar 30 09:58:58 volumiostudio volumio[713]: info: Received an update from plugin. extracting info from payload Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:58 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:58 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:58 volumiostudio volumio[713]: info: ------------------------------ 90ms Mar 30 09:58:58 volumiostudio volumio[713]: info: ------------------------------ 113ms Mar 30 09:58:58 volumiostudio volumio[713]: info: ------------------------------ 111ms Mar 30 09:58:58 volumiostudio volumio[713]: info: sendMpdCommand status took 63 milliseconds Mar 30 09:58:58 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 51 milliseconds Mar 30 09:58:58 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 49 milliseconds Mar 30 09:58:58 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:58:58 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:58:58 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:58 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:58 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:58 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:58:58 volumiostudio volumio[713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":293,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Jheena Lodwick / Perhaps Love","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(06) Jheena Lodwick_Perhaps Love.ape","trackType":"ape"} Mar 30 09:58:58 volumiostudio volumio[713]: verbose: CURRENT POSITION 5 Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService play Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus play Mar 30 09:58:58 volumiostudio volumio[713]: info: Received an update from plugin. extracting info from payload Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:58 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:58 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:58 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:58 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:58:58 volumiostudio volumio[713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":293,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Jheena Lodwick / Perhaps Love","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(06) Jheena Lodwick_Perhaps Love.ape","trackType":"ape"} Mar 30 09:58:58 volumiostudio volumio[713]: verbose: CURRENT POSITION 5 Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService play Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus play Mar 30 09:58:58 volumiostudio volumio[713]: info: Received an update from plugin. extracting info from payload Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:58 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:58 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:58 volumiostudio volumio[713]: info: ------------------------------ 121ms Mar 30 09:58:58 volumiostudio volumio[713]: info: ------------------------------ 116ms Mar 30 09:58:58 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 124 milliseconds Mar 30 09:58:58 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:58:58 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:58:58 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:58:58 volumiostudio volumio[713]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":293,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Jheena Lodwick / Perhaps Love","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(06) Jheena Lodwick_Perhaps Love.ape","trackType":"ape"} Mar 30 09:58:58 volumiostudio volumio[713]: verbose: CURRENT POSITION 5 Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService play Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus play Mar 30 09:58:58 volumiostudio volumio[713]: info: Received an update from plugin. extracting info from payload Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:58 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:58:58 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:58:58 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:58:58 volumiostudio volumio[713]: info: ------------------------------ 216ms Mar 30 09:58:58 volumiostudio volumio[713]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 30 09:59:42 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPause Mar 30 09:59:42 volumiostudio volumio[713]: info: CoreStateMachine::pause Mar 30 09:59:42 volumiostudio volumio[713]: info: CoreStateMachine::stPlaybackTimer Mar 30 09:59:42 volumiostudio volumio[713]: info: CoreStateMachine::servicePause Mar 30 09:59:42 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:59:42 volumiostudio volumio[713]: info: CoreCommandRouter::servicePause Mar 30 09:59:42 volumiostudio volumio[713]: info: ControllerMpd::pause Mar 30 09:59:42 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand pause Mar 30 09:59:42 volumiostudio volumio[713]: info: sendMpdCommand pause took 3 milliseconds Mar 30 09:59:42 volumiostudio volumio[713]: info: Mar 30 09:59:42 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:59:42 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:59:42 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:59:42 volumiostudio volumio[713]: info: Mar 30 09:59:42 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:59:42 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:59:42 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:59:42 volumiostudio volumio[713]: info: Mar 30 09:59:42 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:59:42 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:59:42 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:59:42 volumiostudio volumio[713]: info: sendMpdCommand status took 6 milliseconds Mar 30 09:59:42 volumiostudio volumio[713]: info: sendMpdCommand status took 4 milliseconds Mar 30 09:59:42 volumiostudio volumio[713]: info: sendMpdCommand status took 3 milliseconds Mar 30 09:59:42 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:59:42 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:59:42 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:59:42 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:59:42 volumiostudio volumio[713]: verbose: ControllerMpd::parseState Mar 30 09:59:42 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 30 09:59:42 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 30 09:59:42 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 30 09:59:42 volumiostudio volumio[713]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 30 09:59:42 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:59:42 volumiostudio volumio[713]: verbose: ControllerMpd::parseTrackInfo Mar 30 09:59:42 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:59:42 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:59:42 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:59:42 volumiostudio volumio[713]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":45096,"duration":293,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Jheena Lodwick / Perhaps Love","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(06) Jheena Lodwick_Perhaps Love.ape","trackType":"ape"} Mar 30 09:59:42 volumiostudio volumio[713]: verbose: CURRENT POSITION 5 Mar 30 09:59:42 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService pause Mar 30 09:59:42 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus pause Mar 30 09:59:42 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:59:42 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:59:42 volumiostudio volumio[713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 09:59:42 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:59:42 volumiostudio volumio[713]: info: CoreStateMachine::stPlaybackTimer Mar 30 09:59:42 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:59:42 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:59:42 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:59:42 volumiostudio volumio[713]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":45096,"duration":293,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Jheena Lodwick / Perhaps Love","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(06) Jheena Lodwick_Perhaps Love.ape","trackType":"ape"} Mar 30 09:59:42 volumiostudio volumio[713]: verbose: CURRENT POSITION 5 Mar 30 09:59:42 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService pause Mar 30 09:59:42 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus pause Mar 30 09:59:42 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:59:42 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:59:42 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:59:42 volumiostudio volumio[713]: info: CoreStateMachine::stPlaybackTimer Mar 30 09:59:42 volumiostudio volumio[713]: info: ControllerMpd::pushState Mar 30 09:59:42 volumiostudio volumio[713]: info: CoreCommandRouter::servicePushState Mar 30 09:59:42 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:59:42 volumiostudio volumio[713]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":45096,"duration":293,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Jheena Lodwick / Perhaps Love","artist":"Various","album":"Best Audiophile Voices","uri":"NAS/NasMyHome/Best Audiophile Voices/(06) Jheena Lodwick_Perhaps Love.ape","trackType":"ape"} Mar 30 09:59:42 volumiostudio volumio[713]: verbose: CURRENT POSITION 5 Mar 30 09:59:42 volumiostudio volumio[713]: info: CoreStateMachine::syncState stateService pause Mar 30 09:59:42 volumiostudio volumio[713]: info: CoreStateMachine::syncState currentStatus pause Mar 30 09:59:42 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:59:42 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:59:42 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:59:42 volumiostudio volumio[713]: info: CoreStateMachine::stPlaybackTimer Mar 30 09:59:42 volumiostudio volumio[713]: info: ------------------------------ 44ms Mar 30 09:59:42 volumiostudio volumio[713]: info: ------------------------------ 41ms Mar 30 09:59:42 volumiostudio volumio[713]: info: ------------------------------ 41ms Mar 30 09:59:42 volumiostudio volumio[713]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 30 09:59:46 volumiostudio volumio[713]: info: Preload queue cleared Mar 30 09:59:46 volumiostudio volumio[713]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 30 09:59:46 volumiostudio volumio[713]: info: CoreStateMachine::ClearQueue Mar 30 09:59:46 volumiostudio volumio[713]: info: CoreStateMachine::stop Mar 30 09:59:46 volumiostudio volumio[713]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 30 09:59:46 volumiostudio volumio[713]: info: CoreStateMachine::updateTrackBlock Mar 30 09:59:46 volumiostudio volumio[713]: info: CorePlayQueue::getTrackBlock Mar 30 09:59:46 volumiostudio volumio[713]: info: CoreStateMachine::stPlaybackTimer Mar 30 09:59:46 volumiostudio volumio[713]: info: CoreStateMachine::pushState Mar 30 09:59:46 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:59:46 volumiostudio volumio[713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 09:59:46 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushState Mar 30 09:59:46 volumiostudio volumio[713]: info: CoreStateMachine::serviceStop Mar 30 09:59:46 volumiostudio volumio[713]: info: CorePlayQueue::getTrack 5 Mar 30 09:59:46 volumiostudio volumio[713]: info: CoreCommandRouter::serviceStop Mar 30 09:59:46 volumiostudio volumio[713]: info: ControllerMpd::stop Mar 30 09:59:46 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand stop Mar 30 09:59:46 volumiostudio volumio[713]: info: CorePlayQueue::clearPlayQueue Mar 30 09:59:46 volumiostudio volumio[713]: info: CorePlayQueue::saveQueue Mar 30 09:59:46 volumiostudio volumio[713]: info: CoreCommandRouter::volumioPushQueue Mar 30 09:59:46 volumiostudio volumio[713]: info: CoreStateMachine::addQueueItems Mar 30 09:59:46 volumiostudio volumio[713]: info: CorePlayQueue::addQueueItems Mar 30 09:59:46 volumiostudio volumio[713]: info: Preload queue cleared Mar 30 09:59:46 volumiostudio volumio[713]: info: Adding Item to queue: music-library/NAS/NasMyHome/Bob Dylan - Desire MFSL (2013) Mar 30 09:59:46 volumiostudio volumio[713]: info: Exploding uri music-library/NAS/NasMyHome/Bob Dylan - Desire MFSL (2013) in service mpd Mar 30 09:59:46 volumiostudio volumio[713]: info: sendMpdCommand stop took 69 milliseconds Mar 30 09:59:46 volumiostudio volumio[713]: info: Mar 30 09:59:46 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:59:46 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:59:46 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:59:46 volumiostudio volumio[713]: info: Mar 30 09:59:46 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:59:46 volumiostudio volumio[713]: info: ControllerMpd::getState Mar 30 09:59:46 volumiostudio volumio[713]: verbose: ControllerMpd::sendMpdCommand status Mar 30 09:59:46 volumiostudio volumio[713]: info: Mar 30 09:59:46 volumiostudio volumio[713]: ---------------------------- MPD announces state update: player Mar 30 09:59:46 volumiostudio volumio[713]: info: ALBUMART /albumart?cacheid=774&web=Bob%20Dylan/Desire/extralarge&path=%2Fmnt%2FNAS%2FNasMyHome%2FBob%20Dylan%20-%20Desire%20MFSL%20(2013)%2F01%20Hurricane.flac&metadata=false Mar 30 09:59:46 volumiostudio volumio[713]: info: URI /mnt/NAS/NasMyHome/Bob Dylan - Desire MFSL (2013)/01 Hurricane.flac Mar 30 09:59:46 volumiostudio volumio[713]: info: ALBUMART /albumart?cacheid=774&web=Bob%20Dylan/Desire/extralarge&path=%2Fmnt%2FNAS%2FNasMyHome%2FBob%20Dylan%20-%20Desire%20MFSL%20(2013)%2F02%20Isis.flac&metadata=false Mar 30 09:59:46 volumiostudio volumio[713]: info: URI /mnt/NAS/NasMyHome/Bob Dylan - Desire MFSL (2013)/02 Isis.flac Mar 30 09:59:46 volumiostudio volumio[713]: info: ALBUMART /albumart?cacheid=774&web=Bob%20Dylan/Desire/extralarge&path=%2Fmnt%2FNAS%2FNasMyHome%2FBob%20Dylan%20-%20Desire%20MFSL%20(2013)%2F03%20Mozambique.flac&metadata=false Mar 30 09:59:46 volumiostudio volumio[713]: info: URI /mnt/NAS/NasMyHome/Bob Dylan - Desire MFSL (2013)/03 Mozambique.flac Mar 30 09:59:46 volumiostudio volumio[713]: info: ALBUMART /albumart?cacheid=774&web=Bob%20Dylan/Desire/extralarge&path=%2Fmnt%2FNAS%2FNasMyHome%2FBob%20Dylan%20-%20Desire%20MFSL%20(2013)%2F04%20One%20More%20Cup%20Of%20Coffee.flac&metadata=false Mar 30 09:59:46 volumiostudio volumio[713]: info: URI /mnt/NAS/NasMyHome/Bob Dylan - Desire MFSL (2013)/04 One More Cup Of Coffee.flac Mar 30 09:59:46 volumiostudio volumio[713]: info: ALBUMART /albumart?cacheid=774&web=Bob%20Dylan/Desire/extralarge&path=%2Fmnt%2FNAS%2FNasMyHome%2FBob%20Dylan%20-%20Desire%20MFSL%20(2013)%2F05%20Oh%2C%20Sister.flac&metadata=false Mar 30 09:59:46 volumiostudio volumio[713]: info: URI /mnt/NAS/NasMyHome/Bob Dylan - Desire MFSL (2013)/05 Oh, Sister.flac Mar 30 09:59:46 volumiostudio volumio[713]: info: ALBUMART /albumart?cacheid=774&web=Bob%20Dylan/Desire/extralarge&path=%2Fmnt%2FNAS%2FNasMyHome%2FBob%20Dylan%20-%20Desire%20MFSL%20(2013)%2F06%20Joey.flac&metadata=false Mar 30 09:59:46 volumiostudio volumio[713]: info: URI /mnt/NAS/NasMyHome/Bob Dylan - Desire MFSL (2013)/06 Joey.flac Mar 30 09:59:46 volumiostudio volumio[713]: info: ALBUMART /albumart?cacheid=774&web=Bob%20Dylan/Desire/extralarge&path=%2Fmnt%2FNAS%2FNasMyHome%2FBob%20Dylan%20-%20Desire%20MFSL%20(2013)%2F07%20Romance%20In%20Durango.flac&metadata=false Mar 30 09:59:46 volumiostudio volumio[713]: info: URI /mnt/NAS/NasMyHome/Bob Dylan - Desire MFSL (2013)/07 Romance In Durango.flac Mar 30 09:59:46 volumiostudio volumio[713]: info: ALBUMART /albumart?cacheid=774&web=Bob%20Dylan/Desire/extralarge&path=%2Fmnt%2FNAS%2FNasMyHome%2FBob%20Dylan%20-%20Desire%20MFSL%20(2013)%2F08%20Black%20Diamond%20Bay.flac&metadata=false Mar 30 09:59:46 volumiostudio volumio[713]: info: URI /mnt/NAS/NasMyHome/Bob Dylan - Desire MFSL (2013)/08 Black Diamond Bay.flac Mar 30 09:59:46 volumiostudio volumio[713]: info: ALBUMART /albumart?cacheid=774&web=Bob%20Dylan/Desire/extralarge&path=%2Fmnt%2FNAS%2FNasMyHome%2FBob%20Dylan%20-%20Desire%20MFSL%20(2013)%2F09%20Sara.flac&metadata=false Mar 30 09:59:46 volumiostudio volumio[713]: info: URI /mnt/NAS/NasMyHome/Bob Dylan - Desire MFSL (2013)/09 Sara.flac Mar 30 09:59:46 volumiostudio volumio[713]: info: ALBUMART /albumart?cacheid=774&web=Bob%20Dylan/Desire/extralarge&path=%2Fmnt%2FNAS%2FNasMyHome%2FBob%20Dylan%20-%20Desire%20MFSL%20(2013)%2FDesire.cue&metadata=false Mar 30 09:59:46 volumiostudio volumio[713]: info: URI /mnt/NAS/NasMyHome/Bob Dylan - Desire MFSL (2013)/Desire.cue Mar 30 09:59:46 volumiostudio volumio[713]: info: ALBUMART /albumart?cacheid=774&web=Bob%20Dylan/Desire/extralarge&path=%2Fmnt%2FNAS%2FNasMyHome%2FBob%20Dylan%20-%20Desire%20MFSL%20(2013)%2FDesire.cue&metadata=false Mar 30 09:59:46 volumiostudio volumio[713]: info: URI /mnt/NAS/NasMyHome/Bob Dylan - Desire MFSL (2013)/Desire.cue Mar 30 09:59:46 volumiostudio volumio[713]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 30 09:59:46 volumiostudio volumio[713]: Error: Unable to resolve or reject the same promise twice Mar 30 09:59:46 volumiostudio volumio[713]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Mar 30 09:59:46 volumiostudio volumio[713]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Mar 30 09:59:46 volumiostudio volumio[713]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Mar 30 09:59:46 volumiostudio volumio[713]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Mar 30 09:59:46 volumiostudio volumio[713]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Mar 30 09:59:46 volumiostudio volumio[713]: at Socket.emit (events.js:315:20) Mar 30 09:59:46 volumiostudio volumio[713]: at addChunk (internal/streams/readable.js:309:12) Mar 30 09:59:46 volumiostudio volumio[713]: at readableAddChunk (internal/streams/readable.js:280:11) Mar 30 09:59:46 volumiostudio volumio[713]: at Socket.Readable.push (internal/streams/readable.js:223:10) Mar 30 09:59:46 volumiostudio volumio[713]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Mar 30 09:59:46 volumiostudio volumio[713]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 30 09:59:48 volumiostudio sudo[5184]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-30 09:58 Mar 30 09:59:48 volumiostudio sudo[5184]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"