-- Logs begin at Wed 2024-09-04 00:04:10 HKT, end at Wed 2024-09-04 21:14:38 HKT. -- Sep 04 21:13:00 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 21:13:05 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 21:13:10 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 21:13:12 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 04 21:13:12 volumio volumio[1298]: info: CURURI: artists:// Sep 04 21:13:12 volumio volumio[1298]: info: Preload queue cleared Sep 04 21:13:15 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 21:13:17 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 04 21:13:17 volumio volumio[1298]: info: CURURI: artists://Dr.%20Mad Sep 04 21:13:17 volumio volumio[1298]: info: Preload queue cleared Sep 04 21:13:17 volumio volumio[1298]: info: Preload queue cleared Sep 04 21:13:17 volumio volumio[1298]: info: No valid Plugin REST Endpoint Sep 04 21:13:17 volumio volumio[1298]: info: No valid Plugin REST Endpoint Sep 04 21:13:20 volumio volumio[1298]: info: Preload queue cleared Sep 04 21:13:20 volumio volumio[1298]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 04 21:13:20 volumio volumio[1298]: info: CoreStateMachine::ClearQueue Sep 04 21:13:20 volumio volumio[1298]: info: CoreStateMachine::stop Sep 04 21:13:20 volumio volumio[1298]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 21:13:20 volumio volumio[1298]: info: CoreStateMachine::stPlaybackTimer Sep 04 21:13:20 volumio volumio[1298]: info: CoreStateMachine::updateTrackBlock Sep 04 21:13:20 volumio volumio[1298]: info: CorePlayQueue::getTrackBlock Sep 04 21:13:20 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:13:20 volumio volumio[1298]: info: CorePlayQueue::getTrack 6 Sep 04 21:13:20 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 21:13:20 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:13:20 volumio volumio[1298]: info: CoreStateMachine::serviceStop Sep 04 21:13:20 volumio volumio[1298]: info: CorePlayQueue::getTrack 6 Sep 04 21:13:20 volumio volumio[1298]: info: CoreCommandRouter::serviceStop Sep 04 21:13:20 volumio volumio[1298]: info: ControllerMpd::stop Sep 04 21:13:20 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand stop Sep 04 21:13:20 volumio volumio[1298]: info: CorePlayQueue::clearPlayQueue Sep 04 21:13:20 volumio volumio[1298]: info: CorePlayQueue::saveQueue Sep 04 21:13:20 volumio volumio[1298]: info: CoreCommandRouter::volumioPushQueue Sep 04 21:13:20 volumio volumio[1298]: info: CoreStateMachine::addQueueItems Sep 04 21:13:20 volumio volumio[1298]: info: CorePlayQueue::addQueueItems Sep 04 21:13:20 volumio volumio[1298]: info: Preload queue cleared Sep 04 21:13:20 volumio volumio[1298]: info: Adding Item to queue: music-library/USB/D512/Ring Tone/Road trip.ogg Sep 04 21:13:20 volumio volumio[1298]: info: Using cached record of: music-library/USB/D512/Ring Tone/Road trip.ogg Sep 04 21:13:20 volumio volumio[1298]: info: CoreCommandRouter::volumioPushQueue Sep 04 21:13:20 volumio volumio[1298]: info: CorePlayQueue::saveQueue Sep 04 21:13:20 volumio volumio[1298]: info: CoreStateMachine::updateTrackBlock Sep 04 21:13:20 volumio volumio[1298]: info: CorePlayQueue::getTrackBlock Sep 04 21:13:20 volumio volumio[1298]: info: CoreCommandRouter::volumioPlay Sep 04 21:13:20 volumio volumio[1298]: info: CoreStateMachine::play index 0 Sep 04 21:13:20 volumio volumio[1298]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 21:13:20 volumio volumio[1298]: info: CoreStateMachine::stop Sep 04 21:13:20 volumio volumio[1298]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 21:13:20 volumio volumio[1298]: info: CoreStateMachine::play index undefined Sep 04 21:13:20 volumio volumio[1298]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 21:13:20 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:20 volumio volumio[1298]: info: CoreStateMachine::startPlaybackTimer Sep 04 21:13:20 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:20 volumio volumio[1298]: verbose: ControllerMpd::clearAddPlayTracks USB/D512/Ring Tone/Road trip.ogg Sep 04 21:13:20 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand stop Sep 04 21:13:20 volumio volumio[1298]: info: Sep 04 21:13:20 volumio volumio[1298]: ---------------------------- MPD announces state update: player Sep 04 21:13:20 volumio volumio[1298]: info: sendMpdCommand stop took 22 milliseconds Sep 04 21:13:20 volumio volumio[1298]: info: ControllerMpd::getState Sep 04 21:13:20 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand status Sep 04 21:13:20 volumio volumio[1298]: info: sendMpdCommand stop took 9 milliseconds Sep 04 21:13:20 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand clear Sep 04 21:13:20 volumio volumio[1298]: info: Sep 04 21:13:20 volumio volumio[1298]: ---------------------------- MPD announces system playlist update Sep 04 21:13:20 volumio volumio[1298]: info: Ignoring MPD Status Update Sep 04 21:13:20 volumio volumio[1298]: info: sendMpdCommand status took 2 milliseconds Sep 04 21:13:20 volumio volumio[1298]: info: sendMpdCommand clear took 1 milliseconds Sep 04 21:13:20 volumio volumio[1298]: verbose: ControllerMpd::parseState Sep 04 21:13:20 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 21:13:20 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand add "USB/D512/Ring Tone/Road trip.ogg" Sep 04 21:13:20 volumio volumio[1298]: error: updateQueue error: null Sep 04 21:13:20 volumio volumio[1298]: info: Sep 04 21:13:20 volumio volumio[1298]: ---------------------------- MPD announces system playlist update Sep 04 21:13:20 volumio volumio[1298]: info: Ignoring MPD Status Update Sep 04 21:13:20 volumio volumio[1298]: info: ------------------------------ 2ms Sep 04 21:13:20 volumio volumio[1298]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 04 21:13:20 volumio volumio[1298]: info: sendMpdCommand add "USB/D512/Ring Tone/Road trip.ogg" took 1 milliseconds Sep 04 21:13:20 volumio volumio[1298]: verbose: ControllerMpd::parseTrackInfo Sep 04 21:13:20 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand play Sep 04 21:13:20 volumio volumio[1298]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 04 21:13:20 volumio volumio[1298]: info: ------------------------------ 6ms Sep 04 21:13:20 volumio volumio[1298]: info: ------------------------------ 2ms Sep 04 21:13:20 volumio volumio[1298]: info: sendMpdCommand play took 1 milliseconds Sep 04 21:13:20 volumio volumio[1298]: info: Sep 04 21:13:20 volumio volumio[1298]: ---------------------------- MPD announces state update: player Sep 04 21:13:20 volumio volumio[1298]: info: ControllerMpd::getState Sep 04 21:13:20 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand status Sep 04 21:13:20 volumio volumio[1298]: info: Sep 04 21:13:20 volumio volumio[1298]: ---------------------------- MPD announces state update: player Sep 04 21:13:20 volumio volumio[1298]: info: ControllerMpd::getState Sep 04 21:13:20 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand status Sep 04 21:13:20 volumio volumio[1298]: info: sendMpdCommand status took 3 milliseconds Sep 04 21:13:20 volumio volumio[1298]: verbose: ControllerMpd::parseState Sep 04 21:13:20 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 21:13:20 volumio volumio[1298]: info: sendMpdCommand status took 3 milliseconds Sep 04 21:13:20 volumio volumio[1298]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 04 21:13:20 volumio volumio[1298]: verbose: ControllerMpd::parseState Sep 04 21:13:20 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 21:13:20 volumio volumio[1298]: verbose: ControllerMpd::parseTrackInfo Sep 04 21:13:20 volumio volumio[1298]: info: ControllerMpd::pushState Sep 04 21:13:20 volumio volumio[1298]: info: CoreCommandRouter::servicePushState Sep 04 21:13:20 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:20 volumio volumio[1298]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":5,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Road trip","artist":"Dr. Mad","album":null,"uri":"USB/D512/Ring Tone/Road trip.ogg","trackType":"ogg"} Sep 04 21:13:20 volumio volumio[1298]: verbose: CURRENT POSITION 0 Sep 04 21:13:20 volumio volumio[1298]: info: CoreStateMachine::syncState stateService play Sep 04 21:13:20 volumio volumio[1298]: info: CoreStateMachine::syncState currentStatus stop Sep 04 21:13:20 volumio volumio[1298]: info: ------------------------------ 10ms Sep 04 21:13:20 volumio volumio[1298]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 04 21:13:20 volumio volumio[1298]: verbose: ControllerMpd::parseTrackInfo Sep 04 21:13:20 volumio volumio[1298]: info: ControllerMpd::pushState Sep 04 21:13:20 volumio volumio[1298]: info: CoreCommandRouter::servicePushState Sep 04 21:13:20 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:20 volumio volumio[1298]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":5,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Road trip","artist":"Dr. Mad","album":null,"uri":"USB/D512/Ring Tone/Road trip.ogg","trackType":"ogg"} Sep 04 21:13:20 volumio volumio[1298]: verbose: CURRENT POSITION 0 Sep 04 21:13:20 volumio volumio[1298]: info: CoreStateMachine::syncState stateService play Sep 04 21:13:20 volumio volumio[1298]: info: CoreStateMachine::syncState currentStatus play Sep 04 21:13:20 volumio volumio[1298]: info: Received an update from plugin. extracting info from payload Sep 04 21:13:20 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:13:20 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:20 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 21:13:20 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:13:20 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:13:20 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:20 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:13:20 volumio volumio[1298]: info: ------------------------------ 35ms Sep 04 21:13:20 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 21:13:20 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:20 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:20 volumio volumio[1298]: info: Prefetching next song Sep 04 21:13:20 volumio volumio[1298]: info: DOING PREFETCH IN MPD Sep 04 21:13:20 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand add "USB/D512/Ring Tone/Road trip.ogg" Sep 04 21:13:20 volumio volumio[1298]: info: Sep 04 21:13:20 volumio volumio[1298]: ---------------------------- MPD announces system playlist update Sep 04 21:13:20 volumio volumio[1298]: info: Ignoring MPD Status Update Sep 04 21:13:20 volumio volumio[1298]: info: sendMpdCommand add "USB/D512/Ring Tone/Road trip.ogg" took 2 milliseconds Sep 04 21:13:20 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand consume 1 Sep 04 21:13:20 volumio volumio[1298]: info: ------------------------------ 2ms Sep 04 21:13:20 volumio volumio[1298]: info: sendMpdCommand consume 1 took 1 milliseconds Sep 04 21:13:24 volumio volumio[1298]: info: CoreStateMachine::startPlaybackTimer Sep 04 21:13:24 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:24 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:24 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:24 volumio volumio[1298]: info: Prefetching next song Sep 04 21:13:24 volumio volumio[1298]: info: DOING PREFETCH IN MPD Sep 04 21:13:24 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand add "USB/D512/Ring Tone/Road trip.ogg" Sep 04 21:13:24 volumio volumio[1298]: info: Sep 04 21:13:24 volumio volumio[1298]: ---------------------------- MPD announces system playlist update Sep 04 21:13:24 volumio volumio[1298]: info: Ignoring MPD Status Update Sep 04 21:13:24 volumio volumio[1298]: info: sendMpdCommand add "USB/D512/Ring Tone/Road trip.ogg" took 1 milliseconds Sep 04 21:13:24 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand consume 1 Sep 04 21:13:24 volumio volumio[1298]: info: ------------------------------ 1ms Sep 04 21:13:24 volumio volumio[1298]: info: sendMpdCommand consume 1 took 1 milliseconds Sep 04 21:13:24 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:13:24 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:24 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 21:13:24 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:13:25 volumio volumio[1298]: info: Sep 04 21:13:25 volumio volumio[1298]: ---------------------------- MPD announces system playlist update Sep 04 21:13:25 volumio volumio[1298]: info: Ignoring MPD Status Update Sep 04 21:13:25 volumio volumio[1298]: info: Sep 04 21:13:25 volumio volumio[1298]: ---------------------------- MPD announces state update: player Sep 04 21:13:25 volumio volumio[1298]: info: ControllerMpd::getState Sep 04 21:13:25 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand status Sep 04 21:13:25 volumio volumio[1298]: info: ------------------------------ 2ms Sep 04 21:13:25 volumio volumio[1298]: info: sendMpdCommand status took 1 milliseconds Sep 04 21:13:25 volumio volumio[1298]: verbose: ControllerMpd::parseState Sep 04 21:13:25 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 21:13:25 volumio volumio[1298]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 04 21:13:25 volumio volumio[1298]: verbose: ControllerMpd::parseTrackInfo Sep 04 21:13:25 volumio volumio[1298]: info: ControllerMpd::pushState Sep 04 21:13:25 volumio volumio[1298]: info: CoreCommandRouter::servicePushState Sep 04 21:13:25 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:25 volumio volumio[1298]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":5,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Road trip","artist":"Dr. Mad","album":null,"uri":"USB/D512/Ring Tone/Road trip.ogg","trackType":"ogg"} Sep 04 21:13:25 volumio volumio[1298]: verbose: CURRENT POSITION 0 Sep 04 21:13:25 volumio volumio[1298]: info: CoreStateMachine::syncState stateService play Sep 04 21:13:25 volumio volumio[1298]: info: CoreStateMachine::syncState currentStatus play Sep 04 21:13:25 volumio volumio[1298]: info: Received an update from plugin. extracting info from payload Sep 04 21:13:25 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:13:25 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:25 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 21:13:25 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:13:25 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:13:25 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:25 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:13:25 volumio volumio[1298]: info: ------------------------------ 19ms Sep 04 21:13:25 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 21:13:26 volumio volumio[1298]: info: MPD Database updated - AlbumList cache refreshed Sep 04 21:13:26 volumio volumio[1298]: info: Sep 04 21:13:26 volumio volumio[1298]: ---------------------------- MPD announces state update: database Sep 04 21:13:26 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand status Sep 04 21:13:26 volumio volumio[1298]: info: Sep 04 21:13:26 volumio volumio[1298]: ---------------------------- MPD announces state update: update Sep 04 21:13:26 volumio volumio[1298]: info: ControllerMpd::getState Sep 04 21:13:26 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand status Sep 04 21:13:26 volumio volumio[1298]: info: ControllerMpd::getState Sep 04 21:13:26 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand status Sep 04 21:13:26 volumio volumio[1298]: info: sendMpdCommand status took 37 milliseconds Sep 04 21:13:26 volumio volumio[1298]: verbose: ControllerMpd::parseState Sep 04 21:13:26 volumio volumio[1298]: info: Command Router : Notfying DB Updatefalse Sep 04 21:13:26 volumio volumio[1298]: info: CoreCommandRouter::Close All Modals sent Sep 04 21:13:26 volumio volumio[1298]: info: sendMpdCommand status took 113 milliseconds Sep 04 21:13:26 volumio volumio[1298]: info: sendMpdCommand status took 112 milliseconds Sep 04 21:13:26 volumio volumio[1298]: verbose: ControllerMpd::parseState Sep 04 21:13:26 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 21:13:26 volumio volumio[1298]: verbose: ControllerMpd::parseState Sep 04 21:13:26 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 21:13:26 volumio volumio[1298]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 04 21:13:26 volumio volumio[1298]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 04 21:13:26 volumio volumio[1298]: verbose: ControllerMpd::parseTrackInfo Sep 04 21:13:26 volumio volumio[1298]: verbose: ControllerMpd::parseTrackInfo Sep 04 21:13:26 volumio volumio[1298]: info: ControllerMpd::pushState Sep 04 21:13:26 volumio volumio[1298]: info: CoreCommandRouter::servicePushState Sep 04 21:13:26 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:26 volumio volumio[1298]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":5,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Road trip","artist":"Dr. Mad","album":null,"uri":"USB/D512/Ring Tone/Road trip.ogg","trackType":"ogg"} Sep 04 21:13:26 volumio volumio[1298]: verbose: CURRENT POSITION 0 Sep 04 21:13:26 volumio volumio[1298]: info: CoreStateMachine::syncState stateService play Sep 04 21:13:26 volumio volumio[1298]: info: CoreStateMachine::syncState currentStatus play Sep 04 21:13:26 volumio volumio[1298]: info: Received an update from plugin. extracting info from payload Sep 04 21:13:26 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:13:26 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:26 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 21:13:26 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:13:26 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:13:26 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:26 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:13:26 volumio volumio[1298]: info: ControllerMpd::pushState Sep 04 21:13:26 volumio volumio[1298]: info: CoreCommandRouter::servicePushState Sep 04 21:13:26 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:26 volumio volumio[1298]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":5,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Road trip","artist":"Dr. Mad","album":null,"uri":"USB/D512/Ring Tone/Road trip.ogg","trackType":"ogg"} Sep 04 21:13:26 volumio volumio[1298]: verbose: CURRENT POSITION 0 Sep 04 21:13:26 volumio volumio[1298]: info: CoreStateMachine::syncState stateService play Sep 04 21:13:26 volumio volumio[1298]: info: CoreStateMachine::syncState currentStatus play Sep 04 21:13:26 volumio volumio[1298]: info: Received an update from plugin. extracting info from payload Sep 04 21:13:26 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:13:26 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:26 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:13:26 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:13:26 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:26 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:13:26 volumio volumio[1298]: info: ------------------------------ 136ms Sep 04 21:13:26 volumio volumio[1298]: info: ------------------------------ 136ms Sep 04 21:13:28 volumio volumio[1298]: info: CoreStateMachine::startPlaybackTimer Sep 04 21:13:28 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:28 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:28 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:28 volumio volumio[1298]: info: Prefetching next song Sep 04 21:13:28 volumio volumio[1298]: info: DOING PREFETCH IN MPD Sep 04 21:13:28 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand add "USB/D512/Ring Tone/Road trip.ogg" Sep 04 21:13:28 volumio volumio[1298]: info: Sep 04 21:13:28 volumio volumio[1298]: ---------------------------- MPD announces system playlist update Sep 04 21:13:28 volumio volumio[1298]: info: Ignoring MPD Status Update Sep 04 21:13:28 volumio volumio[1298]: info: sendMpdCommand add "USB/D512/Ring Tone/Road trip.ogg" took 1 milliseconds Sep 04 21:13:28 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand consume 1 Sep 04 21:13:28 volumio volumio[1298]: info: ------------------------------ 1ms Sep 04 21:13:28 volumio volumio[1298]: info: sendMpdCommand consume 1 took 1 milliseconds Sep 04 21:13:29 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 04 21:13:29 volumio volumio[1298]: info: CURURI: artists:// Sep 04 21:13:29 volumio volumio[1298]: info: Preload queue cleared Sep 04 21:13:29 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:13:29 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:29 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 21:13:29 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:13:30 volumio volumio[1298]: info: Sep 04 21:13:30 volumio volumio[1298]: ---------------------------- MPD announces system playlist update Sep 04 21:13:30 volumio volumio[1298]: info: Ignoring MPD Status Update Sep 04 21:13:30 volumio volumio[1298]: info: Sep 04 21:13:30 volumio volumio[1298]: ---------------------------- MPD announces state update: player Sep 04 21:13:30 volumio volumio[1298]: info: ControllerMpd::getState Sep 04 21:13:30 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand status Sep 04 21:13:30 volumio volumio[1298]: info: ------------------------------ 3ms Sep 04 21:13:30 volumio volumio[1298]: info: sendMpdCommand status took 2 milliseconds Sep 04 21:13:30 volumio volumio[1298]: verbose: ControllerMpd::parseState Sep 04 21:13:30 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 21:13:30 volumio volumio[1298]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 04 21:13:30 volumio volumio[1298]: verbose: ControllerMpd::parseTrackInfo Sep 04 21:13:30 volumio volumio[1298]: info: ControllerMpd::pushState Sep 04 21:13:30 volumio volumio[1298]: info: CoreCommandRouter::servicePushState Sep 04 21:13:30 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:30 volumio volumio[1298]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":5,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Road trip","artist":"Dr. Mad","album":null,"uri":"USB/D512/Ring Tone/Road trip.ogg","trackType":"ogg"} Sep 04 21:13:30 volumio volumio[1298]: verbose: CURRENT POSITION 0 Sep 04 21:13:30 volumio volumio[1298]: info: CoreStateMachine::syncState stateService play Sep 04 21:13:30 volumio volumio[1298]: info: CoreStateMachine::syncState currentStatus play Sep 04 21:13:30 volumio volumio[1298]: info: Received an update from plugin. extracting info from payload Sep 04 21:13:30 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:13:30 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:30 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 21:13:30 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:13:30 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:13:30 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:30 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:13:30 volumio volumio[1298]: info: ------------------------------ 23ms Sep 04 21:13:30 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 21:13:33 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 04 21:13:33 volumio volumio[1298]: info: CURURI: artists://Andy%20Lau Sep 04 21:13:33 volumio volumio[1298]: info: Preload queue cleared Sep 04 21:13:33 volumio volumio[1298]: info: Preload queue cleared Sep 04 21:13:33 volumio volumio[1298]: info: CoreStateMachine::startPlaybackTimer Sep 04 21:13:33 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:33 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:33 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:33 volumio volumio[1298]: info: Prefetching next song Sep 04 21:13:33 volumio volumio[1298]: info: DOING PREFETCH IN MPD Sep 04 21:13:33 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand add "USB/D512/Ring Tone/Road trip.ogg" Sep 04 21:13:33 volumio volumio[1298]: info: sendMpdCommand add "USB/D512/Ring Tone/Road trip.ogg" took 0 milliseconds Sep 04 21:13:33 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand consume 1 Sep 04 21:13:33 volumio volumio[1298]: info: Sep 04 21:13:33 volumio volumio[1298]: ---------------------------- MPD announces system playlist update Sep 04 21:13:33 volumio volumio[1298]: info: Ignoring MPD Status Update Sep 04 21:13:33 volumio volumio[1298]: info: sendMpdCommand consume 1 took 1 milliseconds Sep 04 21:13:33 volumio volumio[1298]: info: ------------------------------ 1ms Sep 04 21:13:33 volumio volumio[1298]: info: No valid Plugin REST Endpoint Sep 04 21:13:33 volumio volumio[1298]: info: No valid Plugin REST Endpoint Sep 04 21:13:33 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:13:33 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:33 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 21:13:33 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:13:35 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 21:13:36 volumio volumio[1298]: info: Sep 04 21:13:36 volumio volumio[1298]: ---------------------------- MPD announces system playlist update Sep 04 21:13:36 volumio volumio[1298]: info: Ignoring MPD Status Update Sep 04 21:13:36 volumio volumio[1298]: info: Sep 04 21:13:36 volumio volumio[1298]: ---------------------------- MPD announces state update: player Sep 04 21:13:36 volumio volumio[1298]: info: ControllerMpd::getState Sep 04 21:13:36 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand status Sep 04 21:13:36 volumio volumio[1298]: info: ------------------------------ 2ms Sep 04 21:13:36 volumio volumio[1298]: info: sendMpdCommand status took 1 milliseconds Sep 04 21:13:36 volumio volumio[1298]: verbose: ControllerMpd::parseState Sep 04 21:13:36 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 21:13:36 volumio volumio[1298]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 04 21:13:36 volumio volumio[1298]: verbose: ControllerMpd::parseTrackInfo Sep 04 21:13:36 volumio volumio[1298]: info: ControllerMpd::pushState Sep 04 21:13:36 volumio volumio[1298]: info: CoreCommandRouter::servicePushState Sep 04 21:13:36 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:36 volumio volumio[1298]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":5,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Road trip","artist":"Dr. Mad","album":null,"uri":"USB/D512/Ring Tone/Road trip.ogg","trackType":"ogg"} Sep 04 21:13:36 volumio volumio[1298]: verbose: CURRENT POSITION 0 Sep 04 21:13:36 volumio volumio[1298]: info: CoreStateMachine::syncState stateService play Sep 04 21:13:36 volumio volumio[1298]: info: CoreStateMachine::syncState currentStatus play Sep 04 21:13:36 volumio volumio[1298]: info: Received an update from plugin. extracting info from payload Sep 04 21:13:36 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:13:36 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:36 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 21:13:36 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:13:36 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:13:36 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:36 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:13:36 volumio volumio[1298]: info: ------------------------------ 8ms Sep 04 21:13:37 volumio volumio[1298]: info: CoreStateMachine::startPlaybackTimer Sep 04 21:13:37 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:37 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:37 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:37 volumio volumio[1298]: info: Prefetching next song Sep 04 21:13:37 volumio volumio[1298]: info: DOING PREFETCH IN MPD Sep 04 21:13:37 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand add "USB/D512/Ring Tone/Road trip.ogg" Sep 04 21:13:37 volumio volumio[1298]: info: Sep 04 21:13:37 volumio volumio[1298]: ---------------------------- MPD announces system playlist update Sep 04 21:13:37 volumio volumio[1298]: info: Ignoring MPD Status Update Sep 04 21:13:37 volumio volumio[1298]: info: sendMpdCommand add "USB/D512/Ring Tone/Road trip.ogg" took 1 milliseconds Sep 04 21:13:37 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand consume 1 Sep 04 21:13:37 volumio volumio[1298]: info: ------------------------------ 1ms Sep 04 21:13:37 volumio volumio[1298]: info: sendMpdCommand consume 1 took 1 milliseconds Sep 04 21:13:38 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:13:38 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:38 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 21:13:38 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:13:39 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 04 21:13:39 volumio volumio[1298]: info: CURURI: artists://Andy%20Lau/Everyone%20Is%20No.%201 Sep 04 21:13:39 volumio volumio[1298]: info: Preload queue cleared Sep 04 21:13:39 volumio volumio[1298]: info: No valid Plugin REST Endpoint Sep 04 21:13:39 volumio volumio[1298]: info: No valid Plugin REST Endpoint Sep 04 21:13:40 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 21:13:41 volumio volumio[1298]: info: Sep 04 21:13:41 volumio volumio[1298]: ---------------------------- MPD announces system playlist update Sep 04 21:13:41 volumio volumio[1298]: info: Ignoring MPD Status Update Sep 04 21:13:41 volumio volumio[1298]: info: Sep 04 21:13:41 volumio volumio[1298]: ---------------------------- MPD announces state update: player Sep 04 21:13:41 volumio volumio[1298]: info: ControllerMpd::getState Sep 04 21:13:41 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand status Sep 04 21:13:41 volumio volumio[1298]: info: ------------------------------ 2ms Sep 04 21:13:41 volumio volumio[1298]: info: sendMpdCommand status took 1 milliseconds Sep 04 21:13:41 volumio volumio[1298]: verbose: ControllerMpd::parseState Sep 04 21:13:41 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 21:13:41 volumio volumio[1298]: info: sendMpdCommand playlistinfo took 0 milliseconds Sep 04 21:13:41 volumio volumio[1298]: verbose: ControllerMpd::parseTrackInfo Sep 04 21:13:41 volumio volumio[1298]: info: ControllerMpd::pushState Sep 04 21:13:41 volumio volumio[1298]: info: CoreCommandRouter::servicePushState Sep 04 21:13:41 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:41 volumio volumio[1298]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":5,"samplerate":44.1,"bitdepth":"32 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Road trip","artist":"Dr. Mad","album":null,"uri":"USB/D512/Ring Tone/Road trip.ogg","trackType":"ogg"} Sep 04 21:13:41 volumio volumio[1298]: verbose: CURRENT POSITION 0 Sep 04 21:13:41 volumio volumio[1298]: info: CoreStateMachine::syncState stateService play Sep 04 21:13:41 volumio volumio[1298]: info: CoreStateMachine::syncState currentStatus play Sep 04 21:13:41 volumio volumio[1298]: info: Received an update from plugin. extracting info from payload Sep 04 21:13:41 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:13:41 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:41 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 21:13:41 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:13:41 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:13:41 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:41 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:13:41 volumio volumio[1298]: info: ------------------------------ 11ms Sep 04 21:13:42 volumio volumio[1298]: info: CoreStateMachine::startPlaybackTimer Sep 04 21:13:42 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:42 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:42 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:42 volumio volumio[1298]: info: Prefetching next song Sep 04 21:13:42 volumio volumio[1298]: info: DOING PREFETCH IN MPD Sep 04 21:13:42 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand add "USB/D512/Ring Tone/Road trip.ogg" Sep 04 21:13:42 volumio volumio[1298]: info: sendMpdCommand add "USB/D512/Ring Tone/Road trip.ogg" took 1 milliseconds Sep 04 21:13:42 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand consume 1 Sep 04 21:13:42 volumio volumio[1298]: info: Sep 04 21:13:42 volumio volumio[1298]: ---------------------------- MPD announces system playlist update Sep 04 21:13:42 volumio volumio[1298]: info: Ignoring MPD Status Update Sep 04 21:13:42 volumio volumio[1298]: info: sendMpdCommand consume 1 took 0 milliseconds Sep 04 21:13:42 volumio volumio[1298]: info: ------------------------------ 1ms Sep 04 21:13:42 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:13:42 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:42 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 21:13:42 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:13:43 volumio volumio[1298]: info: Preload queue cleared Sep 04 21:13:43 volumio volumio[1298]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 04 21:13:43 volumio volumio[1298]: info: CoreStateMachine::ClearQueue Sep 04 21:13:43 volumio volumio[1298]: info: CoreStateMachine::stop Sep 04 21:13:43 volumio volumio[1298]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 21:13:43 volumio volumio[1298]: info: CoreStateMachine::stPlaybackTimer Sep 04 21:13:43 volumio volumio[1298]: info: CoreStateMachine::updateTrackBlock Sep 04 21:13:43 volumio volumio[1298]: info: CorePlayQueue::getTrackBlock Sep 04 21:13:43 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:13:43 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:43 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 21:13:43 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:13:43 volumio volumio[1298]: info: CoreStateMachine::serviceStop Sep 04 21:13:43 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:43 volumio volumio[1298]: info: CoreCommandRouter::serviceStop Sep 04 21:13:43 volumio volumio[1298]: info: ControllerMpd::stop Sep 04 21:13:43 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand stop Sep 04 21:13:43 volumio volumio[1298]: info: CorePlayQueue::clearPlayQueue Sep 04 21:13:43 volumio volumio[1298]: info: CorePlayQueue::saveQueue Sep 04 21:13:43 volumio volumio[1298]: info: CoreCommandRouter::volumioPushQueue Sep 04 21:13:43 volumio volumio[1298]: info: CoreStateMachine::addQueueItems Sep 04 21:13:43 volumio volumio[1298]: info: CorePlayQueue::addQueueItems Sep 04 21:13:43 volumio volumio[1298]: info: Preload queue cleared Sep 04 21:13:43 volumio volumio[1298]: info: Adding Item to queue: artists://Andy%20Lau/Everyone%20Is%20No.%201 Sep 04 21:13:43 volumio volumio[1298]: info: Exploding uri artists://Andy%20Lau/Everyone%20Is%20No.%201 in service mpd Sep 04 21:13:43 volumio volumio[1298]: info: CoreCommandRouter::volumioPushQueue Sep 04 21:13:43 volumio volumio[1298]: info: CorePlayQueue::saveQueue Sep 04 21:13:43 volumio volumio[1298]: info: CoreStateMachine::updateTrackBlock Sep 04 21:13:43 volumio volumio[1298]: info: CorePlayQueue::getTrackBlock Sep 04 21:13:43 volumio volumio[1298]: info: CoreCommandRouter::volumioPlay Sep 04 21:13:43 volumio volumio[1298]: info: CoreStateMachine::play index 0 Sep 04 21:13:43 volumio volumio[1298]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 21:13:43 volumio volumio[1298]: info: CoreStateMachine::stop Sep 04 21:13:43 volumio volumio[1298]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 21:13:43 volumio volumio[1298]: info: CoreStateMachine::play index undefined Sep 04 21:13:43 volumio volumio[1298]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 21:13:43 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:43 volumio volumio[1298]: info: CoreStateMachine::startPlaybackTimer Sep 04 21:13:43 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:43 volumio volumio[1298]: verbose: ControllerMpd::clearAddPlayTracks USB/D512/Baidu FLAC/FLAC/29 - Andy Lau - Nan Ren Ku Ba Bu Shi Zui.flac Sep 04 21:13:43 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand stop Sep 04 21:13:43 volumio volumio[1298]: info: sendMpdCommand stop took 21 milliseconds Sep 04 21:13:43 volumio volumio[1298]: info: Sep 04 21:13:43 volumio volumio[1298]: ---------------------------- MPD announces state update: player Sep 04 21:13:43 volumio volumio[1298]: info: ControllerMpd::getState Sep 04 21:13:43 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand status Sep 04 21:13:43 volumio volumio[1298]: info: sendMpdCommand stop took 12 milliseconds Sep 04 21:13:43 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand clear Sep 04 21:13:43 volumio volumio[1298]: info: Sep 04 21:13:43 volumio volumio[1298]: ---------------------------- MPD announces system playlist update Sep 04 21:13:43 volumio volumio[1298]: info: Ignoring MPD Status Update Sep 04 21:13:43 volumio volumio[1298]: info: sendMpdCommand status took 1 milliseconds Sep 04 21:13:43 volumio volumio[1298]: info: sendMpdCommand clear took 0 milliseconds Sep 04 21:13:43 volumio volumio[1298]: verbose: ControllerMpd::parseState Sep 04 21:13:43 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 21:13:43 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand add "USB/D512/Baidu FLAC/FLAC/29 - Andy Lau - Nan Ren Ku Ba Bu Shi Zui.flac" Sep 04 21:13:43 volumio volumio[1298]: error: updateQueue error: null Sep 04 21:13:43 volumio volumio[1298]: info: Sep 04 21:13:43 volumio volumio[1298]: ---------------------------- MPD announces system playlist update Sep 04 21:13:43 volumio volumio[1298]: info: Ignoring MPD Status Update Sep 04 21:13:43 volumio volumio[1298]: info: ------------------------------ 2ms Sep 04 21:13:43 volumio volumio[1298]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 04 21:13:43 volumio volumio[1298]: info: sendMpdCommand add "USB/D512/Baidu FLAC/FLAC/29 - Andy Lau - Nan Ren Ku Ba Bu Shi Zui.flac" took 1 milliseconds Sep 04 21:13:43 volumio volumio[1298]: verbose: ControllerMpd::parseTrackInfo Sep 04 21:13:43 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand play Sep 04 21:13:43 volumio volumio[1298]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 04 21:13:43 volumio volumio[1298]: info: ------------------------------ 4ms Sep 04 21:13:43 volumio volumio[1298]: info: ------------------------------ 2ms Sep 04 21:13:43 volumio volumio[1298]: info: sendMpdCommand play took 1 milliseconds Sep 04 21:13:43 volumio volumio[1298]: info: Sep 04 21:13:43 volumio volumio[1298]: ---------------------------- MPD announces state update: player Sep 04 21:13:43 volumio volumio[1298]: info: ControllerMpd::getState Sep 04 21:13:43 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand status Sep 04 21:13:43 volumio volumio[1298]: info: Sep 04 21:13:43 volumio volumio[1298]: ---------------------------- MPD announces state update: player Sep 04 21:13:43 volumio volumio[1298]: info: sendMpdCommand status took 3 milliseconds Sep 04 21:13:43 volumio volumio[1298]: info: ControllerMpd::getState Sep 04 21:13:43 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand status Sep 04 21:13:43 volumio volumio[1298]: verbose: ControllerMpd::parseState Sep 04 21:13:43 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 21:13:43 volumio volumio[1298]: info: sendMpdCommand status took 1 milliseconds Sep 04 21:13:43 volumio volumio[1298]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 04 21:13:43 volumio volumio[1298]: verbose: ControllerMpd::parseState Sep 04 21:13:43 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 21:13:43 volumio volumio[1298]: verbose: ControllerMpd::parseTrackInfo Sep 04 21:13:43 volumio volumio[1298]: info: ControllerMpd::pushState Sep 04 21:13:43 volumio volumio[1298]: info: CoreCommandRouter::servicePushState Sep 04 21:13:43 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:43 volumio volumio[1298]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":311,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nan Ren Ku Ba Bu Shi Zui","artist":"Andy Lau","album":"Everyone Is No. 1","uri":"USB/D512/Baidu FLAC/FLAC/29 - Andy Lau - Nan Ren Ku Ba Bu Shi Zui.flac","trackType":"flac"} Sep 04 21:13:43 volumio volumio[1298]: verbose: CURRENT POSITION 0 Sep 04 21:13:43 volumio volumio[1298]: info: CoreStateMachine::syncState stateService play Sep 04 21:13:43 volumio volumio[1298]: info: CoreStateMachine::syncState currentStatus stop Sep 04 21:13:43 volumio volumio[1298]: info: ------------------------------ 11ms Sep 04 21:13:43 volumio volumio[1298]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 04 21:13:43 volumio volumio[1298]: verbose: ControllerMpd::parseTrackInfo Sep 04 21:13:43 volumio volumio[1298]: info: ControllerMpd::pushState Sep 04 21:13:43 volumio volumio[1298]: info: CoreCommandRouter::servicePushState Sep 04 21:13:43 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:43 volumio volumio[1298]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":311,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nan Ren Ku Ba Bu Shi Zui","artist":"Andy Lau","album":"Everyone Is No. 1","uri":"USB/D512/Baidu FLAC/FLAC/29 - Andy Lau - Nan Ren Ku Ba Bu Shi Zui.flac","trackType":"flac"} Sep 04 21:13:43 volumio volumio[1298]: verbose: CURRENT POSITION 0 Sep 04 21:13:43 volumio volumio[1298]: info: CoreStateMachine::syncState stateService play Sep 04 21:13:43 volumio volumio[1298]: info: CoreStateMachine::syncState currentStatus play Sep 04 21:13:43 volumio volumio[1298]: info: Received an update from plugin. extracting info from payload Sep 04 21:13:43 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:13:43 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:43 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 21:13:43 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:13:43 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:13:43 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:13:43 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:13:43 volumio volumio[1298]: info: ------------------------------ 16ms Sep 04 21:13:45 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 21:13:50 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 21:13:55 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 21:14:00 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 21:14:05 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 21:14:06 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 04 21:14:06 volumio volumio[1298]: info: CURURI: artists://The%20Eagles Sep 04 21:14:06 volumio volumio[1298]: info: Preload queue cleared Sep 04 21:14:06 volumio volumio[1298]: info: Preload queue cleared Sep 04 21:14:06 volumio volumio[1298]: info: No valid Plugin REST Endpoint Sep 04 21:14:06 volumio volumio[1298]: info: No valid Plugin REST Endpoint Sep 04 21:14:10 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 21:14:11 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 04 21:14:11 volumio volumio[1298]: info: CURURI: artists://The%20Eagles/%3F%3F%3F%3F%3F%3F%3F%C3%B9%DD%A1%3FHotel%20California Sep 04 21:14:11 volumio volumio[1298]: info: Preload queue cleared Sep 04 21:14:11 volumio volumio[1298]: info: No valid Plugin REST Endpoint Sep 04 21:14:11 volumio volumio[1298]: info: No valid Plugin REST Endpoint Sep 04 21:14:13 volumio volumio[1298]: info: Preload queue cleared Sep 04 21:14:13 volumio volumio[1298]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 04 21:14:13 volumio volumio[1298]: info: CoreStateMachine::ClearQueue Sep 04 21:14:13 volumio volumio[1298]: info: CoreStateMachine::stop Sep 04 21:14:13 volumio volumio[1298]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 21:14:13 volumio volumio[1298]: info: CoreStateMachine::stPlaybackTimer Sep 04 21:14:13 volumio volumio[1298]: info: CoreStateMachine::updateTrackBlock Sep 04 21:14:13 volumio volumio[1298]: info: CorePlayQueue::getTrackBlock Sep 04 21:14:13 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:14:13 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:14:13 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 21:14:13 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:14:13 volumio volumio[1298]: info: CoreStateMachine::serviceStop Sep 04 21:14:13 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:14:13 volumio volumio[1298]: info: CoreCommandRouter::serviceStop Sep 04 21:14:13 volumio volumio[1298]: info: ControllerMpd::stop Sep 04 21:14:13 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand stop Sep 04 21:14:13 volumio volumio[1298]: info: CorePlayQueue::clearPlayQueue Sep 04 21:14:13 volumio volumio[1298]: info: CorePlayQueue::saveQueue Sep 04 21:14:13 volumio volumio[1298]: info: CoreCommandRouter::volumioPushQueue Sep 04 21:14:13 volumio volumio[1298]: info: CoreStateMachine::addQueueItems Sep 04 21:14:13 volumio volumio[1298]: info: CorePlayQueue::addQueueItems Sep 04 21:14:13 volumio volumio[1298]: info: Preload queue cleared Sep 04 21:14:13 volumio volumio[1298]: info: Adding Item to queue: artists://The%20Eagles/%3F%3F%3F%3F%3F%3F%3F%C3%B9%DD%A1%3FHotel%20California Sep 04 21:14:13 volumio volumio[1298]: info: Exploding uri artists://The%20Eagles/%3F%3F%3F%3F%3F%3F%3F%C3%B9%DD%A1%3FHotel%20California in service mpd Sep 04 21:14:13 volumio volumio[1298]: info: CoreCommandRouter::volumioPushQueue Sep 04 21:14:13 volumio volumio[1298]: info: CorePlayQueue::saveQueue Sep 04 21:14:13 volumio volumio[1298]: info: CoreStateMachine::updateTrackBlock Sep 04 21:14:13 volumio volumio[1298]: info: CorePlayQueue::getTrackBlock Sep 04 21:14:13 volumio volumio[1298]: info: CoreCommandRouter::volumioPlay Sep 04 21:14:13 volumio volumio[1298]: info: CoreStateMachine::play index 0 Sep 04 21:14:13 volumio volumio[1298]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 21:14:13 volumio volumio[1298]: info: CoreStateMachine::stop Sep 04 21:14:13 volumio volumio[1298]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 21:14:13 volumio volumio[1298]: info: CoreStateMachine::play index undefined Sep 04 21:14:13 volumio volumio[1298]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 21:14:13 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:14:13 volumio volumio[1298]: info: CoreStateMachine::startPlaybackTimer Sep 04 21:14:13 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:14:13 volumio volumio[1298]: verbose: ControllerMpd::clearAddPlayTracks USB/D512/Baidu FLAC/FLAC/双版1.2g《加州旅馆》Hotel California/【网络大众版】《加州旅馆》Hotel California-The Eagles.wav Sep 04 21:14:13 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand stop Sep 04 21:14:13 volumio volumio[1298]: info: Sep 04 21:14:13 volumio volumio[1298]: ---------------------------- MPD announces state update: player Sep 04 21:14:13 volumio volumio[1298]: info: sendMpdCommand stop took 24 milliseconds Sep 04 21:14:13 volumio volumio[1298]: info: ControllerMpd::getState Sep 04 21:14:13 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand status Sep 04 21:14:13 volumio volumio[1298]: info: sendMpdCommand stop took 14 milliseconds Sep 04 21:14:13 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand clear Sep 04 21:14:13 volumio volumio[1298]: info: Sep 04 21:14:13 volumio volumio[1298]: ---------------------------- MPD announces system playlist update Sep 04 21:14:13 volumio volumio[1298]: info: Ignoring MPD Status Update Sep 04 21:14:13 volumio volumio[1298]: info: sendMpdCommand status took 5 milliseconds Sep 04 21:14:13 volumio volumio[1298]: info: sendMpdCommand clear took 1 milliseconds Sep 04 21:14:13 volumio volumio[1298]: verbose: ControllerMpd::parseState Sep 04 21:14:13 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 21:14:13 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand add "USB/D512/Baidu FLAC/FLAC/双版1.2g《加州旅馆》Hotel California/【网络大众版】《加州旅馆》Hotel California-The Eagles.wav" Sep 04 21:14:13 volumio volumio[1298]: error: updateQueue error: null Sep 04 21:14:13 volumio volumio[1298]: info: Sep 04 21:14:13 volumio volumio[1298]: ---------------------------- MPD announces system playlist update Sep 04 21:14:13 volumio volumio[1298]: info: Ignoring MPD Status Update Sep 04 21:14:13 volumio volumio[1298]: info: ------------------------------ 2ms Sep 04 21:14:13 volumio volumio[1298]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 04 21:14:13 volumio volumio[1298]: info: sendMpdCommand add "USB/D512/Baidu FLAC/FLAC/双版1.2g《加州旅馆》Hotel California/【网络大众版】《加州旅馆》Hotel California-The Eagles.wav" took 1 milliseconds Sep 04 21:14:13 volumio volumio[1298]: verbose: ControllerMpd::parseTrackInfo Sep 04 21:14:13 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand play Sep 04 21:14:13 volumio volumio[1298]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 04 21:14:13 volumio volumio[1298]: info: ------------------------------ 8ms Sep 04 21:14:13 volumio volumio[1298]: info: ------------------------------ 2ms Sep 04 21:14:13 volumio volumio[1298]: info: sendMpdCommand play took 1 milliseconds Sep 04 21:14:13 volumio volumio[1298]: info: Sep 04 21:14:13 volumio volumio[1298]: ---------------------------- MPD announces state update: player Sep 04 21:14:13 volumio volumio[1298]: info: ControllerMpd::getState Sep 04 21:14:13 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand status Sep 04 21:14:13 volumio volumio[1298]: info: Sep 04 21:14:13 volumio volumio[1298]: ---------------------------- MPD announces state update: player Sep 04 21:14:13 volumio volumio[1298]: info: sendMpdCommand status took 27 milliseconds Sep 04 21:14:13 volumio volumio[1298]: info: ControllerMpd::getState Sep 04 21:14:13 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand status Sep 04 21:14:13 volumio volumio[1298]: verbose: ControllerMpd::parseState Sep 04 21:14:13 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 21:14:13 volumio volumio[1298]: info: sendMpdCommand status took 1 milliseconds Sep 04 21:14:13 volumio volumio[1298]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 04 21:14:13 volumio volumio[1298]: verbose: ControllerMpd::parseState Sep 04 21:14:13 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 21:14:13 volumio volumio[1298]: verbose: ControllerMpd::parseTrackInfo Sep 04 21:14:13 volumio volumio[1298]: info: ControllerMpd::pushState Sep 04 21:14:13 volumio volumio[1298]: info: CoreCommandRouter::servicePushState Sep 04 21:14:13 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:14:13 volumio volumio[1298]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":433,"samplerate":192,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???????ùݡ?Hotel California","artist":"The Eagles","album":"???????ùݡ?Hotel California","uri":"USB/D512/Baidu FLAC/FLAC/双版1.2g《加州旅馆》Hotel California/【网络大众版】《加州旅馆》Hotel California-The Eagles.wav","trackType":"wav"} Sep 04 21:14:13 volumio volumio[1298]: verbose: CURRENT POSITION 0 Sep 04 21:14:13 volumio volumio[1298]: info: CoreStateMachine::syncState stateService play Sep 04 21:14:13 volumio volumio[1298]: info: CoreStateMachine::syncState currentStatus stop Sep 04 21:14:13 volumio volumio[1298]: info: ------------------------------ 30ms Sep 04 21:14:13 volumio volumio[1298]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 04 21:14:13 volumio volumio[1298]: verbose: ControllerMpd::parseTrackInfo Sep 04 21:14:13 volumio volumio[1298]: info: ControllerMpd::pushState Sep 04 21:14:13 volumio volumio[1298]: info: CoreCommandRouter::servicePushState Sep 04 21:14:13 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:14:13 volumio volumio[1298]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":433,"samplerate":192,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"???????ùݡ?Hotel California","artist":"The Eagles","album":"???????ùݡ?Hotel California","uri":"USB/D512/Baidu FLAC/FLAC/双版1.2g《加州旅馆》Hotel California/【网络大众版】《加州旅馆》Hotel California-The Eagles.wav","trackType":"wav"} Sep 04 21:14:13 volumio volumio[1298]: verbose: CURRENT POSITION 0 Sep 04 21:14:13 volumio volumio[1298]: info: CoreStateMachine::syncState stateService play Sep 04 21:14:13 volumio volumio[1298]: info: CoreStateMachine::syncState currentStatus play Sep 04 21:14:13 volumio volumio[1298]: info: Received an update from plugin. extracting info from payload Sep 04 21:14:13 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:14:13 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:14:13 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 21:14:13 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:14:13 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:14:13 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:14:13 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:14:13 volumio volumio[1298]: info: ------------------------------ 11ms Sep 04 21:14:15 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 21:14:20 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 04 21:14:20 volumio volumio[1298]: info: CURURI: artists://Tokyo%20Vivaldi%20Ensemble%3B%20Yevgeny%20Kutik%2C%20solo%20violin Sep 04 21:14:20 volumio volumio[1298]: info: Preload queue cleared Sep 04 21:14:20 volumio volumio[1298]: info: Preload queue cleared Sep 04 21:14:20 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 21:14:20 volumio volumio[1298]: info: No valid Plugin REST Endpoint Sep 04 21:14:20 volumio volumio[1298]: info: No valid Plugin REST Endpoint Sep 04 21:14:23 volumio volumio[1298]: info: Preload queue cleared Sep 04 21:14:23 volumio volumio[1298]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 04 21:14:23 volumio volumio[1298]: info: CoreStateMachine::ClearQueue Sep 04 21:14:23 volumio volumio[1298]: info: CoreStateMachine::stop Sep 04 21:14:23 volumio volumio[1298]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 21:14:23 volumio volumio[1298]: info: CoreStateMachine::stPlaybackTimer Sep 04 21:14:23 volumio volumio[1298]: info: CoreStateMachine::updateTrackBlock Sep 04 21:14:23 volumio volumio[1298]: info: CorePlayQueue::getTrackBlock Sep 04 21:14:23 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:14:23 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:14:23 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 21:14:23 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:14:23 volumio volumio[1298]: info: CoreStateMachine::serviceStop Sep 04 21:14:23 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:14:23 volumio volumio[1298]: info: CoreCommandRouter::serviceStop Sep 04 21:14:23 volumio volumio[1298]: info: ControllerMpd::stop Sep 04 21:14:23 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand stop Sep 04 21:14:23 volumio volumio[1298]: info: CorePlayQueue::clearPlayQueue Sep 04 21:14:23 volumio volumio[1298]: info: CorePlayQueue::saveQueue Sep 04 21:14:23 volumio volumio[1298]: info: CoreCommandRouter::volumioPushQueue Sep 04 21:14:23 volumio volumio[1298]: info: CoreStateMachine::addQueueItems Sep 04 21:14:23 volumio volumio[1298]: info: CorePlayQueue::addQueueItems Sep 04 21:14:23 volumio volumio[1298]: info: Preload queue cleared Sep 04 21:14:23 volumio volumio[1298]: info: Adding Item to queue: music-library/USB/D512/Baidu FLAC/FLAC 2/随风入梦 (For Healing) - 为不眠夜而作 (11.2MHz DSD)/03.卡农 (Canon).dsf Sep 04 21:14:23 volumio volumio[1298]: info: Using cached record of: music-library/USB/D512/Baidu FLAC/FLAC 2/随风入梦 (For Healing) - 为不眠夜而作 (11.2MHz DSD)/03.卡农 (Canon).dsf Sep 04 21:14:23 volumio volumio[1298]: info: CoreCommandRouter::volumioPushQueue Sep 04 21:14:23 volumio volumio[1298]: info: CorePlayQueue::saveQueue Sep 04 21:14:23 volumio volumio[1298]: info: CoreStateMachine::updateTrackBlock Sep 04 21:14:23 volumio volumio[1298]: info: CorePlayQueue::getTrackBlock Sep 04 21:14:23 volumio volumio[1298]: info: CoreCommandRouter::volumioPlay Sep 04 21:14:23 volumio volumio[1298]: info: CoreStateMachine::play index 0 Sep 04 21:14:23 volumio volumio[1298]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 21:14:23 volumio volumio[1298]: info: CoreStateMachine::stop Sep 04 21:14:23 volumio volumio[1298]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 21:14:23 volumio volumio[1298]: info: CoreStateMachine::play index undefined Sep 04 21:14:23 volumio volumio[1298]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 21:14:23 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:14:23 volumio volumio[1298]: info: Sep 04 21:14:23 volumio volumio[1298]: ---------------------------- MPD announces state update: player Sep 04 21:14:23 volumio volumio[1298]: info: sendMpdCommand stop took 19 milliseconds Sep 04 21:14:23 volumio volumio[1298]: info: ControllerMpd::getState Sep 04 21:14:23 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand status Sep 04 21:14:23 volumio volumio[1298]: info: sendMpdCommand status took 1 milliseconds Sep 04 21:14:23 volumio volumio[1298]: verbose: ControllerMpd::parseState Sep 04 21:14:23 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 21:14:23 volumio volumio[1298]: info: sendMpdCommand playlistinfo took 0 milliseconds Sep 04 21:14:23 volumio volumio[1298]: verbose: ControllerMpd::parseTrackInfo Sep 04 21:14:23 volumio volumio[1298]: info: ControllerMpd::pushState Sep 04 21:14:23 volumio volumio[1298]: info: CoreCommandRouter::servicePushState Sep 04 21:14:23 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:14:23 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:14:23 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 21:14:23 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:14:23 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:14:23 volumio volumio[1298]: 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":"???????ùݡ?Hotel California","artist":"The Eagles","album":"???????ùݡ?Hotel California","uri":"USB/D512/Baidu FLAC/FLAC/双版1.2g《加州旅馆》Hotel California/【网络大众版】《加州旅馆》Hotel California-The Eagles.wav","trackType":"wav"} Sep 04 21:14:23 volumio volumio[1298]: verbose: CURRENT POSITION 0 Sep 04 21:14:23 volumio volumio[1298]: info: CoreStateMachine::syncState stateService stop Sep 04 21:14:23 volumio volumio[1298]: info: CoreStateMachine::syncState currentStatus stop Sep 04 21:14:23 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:14:23 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:14:23 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:14:23 volumio volumio[1298]: info: No code Sep 04 21:14:23 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:14:23 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:14:23 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:14:23 volumio volumio[1298]: info: ------------------------------ 10ms Sep 04 21:14:24 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 04 21:14:24 volumio volumio[1298]: info: CURURI: artists://Tokyo%20Vivaldi%20Ensemble%3B%20Yevgeny%20Kutik%2C%20solo%20violin/Winds Sep 04 21:14:24 volumio volumio[1298]: info: Preload queue cleared Sep 04 21:14:24 volumio volumio[1298]: info: No valid Plugin REST Endpoint Sep 04 21:14:25 volumio volumio[1298]: info: No valid Plugin REST Endpoint Sep 04 21:14:25 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 21:14:26 volumio volumio[1298]: info: Preload queue cleared Sep 04 21:14:26 volumio volumio[1298]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 04 21:14:26 volumio volumio[1298]: info: CoreStateMachine::ClearQueue Sep 04 21:14:26 volumio volumio[1298]: info: CoreStateMachine::stop Sep 04 21:14:26 volumio volumio[1298]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 21:14:26 volumio volumio[1298]: info: CorePlayQueue::clearPlayQueue Sep 04 21:14:26 volumio volumio[1298]: info: CorePlayQueue::saveQueue Sep 04 21:14:26 volumio volumio[1298]: info: CoreCommandRouter::volumioPushQueue Sep 04 21:14:26 volumio volumio[1298]: info: CoreStateMachine::addQueueItems Sep 04 21:14:26 volumio volumio[1298]: info: CorePlayQueue::addQueueItems Sep 04 21:14:26 volumio volumio[1298]: info: Preload queue cleared Sep 04 21:14:26 volumio volumio[1298]: info: Adding Item to queue: artists://Tokyo%20Vivaldi%20Ensemble%3B%20Yevgeny%20Kutik%2C%20solo%20violin/Winds Sep 04 21:14:26 volumio volumio[1298]: info: Exploding uri artists://Tokyo%20Vivaldi%20Ensemble%3B%20Yevgeny%20Kutik%2C%20solo%20violin/Winds in service mpd Sep 04 21:14:26 volumio volumio[1298]: info: CoreCommandRouter::volumioPushQueue Sep 04 21:14:26 volumio volumio[1298]: info: CorePlayQueue::saveQueue Sep 04 21:14:26 volumio volumio[1298]: info: CoreStateMachine::updateTrackBlock Sep 04 21:14:26 volumio volumio[1298]: info: CorePlayQueue::getTrackBlock Sep 04 21:14:26 volumio volumio[1298]: info: CoreCommandRouter::volumioPlay Sep 04 21:14:26 volumio volumio[1298]: info: CoreStateMachine::play index 0 Sep 04 21:14:26 volumio volumio[1298]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 21:14:26 volumio volumio[1298]: info: CoreStateMachine::stop Sep 04 21:14:26 volumio volumio[1298]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 21:14:26 volumio volumio[1298]: info: CoreStateMachine::play index undefined Sep 04 21:14:26 volumio volumio[1298]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 04 21:14:26 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:14:26 volumio volumio[1298]: info: CoreStateMachine::startPlaybackTimer Sep 04 21:14:26 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:14:26 volumio volumio[1298]: verbose: ControllerMpd::clearAddPlayTracks USB/D512/Baidu FLAC/FLAC 2/随风入梦 (For Healing) - 为不眠夜而作 (11.2MHz DSD)/03.卡农 (Canon).dsf Sep 04 21:14:26 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand stop Sep 04 21:14:26 volumio volumio[1298]: info: sendMpdCommand stop took 1 milliseconds Sep 04 21:14:26 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand clear Sep 04 21:14:27 volumio volumio[1298]: info: Sep 04 21:14:27 volumio volumio[1298]: ---------------------------- MPD announces system playlist update Sep 04 21:14:27 volumio volumio[1298]: info: Ignoring MPD Status Update Sep 04 21:14:27 volumio volumio[1298]: info: sendMpdCommand clear took 1 milliseconds Sep 04 21:14:27 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand add "USB/D512/Baidu FLAC/FLAC 2/随风入梦 (For Healing) - 为不眠夜而作 (11.2MHz DSD)/03.卡农 (Canon).dsf" Sep 04 21:14:27 volumio volumio[1298]: error: updateQueue error: null Sep 04 21:14:27 volumio volumio[1298]: info: Sep 04 21:14:27 volumio volumio[1298]: ---------------------------- MPD announces system playlist update Sep 04 21:14:27 volumio volumio[1298]: info: Ignoring MPD Status Update Sep 04 21:14:27 volumio volumio[1298]: info: ------------------------------ 1ms Sep 04 21:14:27 volumio volumio[1298]: info: sendMpdCommand add "USB/D512/Baidu FLAC/FLAC 2/随风入梦 (For Healing) - 为不眠夜而作 (11.2MHz DSD)/03.卡农 (Canon).dsf" took 1 milliseconds Sep 04 21:14:27 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand play Sep 04 21:14:27 volumio volumio[1298]: info: ------------------------------ 1ms Sep 04 21:14:27 volumio volumio[1298]: info: Sep 04 21:14:27 volumio volumio[1298]: ---------------------------- MPD announces state update: player Sep 04 21:14:27 volumio volumio[1298]: info: sendMpdCommand play took 6 milliseconds Sep 04 21:14:27 volumio volumio[1298]: info: ControllerMpd::getState Sep 04 21:14:27 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand status Sep 04 21:14:27 volumio volumio[1298]: info: Sep 04 21:14:27 volumio volumio[1298]: ---------------------------- MPD announces state update: player Sep 04 21:14:27 volumio volumio[1298]: info: sendMpdCommand status took 36 milliseconds Sep 04 21:14:27 volumio volumio[1298]: info: ControllerMpd::getState Sep 04 21:14:27 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand status Sep 04 21:14:27 volumio volumio[1298]: verbose: ControllerMpd::parseState Sep 04 21:14:27 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 21:14:27 volumio volumio[1298]: info: sendMpdCommand status took 3 milliseconds Sep 04 21:14:27 volumio volumio[1298]: info: sendMpdCommand playlistinfo took 4 milliseconds Sep 04 21:14:27 volumio volumio[1298]: verbose: ControllerMpd::parseState Sep 04 21:14:27 volumio volumio[1298]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 21:14:27 volumio volumio[1298]: verbose: ControllerMpd::parseTrackInfo Sep 04 21:14:27 volumio volumio[1298]: info: ControllerMpd::pushState Sep 04 21:14:27 volumio volumio[1298]: info: CoreCommandRouter::servicePushState Sep 04 21:14:27 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:14:27 volumio volumio[1298]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":340,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"22579 Kbps","isStreaming":false,"title":"卡农 (Canon)","artist":"Tokyo Vivaldi Ensemble; Yevgeny Kutik, solo violin","album":"Winds","uri":"USB/D512/Baidu FLAC/FLAC 2/随风入梦 (For Healing) - 为不眠夜而作 (11.2MHz DSD)/03.卡农 (Canon).dsf","trackType":"dsf"} Sep 04 21:14:27 volumio volumio[1298]: verbose: CURRENT POSITION 0 Sep 04 21:14:27 volumio volumio[1298]: info: CoreStateMachine::syncState stateService play Sep 04 21:14:27 volumio volumio[1298]: info: CoreStateMachine::syncState currentStatus stop Sep 04 21:14:27 volumio volumio[1298]: info: ------------------------------ 48ms Sep 04 21:14:27 volumio volumio[1298]: info: sendMpdCommand playlistinfo took 5 milliseconds Sep 04 21:14:27 volumio volumio[1298]: verbose: ControllerMpd::parseTrackInfo Sep 04 21:14:27 volumio volumio[1298]: info: ControllerMpd::pushState Sep 04 21:14:27 volumio volumio[1298]: info: CoreCommandRouter::servicePushState Sep 04 21:14:27 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:14:27 volumio volumio[1298]: verbose: STATE SERVICE {"status":"play","position":0,"seek":749,"duration":340,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"22579 Kbps","isStreaming":false,"title":"卡农 (Canon)","artist":"Tokyo Vivaldi Ensemble; Yevgeny Kutik, solo violin","album":"Winds","uri":"USB/D512/Baidu FLAC/FLAC 2/随风入梦 (For Healing) - 为不眠夜而作 (11.2MHz DSD)/03.卡农 (Canon).dsf","trackType":"dsf"} Sep 04 21:14:27 volumio volumio[1298]: verbose: CURRENT POSITION 0 Sep 04 21:14:27 volumio volumio[1298]: info: CoreStateMachine::syncState stateService play Sep 04 21:14:27 volumio volumio[1298]: info: CoreStateMachine::syncState currentStatus play Sep 04 21:14:27 volumio volumio[1298]: info: Received an update from plugin. extracting info from payload Sep 04 21:14:27 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:14:27 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:14:27 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 21:14:27 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:14:27 volumio volumio[1298]: info: CoreStateMachine::pushState Sep 04 21:14:27 volumio volumio[1298]: info: CorePlayQueue::getTrack 0 Sep 04 21:14:27 volumio volumio[1298]: info: CoreCommandRouter::volumioPushState Sep 04 21:14:27 volumio volumio[1298]: info: ------------------------------ 21ms Sep 04 21:14:30 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 21:14:35 volumio volumio[1298]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 04 21:14:38 volumio volumio[1298]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 21:14:38 volumio volumio[1298]: Error: socket hang up Sep 04 21:14:38 volumio volumio[1298]: at connResetException (internal/errors.js:607:14) Sep 04 21:14:38 volumio volumio[1298]: at Socket.socketOnEnd (_http_client.js:493:23) Sep 04 21:14:38 volumio volumio[1298]: at Socket.emit (events.js:327:22) Sep 04 21:14:38 volumio volumio[1298]: at endReadableNT (internal/streams/readable.js:1327:12) Sep 04 21:14:38 volumio volumio[1298]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Sep 04 21:14:38 volumio volumio[1298]: code: 'ECONNRESET' Sep 04 21:14:38 volumio volumio[1298]: } Sep 04 21:14:38 volumio volumio[1298]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 21:14:38 volumio sudo[3460]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-04 21:13 Sep 04 21:14:38 volumio sudo[3460]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"