-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Wed 2026-03-25 19:52:49 CET. -- Mar 25 19:51:22 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Mar 25 19:51:22 minidsp-shd volumio[773]: info: UPNP Browser: No servers found, reinitializing and searching... Mar 25 19:51:25 minidsp-shd volumio[773]: info: UPNP Browser: Returning 1 server(s) after 3s wait Mar 25 19:51:25 minidsp-shd volumio[773]: info: Preload queue cleared Mar 25 19:51:28 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Mar 25 19:51:28 minidsp-shd volumio[773]: info: Preload queue cleared Mar 25 19:51:29 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Mar 25 19:51:29 minidsp-shd volumio[773]: info: Preload queue cleared Mar 25 19:51:31 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Mar 25 19:51:33 minidsp-shd volumio[773]: info: Preload queue cleared Mar 25 19:51:35 minidsp-shd volumio[773]: info: MPD Database updated - AlbumList cache refreshed Mar 25 19:51:35 minidsp-shd volumio[773]: info: Mar 25 19:51:35 minidsp-shd volumio[773]: ---------------------------- MPD announces state update: database Mar 25 19:51:35 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:51:35 minidsp-shd volumio[773]: info: Mar 25 19:51:35 minidsp-shd volumio[773]: ---------------------------- MPD announces state update: update Mar 25 19:51:35 minidsp-shd volumio[773]: info: ControllerMpd::getState Mar 25 19:51:35 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:51:35 minidsp-shd volumio[773]: info: ControllerMpd::getState Mar 25 19:51:35 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:51:35 minidsp-shd volumio[773]: info: MPD Database updated - AlbumList cache refreshed Mar 25 19:51:35 minidsp-shd volumio[773]: info: Mar 25 19:51:35 minidsp-shd volumio[773]: ---------------------------- MPD announces state update: database Mar 25 19:51:35 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:51:35 minidsp-shd volumio[773]: info: Mar 25 19:51:35 minidsp-shd volumio[773]: ---------------------------- MPD announces state update: update Mar 25 19:51:35 minidsp-shd volumio[773]: info: ControllerMpd::getState Mar 25 19:51:35 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:51:35 minidsp-shd volumio[773]: info: ControllerMpd::getState Mar 25 19:51:35 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:51:35 minidsp-shd volumio[773]: info: MPD Database updated - AlbumList cache refreshed Mar 25 19:51:35 minidsp-shd volumio[773]: info: Mar 25 19:51:35 minidsp-shd volumio[773]: ---------------------------- MPD announces state update: database Mar 25 19:51:35 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:51:35 minidsp-shd volumio[773]: info: Mar 25 19:51:35 minidsp-shd volumio[773]: ---------------------------- MPD announces state update: update Mar 25 19:51:35 minidsp-shd volumio[773]: info: ControllerMpd::getState Mar 25 19:51:35 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:51:35 minidsp-shd volumio[773]: info: ControllerMpd::getState Mar 25 19:51:35 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:51:36 minidsp-shd volumio[773]: info: sendMpdCommand status took 998 milliseconds Mar 25 19:51:36 minidsp-shd volumio[773]: info: sendMpdCommand status took 996 milliseconds Mar 25 19:51:36 minidsp-shd volumio[773]: info: sendMpdCommand status took 994 milliseconds Mar 25 19:51:36 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:51:36 minidsp-shd volumio[773]: info: Command Router : Notfying DB Updatetrue Mar 25 19:51:36 minidsp-shd volumio[773]: info: CoreCommandRouter::Close All Modals sent Mar 25 19:51:36 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:51:36 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 19:51:36 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:51:36 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 19:51:37 minidsp-shd volumio[773]: info: sendMpdCommand status took 1750 milliseconds Mar 25 19:51:37 minidsp-shd volumio[773]: info: sendMpdCommand status took 1741 milliseconds Mar 25 19:51:37 minidsp-shd volumio[773]: info: sendMpdCommand status took 1740 milliseconds Mar 25 19:51:37 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:51:37 minidsp-shd volumio[773]: info: Command Router : Notfying DB Updatetrue Mar 25 19:51:37 minidsp-shd volumio[773]: info: CoreCommandRouter::Close All Modals sent Mar 25 19:51:37 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:51:37 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 19:51:37 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:51:37 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 19:51:38 minidsp-shd volumio[773]: info: sendMpdCommand status took 2697 milliseconds Mar 25 19:51:38 minidsp-shd volumio[773]: info: sendMpdCommand status took 2695 milliseconds Mar 25 19:51:38 minidsp-shd volumio[773]: info: sendMpdCommand status took 2694 milliseconds Mar 25 19:51:38 minidsp-shd volumio[773]: info: sendMpdCommand playlistinfo took 1608 milliseconds Mar 25 19:51:38 minidsp-shd volumio[773]: info: sendMpdCommand playlistinfo took 1608 milliseconds Mar 25 19:51:38 minidsp-shd volumio[773]: info: sendMpdCommand playlistinfo took 879 milliseconds Mar 25 19:51:38 minidsp-shd volumio[773]: info: sendMpdCommand playlistinfo took 878 milliseconds Mar 25 19:51:38 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:51:38 minidsp-shd volumio[773]: info: Command Router : Notfying DB Updatetrue Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreCommandRouter::Close All Modals sent Mar 25 19:51:38 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:51:38 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 19:51:38 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:51:38 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 19:51:38 minidsp-shd volumio[773]: verbose: ControllerMpd::parseTrackInfo Mar 25 19:51:38 minidsp-shd volumio[773]: verbose: ControllerMpd::parseTrackInfo Mar 25 19:51:38 minidsp-shd volumio[773]: verbose: ControllerMpd::parseTrackInfo Mar 25 19:51:38 minidsp-shd volumio[773]: verbose: ControllerMpd::parseTrackInfo Mar 25 19:51:38 minidsp-shd volumio[773]: info: ControllerMpd::pushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreCommandRouter::servicePushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:51:38 minidsp-shd volumio[773]: verbose: STATE SERVICE {"status":"play","position":0,"seek":41847,"duration":307,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"788 Kbps","isStreaming":false,"title":"What A Wonderful World","artist":"Eva Cassidy","album":"Best Audiophile Voices Selection","uri":"USB/DISCO_1TB/FLAC/2006 - Best Audiophile Voices Selection Premium Records/Premium Records 02 Eva Cassidy , What a wonderful world.m4a","trackType":"m4a"} Mar 25 19:51:38 minidsp-shd volumio[773]: verbose: CURRENT POSITION 1205 Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreStateMachine::syncState stateService play Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreStateMachine::syncState currentStatus play Mar 25 19:51:38 minidsp-shd volumio[773]: info: Received an update from plugin. extracting info from payload Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:51:38 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:51:38 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:51:38 minidsp-shd volumio[773]: info: ControllerMpd::pushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreCommandRouter::servicePushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:51:38 minidsp-shd volumio[773]: verbose: STATE SERVICE {"status":"play","position":0,"seek":41847,"duration":307,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"788 Kbps","isStreaming":false,"title":"What A Wonderful World","artist":"Eva Cassidy","album":"Best Audiophile Voices Selection","uri":"USB/DISCO_1TB/FLAC/2006 - Best Audiophile Voices Selection Premium Records/Premium Records 02 Eva Cassidy , What a wonderful world.m4a","trackType":"m4a"} Mar 25 19:51:38 minidsp-shd volumio[773]: verbose: CURRENT POSITION 1205 Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreStateMachine::syncState stateService play Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreStateMachine::syncState currentStatus play Mar 25 19:51:38 minidsp-shd volumio[773]: info: Received an update from plugin. extracting info from payload Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:51:38 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:51:38 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:51:38 minidsp-shd volumio[773]: info: ControllerMpd::pushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreCommandRouter::servicePushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:51:38 minidsp-shd volumio[773]: verbose: STATE SERVICE {"status":"play","position":0,"seek":41961,"duration":307,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"788 Kbps","isStreaming":false,"title":"What A Wonderful World","artist":"Eva Cassidy","album":"Best Audiophile Voices Selection","uri":"USB/DISCO_1TB/FLAC/2006 - Best Audiophile Voices Selection Premium Records/Premium Records 02 Eva Cassidy , What a wonderful world.m4a","trackType":"m4a"} Mar 25 19:51:38 minidsp-shd volumio[773]: verbose: CURRENT POSITION 1205 Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreStateMachine::syncState stateService play Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreStateMachine::syncState currentStatus play Mar 25 19:51:38 minidsp-shd volumio[773]: info: Received an update from plugin. extracting info from payload Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:51:38 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:51:38 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:51:38 minidsp-shd volumio[773]: info: ControllerMpd::pushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreCommandRouter::servicePushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:51:38 minidsp-shd volumio[773]: verbose: STATE SERVICE {"status":"play","position":0,"seek":41961,"duration":307,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"788 Kbps","isStreaming":false,"title":"What A Wonderful World","artist":"Eva Cassidy","album":"Best Audiophile Voices Selection","uri":"USB/DISCO_1TB/FLAC/2006 - Best Audiophile Voices Selection Premium Records/Premium Records 02 Eva Cassidy , What a wonderful world.m4a","trackType":"m4a"} Mar 25 19:51:38 minidsp-shd volumio[773]: verbose: CURRENT POSITION 1205 Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreStateMachine::syncState stateService play Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreStateMachine::syncState currentStatus play Mar 25 19:51:38 minidsp-shd volumio[773]: info: Received an update from plugin. extracting info from payload Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:51:38 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:51:38 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:51:38 minidsp-shd volumio[773]: info: ------------------------------ 3373ms Mar 25 19:51:38 minidsp-shd volumio[773]: info: ------------------------------ 3374ms Mar 25 19:51:38 minidsp-shd volumio[773]: info: ------------------------------ 3364ms Mar 25 19:51:38 minidsp-shd volumio[773]: info: ------------------------------ 3364ms Mar 25 19:51:38 minidsp-shd volumio[773]: info: sendMpdCommand playlistinfo took 599 milliseconds Mar 25 19:51:38 minidsp-shd volumio[773]: info: sendMpdCommand playlistinfo took 599 milliseconds Mar 25 19:51:38 minidsp-shd volumio[773]: verbose: ControllerMpd::parseTrackInfo Mar 25 19:51:38 minidsp-shd volumio[773]: verbose: ControllerMpd::parseTrackInfo Mar 25 19:51:38 minidsp-shd volumio[773]: info: ControllerMpd::pushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreCommandRouter::servicePushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:51:38 minidsp-shd volumio[773]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42075,"duration":307,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"788 Kbps","isStreaming":false,"title":"What A Wonderful World","artist":"Eva Cassidy","album":"Best Audiophile Voices Selection","uri":"USB/DISCO_1TB/FLAC/2006 - Best Audiophile Voices Selection Premium Records/Premium Records 02 Eva Cassidy , What a wonderful world.m4a","trackType":"m4a"} Mar 25 19:51:38 minidsp-shd volumio[773]: verbose: CURRENT POSITION 1205 Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreStateMachine::syncState stateService play Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreStateMachine::syncState currentStatus play Mar 25 19:51:38 minidsp-shd volumio[773]: info: Received an update from plugin. extracting info from payload Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:51:38 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:51:38 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:51:38 minidsp-shd volumio[773]: info: ControllerMpd::pushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreCommandRouter::servicePushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:51:38 minidsp-shd volumio[773]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42075,"duration":307,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"788 Kbps","isStreaming":false,"title":"What A Wonderful World","artist":"Eva Cassidy","album":"Best Audiophile Voices Selection","uri":"USB/DISCO_1TB/FLAC/2006 - Best Audiophile Voices Selection Premium Records/Premium Records 02 Eva Cassidy , What a wonderful world.m4a","trackType":"m4a"} Mar 25 19:51:38 minidsp-shd volumio[773]: verbose: CURRENT POSITION 1205 Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreStateMachine::syncState stateService play Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreStateMachine::syncState currentStatus play Mar 25 19:51:38 minidsp-shd volumio[773]: info: Received an update from plugin. extracting info from payload Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:51:38 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:51:38 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:51:38 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:51:38 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:51:38 minidsp-shd volumio[773]: info: ------------------------------ 3644ms Mar 25 19:51:38 minidsp-shd volumio[773]: info: ------------------------------ 3645ms Mar 25 19:51:40 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 25 19:51:40 minidsp-shd volumio[773]: info: CURURI: playlists Mar 25 19:51:40 minidsp-shd volumio[773]: info: Listing playlists Mar 25 19:51:41 minidsp-shd volumio[773]: info: Preload queue cleared Mar 25 19:51:48 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:51:48 minidsp-shd volumio[773]: info: Mar 25 19:51:48 minidsp-shd volumio[773]: ---------------------------- MPD announces state update: update Mar 25 19:51:48 minidsp-shd volumio[773]: info: ControllerMpd::getState Mar 25 19:51:48 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:51:48 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:51:48 minidsp-shd volumio[773]: info: Mar 25 19:51:48 minidsp-shd volumio[773]: ---------------------------- MPD announces state update: update Mar 25 19:51:48 minidsp-shd volumio[773]: info: ControllerMpd::getState Mar 25 19:51:48 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:51:48 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:51:48 minidsp-shd volumio[773]: info: Mar 25 19:51:48 minidsp-shd volumio[773]: ---------------------------- MPD announces state update: update Mar 25 19:51:48 minidsp-shd volumio[773]: info: ControllerMpd::getState Mar 25 19:51:48 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:51:48 minidsp-shd volumio[773]: info: sendMpdCommand status took 23 milliseconds Mar 25 19:51:48 minidsp-shd volumio[773]: info: sendMpdCommand status took 20 milliseconds Mar 25 19:51:48 minidsp-shd volumio[773]: info: sendMpdCommand status took 18 milliseconds Mar 25 19:51:48 minidsp-shd volumio[773]: info: sendMpdCommand status took 16 milliseconds Mar 25 19:51:48 minidsp-shd volumio[773]: info: sendMpdCommand status took 14 milliseconds Mar 25 19:51:48 minidsp-shd volumio[773]: info: sendMpdCommand status took 11 milliseconds Mar 25 19:51:48 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:51:48 minidsp-shd volumio[773]: info: Command Router : Notfying DB Updatefalse Mar 25 19:51:48 minidsp-shd volumio[773]: info: CoreCommandRouter::Close All Modals sent Mar 25 19:51:48 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:51:48 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 19:51:48 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:51:48 minidsp-shd volumio[773]: info: Command Router : Notfying DB Updatefalse Mar 25 19:51:48 minidsp-shd volumio[773]: info: CoreCommandRouter::Close All Modals sent Mar 25 19:51:48 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:51:48 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 19:51:48 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:51:48 minidsp-shd volumio[773]: info: Command Router : Notfying DB Updatefalse Mar 25 19:51:48 minidsp-shd volumio[773]: info: CoreCommandRouter::Close All Modals sent Mar 25 19:51:48 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:51:48 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 19:51:49 minidsp-shd volumio[773]: info: sendMpdCommand playlistinfo took 184 milliseconds Mar 25 19:51:49 minidsp-shd volumio[773]: info: sendMpdCommand playlistinfo took 126 milliseconds Mar 25 19:51:49 minidsp-shd volumio[773]: info: sendMpdCommand playlistinfo took 71 milliseconds Mar 25 19:51:49 minidsp-shd volumio[773]: verbose: ControllerMpd::parseTrackInfo Mar 25 19:51:49 minidsp-shd volumio[773]: verbose: ControllerMpd::parseTrackInfo Mar 25 19:51:49 minidsp-shd volumio[773]: verbose: ControllerMpd::parseTrackInfo Mar 25 19:51:49 minidsp-shd volumio[773]: info: ControllerMpd::pushState Mar 25 19:51:49 minidsp-shd volumio[773]: info: CoreCommandRouter::servicePushState Mar 25 19:51:49 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:51:49 minidsp-shd volumio[773]: verbose: STATE SERVICE {"status":"play","position":0,"seek":55209,"duration":307,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"788 Kbps","isStreaming":false,"title":"What A Wonderful World","artist":"Eva Cassidy","album":"Best Audiophile Voices Selection","uri":"USB/DISCO_1TB/FLAC/2006 - Best Audiophile Voices Selection Premium Records/Premium Records 02 Eva Cassidy , What a wonderful world.m4a","trackType":"m4a"} Mar 25 19:51:49 minidsp-shd volumio[773]: verbose: CURRENT POSITION 1205 Mar 25 19:51:49 minidsp-shd volumio[773]: info: CoreStateMachine::syncState stateService play Mar 25 19:51:49 minidsp-shd volumio[773]: info: CoreStateMachine::syncState currentStatus play Mar 25 19:51:49 minidsp-shd volumio[773]: info: Received an update from plugin. extracting info from payload Mar 25 19:51:49 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:51:49 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:51:49 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 19:51:49 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:51:49 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:51:49 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:51:49 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:51:49 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:51:49 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:51:49 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:51:49 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:51:49 minidsp-shd volumio[773]: info: ControllerMpd::pushState Mar 25 19:51:49 minidsp-shd volumio[773]: info: CoreCommandRouter::servicePushState Mar 25 19:51:49 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:51:49 minidsp-shd volumio[773]: verbose: STATE SERVICE {"status":"play","position":0,"seek":55209,"duration":307,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"788 Kbps","isStreaming":false,"title":"What A Wonderful World","artist":"Eva Cassidy","album":"Best Audiophile Voices Selection","uri":"USB/DISCO_1TB/FLAC/2006 - Best Audiophile Voices Selection Premium Records/Premium Records 02 Eva Cassidy , What a wonderful world.m4a","trackType":"m4a"} Mar 25 19:51:49 minidsp-shd volumio[773]: verbose: CURRENT POSITION 1205 Mar 25 19:51:49 minidsp-shd volumio[773]: info: CoreStateMachine::syncState stateService play Mar 25 19:51:49 minidsp-shd volumio[773]: info: CoreStateMachine::syncState currentStatus play Mar 25 19:51:49 minidsp-shd volumio[773]: info: Received an update from plugin. extracting info from payload Mar 25 19:51:49 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:51:49 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:51:49 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:51:49 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:51:49 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:51:49 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:51:49 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:51:49 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:51:49 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:51:49 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:51:49 minidsp-shd volumio[773]: info: ControllerMpd::pushState Mar 25 19:51:49 minidsp-shd volumio[773]: info: CoreCommandRouter::servicePushState Mar 25 19:51:49 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:51:49 minidsp-shd volumio[773]: verbose: STATE SERVICE {"status":"play","position":0,"seek":55209,"duration":307,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"788 Kbps","isStreaming":false,"title":"What A Wonderful World","artist":"Eva Cassidy","album":"Best Audiophile Voices Selection","uri":"USB/DISCO_1TB/FLAC/2006 - Best Audiophile Voices Selection Premium Records/Premium Records 02 Eva Cassidy , What a wonderful world.m4a","trackType":"m4a"} Mar 25 19:51:49 minidsp-shd volumio[773]: verbose: CURRENT POSITION 1205 Mar 25 19:51:49 minidsp-shd volumio[773]: info: CoreStateMachine::syncState stateService play Mar 25 19:51:49 minidsp-shd volumio[773]: info: CoreStateMachine::syncState currentStatus play Mar 25 19:51:49 minidsp-shd volumio[773]: info: Received an update from plugin. extracting info from payload Mar 25 19:51:49 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:51:49 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:51:49 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:51:49 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:51:49 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:51:49 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:51:49 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:51:49 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:51:49 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:51:49 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:51:49 minidsp-shd volumio[773]: info: ------------------------------ 632ms Mar 25 19:51:49 minidsp-shd volumio[773]: info: ------------------------------ 627ms Mar 25 19:51:49 minidsp-shd volumio[773]: info: ------------------------------ 623ms Mar 25 19:51:49 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 25 19:51:49 minidsp-shd volumio[773]: info: CURURI: music-library Mar 25 19:51:49 minidsp-shd volumio[773]: info: Preload queue cleared Mar 25 19:51:52 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 25 19:51:52 minidsp-shd volumio[773]: info: CURURI: music-library/USB Mar 25 19:51:52 minidsp-shd volumio[773]: info: Preload queue cleared Mar 25 19:51:53 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 25 19:51:53 minidsp-shd volumio[773]: info: CURURI: music-library/USB/DISCO_1TB Mar 25 19:51:53 minidsp-shd volumio[773]: info: Preload queue cleared Mar 25 19:51:54 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 25 19:51:54 minidsp-shd volumio[773]: info: CURURI: music-library/USB/DISCO_1TB/FLAC Mar 25 19:51:54 minidsp-shd volumio[773]: info: Preload queue cleared Mar 25 19:52:10 minidsp-shd volumio[773]: info: Preload queue cleared Mar 25 19:52:10 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioAddQueueItems Mar 25 19:52:10 minidsp-shd volumio[773]: info: CoreStateMachine::addQueueItems Mar 25 19:52:10 minidsp-shd volumio[773]: info: CorePlayQueue::addQueueItems Mar 25 19:52:10 minidsp-shd volumio[773]: info: Preload queue cleared Mar 25 19:52:10 minidsp-shd volumio[773]: info: Adding Item to queue: music-library/USB/DISCO_1TB/FLAC/Best Audiophile Voices II Mar 25 19:52:10 minidsp-shd volumio[773]: info: Exploding uri music-library/USB/DISCO_1TB/FLAC/Best Audiophile Voices II in service mpd Mar 25 19:52:10 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Emi%20Fujita/Best%20Audiophile%20Voices%20II/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20II%2F01%20Emi%20Fujita%20-%20Desperado.m4a&metadata=false Mar 25 19:52:10 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices II/01 Emi Fujita - Desperado.m4a Mar 25 19:52:10 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Eva%20Cassidy/Best%20Audiophile%20Voices%20II/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20II%2F02%20Eva%20Cassidy%20-%20Fields%20Of%20Gold.m4a&metadata=false Mar 25 19:52:10 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices II/02 Eva Cassidy - Fields Of Gold.m4a Mar 25 19:52:10 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Andrea%20Zonn/Best%20Audiophile%20Voices%20II/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20II%2F03%20Andrea%20Zonn%20-%20Better%20Be%20Home%20Soon.m4a&metadata=false Mar 25 19:52:10 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices II/03 Andrea Zonn - Better Be Home Soon.m4a Mar 25 19:52:10 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Jean%20Frye%20Sidwell/Best%20Audiophile%20Voices%20II/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20II%2F04%20Jean%20Frye%20Sidwell%20-%20I%20Left%20My%20Heart%20In%20San%20Francisco.m4a&metadata=false Mar 25 19:52:10 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices II/04 Jean Frye Sidwell - I Left My Heart In San Francisco.m4a Mar 25 19:52:10 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Jheena%20Lodwick/Best%20Audiophile%20Voices%20II/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20II%2F05%20Jheena%20Lodwick%20-%20Do%20That%20To%20Me%20One%20More%20Time.m4a&metadata=false Mar 25 19:52:10 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices II/05 Jheena Lodwick - Do That To Me One More Time.m4a Mar 25 19:52:10 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Corrinne%20May/Best%20Audiophile%20Voices%20II/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20II%2F06%20Corrinne%20May%20-%20Fly%20Away.m4a&metadata=false Mar 25 19:52:10 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices II/06 Corrinne May - Fly Away.m4a Mar 25 19:52:10 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Etta%20Jones/Best%20Audiophile%20Voices%20II/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20II%2F07%20Etta%20Jones%20-%20That%20Ole%20Devil%20Called%20Love.m4a&metadata=false Mar 25 19:52:10 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices II/07 Etta Jones - That Ole Devil Called Love.m4a Mar 25 19:52:10 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Sofia%20Petersson/Best%20Audiophile%20Voices%20II/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20II%2F08%20Sofia%20Petersson%20-%20Can't%20Take%20My%20Eyes%20Off%20You.m4a&metadata=false Mar 25 19:52:10 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices II/08 Sofia Petersson - Can't Take My Eyes Off You.m4a Mar 25 19:52:10 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Jeanette%20Lindstrom%20%26%20Steve%20Dobrogosz/Best%20Audiophile%20Voices%20II/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20II%2F09%20Jeanette%20Lindstrom%20%26%20Steve%20Dobrogosz%20-%20Both%20Sides%20Now.m4a&metadata=false Mar 25 19:52:10 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices II/09 Jeanette Lindstrom & Steve Dobrogosz - Both Sides Now.m4a Mar 25 19:52:10 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Alison%20Krauss/Best%20Audiophile%20Voices%20II/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20II%2F10%20Alison%20Krauss%20-%20Stay.m4a&metadata=false Mar 25 19:52:10 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices II/10 Alison Krauss - Stay.m4a Mar 25 19:52:10 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Susannah%20McCorkle/Best%20Audiophile%20Voices%20II/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20II%2F11%20Susannah%20McCorkle%20-%20Someone%20To%20Watch%20Over%20Me.m4a&metadata=false Mar 25 19:52:10 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices II/11 Susannah McCorkle - Someone To Watch Over Me.m4a Mar 25 19:52:10 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Salena%20Jones/Best%20Audiophile%20Voices%20II/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20II%2F12%20Salena%20Jones%20-%20My%20Foolish%20Heart.m4a&metadata=false Mar 25 19:52:10 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices II/12 Salena Jones - My Foolish Heart.m4a Mar 25 19:52:10 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Jacqui%20Dankworth/Best%20Audiophile%20Voices%20II/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20II%2F13%20Jacqui%20Dankworth%20-%20In%20A%20Sentimental%20Mood.m4a&metadata=false Mar 25 19:52:10 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices II/13 Jacqui Dankworth - In A Sentimental Mood.m4a Mar 25 19:52:10 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Claire%20Martin/Best%20Audiophile%20Voices%20II/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20II%2F14%20Claire%20Martin%20-%20When%20I%20Fall%20In%20Love.m4a&metadata=false Mar 25 19:52:10 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices II/14 Claire Martin - When I Fall In Love.m4a Mar 25 19:52:10 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Tania%20Maria/Best%20Audiophile%20Voices%20II/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20II%2F15%20Tania%20Maria%20-%20Cry%20Me%20A%20River.m4a&metadata=false Mar 25 19:52:10 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices II/15 Tania Maria - Cry Me A River.m4a Mar 25 19:52:10 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushQueue Mar 25 19:52:10 minidsp-shd volumio[773]: info: CorePlayQueue::saveQueue Mar 25 19:52:10 minidsp-shd volumio[773]: info: CoreStateMachine::updateTrackBlock Mar 25 19:52:10 minidsp-shd volumio[773]: info: CorePlayQueue::getTrackBlock Mar 25 19:52:10 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPlay Mar 25 19:52:10 minidsp-shd volumio[773]: info: CoreStateMachine::play index 1206 Mar 25 19:52:10 minidsp-shd volumio[773]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 25 19:52:10 minidsp-shd volumio[773]: info: CoreStateMachine::stop Mar 25 19:52:10 minidsp-shd volumio[773]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 25 19:52:10 minidsp-shd volumio[773]: info: CoreStateMachine::stPlaybackTimer Mar 25 19:52:10 minidsp-shd volumio[773]: info: CoreStateMachine::updateTrackBlock Mar 25 19:52:10 minidsp-shd volumio[773]: info: CorePlayQueue::getTrackBlock Mar 25 19:52:10 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:10 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:52:10 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 19:52:10 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:10 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:10 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:10 minidsp-shd volumio[773]: info: CoreStateMachine::serviceStop Mar 25 19:52:10 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1205 Mar 25 19:52:10 minidsp-shd volumio[773]: info: CoreCommandRouter::serviceStop Mar 25 19:52:10 minidsp-shd volumio[773]: info: ControllerMpd::stop Mar 25 19:52:10 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand stop Mar 25 19:52:10 minidsp-shd volumio[773]: info: Mar 25 19:52:10 minidsp-shd volumio[773]: ---------------------------- MPD announces state update: player Mar 25 19:52:10 minidsp-shd volumio[773]: info: sendMpdCommand stop took 88 milliseconds Mar 25 19:52:10 minidsp-shd volumio[773]: info: ControllerMpd::getState Mar 25 19:52:10 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:52:10 minidsp-shd volumio[773]: info: CoreStateMachine::play index undefined Mar 25 19:52:10 minidsp-shd volumio[773]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 25 19:52:10 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1206 Mar 25 19:52:10 minidsp-shd volumio[773]: info: CoreStateMachine::startPlaybackTimer Mar 25 19:52:10 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1206 Mar 25 19:52:10 minidsp-shd volumio[773]: verbose: ControllerMpd::clearAddPlayTracks USB/DISCO_1TB/FLAC/Best Audiophile Voices II/01 Emi Fujita - Desperado.m4a Mar 25 19:52:10 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand stop Mar 25 19:52:10 minidsp-shd volumio[773]: info: Mar 25 19:52:10 minidsp-shd volumio[773]: ---------------------------- MPD announces state update: player Mar 25 19:52:10 minidsp-shd volumio[773]: info: ControllerMpd::getState Mar 25 19:52:10 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:52:10 minidsp-shd volumio[773]: info: Mar 25 19:52:10 minidsp-shd volumio[773]: ---------------------------- MPD announces state update: player Mar 25 19:52:10 minidsp-shd volumio[773]: info: ControllerMpd::getState Mar 25 19:52:10 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:52:10 minidsp-shd volumio[773]: info: sendMpdCommand status took 165 milliseconds Mar 25 19:52:10 minidsp-shd volumio[773]: info: sendMpdCommand stop took 159 milliseconds Mar 25 19:52:10 minidsp-shd volumio[773]: info: sendMpdCommand status took 10 milliseconds Mar 25 19:52:10 minidsp-shd volumio[773]: info: sendMpdCommand status took 7 milliseconds Mar 25 19:52:10 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand clear Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 19:52:11 minidsp-shd volumio[773]: info: Mar 25 19:52:11 minidsp-shd volumio[773]: ---------------------------- MPD announces system playlist update Mar 25 19:52:11 minidsp-shd volumio[773]: info: Ignoring MPD Status Update Mar 25 19:52:11 minidsp-shd volumio[773]: info: sendMpdCommand playlistinfo took 12 milliseconds Mar 25 19:52:11 minidsp-shd volumio[773]: info: sendMpdCommand clear took 12 milliseconds Mar 25 19:52:11 minidsp-shd volumio[773]: info: sendMpdCommand playlistinfo took 11 milliseconds Mar 25 19:52:11 minidsp-shd volumio[773]: info: sendMpdCommand playlistinfo took 10 milliseconds Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::parseTrackInfo Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand add "USB/DISCO_1TB/FLAC/Best Audiophile Voices II/01 Emi Fujita - Desperado.m4a" Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::parseTrackInfo Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::parseTrackInfo Mar 25 19:52:11 minidsp-shd volumio[773]: info: ControllerMpd::pushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreCommandRouter::servicePushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1206 Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:11 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:11 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1206 Mar 25 19:52:11 minidsp-shd volumio[773]: 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":"What A Wonderful World","artist":"Eva Cassidy","album":"Best Audiophile Voices Selection","uri":"USB/DISCO_1TB/FLAC/2006 - Best Audiophile Voices Selection Premium Records/Premium Records 02 Eva Cassidy , What a wonderful world.m4a","trackType":"m4a"} Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: CURRENT POSITION 1206 Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreStateMachine::syncState stateService stop Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreStateMachine::syncState currentStatus stop Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1206 Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:11 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:11 minidsp-shd volumio[773]: info: No code Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1206 Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:11 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:11 minidsp-shd volumio[773]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 25 19:52:11 minidsp-shd volumio[773]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 25 19:52:11 minidsp-shd volumio[773]: info: ------------------------------ 336ms Mar 25 19:52:11 minidsp-shd volumio[773]: info: ------------------------------ 179ms Mar 25 19:52:11 minidsp-shd volumio[773]: info: ------------------------------ 176ms Mar 25 19:52:11 minidsp-shd volumio[773]: info: Mar 25 19:52:11 minidsp-shd volumio[773]: ---------------------------- MPD announces system playlist update Mar 25 19:52:11 minidsp-shd volumio[773]: info: Ignoring MPD Status Update Mar 25 19:52:11 minidsp-shd volumio[773]: info: Mar 25 19:52:11 minidsp-shd volumio[773]: ---------------------------- MPD announces system playlist update Mar 25 19:52:11 minidsp-shd volumio[773]: info: Ignoring MPD Status Update Mar 25 19:52:11 minidsp-shd volumio[773]: error: updateQueue error: null Mar 25 19:52:11 minidsp-shd volumio[773]: info: Mar 25 19:52:11 minidsp-shd volumio[773]: ---------------------------- MPD announces system playlist update Mar 25 19:52:11 minidsp-shd volumio[773]: info: Ignoring MPD Status Update Mar 25 19:52:11 minidsp-shd volumio[773]: info: ------------------------------ 167ms Mar 25 19:52:11 minidsp-shd volumio[773]: info: sendMpdCommand add "USB/DISCO_1TB/FLAC/Best Audiophile Voices II/01 Emi Fujita - Desperado.m4a" took 159 milliseconds Mar 25 19:52:11 minidsp-shd volumio[773]: info: ------------------------------ 13ms Mar 25 19:52:11 minidsp-shd volumio[773]: info: ------------------------------ 11ms Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand play Mar 25 19:52:11 minidsp-shd volumio[773]: info: Mar 25 19:52:11 minidsp-shd volumio[773]: ---------------------------- MPD announces system playlist update Mar 25 19:52:11 minidsp-shd volumio[773]: info: Ignoring MPD Status Update Mar 25 19:52:11 minidsp-shd volumio[773]: info: Mar 25 19:52:11 minidsp-shd volumio[773]: ---------------------------- MPD announces system playlist update Mar 25 19:52:11 minidsp-shd volumio[773]: info: Ignoring MPD Status Update Mar 25 19:52:11 minidsp-shd volumio[773]: info: ------------------------------ 69ms Mar 25 19:52:11 minidsp-shd volumio[773]: info: sendMpdCommand play took 62 milliseconds Mar 25 19:52:11 minidsp-shd volumio[773]: info: ------------------------------ 60ms Mar 25 19:52:11 minidsp-shd volumio[773]: info: ------------------------------ 58ms Mar 25 19:52:11 minidsp-shd volumio[773]: info: Mar 25 19:52:11 minidsp-shd volumio[773]: ---------------------------- MPD announces state update: player Mar 25 19:52:11 minidsp-shd volumio[773]: info: ControllerMpd::getState Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:52:11 minidsp-shd volumio[773]: info: Mar 25 19:52:11 minidsp-shd volumio[773]: ---------------------------- MPD announces state update: player Mar 25 19:52:11 minidsp-shd volumio[773]: info: sendMpdCommand status took 7 milliseconds Mar 25 19:52:11 minidsp-shd volumio[773]: info: ControllerMpd::getState Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 19:52:11 minidsp-shd volumio[773]: info: Mar 25 19:52:11 minidsp-shd volumio[773]: ---------------------------- MPD announces state update: player Mar 25 19:52:11 minidsp-shd volumio[773]: info: ControllerMpd::getState Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:52:11 minidsp-shd volumio[773]: info: Mar 25 19:52:11 minidsp-shd volumio[773]: ---------------------------- MPD announces state update: player Mar 25 19:52:11 minidsp-shd volumio[773]: info: ControllerMpd::getState Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:52:11 minidsp-shd volumio[773]: info: sendMpdCommand status took 21 milliseconds Mar 25 19:52:11 minidsp-shd volumio[773]: info: sendMpdCommand playlistinfo took 19 milliseconds Mar 25 19:52:11 minidsp-shd volumio[773]: info: sendMpdCommand status took 15 milliseconds Mar 25 19:52:11 minidsp-shd volumio[773]: info: sendMpdCommand status took 7 milliseconds Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::parseTrackInfo Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 19:52:11 minidsp-shd volumio[773]: info: ControllerMpd::pushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreCommandRouter::servicePushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1206 Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Desperado","artist":"Emi Fujita","album":"Best Audiophile Voices II","uri":"USB/DISCO_1TB/FLAC/Best Audiophile Voices II/01 Emi Fujita - Desperado.m4a","trackType":"m4a"} Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: CURRENT POSITION 1206 Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreStateMachine::syncState stateService play Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreStateMachine::syncState currentStatus stop Mar 25 19:52:11 minidsp-shd volumio[773]: info: ------------------------------ 58ms Mar 25 19:52:11 minidsp-shd volumio[773]: info: Mar 25 19:52:11 minidsp-shd volumio[773]: ---------------------------- MPD announces state update: player Mar 25 19:52:11 minidsp-shd volumio[773]: info: ControllerMpd::getState Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:52:11 minidsp-shd volumio[773]: info: Mar 25 19:52:11 minidsp-shd volumio[773]: ---------------------------- MPD announces state update: player Mar 25 19:52:11 minidsp-shd volumio[773]: info: ControllerMpd::getState Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:52:11 minidsp-shd volumio[773]: info: sendMpdCommand playlistinfo took 42 milliseconds Mar 25 19:52:11 minidsp-shd volumio[773]: info: sendMpdCommand playlistinfo took 40 milliseconds Mar 25 19:52:11 minidsp-shd volumio[773]: info: sendMpdCommand playlistinfo took 39 milliseconds Mar 25 19:52:11 minidsp-shd volumio[773]: info: sendMpdCommand status took 25 milliseconds Mar 25 19:52:11 minidsp-shd volumio[773]: info: sendMpdCommand status took 19 milliseconds Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::parseTrackInfo Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::parseTrackInfo Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::parseTrackInfo Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 19:52:11 minidsp-shd volumio[773]: info: ControllerMpd::pushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreCommandRouter::servicePushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1206 Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Desperado","artist":"Emi Fujita","album":"Best Audiophile Voices II","uri":"USB/DISCO_1TB/FLAC/Best Audiophile Voices II/01 Emi Fujita - Desperado.m4a","trackType":"m4a"} Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: CURRENT POSITION 1206 Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreStateMachine::syncState stateService play Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreStateMachine::syncState currentStatus play Mar 25 19:52:11 minidsp-shd volumio[773]: info: Received an update from plugin. extracting info from payload Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1206 Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:11 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1206 Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:11 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:11 minidsp-shd volumio[773]: info: ControllerMpd::pushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreCommandRouter::servicePushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1206 Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: STATE SERVICE {"status":"play","position":0,"seek":457,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"831 Kbps","isStreaming":false,"title":"Desperado","artist":"Emi Fujita","album":"Best Audiophile Voices II","uri":"USB/DISCO_1TB/FLAC/Best Audiophile Voices II/01 Emi Fujita - Desperado.m4a","trackType":"m4a"} Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: CURRENT POSITION 1206 Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreStateMachine::syncState stateService play Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreStateMachine::syncState currentStatus play Mar 25 19:52:11 minidsp-shd volumio[773]: info: Received an update from plugin. extracting info from payload Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1206 Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:11 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1206 Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:11 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:11 minidsp-shd volumio[773]: info: ControllerMpd::pushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreCommandRouter::servicePushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1206 Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"831 Kbps","isStreaming":false,"title":"Desperado","artist":"Emi Fujita","album":"Best Audiophile Voices II","uri":"USB/DISCO_1TB/FLAC/Best Audiophile Voices II/01 Emi Fujita - Desperado.m4a","trackType":"m4a"} Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: CURRENT POSITION 1206 Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreStateMachine::syncState stateService play Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreStateMachine::syncState currentStatus play Mar 25 19:52:11 minidsp-shd volumio[773]: info: Received an update from plugin. extracting info from payload Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1206 Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:11 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1206 Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:11 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:11 minidsp-shd volumio[773]: info: ------------------------------ 482ms Mar 25 19:52:11 minidsp-shd volumio[773]: info: ------------------------------ 474ms Mar 25 19:52:11 minidsp-shd volumio[773]: info: ------------------------------ 469ms Mar 25 19:52:11 minidsp-shd volumio[773]: info: sendMpdCommand playlistinfo took 403 milliseconds Mar 25 19:52:11 minidsp-shd volumio[773]: info: sendMpdCommand playlistinfo took 403 milliseconds Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::parseTrackInfo Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: ControllerMpd::parseTrackInfo Mar 25 19:52:11 minidsp-shd volumio[773]: info: ControllerMpd::pushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreCommandRouter::servicePushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1206 Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"831 Kbps","isStreaming":false,"title":"Desperado","artist":"Emi Fujita","album":"Best Audiophile Voices II","uri":"USB/DISCO_1TB/FLAC/Best Audiophile Voices II/01 Emi Fujita - Desperado.m4a","trackType":"m4a"} Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: CURRENT POSITION 1206 Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreStateMachine::syncState stateService play Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreStateMachine::syncState currentStatus play Mar 25 19:52:11 minidsp-shd volumio[773]: info: Received an update from plugin. extracting info from payload Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1206 Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:11 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1206 Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:11 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:11 minidsp-shd volumio[773]: info: ControllerMpd::pushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreCommandRouter::servicePushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1206 Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"831 Kbps","isStreaming":false,"title":"Desperado","artist":"Emi Fujita","album":"Best Audiophile Voices II","uri":"USB/DISCO_1TB/FLAC/Best Audiophile Voices II/01 Emi Fujita - Desperado.m4a","trackType":"m4a"} Mar 25 19:52:11 minidsp-shd volumio[773]: verbose: CURRENT POSITION 1206 Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreStateMachine::syncState stateService play Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreStateMachine::syncState currentStatus play Mar 25 19:52:11 minidsp-shd volumio[773]: info: Received an update from plugin. extracting info from payload Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1206 Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:11 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1206 Mar 25 19:52:11 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:11 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:11 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:12 minidsp-shd volumio[773]: info: ------------------------------ 656ms Mar 25 19:52:12 minidsp-shd volumio[773]: info: ------------------------------ 651ms Mar 25 19:52:13 minidsp-shd volumio[773]: info: Preload queue cleared Mar 25 19:52:13 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioAddQueueItems Mar 25 19:52:13 minidsp-shd volumio[773]: info: CoreStateMachine::addQueueItems Mar 25 19:52:13 minidsp-shd volumio[773]: info: CorePlayQueue::addQueueItems Mar 25 19:52:13 minidsp-shd volumio[773]: info: Preload queue cleared Mar 25 19:52:13 minidsp-shd volumio[773]: info: Adding Item to queue: music-library/USB/DISCO_1TB/FLAC/Best Audiophile Voices I Mar 25 19:52:13 minidsp-shd volumio[773]: info: Exploding uri music-library/USB/DISCO_1TB/FLAC/Best Audiophile Voices I in service mpd Mar 25 19:52:13 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Jane%20Monheit/Best%20Audiophile%20Voices/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20I%2F01%20Jane%20Monheit%20-%20Over%20The%20Rainbow.m4a&metadata=false Mar 25 19:52:13 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices I/01 Jane Monheit - Over The Rainbow.m4a Mar 25 19:52:13 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Eva%20Cassidy/Best%20Audiophile%20Voices/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20I%2F02%20Eva%20Cassidy%20-%20What%20A%20Wonderful%20World.m4a&metadata=false Mar 25 19:52:13 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices I/02 Eva Cassidy - What A Wonderful World.m4a Mar 25 19:52:13 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Alison%20Krauss/Best%20Audiophile%20Voices/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20I%2F03%20Alison%20Krauss%20-%20It%20Wouldn't%20Have%20Made%20a%20Difference.m4a&metadata=false Mar 25 19:52:13 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices I/03 Alison Krauss - It Wouldn't Have Made a Difference.m4a Mar 25 19:52:13 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Stacey%20Kent%20%26%20Jim%20Tomlinson/Best%20Audiophile%20Voices/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20I%2F04%20Stacey%20Kent%20%26%20Jim%20Tomlinson%20-%20So%20Nice.m4a&metadata=false Mar 25 19:52:13 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices I/04 Stacey Kent & Jim Tomlinson - So Nice.m4a Mar 25 19:52:13 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Carol%20Kidd/Best%20Audiophile%20Voices/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20I%2F05%20Carol%20Kidd%20-%20When%20I%20Dream.m4a&metadata=false Mar 25 19:52:13 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices I/05 Carol Kidd - When I Dream.m4a Mar 25 19:52:13 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Jheena%20Lodwick/Best%20Audiophile%20Voices/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20I%2F06%20Jheena%20Lodwick%20-%20Perhaps%20Love.m4a&metadata=false Mar 25 19:52:13 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices I/06 Jheena Lodwick - Perhaps Love.m4a Mar 25 19:52:13 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Kelly%20Flint/Best%20Audiophile%20Voices/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20I%2F07%20Kelly%20Flint%20-%20Dave%20True%20Story.m4a&metadata=false Mar 25 19:52:13 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices I/07 Kelly Flint - Dave True Story.m4a Mar 25 19:52:13 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Tish%20Hinojosa/Best%20Audiophile%20Voices/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20I%2F08%20Tish%20Hinojosa%20-%20Song%20for%20the%20Journey.m4a&metadata=false Mar 25 19:52:13 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices I/08 Tish Hinojosa - Song for the Journey.m4a Mar 25 19:52:13 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Cheryl%20Wheeler/Best%20Audiophile%20Voices/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20I%2F09%20Cheryl%20Wheeler%20-%20Sylvia%20Hotel.m4a&metadata=false Mar 25 19:52:13 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices I/09 Cheryl Wheeler - Sylvia Hotel.m4a Mar 25 19:52:13 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Salena%20Jones/Best%20Audiophile%20Voices/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20I%2F10%20Salena%20Jones%20-%20You%20Light%20Up%20My%20Life.m4a&metadata=false Mar 25 19:52:13 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices I/10 Salena Jones - You Light Up My Life.m4a Mar 25 19:52:13 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Eva%20Cassidy/Best%20Audiophile%20Voices/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20I%2F11%20Eva%20Cassidy%20-%20Ain't%20No%20Sunshine.m4a&metadata=false Mar 25 19:52:13 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices I/11 Eva Cassidy - Ain't No Sunshine.m4a Mar 25 19:52:13 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Jeanette%20Lindstrom%20%26%20Steve%20Dobrogosz/Best%20Audiophile%20Voices/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20I%2F12%20Jeanette%20Lindstrom%20%26%20Steve%20Dobrogosz%20-%20The%20Look%20of%20Love.m4a&metadata=false Mar 25 19:52:13 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices I/12 Jeanette Lindstrom & Steve Dobrogosz - The Look of Love.m4a Mar 25 19:52:13 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Karrin%20Allyson/Best%20Audiophile%20Voices/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20I%2F13%20Karrin%20Allyson%20-%20Too%20Young%20to%20Go%20Steady.m4a&metadata=false Mar 25 19:52:13 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices I/13 Karrin Allyson - Too Young to Go Steady.m4a Mar 25 19:52:13 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Monica%20Mancini/Best%20Audiophile%20Voices/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20I%2F14%20Monica%20Mancini%20-%20Skylark.m4a&metadata=false Mar 25 19:52:13 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices I/14 Monica Mancini - Skylark.m4a Mar 25 19:52:13 minidsp-shd volumio[773]: info: ALBUMART /albumart?cacheid=492&web=Nnenna%20Freelon/Best%20Audiophile%20Voices/extralarge&path=%2Fmnt%2FUSB%2FDISCO_1TB%2FFLAC%2FBest%20Audiophile%20Voices%20I%2F15%20Nnenna%20Freelon%20-%20Overjoyed.m4a&metadata=false Mar 25 19:52:13 minidsp-shd volumio[773]: info: URI /mnt/USB/DISCO_1TB/FLAC/Best Audiophile Voices I/15 Nnenna Freelon - Overjoyed.m4a Mar 25 19:52:13 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushQueue Mar 25 19:52:14 minidsp-shd volumio[773]: info: CorePlayQueue::saveQueue Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreStateMachine::updateTrackBlock Mar 25 19:52:14 minidsp-shd volumio[773]: info: CorePlayQueue::getTrackBlock Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPlay Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreStateMachine::play index 1221 Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreStateMachine::stop Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreStateMachine::stPlaybackTimer Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreStateMachine::updateTrackBlock Mar 25 19:52:14 minidsp-shd volumio[773]: info: CorePlayQueue::getTrackBlock Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:14 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1206 Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:14 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:14 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreStateMachine::serviceStop Mar 25 19:52:14 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1206 Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreCommandRouter::serviceStop Mar 25 19:52:14 minidsp-shd volumio[773]: info: ControllerMpd::stop Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand stop Mar 25 19:52:14 minidsp-shd volumio[773]: info: Mar 25 19:52:14 minidsp-shd volumio[773]: ---------------------------- MPD announces state update: player Mar 25 19:52:14 minidsp-shd volumio[773]: info: sendMpdCommand stop took 75 milliseconds Mar 25 19:52:14 minidsp-shd volumio[773]: info: ControllerMpd::getState Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreStateMachine::play index undefined Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 25 19:52:14 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1221 Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreStateMachine::startPlaybackTimer Mar 25 19:52:14 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1221 Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::clearAddPlayTracks USB/DISCO_1TB/FLAC/Best Audiophile Voices I/01 Jane Monheit - Over The Rainbow.m4a Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand stop Mar 25 19:52:14 minidsp-shd volumio[773]: info: Mar 25 19:52:14 minidsp-shd volumio[773]: ---------------------------- MPD announces state update: player Mar 25 19:52:14 minidsp-shd volumio[773]: info: ControllerMpd::getState Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:52:14 minidsp-shd volumio[773]: info: Mar 25 19:52:14 minidsp-shd volumio[773]: ---------------------------- MPD announces state update: player Mar 25 19:52:14 minidsp-shd volumio[773]: info: ControllerMpd::getState Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:52:14 minidsp-shd volumio[773]: info: sendMpdCommand status took 316 milliseconds Mar 25 19:52:14 minidsp-shd volumio[773]: info: sendMpdCommand stop took 289 milliseconds Mar 25 19:52:14 minidsp-shd volumio[773]: info: sendMpdCommand status took 15 milliseconds Mar 25 19:52:14 minidsp-shd volumio[773]: info: sendMpdCommand status took 9 milliseconds Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand clear Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 19:52:14 minidsp-shd volumio[773]: info: Mar 25 19:52:14 minidsp-shd volumio[773]: ---------------------------- MPD announces system playlist update Mar 25 19:52:14 minidsp-shd volumio[773]: info: Ignoring MPD Status Update Mar 25 19:52:14 minidsp-shd volumio[773]: info: sendMpdCommand playlistinfo took 69 milliseconds Mar 25 19:52:14 minidsp-shd volumio[773]: info: sendMpdCommand clear took 70 milliseconds Mar 25 19:52:14 minidsp-shd volumio[773]: info: sendMpdCommand playlistinfo took 70 milliseconds Mar 25 19:52:14 minidsp-shd volumio[773]: info: sendMpdCommand playlistinfo took 70 milliseconds Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::parseTrackInfo Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand add "USB/DISCO_1TB/FLAC/Best Audiophile Voices I/01 Jane Monheit - Over The Rainbow.m4a" Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::parseTrackInfo Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::parseTrackInfo Mar 25 19:52:14 minidsp-shd volumio[773]: info: ControllerMpd::pushState Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreCommandRouter::servicePushState Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:14 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1221 Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:14 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:14 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:14 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1221 Mar 25 19:52:14 minidsp-shd volumio[773]: 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":"Desperado","artist":"Emi Fujita","album":"Best Audiophile Voices II","uri":"USB/DISCO_1TB/FLAC/Best Audiophile Voices II/01 Emi Fujita - Desperado.m4a","trackType":"m4a"} Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: CURRENT POSITION 1221 Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreStateMachine::syncState stateService stop Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreStateMachine::syncState currentStatus stop Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:14 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1221 Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:14 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:14 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:14 minidsp-shd volumio[773]: info: No code Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:14 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1221 Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:14 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:14 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:14 minidsp-shd volumio[773]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 25 19:52:14 minidsp-shd volumio[773]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 25 19:52:14 minidsp-shd volumio[773]: info: ------------------------------ 559ms Mar 25 19:52:14 minidsp-shd volumio[773]: info: ------------------------------ 257ms Mar 25 19:52:14 minidsp-shd volumio[773]: info: ------------------------------ 251ms Mar 25 19:52:14 minidsp-shd volumio[773]: info: Mar 25 19:52:14 minidsp-shd volumio[773]: ---------------------------- MPD announces system playlist update Mar 25 19:52:14 minidsp-shd volumio[773]: info: Ignoring MPD Status Update Mar 25 19:52:14 minidsp-shd volumio[773]: info: Mar 25 19:52:14 minidsp-shd volumio[773]: ---------------------------- MPD announces system playlist update Mar 25 19:52:14 minidsp-shd volumio[773]: info: Ignoring MPD Status Update Mar 25 19:52:14 minidsp-shd volumio[773]: error: updateQueue error: null Mar 25 19:52:14 minidsp-shd volumio[773]: info: Mar 25 19:52:14 minidsp-shd volumio[773]: ---------------------------- MPD announces system playlist update Mar 25 19:52:14 minidsp-shd volumio[773]: info: Ignoring MPD Status Update Mar 25 19:52:14 minidsp-shd volumio[773]: info: ------------------------------ 257ms Mar 25 19:52:14 minidsp-shd volumio[773]: info: sendMpdCommand add "USB/DISCO_1TB/FLAC/Best Audiophile Voices I/01 Jane Monheit - Over The Rainbow.m4a" took 190 milliseconds Mar 25 19:52:14 minidsp-shd volumio[773]: info: ------------------------------ 33ms Mar 25 19:52:14 minidsp-shd volumio[773]: info: ------------------------------ 29ms Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand play Mar 25 19:52:14 minidsp-shd volumio[773]: info: Mar 25 19:52:14 minidsp-shd volumio[773]: ---------------------------- MPD announces system playlist update Mar 25 19:52:14 minidsp-shd volumio[773]: info: Ignoring MPD Status Update Mar 25 19:52:14 minidsp-shd volumio[773]: info: Mar 25 19:52:14 minidsp-shd volumio[773]: ---------------------------- MPD announces system playlist update Mar 25 19:52:14 minidsp-shd volumio[773]: info: Ignoring MPD Status Update Mar 25 19:52:14 minidsp-shd volumio[773]: info: ------------------------------ 60ms Mar 25 19:52:14 minidsp-shd volumio[773]: info: sendMpdCommand play took 54 milliseconds Mar 25 19:52:14 minidsp-shd volumio[773]: info: ------------------------------ 52ms Mar 25 19:52:14 minidsp-shd volumio[773]: info: ------------------------------ 49ms Mar 25 19:52:14 minidsp-shd volumio[773]: info: Mar 25 19:52:14 minidsp-shd volumio[773]: ---------------------------- MPD announces state update: player Mar 25 19:52:14 minidsp-shd volumio[773]: info: ControllerMpd::getState Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:52:14 minidsp-shd volumio[773]: info: Mar 25 19:52:14 minidsp-shd volumio[773]: ---------------------------- MPD announces state update: player Mar 25 19:52:14 minidsp-shd volumio[773]: info: ControllerMpd::getState Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:52:14 minidsp-shd volumio[773]: info: Mar 25 19:52:14 minidsp-shd volumio[773]: ---------------------------- MPD announces state update: player Mar 25 19:52:14 minidsp-shd volumio[773]: info: ControllerMpd::getState Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:52:14 minidsp-shd volumio[773]: info: Mar 25 19:52:14 minidsp-shd volumio[773]: ---------------------------- MPD announces state update: player Mar 25 19:52:14 minidsp-shd volumio[773]: info: sendMpdCommand status took 16 milliseconds Mar 25 19:52:14 minidsp-shd volumio[773]: info: ControllerMpd::getState Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:52:14 minidsp-shd volumio[773]: info: sendMpdCommand status took 14 milliseconds Mar 25 19:52:14 minidsp-shd volumio[773]: info: sendMpdCommand status took 9 milliseconds Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 19:52:14 minidsp-shd volumio[773]: info: Mar 25 19:52:14 minidsp-shd volumio[773]: ---------------------------- MPD announces state update: player Mar 25 19:52:14 minidsp-shd volumio[773]: info: ControllerMpd::getState Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:52:14 minidsp-shd volumio[773]: info: Mar 25 19:52:14 minidsp-shd volumio[773]: ---------------------------- MPD announces state update: player Mar 25 19:52:14 minidsp-shd volumio[773]: info: ControllerMpd::getState Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand status Mar 25 19:52:14 minidsp-shd volumio[773]: info: sendMpdCommand status took 26 milliseconds Mar 25 19:52:14 minidsp-shd volumio[773]: info: sendMpdCommand playlistinfo took 23 milliseconds Mar 25 19:52:14 minidsp-shd volumio[773]: info: sendMpdCommand playlistinfo took 21 milliseconds Mar 25 19:52:14 minidsp-shd volumio[773]: info: sendMpdCommand playlistinfo took 21 milliseconds Mar 25 19:52:14 minidsp-shd volumio[773]: info: sendMpdCommand status took 14 milliseconds Mar 25 19:52:14 minidsp-shd volumio[773]: info: sendMpdCommand status took 11 milliseconds Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::parseTrackInfo Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::parseTrackInfo Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::parseTrackInfo Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::parseState Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 19:52:14 minidsp-shd volumio[773]: info: ControllerMpd::pushState Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreCommandRouter::servicePushState Mar 25 19:52:14 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1221 Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":401,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Over The Rainbow","artist":"Jane Monheit","album":"Best Audiophile Voices","uri":"USB/DISCO_1TB/FLAC/Best Audiophile Voices I/01 Jane Monheit - Over The Rainbow.m4a","trackType":"m4a"} Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: CURRENT POSITION 1221 Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreStateMachine::syncState stateService play Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreStateMachine::syncState currentStatus stop Mar 25 19:52:14 minidsp-shd volumio[773]: info: ControllerMpd::pushState Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreCommandRouter::servicePushState Mar 25 19:52:14 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1221 Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":401,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Over The Rainbow","artist":"Jane Monheit","album":"Best Audiophile Voices","uri":"USB/DISCO_1TB/FLAC/Best Audiophile Voices I/01 Jane Monheit - Over The Rainbow.m4a","trackType":"m4a"} Mar 25 19:52:14 minidsp-shd volumio[773]: verbose: CURRENT POSITION 1221 Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreStateMachine::syncState stateService play Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreStateMachine::syncState currentStatus play Mar 25 19:52:14 minidsp-shd volumio[773]: info: Received an update from plugin. extracting info from payload Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:14 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1221 Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 19:52:14 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:15 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:15 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:15 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1221 Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:15 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:15 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:15 minidsp-shd volumio[773]: info: ControllerMpd::pushState Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreCommandRouter::servicePushState Mar 25 19:52:15 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1221 Mar 25 19:52:15 minidsp-shd volumio[773]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":401,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Over The Rainbow","artist":"Jane Monheit","album":"Best Audiophile Voices","uri":"USB/DISCO_1TB/FLAC/Best Audiophile Voices I/01 Jane Monheit - Over The Rainbow.m4a","trackType":"m4a"} Mar 25 19:52:15 minidsp-shd volumio[773]: verbose: CURRENT POSITION 1221 Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreStateMachine::syncState stateService play Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreStateMachine::syncState currentStatus play Mar 25 19:52:15 minidsp-shd volumio[773]: info: Received an update from plugin. extracting info from payload Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:15 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1221 Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:15 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:15 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:15 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1221 Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:15 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:15 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:15 minidsp-shd volumio[773]: info: ------------------------------ 147ms Mar 25 19:52:15 minidsp-shd volumio[773]: info: ------------------------------ 306ms Mar 25 19:52:15 minidsp-shd volumio[773]: info: ------------------------------ 304ms Mar 25 19:52:15 minidsp-shd volumio[773]: info: sendMpdCommand playlistinfo took 260 milliseconds Mar 25 19:52:15 minidsp-shd volumio[773]: info: sendMpdCommand playlistinfo took 256 milliseconds Mar 25 19:52:15 minidsp-shd volumio[773]: info: sendMpdCommand playlistinfo took 255 milliseconds Mar 25 19:52:15 minidsp-shd volumio[773]: verbose: ControllerMpd::parseTrackInfo Mar 25 19:52:15 minidsp-shd volumio[773]: verbose: ControllerMpd::parseTrackInfo Mar 25 19:52:15 minidsp-shd volumio[773]: verbose: ControllerMpd::parseTrackInfo Mar 25 19:52:15 minidsp-shd volumio[773]: info: ControllerMpd::pushState Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreCommandRouter::servicePushState Mar 25 19:52:15 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1221 Mar 25 19:52:15 minidsp-shd volumio[773]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1075,"duration":401,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"765 Kbps","isStreaming":false,"title":"Over The Rainbow","artist":"Jane Monheit","album":"Best Audiophile Voices","uri":"USB/DISCO_1TB/FLAC/Best Audiophile Voices I/01 Jane Monheit - Over The Rainbow.m4a","trackType":"m4a"} Mar 25 19:52:15 minidsp-shd volumio[773]: verbose: CURRENT POSITION 1221 Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreStateMachine::syncState stateService play Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreStateMachine::syncState currentStatus play Mar 25 19:52:15 minidsp-shd volumio[773]: info: Received an update from plugin. extracting info from payload Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:15 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1221 Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:15 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:15 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:15 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1221 Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:15 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:15 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:15 minidsp-shd volumio[773]: info: ControllerMpd::pushState Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreCommandRouter::servicePushState Mar 25 19:52:15 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1221 Mar 25 19:52:15 minidsp-shd volumio[773]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":401,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"765 Kbps","isStreaming":false,"title":"Over The Rainbow","artist":"Jane Monheit","album":"Best Audiophile Voices","uri":"USB/DISCO_1TB/FLAC/Best Audiophile Voices I/01 Jane Monheit - Over The Rainbow.m4a","trackType":"m4a"} Mar 25 19:52:15 minidsp-shd volumio[773]: verbose: CURRENT POSITION 1221 Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreStateMachine::syncState stateService play Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreStateMachine::syncState currentStatus play Mar 25 19:52:15 minidsp-shd volumio[773]: info: Received an update from plugin. extracting info from payload Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:15 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1221 Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:15 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:15 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:15 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1221 Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:15 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:15 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:15 minidsp-shd volumio[773]: info: ControllerMpd::pushState Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreCommandRouter::servicePushState Mar 25 19:52:15 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1221 Mar 25 19:52:15 minidsp-shd volumio[773]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":401,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"765 Kbps","isStreaming":false,"title":"Over The Rainbow","artist":"Jane Monheit","album":"Best Audiophile Voices","uri":"USB/DISCO_1TB/FLAC/Best Audiophile Voices I/01 Jane Monheit - Over The Rainbow.m4a","trackType":"m4a"} Mar 25 19:52:15 minidsp-shd volumio[773]: verbose: CURRENT POSITION 1221 Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreStateMachine::syncState stateService play Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreStateMachine::syncState currentStatus play Mar 25 19:52:15 minidsp-shd volumio[773]: info: Received an update from plugin. extracting info from payload Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:15 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1221 Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:15 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:15 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:15 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1221 Mar 25 19:52:15 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:15 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:15 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:15 minidsp-shd volumio[773]: info: ------------------------------ 648ms Mar 25 19:52:15 minidsp-shd volumio[773]: info: ------------------------------ 631ms Mar 25 19:52:15 minidsp-shd volumio[773]: info: ------------------------------ 628ms Mar 25 19:52:23 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: inputs , setVolume Mar 25 19:52:23 minidsp-shd volumio[773]: info: msSurfaceDial volumioupdatevolume callback: {"vol":95,"dbVolume":-6.5,"mute":false,"disableVolumeControl":false} Mar 25 19:52:23 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:23 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1221 Mar 25 19:52:23 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 19:52:23 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:23 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:23 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:25 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: inputs , setVolume Mar 25 19:52:25 minidsp-shd volumio[773]: info: msSurfaceDial volumioupdatevolume callback: {"vol":90,"dbVolume":-12.5,"mute":false,"disableVolumeControl":false} Mar 25 19:52:25 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:25 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1221 Mar 25 19:52:25 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 19:52:25 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:25 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:25 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:27 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: inputs , setVolume Mar 25 19:52:27 minidsp-shd volumio[773]: info: msSurfaceDial volumioupdatevolume callback: {"vol":85,"dbVolume":-19,"mute":false,"disableVolumeControl":false} Mar 25 19:52:27 minidsp-shd volumio[773]: info: CoreStateMachine::pushState Mar 25 19:52:27 minidsp-shd volumio[773]: info: CorePlayQueue::getTrack 1221 Mar 25 19:52:27 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 19:52:27 minidsp-shd volumio[773]: info: CoreCommandRouter::volumioPushState Mar 25 19:52:27 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output update for this device Mar 25 19:52:27 minidsp-shd volumio[773]: info: MRS: Pushing multiroomSync output Mar 25 19:52:39 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:39 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:39 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:39 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:39 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:39 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:39 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:39 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:39 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:39 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:39 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:39 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:39 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:39 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:39 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:39 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:40 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:40 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:40 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:40 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:40 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:40 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:40 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:40 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:40 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:40 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:40 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:40 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:40 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:40 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:40 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:40 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:40 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:40 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:40 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:40 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:40 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:40 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:40 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:40 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:40 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:40 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:40 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:40 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:40 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:40 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:40 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:40 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:41 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:41 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:41 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:41 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:41 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:41 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:41 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:41 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:43 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:43 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:44 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:44 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:44 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:44 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:44 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:44 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:44 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:44 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:44 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:44 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:44 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:44 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:44 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:44 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:45 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:45 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:45 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:45 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:45 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:45 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:45 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:45 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:45 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Mar 25 19:52:45 minidsp-shd volumio[773]: error: MRS: impossible to set browserPlayback volume: device not found Mar 25 19:52:48 minidsp-shd volumio[773]: info: CoreCommandRouter::executeOnPlugin: multiroom , audioOutputPause Mar 25 19:52:48 minidsp-shd volumio[773]: info: Error : CoreCommandRouter::executeOnPlugin: No method [audioOutputPause] in plugin multiroom Mar 25 19:52:48 minidsp-shd volumio[773]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 25 19:52:48 minidsp-shd volumio[773]: TypeError: Cannot read property 'then' of undefined Mar 25 19:52:48 minidsp-shd volumio[773]: at outputs.audioOutputPause (/volumio/app/plugins/audio_interface/outputs/index.js:417:9) Mar 25 19:52:48 minidsp-shd volumio[773]: at CoreCommandRouter.audioOutputPause (/volumio/app/index.js:2290:30) Mar 25 19:52:48 minidsp-shd volumio[773]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1473:26) Mar 25 19:52:48 minidsp-shd volumio[773]: at Socket.emit (events.js:400:28) Mar 25 19:52:48 minidsp-shd volumio[773]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Mar 25 19:52:48 minidsp-shd volumio[773]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Mar 25 19:52:48 minidsp-shd volumio[773]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 25 19:52:49 minidsp-shd sudo[3620]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-25 19:51 Mar 25 19:52:49 minidsp-shd sudo[3620]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="3dada8b1e619a5feb94867e0865ace17474d7bce" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="30045b259d1a704a832ca7c1460c1fdfa4b723f9" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="minidspshd" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 05 Mar 2026 11:08:05 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_DEVICENAME="Nanopi Neo3" VOLUMIO_VENDOR="miniDSP" VOLUMIO_MODEL="SHD" VOLUMIO_VENDOR_MODEL="miniDSP SHD" VOLUMIO_HASH="2435172a9e07e22ce77410ca4817b0fa"