-- Logs begin at Wed 2025-09-17 07:23:15 CST, end at Wed 2025-09-17 07:48:44 CST. -- Sep 17 07:47:01 volumio volumio[2337]: info: Preload queue cleared Sep 17 07:47:01 volumio volumio[2337]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 17 07:47:01 volumio volumio[2337]: info: CoreStateMachine::ClearQueue Sep 17 07:47:01 volumio volumio[2337]: info: CoreStateMachine::stop Sep 17 07:47:01 volumio volumio[2337]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 07:47:01 volumio volumio[2337]: info: CoreStateMachine::stPlaybackTimer Sep 17 07:47:01 volumio volumio[2337]: info: CoreStateMachine::updateTrackBlock Sep 17 07:47:01 volumio volumio[2337]: info: CorePlayQueue::getTrackBlock Sep 17 07:47:01 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:01 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:01 volumio volumio[2337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 07:47:01 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:01 volumio volumio[2337]: info: CoreStateMachine::serviceStop Sep 17 07:47:01 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:01 volumio volumio[2337]: info: CoreCommandRouter::serviceStop Sep 17 07:47:01 volumio volumio[2337]: info: [1758066421354] ControllerWebradio::stop Sep 17 07:47:01 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand stop Sep 17 07:47:01 volumio volumio[2337]: info: CorePlayQueue::clearPlayQueue Sep 17 07:47:01 volumio volumio[2337]: info: CorePlayQueue::saveQueue Sep 17 07:47:01 volumio volumio[2337]: info: CoreCommandRouter::volumioPushQueue Sep 17 07:47:01 volumio volumio[2337]: info: CoreStateMachine::addQueueItems Sep 17 07:47:01 volumio volumio[2337]: info: CorePlayQueue::addQueueItems Sep 17 07:47:01 volumio volumio[2337]: info: Preload queue cleared Sep 17 07:47:01 volumio volumio[2337]: info: Adding Item to queue: http://a.files.bbci.co.uk/ms6/live/3441A116-B12E-4D2F-ACA8-C1984642FA4B/audio/simulcast/hls/nonuk/pc_hd_abr_v2/ak/bbc_radio_one.m3u8 Sep 17 07:47:01 volumio volumio[2337]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Sep 17 07:47:01 volumio volumio[2337]: info: CoreCommandRouter::volumioPushQueue Sep 17 07:47:01 volumio volumio[2337]: info: CorePlayQueue::saveQueue Sep 17 07:47:01 volumio volumio[2337]: info: CoreStateMachine::updateTrackBlock Sep 17 07:47:01 volumio volumio[2337]: info: CorePlayQueue::getTrackBlock Sep 17 07:47:01 volumio volumio[2337]: info: CoreCommandRouter::volumioPlay Sep 17 07:47:01 volumio volumio[2337]: info: CoreStateMachine::play index 0 Sep 17 07:47:01 volumio volumio[2337]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 07:47:01 volumio volumio[2337]: info: CoreStateMachine::stop Sep 17 07:47:01 volumio volumio[2337]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 07:47:01 volumio volumio[2337]: info: CoreStateMachine::play index undefined Sep 17 07:47:01 volumio volumio[2337]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 07:47:01 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:01 volumio volumio[2337]: info: CoreStateMachine::startPlaybackTimer Sep 17 07:47:01 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:01 volumio volumio[2337]: info: [1758066421366] ControllerWebradio::clearAddPlayTrack Sep 17 07:47:01 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand stop Sep 17 07:47:01 volumio volumio[2337]: info: sendMpdCommand stop took 27 milliseconds Sep 17 07:47:01 volumio volumio[2337]: info: Sep 17 07:47:01 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:47:01 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:47:01 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:47:01 volumio volumio[2337]: info: sendMpdCommand stop took 16 milliseconds Sep 17 07:47:01 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand clear Sep 17 07:47:01 volumio volumio[2337]: info: Sep 17 07:47:01 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:47:01 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:47:01 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:47:01 volumio volumio[2337]: info: Sep 17 07:47:01 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:47:01 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:47:01 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:47:01 volumio volumio[2337]: info: Sep 17 07:47:01 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:47:01 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:47:01 volumio volumio[2337]: info: sendMpdCommand status took 5 milliseconds Sep 17 07:47:01 volumio volumio[2337]: info: sendMpdCommand clear took 5 milliseconds Sep 17 07:47:01 volumio volumio[2337]: info: sendMpdCommand status took 5 milliseconds Sep 17 07:47:01 volumio volumio[2337]: info: sendMpdCommand status took 4 milliseconds Sep 17 07:47:01 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:47:01 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:47:01 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand add "http://a.files.bbci.co.uk/ms6/live/3441A116-B12E-4D2F-ACA8-C1984642FA4B/audio/simulcast/hls/nonuk/pc_hd_abr_v2/ak/bbc_radio_one.m3u8" Sep 17 07:47:01 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:47:01 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:47:01 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:47:01 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:47:01 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:01 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:01 volumio volumio[2337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 07:47:01 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:01 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:01 volumio volumio[2337]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Sep 17 07:47:01 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:47:01 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:47:01 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:01 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:01 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:01 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:01 volumio volumio[2337]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Sep 17 07:47:01 volumio volumio[2337]: info: ------------------------------ 17ms Sep 17 07:47:01 volumio volumio[2337]: info: ------------------------------ 16ms Sep 17 07:47:01 volumio volumio[2337]: info: Sep 17 07:47:01 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:47:01 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:47:01 volumio volumio[2337]: info: Sep 17 07:47:01 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:47:01 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:47:01 volumio volumio[2337]: error: updateQueue error: null Sep 17 07:47:01 volumio volumio[2337]: info: Sep 17 07:47:01 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:47:01 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:47:01 volumio volumio[2337]: info: ------------------------------ 16ms Sep 17 07:47:01 volumio volumio[2337]: info: sendMpdCommand playlistinfo took 15 milliseconds Sep 17 07:47:01 volumio volumio[2337]: info: sendMpdCommand add "http://a.files.bbci.co.uk/ms6/live/3441A116-B12E-4D2F-ACA8-C1984642FA4B/audio/simulcast/hls/nonuk/pc_hd_abr_v2/ak/bbc_radio_one.m3u8" took 16 milliseconds Sep 17 07:47:01 volumio volumio[2337]: info: ------------------------------ 3ms Sep 17 07:47:01 volumio volumio[2337]: info: ------------------------------ 2ms Sep 17 07:47:01 volumio volumio[2337]: verbose: ControllerMpd::parseTrackInfo Sep 17 07:47:01 volumio volumio[2337]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 17 07:47:01 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand play Sep 17 07:47:01 volumio volumio[2337]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 17 07:47:01 volumio volumio[2337]: info: ------------------------------ 23ms Sep 17 07:47:01 volumio volumio[2337]: info: Sep 17 07:47:01 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:47:01 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:47:01 volumio volumio[2337]: info: Sep 17 07:47:01 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:47:01 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:47:01 volumio volumio[2337]: info: ------------------------------ 6ms Sep 17 07:47:01 volumio volumio[2337]: info: sendMpdCommand play took 5 milliseconds Sep 17 07:47:01 volumio volumio[2337]: info: ------------------------------ 5ms Sep 17 07:47:01 volumio volumio[2337]: info: ------------------------------ 4ms Sep 17 07:47:11 volumio volumio[2337]: info: Sep 17 07:47:11 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:47:11 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:47:11 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:47:11 volumio volumio[2337]: info: Sep 17 07:47:11 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:47:11 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:47:11 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:47:11 volumio volumio[2337]: info: Sep 17 07:47:11 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:47:11 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:47:11 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:47:11 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand clearerror Sep 17 07:47:11 volumio volumio[2337]: info: sendMpdCommand status took 7 milliseconds Sep 17 07:47:11 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand clearerror Sep 17 07:47:11 volumio volumio[2337]: info: sendMpdCommand status took 8 milliseconds Sep 17 07:47:11 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand clearerror Sep 17 07:47:11 volumio volumio[2337]: info: sendMpdCommand status took 8 milliseconds Sep 17 07:47:11 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:47:11 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:47:11 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:47:11 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:47:11 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:47:11 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:47:11 volumio volumio[2337]: info: sendMpdCommand clearerror took 11 milliseconds Sep 17 07:47:11 volumio volumio[2337]: info: sendMpdCommand clearerror took 10 milliseconds Sep 17 07:47:11 volumio volumio[2337]: info: sendMpdCommand clearerror took 9 milliseconds Sep 17 07:47:11 volumio volumio[2337]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 17 07:47:11 volumio volumio[2337]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 17 07:47:11 volumio volumio[2337]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 17 07:47:11 volumio volumio[2337]: verbose: ControllerMpd::parseTrackInfo Sep 17 07:47:11 volumio volumio[2337]: verbose: ControllerMpd::parseTrackInfo Sep 17 07:47:11 volumio volumio[2337]: verbose: ControllerMpd::parseTrackInfo Sep 17 07:47:11 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:47:11 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:47:11 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:11 volumio volumio[2337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 07:47:11 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:11 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:11 volumio volumio[2337]: 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":"bbc_radio_one.m3u8","artist":null,"album":null,"uri":"http://a.files.bbci.co.uk/ms6/live/3441A116-B12E-4D2F-ACA8-C1984642FA4B/audio/simulcast/hls/nonuk/pc_hd_abr_v2/ak/bbc_radio_one.m3u8","trackType":"m3u8"} Sep 17 07:47:11 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:47:11 volumio volumio[2337]: info: CoreStateMachine::syncState stateService stop Sep 17 07:47:11 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus stop Sep 17 07:47:11 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:11 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:11 volumio volumio[2337]: info: No code Sep 17 07:47:11 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:11 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:11 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:47:11 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:47:11 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:11 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:11 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:11 volumio volumio[2337]: 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":"bbc_radio_one.m3u8","artist":null,"album":null,"uri":"http://a.files.bbci.co.uk/ms6/live/3441A116-B12E-4D2F-ACA8-C1984642FA4B/audio/simulcast/hls/nonuk/pc_hd_abr_v2/ak/bbc_radio_one.m3u8","trackType":"m3u8"} Sep 17 07:47:11 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:47:11 volumio volumio[2337]: info: CoreStateMachine::syncState stateService stop Sep 17 07:47:11 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus stop Sep 17 07:47:11 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:11 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:11 volumio volumio[2337]: info: No code Sep 17 07:47:11 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:11 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:11 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:47:11 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:47:11 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:11 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:11 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:11 volumio volumio[2337]: 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":"bbc_radio_one.m3u8","artist":null,"album":null,"uri":"http://a.files.bbci.co.uk/ms6/live/3441A116-B12E-4D2F-ACA8-C1984642FA4B/audio/simulcast/hls/nonuk/pc_hd_abr_v2/ak/bbc_radio_one.m3u8","trackType":"m3u8"} Sep 17 07:47:11 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:47:11 volumio volumio[2337]: info: CoreStateMachine::syncState stateService stop Sep 17 07:47:11 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus stop Sep 17 07:47:11 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:11 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:11 volumio volumio[2337]: info: No code Sep 17 07:47:11 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:11 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:11 volumio volumio[2337]: info: ------------------------------ 86ms Sep 17 07:47:11 volumio volumio[2337]: info: ------------------------------ 86ms Sep 17 07:47:11 volumio volumio[2337]: info: ------------------------------ 86ms Sep 17 07:47:19 volumio volumio[2337]: info: Preload queue cleared Sep 17 07:47:19 volumio volumio[2337]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 17 07:47:19 volumio volumio[2337]: info: CoreStateMachine::ClearQueue Sep 17 07:47:19 volumio volumio[2337]: info: CoreStateMachine::stop Sep 17 07:47:19 volumio volumio[2337]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 07:47:19 volumio volumio[2337]: info: CorePlayQueue::clearPlayQueue Sep 17 07:47:19 volumio volumio[2337]: info: CorePlayQueue::saveQueue Sep 17 07:47:19 volumio volumio[2337]: info: CoreCommandRouter::volumioPushQueue Sep 17 07:47:19 volumio volumio[2337]: info: CoreStateMachine::addQueueItems Sep 17 07:47:19 volumio volumio[2337]: info: CorePlayQueue::addQueueItems Sep 17 07:47:19 volumio volumio[2337]: info: Preload queue cleared Sep 17 07:47:19 volumio volumio[2337]: info: Adding Item to queue: http://as-hls-ww-live.akamaized.net/pool_74208725/live/ww/bbc_radio_two/bbc_radio_two.isml/bbc_radio_two-audio%3d128000.norewind.m3u8 Sep 17 07:47:19 volumio volumio[2337]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Sep 17 07:47:19 volumio volumio[2337]: info: CoreCommandRouter::volumioPushQueue Sep 17 07:47:19 volumio volumio[2337]: info: CorePlayQueue::saveQueue Sep 17 07:47:19 volumio volumio[2337]: info: CoreStateMachine::updateTrackBlock Sep 17 07:47:19 volumio volumio[2337]: info: CorePlayQueue::getTrackBlock Sep 17 07:47:19 volumio volumio[2337]: info: CoreCommandRouter::volumioPlay Sep 17 07:47:19 volumio volumio[2337]: info: CoreStateMachine::play index 0 Sep 17 07:47:19 volumio volumio[2337]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 07:47:19 volumio volumio[2337]: info: CoreStateMachine::stop Sep 17 07:47:19 volumio volumio[2337]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 07:47:19 volumio volumio[2337]: info: CoreStateMachine::play index undefined Sep 17 07:47:19 volumio volumio[2337]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 07:47:19 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:19 volumio volumio[2337]: info: CoreStateMachine::startPlaybackTimer Sep 17 07:47:19 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:19 volumio volumio[2337]: info: [1758066439273] ControllerWebradio::clearAddPlayTrack Sep 17 07:47:19 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand stop Sep 17 07:47:19 volumio volumio[2337]: info: sendMpdCommand stop took 1 milliseconds Sep 17 07:47:19 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand clear Sep 17 07:47:19 volumio volumio[2337]: info: sendMpdCommand clear took 1 milliseconds Sep 17 07:47:19 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_74208725/live/ww/bbc_radio_two/bbc_radio_two.isml/bbc_radio_two-audio%3d128000.norewind.m3u8" Sep 17 07:47:19 volumio volumio[2337]: info: Sep 17 07:47:19 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:47:19 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:47:19 volumio volumio[2337]: info: Sep 17 07:47:19 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:47:19 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:47:19 volumio volumio[2337]: info: sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_74208725/live/ww/bbc_radio_two/bbc_radio_two.isml/bbc_radio_two-audio%3d128000.norewind.m3u8" took 3 milliseconds Sep 17 07:47:19 volumio volumio[2337]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 17 07:47:19 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand play Sep 17 07:47:19 volumio volumio[2337]: info: Sep 17 07:47:19 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:47:19 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:47:19 volumio volumio[2337]: info: Sep 17 07:47:19 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:47:19 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:47:19 volumio volumio[2337]: info: ------------------------------ 5ms Sep 17 07:47:19 volumio volumio[2337]: info: ------------------------------ 5ms Sep 17 07:47:19 volumio volumio[2337]: info: sendMpdCommand play took 3 milliseconds Sep 17 07:47:19 volumio volumio[2337]: info: ------------------------------ 2ms Sep 17 07:47:19 volumio volumio[2337]: info: Sep 17 07:47:19 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:47:19 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:47:19 volumio volumio[2337]: info: ------------------------------ 1ms Sep 17 07:47:19 volumio volumio[2337]: info: Sep 17 07:47:19 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:47:19 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:47:19 volumio volumio[2337]: info: ------------------------------ 1ms Sep 17 07:47:21 volumio volumio[2337]: info: Sep 17 07:47:21 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:47:21 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:47:21 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:47:21 volumio volumio[2337]: info: Sep 17 07:47:21 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:47:21 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:47:21 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:47:21 volumio volumio[2337]: info: Sep 17 07:47:21 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:47:21 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:47:21 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:47:21 volumio volumio[2337]: info: Sep 17 07:47:21 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:47:21 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:47:21 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:47:21 volumio volumio[2337]: info: Sep 17 07:47:21 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:47:21 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:47:21 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:47:21 volumio volumio[2337]: info: Sep 17 07:47:21 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:47:21 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:47:21 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:47:21 volumio volumio[2337]: info: sendMpdCommand status took 12 milliseconds Sep 17 07:47:21 volumio volumio[2337]: info: sendMpdCommand status took 11 milliseconds Sep 17 07:47:21 volumio volumio[2337]: info: sendMpdCommand status took 10 milliseconds Sep 17 07:47:21 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:47:21 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:47:21 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:47:21 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:47:21 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:47:21 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:47:21 volumio volumio[2337]: info: sendMpdCommand status took 7 milliseconds Sep 17 07:47:21 volumio volumio[2337]: info: sendMpdCommand status took 6 milliseconds Sep 17 07:47:21 volumio volumio[2337]: info: sendMpdCommand status took 4 milliseconds Sep 17 07:47:21 volumio volumio[2337]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 17 07:47:21 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:47:21 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:47:21 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:47:21 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:47:21 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:47:21 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:47:21 volumio volumio[2337]: verbose: ControllerMpd::parseTrackInfo Sep 17 07:47:21 volumio volumio[2337]: verbose: ControllerMpd::parseTrackInfo Sep 17 07:47:21 volumio volumio[2337]: verbose: ControllerMpd::parseTrackInfo Sep 17 07:47:21 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:47:21 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:47:21 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:21 volumio volumio[2337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_two-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_74208725/live/ww/bbc_radio_two/bbc_radio_two.isml/bbc_radio_two-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Sep 17 07:47:21 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:47:21 volumio volumio[2337]: info: CoreStateMachine::syncState stateService play Sep 17 07:47:21 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus stop Sep 17 07:47:21 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:47:21 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:47:21 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:21 volumio volumio[2337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":41,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_two-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_74208725/live/ww/bbc_radio_two/bbc_radio_two.isml/bbc_radio_two-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Sep 17 07:47:21 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:47:21 volumio volumio[2337]: info: CoreStateMachine::syncState stateService play Sep 17 07:47:21 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus play Sep 17 07:47:21 volumio volumio[2337]: info: Received an update from plugin. extracting info from payload Sep 17 07:47:21 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:21 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:21 volumio volumio[2337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 07:47:21 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:21 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:21 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:21 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:47:21 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:47:21 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:21 volumio volumio[2337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":63,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_two-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_74208725/live/ww/bbc_radio_two/bbc_radio_two.isml/bbc_radio_two-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Sep 17 07:47:21 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:47:21 volumio volumio[2337]: info: CoreStateMachine::syncState stateService play Sep 17 07:47:21 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus play Sep 17 07:47:21 volumio volumio[2337]: info: Received an update from plugin. extracting info from payload Sep 17 07:47:21 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:21 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:21 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:21 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:21 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:21 volumio volumio[2337]: info: ------------------------------ 39ms Sep 17 07:47:21 volumio volumio[2337]: info: ------------------------------ 51ms Sep 17 07:47:21 volumio volumio[2337]: info: ------------------------------ 50ms Sep 17 07:47:21 volumio volumio[2337]: info: sendMpdCommand playlistinfo took 37 milliseconds Sep 17 07:47:21 volumio volumio[2337]: info: sendMpdCommand playlistinfo took 37 milliseconds Sep 17 07:47:21 volumio volumio[2337]: info: sendMpdCommand playlistinfo took 35 milliseconds Sep 17 07:47:21 volumio volumio[2337]: verbose: ControllerMpd::parseTrackInfo Sep 17 07:47:21 volumio volumio[2337]: verbose: ControllerMpd::parseTrackInfo Sep 17 07:47:21 volumio volumio[2337]: verbose: ControllerMpd::parseTrackInfo Sep 17 07:47:21 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:47:21 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:47:21 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:21 volumio volumio[2337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_two-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_74208725/live/ww/bbc_radio_two/bbc_radio_two.isml/bbc_radio_two-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Sep 17 07:47:21 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:47:21 volumio volumio[2337]: info: CoreStateMachine::syncState stateService play Sep 17 07:47:21 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus play Sep 17 07:47:21 volumio volumio[2337]: info: Received an update from plugin. extracting info from payload Sep 17 07:47:21 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:21 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:21 volumio volumio[2337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 07:47:21 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:21 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:21 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:21 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:47:21 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:47:21 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:21 volumio volumio[2337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_two-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_74208725/live/ww/bbc_radio_two/bbc_radio_two.isml/bbc_radio_two-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Sep 17 07:47:21 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:47:21 volumio volumio[2337]: info: CoreStateMachine::syncState stateService play Sep 17 07:47:21 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus play Sep 17 07:47:21 volumio volumio[2337]: info: Received an update from plugin. extracting info from payload Sep 17 07:47:21 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:21 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:21 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:21 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:21 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:21 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:47:21 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:47:21 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:21 volumio volumio[2337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_two-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_74208725/live/ww/bbc_radio_two/bbc_radio_two.isml/bbc_radio_two-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Sep 17 07:47:21 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:47:21 volumio volumio[2337]: info: CoreStateMachine::syncState stateService play Sep 17 07:47:21 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus play Sep 17 07:47:21 volumio volumio[2337]: info: Received an update from plugin. extracting info from payload Sep 17 07:47:21 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:21 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:21 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:21 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:21 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:21 volumio volumio[2337]: info: ------------------------------ 81ms Sep 17 07:47:21 volumio volumio[2337]: info: ------------------------------ 77ms Sep 17 07:47:21 volumio volumio[2337]: info: ------------------------------ 76ms Sep 17 07:47:42 volumio volumio[2337]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 17 07:47:42 volumio volumio[2337]: info: CURURI: music-library Sep 17 07:47:42 volumio volumio[2337]: info: Preload queue cleared Sep 17 07:47:44 volumio volumio[2337]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 17 07:47:44 volumio volumio[2337]: info: CURURI: music-library/USB Sep 17 07:47:44 volumio volumio[2337]: info: Preload queue cleared Sep 17 07:47:45 volumio volumio[2337]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 17 07:47:45 volumio volumio[2337]: info: CURURI: music-library/USB/HIKSEMI Sep 17 07:47:45 volumio volumio[2337]: info: Preload queue cleared Sep 17 07:47:49 volumio volumio[2337]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 17 07:47:49 volumio volumio[2337]: info: CURURI: music-library/USB/HIKSEMI/试音1-41 Sep 17 07:47:49 volumio volumio[2337]: info: Preload queue cleared Sep 17 07:47:51 volumio volumio[2337]: info: Preload queue cleared Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::ClearQueue Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::stop Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::stPlaybackTimer Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::updateTrackBlock Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrackBlock Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::serviceStop Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::serviceStop Sep 17 07:47:51 volumio volumio[2337]: info: [1758066471730] ControllerWebradio::stop Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand stop Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::clearPlayQueue Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::saveQueue Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::volumioPushQueue Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::addQueueItems Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::addQueueItems Sep 17 07:47:51 volumio volumio[2337]: info: Preload queue cleared Sep 17 07:47:51 volumio volumio[2337]: info: Adding Item to queue: music-library/USB/HIKSEMI/试音1-41/04 Sep 17 07:47:51 volumio volumio[2337]: info: Exploding uri music-library/USB/HIKSEMI/试音1-41/04 in service mpd Sep 17 07:47:51 volumio volumio[2337]: info: sendMpdCommand stop took 27 milliseconds Sep 17 07:47:51 volumio volumio[2337]: info: Sep 17 07:47:51 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:47:51 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:47:51 volumio volumio[2337]: info: Sep 17 07:47:51 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:47:51 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:47:51 volumio volumio[2337]: info: Sep 17 07:47:51 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:47:51 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:47:51 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E5%9B%9B%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F04%2F%E4%B8%89%E5%B3%A1.flac&metadata=false Sep 17 07:47:51 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/04/三峡.flac Sep 17 07:47:51 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E5%9B%9B%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F04%2F%E4%BB%8A%E5%A4%9C%E6%83%85%E4%B8%BA%E8%AF%81.flac&metadata=false Sep 17 07:47:51 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/04/今夜情为证.flac Sep 17 07:47:51 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E5%9B%9B%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F04%2F%E4%BD%86%E6%84%BF%E4%BA%BA%E9%95%BF%E4%B9%85.flac&metadata=false Sep 17 07:47:51 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/04/但愿人长久.flac Sep 17 07:47:51 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E5%9B%9B%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F04%2F%E5%88%9D%E6%AC%A1%E5%B0%9D%E5%88%B0%E5%AF%82%E5%AF%9E.flac&metadata=false Sep 17 07:47:51 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/04/初次尝到寂寞.flac Sep 17 07:47:51 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E5%9B%9B%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F04%2F%E5%8C%97%E4%BA%AC%E5%96%9C%E8%AE%AF%E4%BC%A0%E8%BE%B9%E5%AF%A8.flac&metadata=false Sep 17 07:47:51 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/04/北京喜讯传边寨.flac Sep 17 07:47:51 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E5%9B%9B%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F04%2F%E5%90%BB%E5%88%AB.flac&metadata=false Sep 17 07:47:51 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/04/吻别.flac Sep 17 07:47:51 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E5%9B%9B%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F04%2F%E5%9D%90%E4%B8%8A%E7%81%AB%E8%BD%A6%E5%8E%BB%E6%8B%89%E8%90%A8.flac&metadata=false Sep 17 07:47:51 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/04/坐上火车去拉萨.flac Sep 17 07:47:51 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E5%9B%9B%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F04%2F%E5%A4%A9%E8%BE%B9.flac&metadata=false Sep 17 07:47:51 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/04/天边.flac Sep 17 07:47:51 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E5%9B%9B%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F04%2F%E6%9C%88%E4%BA%AE%E4%BB%A3%E8%A1%A8%E6%88%91%E7%9A%84%E5%BF%83.flac&metadata=false Sep 17 07:47:51 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/04/月亮代表我的心.flac Sep 17 07:47:51 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E5%9B%9B%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F04%2F%E6%B5%81%E6%B5%AA%E8%80%85%E4%B9%8B%E6%AD%8C.flac&metadata=false Sep 17 07:47:51 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/04/流浪者之歌.flac Sep 17 07:47:51 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E5%9B%9B%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F04%2F%E7%89%B5%E6%89%8B.flac&metadata=false Sep 17 07:47:51 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/04/牵手.flac Sep 17 07:47:51 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E5%9B%9B%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F04%2F%E7%97%B4%E7%97%B4%E7%9A%84%E7%AD%89.flac&metadata=false Sep 17 07:47:51 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/04/痴痴的等.flac Sep 17 07:47:51 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E5%9B%9B%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F04%2F%E8%AF%95%E6%9C%BA%E5%9B%9B%E5%8F%B7%E3%80%8A%E8%8B%B1%E9%9B%84%E3%80%8B%E5%BA%8F%E6%9B%B2.flac&metadata=false Sep 17 07:47:51 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/04/试机四号《英雄》序曲.flac Sep 17 07:47:51 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E5%9B%9B%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F04%2F%E8%BF%88%E5%85%8B%E5%B0%94%C2%B7%E6%9D%B0%E5%85%8B%E9%80%8A.flac&metadata=false Sep 17 07:47:51 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/04/迈克尔·杰克逊.flac Sep 17 07:47:51 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E5%9B%9B%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F04%2F%E9%98%BF%E6%B7%98%E7%9A%84%E6%AD%8C.flac&metadata=false Sep 17 07:47:51 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/04/阿淘的歌.flac Sep 17 07:47:51 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E5%9B%9B%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F04%2F%E9%BC%93%E5%8A%A8%E5%BF%83%E5%BC%A6.flac&metadata=false Sep 17 07:47:51 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/04/鼓动心弦.flac Sep 17 07:47:51 volumio volumio[2337]: info: sendMpdCommand status took 8 milliseconds Sep 17 07:47:51 volumio volumio[2337]: info: sendMpdCommand status took 8 milliseconds Sep 17 07:47:51 volumio volumio[2337]: info: sendMpdCommand status took 7 milliseconds Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::volumioPushQueue Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::saveQueue Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::updateTrackBlock Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrackBlock Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::volumioPlay Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::play index 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::stop Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::play index undefined Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::startPlaybackTimer Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::clearAddPlayTracks USB/HIKSEMI/试音1-41/04/三峡.flac Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand stop Sep 17 07:47:51 volumio volumio[2337]: info: sendMpdCommand playlistinfo took 12 milliseconds Sep 17 07:47:51 volumio volumio[2337]: info: sendMpdCommand playlistinfo took 13 milliseconds Sep 17 07:47:51 volumio volumio[2337]: info: sendMpdCommand playlistinfo took 12 milliseconds Sep 17 07:47:51 volumio volumio[2337]: info: sendMpdCommand stop took 2 milliseconds Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::parseTrackInfo Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::parseTrackInfo Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::parseTrackInfo Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand clear Sep 17 07:47:51 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: 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":"bbc_radio_two-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_74208725/live/ww/bbc_radio_two/bbc_radio_two.isml/bbc_radio_two-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Sep 17 07:47:51 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::syncState stateService stop Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus stop Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:51 volumio volumio[2337]: info: No code Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:51 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: 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":"bbc_radio_two-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_74208725/live/ww/bbc_radio_two/bbc_radio_two.isml/bbc_radio_two-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Sep 17 07:47:51 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::syncState stateService stop Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus stop Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:51 volumio volumio[2337]: info: No code Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:51 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: 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":"bbc_radio_two-audio%3d128000.norewind.m3u8","artist":null,"album":null,"uri":"http://as-hls-ww-live.akamaized.net/pool_74208725/live/ww/bbc_radio_two/bbc_radio_two.isml/bbc_radio_two-audio%3d128000.norewind.m3u8","trackType":"m3u8"} Sep 17 07:47:51 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::syncState stateService stop Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus stop Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:51 volumio volumio[2337]: info: No code Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:51 volumio volumio[2337]: info: ------------------------------ 67ms Sep 17 07:47:51 volumio volumio[2337]: info: ------------------------------ 66ms Sep 17 07:47:51 volumio volumio[2337]: info: ------------------------------ 66ms Sep 17 07:47:51 volumio volumio[2337]: info: Sep 17 07:47:51 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:47:51 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:47:51 volumio volumio[2337]: info: sendMpdCommand clear took 56 milliseconds Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand add "USB/HIKSEMI/试音1-41/04/三峡.flac" Sep 17 07:47:51 volumio volumio[2337]: info: Sep 17 07:47:51 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:47:51 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:47:51 volumio volumio[2337]: info: Sep 17 07:47:51 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:47:51 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:47:51 volumio volumio[2337]: error: updateQueue error: null Sep 17 07:47:51 volumio volumio[2337]: info: Sep 17 07:47:51 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:47:51 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:47:51 volumio volumio[2337]: info: ------------------------------ 9ms Sep 17 07:47:51 volumio volumio[2337]: info: sendMpdCommand add "USB/HIKSEMI/试音1-41/04/三峡.flac" took 8 milliseconds Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand play Sep 17 07:47:51 volumio volumio[2337]: info: Sep 17 07:47:51 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:47:51 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:47:51 volumio volumio[2337]: info: Sep 17 07:47:51 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:47:51 volumio volumio[2337]: info: ------------------------------ 14ms Sep 17 07:47:51 volumio volumio[2337]: info: ------------------------------ 11ms Sep 17 07:47:51 volumio volumio[2337]: info: sendMpdCommand play took 9 milliseconds Sep 17 07:47:51 volumio volumio[2337]: info: ------------------------------ 9ms Sep 17 07:47:51 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:47:51 volumio volumio[2337]: info: Sep 17 07:47:51 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:47:51 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:47:51 volumio volumio[2337]: info: Sep 17 07:47:51 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:47:51 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:47:51 volumio volumio[2337]: info: Sep 17 07:47:51 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:47:51 volumio volumio[2337]: info: sendMpdCommand status took 45 milliseconds Sep 17 07:47:51 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:47:51 volumio volumio[2337]: info: sendMpdCommand status took 43 milliseconds Sep 17 07:47:51 volumio volumio[2337]: info: ------------------------------ 2ms Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:47:51 volumio volumio[2337]: info: Sep 17 07:47:51 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:47:51 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:47:51 volumio volumio[2337]: info: sendMpdCommand status took 5 milliseconds Sep 17 07:47:51 volumio volumio[2337]: info: sendMpdCommand playlistinfo took 5 milliseconds Sep 17 07:47:51 volumio volumio[2337]: info: sendMpdCommand playlistinfo took 4 milliseconds Sep 17 07:47:51 volumio volumio[2337]: info: sendMpdCommand status took 3 milliseconds Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::parseTrackInfo Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::parseTrackInfo Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:47:51 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":328,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"三峡","artist":"群星","album":"群星《试机四号》","uri":"USB/HIKSEMI/试音1-41/04/三峡.flac","trackType":"flac"} Sep 17 07:47:51 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::syncState stateService play Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus stop Sep 17 07:47:51 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":328,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"616 Kbps","isStreaming":false,"title":"三峡","artist":"群星","album":"群星《试机四号》","uri":"USB/HIKSEMI/试音1-41/04/三峡.flac","trackType":"flac"} Sep 17 07:47:51 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::syncState stateService play Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus play Sep 17 07:47:51 volumio volumio[2337]: info: Received an update from plugin. extracting info from payload Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:51 volumio volumio[2337]: info: ------------------------------ 61ms Sep 17 07:47:51 volumio volumio[2337]: info: ------------------------------ 76ms Sep 17 07:47:51 volumio volumio[2337]: info: Sep 17 07:47:51 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:47:51 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:47:51 volumio volumio[2337]: info: sendMpdCommand playlistinfo took 30 milliseconds Sep 17 07:47:51 volumio volumio[2337]: info: sendMpdCommand playlistinfo took 29 milliseconds Sep 17 07:47:51 volumio volumio[2337]: info: sendMpdCommand status took 1 milliseconds Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::parseTrackInfo Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::parseTrackInfo Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:47:51 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":328,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"610 Kbps","isStreaming":false,"title":"三峡","artist":"群星","album":"群星《试机四号》","uri":"USB/HIKSEMI/试音1-41/04/三峡.flac","trackType":"flac"} Sep 17 07:47:51 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::syncState stateService play Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus play Sep 17 07:47:51 volumio volumio[2337]: info: Received an update from plugin. extracting info from payload Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:51 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":328,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"610 Kbps","isStreaming":false,"title":"三峡","artist":"群星","album":"群星《试机四号》","uri":"USB/HIKSEMI/试音1-41/04/三峡.flac","trackType":"flac"} Sep 17 07:47:51 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::syncState stateService play Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus play Sep 17 07:47:51 volumio volumio[2337]: info: Received an update from plugin. extracting info from payload Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:51 volumio volumio[2337]: info: ------------------------------ 61ms Sep 17 07:47:51 volumio volumio[2337]: info: ------------------------------ 59ms Sep 17 07:47:51 volumio volumio[2337]: info: sendMpdCommand playlistinfo took 53 milliseconds Sep 17 07:47:51 volumio volumio[2337]: verbose: ControllerMpd::parseTrackInfo Sep 17 07:47:51 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":328,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"610 Kbps","isStreaming":false,"title":"三峡","artist":"群星","album":"群星《试机四号》","uri":"USB/HIKSEMI/试音1-41/04/三峡.flac","trackType":"flac"} Sep 17 07:47:51 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::syncState stateService play Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus play Sep 17 07:47:51 volumio volumio[2337]: info: Received an update from plugin. extracting info from payload Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:51 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:47:51 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:47:51 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:47:52 volumio volumio[2337]: info: ------------------------------ 67ms Sep 17 07:47:58 volumio volumio[2337]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 17 07:47:58 volumio volumio[2337]: info: CURURI: music-library/USB/HIKSEMI/试音1-41/03 Sep 17 07:47:58 volumio volumio[2337]: info: Preload queue cleared Sep 17 07:47:58 volumio volumio[2337]: info: Preloading song: music-library/USB/HIKSEMI/试音1-41/03/试机三号《试音》序曲.flac Sep 17 07:47:58 volumio volumio[2337]: info: Preloading song: music-library/USB/HIKSEMI/试音1-41/03/你可知道我爱谁.flac Sep 17 07:47:58 volumio volumio[2337]: info: Preloading song: music-library/USB/HIKSEMI/试音1-41/03/挪威森林.flac Sep 17 07:47:58 volumio volumio[2337]: info: Preloading song: music-library/USB/HIKSEMI/试音1-41/03/雪中情.flac Sep 17 07:47:58 volumio volumio[2337]: info: Preloading song: music-library/USB/HIKSEMI/试音1-41/03/相思河畔.flac Sep 17 07:47:58 volumio volumio[2337]: info: Preloading song: music-library/USB/HIKSEMI/试音1-41/03/外婆的彭湖湾.flac Sep 17 07:47:58 volumio volumio[2337]: info: Preloading song: music-library/USB/HIKSEMI/试音1-41/03/山茶花.flac Sep 17 07:47:58 volumio volumio[2337]: info: Preloading song: music-library/USB/HIKSEMI/试音1-41/03/爱上负心的人.flac Sep 17 07:47:58 volumio volumio[2337]: info: Preloading song: music-library/USB/HIKSEMI/试音1-41/03/烟花三月.flac Sep 17 07:47:58 volumio volumio[2337]: info: Preloading song: music-library/USB/HIKSEMI/试音1-41/03/渔舟唱晚.flac Sep 17 07:47:58 volumio volumio[2337]: info: Preloading song: music-library/USB/HIKSEMI/试音1-41/03/船歌.flac Sep 17 07:47:58 volumio volumio[2337]: info: Preloading song: music-library/USB/HIKSEMI/试音1-41/03/再见杨柳.flac Sep 17 07:47:58 volumio volumio[2337]: info: Preloading song: music-library/USB/HIKSEMI/试音1-41/03/在水一方.flac Sep 17 07:47:58 volumio volumio[2337]: info: Preloading song: music-library/USB/HIKSEMI/试音1-41/03/车站.flac Sep 17 07:47:58 volumio volumio[2337]: info: Preloading song: music-library/USB/HIKSEMI/试音1-41/03/往事如昔.flac Sep 17 07:47:58 volumio volumio[2337]: info: Preloading song: music-library/USB/HIKSEMI/试音1-41/03/夜上海.flac Sep 17 07:47:58 volumio volumio[2337]: info: Exploding uri music-library/USB/HIKSEMI/试音1-41/03/试机三号《试音》序曲.flac in service mpd Sep 17 07:47:58 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B%5B%E9%A3%8E%E4%BA%91%E9%9F%B3%E4%B9%90%E8%B0%B7%5D/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F03%2F%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8A%E8%AF%95%E9%9F%B3%E3%80%8B%E5%BA%8F%E6%9B%B2.flac&metadata=false Sep 17 07:47:58 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/03/试机三号《试音》序曲.flac Sep 17 07:47:58 volumio volumio[2337]: info: Exploding uri music-library/USB/HIKSEMI/试音1-41/03/你可知道我爱谁.flac in service mpd Sep 17 07:47:58 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B%5B%E9%A3%8E%E4%BA%91%E9%9F%B3%E4%B9%90%E8%B0%B7%5D/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F03%2F%E4%BD%A0%E5%8F%AF%E7%9F%A5%E9%81%93%E6%88%91%E7%88%B1%E8%B0%81.flac&metadata=false Sep 17 07:47:58 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/03/你可知道我爱谁.flac Sep 17 07:47:58 volumio volumio[2337]: info: Exploding uri music-library/USB/HIKSEMI/试音1-41/03/挪威森林.flac in service mpd Sep 17 07:47:58 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B%5B%E9%A3%8E%E4%BA%91%E9%9F%B3%E4%B9%90%E8%B0%B7%5D/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F03%2F%E6%8C%AA%E5%A8%81%E6%A3%AE%E6%9E%97.flac&metadata=false Sep 17 07:47:58 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/03/挪威森林.flac Sep 17 07:47:58 volumio volumio[2337]: info: Exploding uri music-library/USB/HIKSEMI/试音1-41/03/雪中情.flac in service mpd Sep 17 07:47:58 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B%5B%E9%A3%8E%E4%BA%91%E9%9F%B3%E4%B9%90%E8%B0%B7%5D/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F03%2F%E9%9B%AA%E4%B8%AD%E6%83%85.flac&metadata=false Sep 17 07:47:58 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/03/雪中情.flac Sep 17 07:47:58 volumio volumio[2337]: info: Exploding uri music-library/USB/HIKSEMI/试音1-41/03/相思河畔.flac in service mpd Sep 17 07:47:58 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B%5B%E9%A3%8E%E4%BA%91%E9%9F%B3%E4%B9%90%E8%B0%B7%5D/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F03%2F%E7%9B%B8%E6%80%9D%E6%B2%B3%E7%95%94.flac&metadata=false Sep 17 07:47:58 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/03/相思河畔.flac Sep 17 07:47:58 volumio volumio[2337]: info: Exploding uri music-library/USB/HIKSEMI/试音1-41/03/外婆的彭湖湾.flac in service mpd Sep 17 07:47:58 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B%5B%E9%A3%8E%E4%BA%91%E9%9F%B3%E4%B9%90%E8%B0%B7%5D/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F03%2F%E5%A4%96%E5%A9%86%E7%9A%84%E5%BD%AD%E6%B9%96%E6%B9%BE.flac&metadata=false Sep 17 07:47:58 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/03/外婆的彭湖湾.flac Sep 17 07:47:58 volumio volumio[2337]: info: Exploding uri music-library/USB/HIKSEMI/试音1-41/03/山茶花.flac in service mpd Sep 17 07:47:58 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B%5B%E9%A3%8E%E4%BA%91%E9%9F%B3%E4%B9%90%E8%B0%B7%5D/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F03%2F%E5%B1%B1%E8%8C%B6%E8%8A%B1.flac&metadata=false Sep 17 07:47:58 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/03/山茶花.flac Sep 17 07:47:58 volumio volumio[2337]: info: Exploding uri music-library/USB/HIKSEMI/试音1-41/03/爱上负心的人.flac in service mpd Sep 17 07:47:58 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B%5B%E9%A3%8E%E4%BA%91%E9%9F%B3%E4%B9%90%E8%B0%B7%5D/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F03%2F%E7%88%B1%E4%B8%8A%E8%B4%9F%E5%BF%83%E7%9A%84%E4%BA%BA.flac&metadata=false Sep 17 07:47:58 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/03/爱上负心的人.flac Sep 17 07:47:58 volumio volumio[2337]: info: Exploding uri music-library/USB/HIKSEMI/试音1-41/03/烟花三月.flac in service mpd Sep 17 07:47:58 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B%5B%E9%A3%8E%E4%BA%91%E9%9F%B3%E4%B9%90%E8%B0%B7%5D/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F03%2F%E7%83%9F%E8%8A%B1%E4%B8%89%E6%9C%88.flac&metadata=false Sep 17 07:47:58 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/03/烟花三月.flac Sep 17 07:47:58 volumio volumio[2337]: info: Exploding uri music-library/USB/HIKSEMI/试音1-41/03/渔舟唱晚.flac in service mpd Sep 17 07:47:58 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B%5B%E9%A3%8E%E4%BA%91%E9%9F%B3%E4%B9%90%E8%B0%B7%5D/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F03%2F%E6%B8%94%E8%88%9F%E5%94%B1%E6%99%9A.flac&metadata=false Sep 17 07:47:58 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/03/渔舟唱晚.flac Sep 17 07:47:58 volumio volumio[2337]: info: Exploding uri music-library/USB/HIKSEMI/试音1-41/03/船歌.flac in service mpd Sep 17 07:47:58 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B%5B%E9%A3%8E%E4%BA%91%E9%9F%B3%E4%B9%90%E8%B0%B7%5D/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F03%2F%E8%88%B9%E6%AD%8C.flac&metadata=false Sep 17 07:47:58 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/03/船歌.flac Sep 17 07:47:58 volumio volumio[2337]: info: Exploding uri music-library/USB/HIKSEMI/试音1-41/03/再见杨柳.flac in service mpd Sep 17 07:47:58 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B%5B%E9%A3%8E%E4%BA%91%E9%9F%B3%E4%B9%90%E8%B0%B7%5D/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F03%2F%E5%86%8D%E8%A7%81%E6%9D%A8%E6%9F%B3.flac&metadata=false Sep 17 07:47:58 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/03/再见杨柳.flac Sep 17 07:47:58 volumio volumio[2337]: info: Exploding uri music-library/USB/HIKSEMI/试音1-41/03/在水一方.flac in service mpd Sep 17 07:47:58 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B%5B%E9%A3%8E%E4%BA%91%E9%9F%B3%E4%B9%90%E8%B0%B7%5D/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F03%2F%E5%9C%A8%E6%B0%B4%E4%B8%80%E6%96%B9.flac&metadata=false Sep 17 07:47:58 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/03/在水一方.flac Sep 17 07:47:58 volumio volumio[2337]: info: Exploding uri music-library/USB/HIKSEMI/试音1-41/03/车站.flac in service mpd Sep 17 07:47:58 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B%5B%E9%A3%8E%E4%BA%91%E9%9F%B3%E4%B9%90%E8%B0%B7%5D/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F03%2F%E8%BD%A6%E7%AB%99.flac&metadata=false Sep 17 07:47:58 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/03/车站.flac Sep 17 07:47:58 volumio volumio[2337]: info: Exploding uri music-library/USB/HIKSEMI/试音1-41/03/往事如昔.flac in service mpd Sep 17 07:47:58 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B%5B%E9%A3%8E%E4%BA%91%E9%9F%B3%E4%B9%90%E8%B0%B7%5D/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F03%2F%E5%BE%80%E4%BA%8B%E5%A6%82%E6%98%94.flac&metadata=false Sep 17 07:47:58 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/03/往事如昔.flac Sep 17 07:47:58 volumio volumio[2337]: info: Exploding uri music-library/USB/HIKSEMI/试音1-41/03/夜上海.flac in service mpd Sep 17 07:47:58 volumio volumio[2337]: info: ALBUMART /albumart?cacheid=906&web=%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B%5B%E9%A3%8E%E4%BA%91%E9%9F%B3%E4%B9%90%E8%B0%B7%5D/%E7%BE%A4%E6%98%9F%E3%80%8A%E8%AF%95%E6%9C%BA%E4%B8%89%E5%8F%B7%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FHIKSEMI%2F%E8%AF%95%E9%9F%B31-41%2F03%2F%E5%A4%9C%E4%B8%8A%E6%B5%B7.flac&metadata=false Sep 17 07:47:58 volumio volumio[2337]: info: URI /mnt/USB/HIKSEMI/试音1-41/03/夜上海.flac Sep 17 07:48:08 volumio volumio[2337]: info: Preload queue cleared Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::ClearQueue Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::stop Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::stPlaybackTimer Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::updateTrackBlock Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrackBlock Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::serviceStop Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::serviceStop Sep 17 07:48:08 volumio volumio[2337]: info: ControllerMpd::stop Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand stop Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::clearPlayQueue Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::saveQueue Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::volumioPushQueue Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::addQueueItems Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::addQueueItems Sep 17 07:48:08 volumio volumio[2337]: info: Preload queue cleared Sep 17 07:48:08 volumio volumio[2337]: info: Adding Item to queue: music-library/USB/HIKSEMI/试音1-41/03/试机三号《试音》序曲.flac Sep 17 07:48:08 volumio volumio[2337]: info: Using cached record of: music-library/USB/HIKSEMI/试音1-41/03/试机三号《试音》序曲.flac Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::volumioPushQueue Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::saveQueue Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::updateTrackBlock Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrackBlock Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::volumioPlay Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::play index 0 Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::addQueueItems Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::addQueueItems Sep 17 07:48:08 volumio volumio[2337]: info: Preload queue cleared Sep 17 07:48:08 volumio volumio[2337]: info: Adding Item to queue: music-library/USB/HIKSEMI/试音1-41/03/你可知道我爱谁.flac Sep 17 07:48:08 volumio volumio[2337]: info: Using cached record of: music-library/USB/HIKSEMI/试音1-41/03/你可知道我爱谁.flac Sep 17 07:48:08 volumio volumio[2337]: info: Adding Item to queue: music-library/USB/HIKSEMI/试音1-41/03/挪威森林.flac Sep 17 07:48:08 volumio volumio[2337]: info: Using cached record of: music-library/USB/HIKSEMI/试音1-41/03/挪威森林.flac Sep 17 07:48:08 volumio volumio[2337]: info: Adding Item to queue: music-library/USB/HIKSEMI/试音1-41/03/雪中情.flac Sep 17 07:48:08 volumio volumio[2337]: info: Using cached record of: music-library/USB/HIKSEMI/试音1-41/03/雪中情.flac Sep 17 07:48:08 volumio volumio[2337]: info: Adding Item to queue: music-library/USB/HIKSEMI/试音1-41/03/相思河畔.flac Sep 17 07:48:08 volumio volumio[2337]: info: Using cached record of: music-library/USB/HIKSEMI/试音1-41/03/相思河畔.flac Sep 17 07:48:08 volumio volumio[2337]: info: Adding Item to queue: music-library/USB/HIKSEMI/试音1-41/03/外婆的彭湖湾.flac Sep 17 07:48:08 volumio volumio[2337]: info: Using cached record of: music-library/USB/HIKSEMI/试音1-41/03/外婆的彭湖湾.flac Sep 17 07:48:08 volumio volumio[2337]: info: Adding Item to queue: music-library/USB/HIKSEMI/试音1-41/03/山茶花.flac Sep 17 07:48:08 volumio volumio[2337]: info: Using cached record of: music-library/USB/HIKSEMI/试音1-41/03/山茶花.flac Sep 17 07:48:08 volumio volumio[2337]: info: Adding Item to queue: music-library/USB/HIKSEMI/试音1-41/03/爱上负心的人.flac Sep 17 07:48:08 volumio volumio[2337]: info: Using cached record of: music-library/USB/HIKSEMI/试音1-41/03/爱上负心的人.flac Sep 17 07:48:08 volumio volumio[2337]: info: Adding Item to queue: music-library/USB/HIKSEMI/试音1-41/03/烟花三月.flac Sep 17 07:48:08 volumio volumio[2337]: info: Using cached record of: music-library/USB/HIKSEMI/试音1-41/03/烟花三月.flac Sep 17 07:48:08 volumio volumio[2337]: info: Adding Item to queue: music-library/USB/HIKSEMI/试音1-41/03/渔舟唱晚.flac Sep 17 07:48:08 volumio volumio[2337]: info: Using cached record of: music-library/USB/HIKSEMI/试音1-41/03/渔舟唱晚.flac Sep 17 07:48:08 volumio volumio[2337]: info: Adding Item to queue: music-library/USB/HIKSEMI/试音1-41/03/船歌.flac Sep 17 07:48:08 volumio volumio[2337]: info: Using cached record of: music-library/USB/HIKSEMI/试音1-41/03/船歌.flac Sep 17 07:48:08 volumio volumio[2337]: info: Adding Item to queue: music-library/USB/HIKSEMI/试音1-41/03/再见杨柳.flac Sep 17 07:48:08 volumio volumio[2337]: info: Using cached record of: music-library/USB/HIKSEMI/试音1-41/03/再见杨柳.flac Sep 17 07:48:08 volumio volumio[2337]: info: Adding Item to queue: music-library/USB/HIKSEMI/试音1-41/03/在水一方.flac Sep 17 07:48:08 volumio volumio[2337]: info: Using cached record of: music-library/USB/HIKSEMI/试音1-41/03/在水一方.flac Sep 17 07:48:08 volumio volumio[2337]: info: Adding Item to queue: music-library/USB/HIKSEMI/试音1-41/03/车站.flac Sep 17 07:48:08 volumio volumio[2337]: info: Using cached record of: music-library/USB/HIKSEMI/试音1-41/03/车站.flac Sep 17 07:48:08 volumio volumio[2337]: info: Adding Item to queue: music-library/USB/HIKSEMI/试音1-41/03/往事如昔.flac Sep 17 07:48:08 volumio volumio[2337]: info: Using cached record of: music-library/USB/HIKSEMI/试音1-41/03/往事如昔.flac Sep 17 07:48:08 volumio volumio[2337]: info: Adding Item to queue: music-library/USB/HIKSEMI/试音1-41/03/夜上海.flac Sep 17 07:48:08 volumio volumio[2337]: info: Using cached record of: music-library/USB/HIKSEMI/试音1-41/03/夜上海.flac Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::stop Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::volumioPushQueue Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::saveQueue Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::play index undefined Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::updateTrackBlock Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrackBlock Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::startPlaybackTimer Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::clearAddPlayTracks USB/HIKSEMI/试音1-41/03/试机三号《试音》序曲.flac Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand stop Sep 17 07:48:08 volumio volumio[2337]: info: Sep 17 07:48:08 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:48:08 volumio volumio[2337]: info: sendMpdCommand stop took 26 milliseconds Sep 17 07:48:08 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:48:08 volumio volumio[2337]: info: sendMpdCommand stop took 4 milliseconds Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand clear Sep 17 07:48:08 volumio volumio[2337]: info: Sep 17 07:48:08 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:48:08 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:48:08 volumio volumio[2337]: info: Sep 17 07:48:08 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:48:08 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:48:08 volumio volumio[2337]: info: Sep 17 07:48:08 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:48:08 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:48:08 volumio volumio[2337]: info: sendMpdCommand status took 3 milliseconds Sep 17 07:48:08 volumio volumio[2337]: info: sendMpdCommand clear took 3 milliseconds Sep 17 07:48:08 volumio volumio[2337]: info: sendMpdCommand status took 2 milliseconds Sep 17 07:48:08 volumio volumio[2337]: info: sendMpdCommand status took 2 milliseconds Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand add "USB/HIKSEMI/试音1-41/03/试机三号《试音》序曲.flac" Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:48:08 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:08 volumio volumio[2337]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 17 07:48:08 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::syncState stateService stop Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus stop Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:08 volumio volumio[2337]: info: No code Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:08 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:08 volumio volumio[2337]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 17 07:48:08 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::syncState stateService stop Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus stop Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:08 volumio volumio[2337]: info: No code Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:08 volumio volumio[2337]: info: ------------------------------ 41ms Sep 17 07:48:08 volumio volumio[2337]: info: ------------------------------ 41ms Sep 17 07:48:08 volumio volumio[2337]: info: Sep 17 07:48:08 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:48:08 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:48:08 volumio volumio[2337]: info: Sep 17 07:48:08 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:48:08 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:48:08 volumio volumio[2337]: error: updateQueue error: null Sep 17 07:48:08 volumio volumio[2337]: info: Sep 17 07:48:08 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:48:08 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:48:08 volumio volumio[2337]: info: ------------------------------ 46ms Sep 17 07:48:08 volumio volumio[2337]: info: sendMpdCommand playlistinfo took 45 milliseconds Sep 17 07:48:08 volumio volumio[2337]: info: sendMpdCommand add "USB/HIKSEMI/试音1-41/03/试机三号《试音》序曲.flac" took 45 milliseconds Sep 17 07:48:08 volumio volumio[2337]: info: ------------------------------ 5ms Sep 17 07:48:08 volumio volumio[2337]: info: ------------------------------ 4ms Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::parseTrackInfo Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand play Sep 17 07:48:08 volumio volumio[2337]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 17 07:48:08 volumio volumio[2337]: info: ------------------------------ 51ms Sep 17 07:48:08 volumio volumio[2337]: info: Sep 17 07:48:08 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:48:08 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:48:08 volumio volumio[2337]: info: Sep 17 07:48:08 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:48:08 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:48:08 volumio volumio[2337]: info: Sep 17 07:48:08 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:48:08 volumio volumio[2337]: info: ------------------------------ 11ms Sep 17 07:48:08 volumio volumio[2337]: info: sendMpdCommand play took 9 milliseconds Sep 17 07:48:08 volumio volumio[2337]: info: ------------------------------ 8ms Sep 17 07:48:08 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:48:08 volumio volumio[2337]: info: Sep 17 07:48:08 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:48:08 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:48:08 volumio volumio[2337]: info: Sep 17 07:48:08 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:48:08 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:48:08 volumio volumio[2337]: info: Sep 17 07:48:08 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:48:08 volumio volumio[2337]: info: sendMpdCommand status took 14 milliseconds Sep 17 07:48:08 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:48:08 volumio volumio[2337]: info: sendMpdCommand status took 13 milliseconds Sep 17 07:48:08 volumio volumio[2337]: info: sendMpdCommand status took 7 milliseconds Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:48:08 volumio volumio[2337]: info: Sep 17 07:48:08 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:48:08 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:48:08 volumio volumio[2337]: info: Sep 17 07:48:08 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:48:08 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:48:08 volumio volumio[2337]: info: sendMpdCommand status took 21 milliseconds Sep 17 07:48:08 volumio volumio[2337]: info: sendMpdCommand playlistinfo took 21 milliseconds Sep 17 07:48:08 volumio volumio[2337]: info: sendMpdCommand playlistinfo took 20 milliseconds Sep 17 07:48:08 volumio volumio[2337]: info: sendMpdCommand playlistinfo took 21 milliseconds Sep 17 07:48:08 volumio volumio[2337]: info: sendMpdCommand status took 21 milliseconds Sep 17 07:48:08 volumio volumio[2337]: info: sendMpdCommand status took 20 milliseconds Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::parseTrackInfo Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::parseTrackInfo Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:48:08 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:08 volumio volumio[2337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":369,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"试机三号《试音》序曲","artist":"群星《试机三号》[风云音乐谷]","album":"群星《试机三号》","uri":"USB/HIKSEMI/试音1-41/03/试机三号《试音》序曲.flac","trackType":"flac"} Sep 17 07:48:08 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::syncState stateService play Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus stop Sep 17 07:48:08 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:08 volumio volumio[2337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":369,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"试机三号《试音》序曲","artist":"群星《试机三号》[风云音乐谷]","album":"群星《试机三号》","uri":"USB/HIKSEMI/试音1-41/03/试机三号《试音》序曲.flac","trackType":"flac"} Sep 17 07:48:08 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::syncState stateService play Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus play Sep 17 07:48:08 volumio volumio[2337]: info: Received an update from plugin. extracting info from payload Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:08 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:08 volumio volumio[2337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":369,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"试机三号《试音》序曲","artist":"群星《试机三号》[风云音乐谷]","album":"群星《试机三号》","uri":"USB/HIKSEMI/试音1-41/03/试机三号《试音》序曲.flac","trackType":"flac"} Sep 17 07:48:08 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::syncState stateService play Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus play Sep 17 07:48:08 volumio volumio[2337]: info: Received an update from plugin. extracting info from payload Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:08 volumio volumio[2337]: info: ------------------------------ 65ms Sep 17 07:48:08 volumio volumio[2337]: info: ------------------------------ 78ms Sep 17 07:48:08 volumio volumio[2337]: info: ------------------------------ 72ms Sep 17 07:48:08 volumio volumio[2337]: info: sendMpdCommand playlistinfo took 42 milliseconds Sep 17 07:48:08 volumio volumio[2337]: info: sendMpdCommand playlistinfo took 42 milliseconds Sep 17 07:48:08 volumio volumio[2337]: info: sendMpdCommand playlistinfo took 37 milliseconds Sep 17 07:48:08 volumio volumio[2337]: verbose: ControllerMpd::parseTrackInfo Sep 17 07:48:08 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:08 volumio volumio[2337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":369,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"试机三号《试音》序曲","artist":"群星《试机三号》[风云音乐谷]","album":"群星《试机三号》","uri":"USB/HIKSEMI/试音1-41/03/试机三号《试音》序曲.flac","trackType":"flac"} Sep 17 07:48:08 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::syncState stateService play Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus play Sep 17 07:48:08 volumio volumio[2337]: info: Received an update from plugin. extracting info from payload Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:08 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:08 volumio volumio[2337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":369,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"试机三号《试音》序曲","artist":"群星《试机三号》[风云音乐谷]","album":"群星《试机三号》","uri":"USB/HIKSEMI/试音1-41/03/试机三号《试音》序曲.flac","trackType":"flac"} Sep 17 07:48:08 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::syncState stateService play Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus play Sep 17 07:48:08 volumio volumio[2337]: info: Received an update from plugin. extracting info from payload Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:08 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:08 volumio volumio[2337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":369,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"试机三号《试音》序曲","artist":"群星《试机三号》[风云音乐谷]","album":"群星《试机三号》","uri":"USB/HIKSEMI/试音1-41/03/试机三号《试音》序曲.flac","trackType":"flac"} Sep 17 07:48:08 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::syncState stateService play Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus play Sep 17 07:48:08 volumio volumio[2337]: info: Received an update from plugin. extracting info from payload Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:08 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:08 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:08 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:08 volumio volumio[2337]: info: ------------------------------ 101ms Sep 17 07:48:08 volumio volumio[2337]: info: ------------------------------ 100ms Sep 17 07:48:08 volumio volumio[2337]: info: ------------------------------ 100ms Sep 17 07:48:36 volumio volumio[2337]: info: Preload queue cleared Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::ClearQueue Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::stop Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::stPlaybackTimer Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::updateTrackBlock Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrackBlock Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::serviceStop Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::serviceStop Sep 17 07:48:36 volumio volumio[2337]: info: ControllerMpd::stop Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand stop Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::clearPlayQueue Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::saveQueue Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::volumioPushQueue Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::addQueueItems Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::addQueueItems Sep 17 07:48:36 volumio volumio[2337]: info: Preload queue cleared Sep 17 07:48:36 volumio volumio[2337]: info: Adding Item to queue: music-library/USB/HIKSEMI/试音1-41/04 Sep 17 07:48:36 volumio volumio[2337]: info: Using cached record of: music-library/USB/HIKSEMI/试音1-41/04 Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::volumioPushQueue Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::saveQueue Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::updateTrackBlock Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrackBlock Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::volumioPlay Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::play index 0 Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::stop Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::play index undefined Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::startPlaybackTimer Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::clearAddPlayTracks USB/HIKSEMI/试音1-41/04/三峡.flac Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand stop Sep 17 07:48:36 volumio volumio[2337]: info: sendMpdCommand stop took 23 milliseconds Sep 17 07:48:36 volumio volumio[2337]: info: Sep 17 07:48:36 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:48:36 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:48:36 volumio volumio[2337]: info: sendMpdCommand stop took 9 milliseconds Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand clear Sep 17 07:48:36 volumio volumio[2337]: info: Sep 17 07:48:36 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:48:36 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:48:36 volumio volumio[2337]: info: Sep 17 07:48:36 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:48:36 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:48:36 volumio volumio[2337]: info: Sep 17 07:48:36 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:48:36 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:48:36 volumio volumio[2337]: info: sendMpdCommand status took 3 milliseconds Sep 17 07:48:36 volumio volumio[2337]: info: sendMpdCommand clear took 2 milliseconds Sep 17 07:48:36 volumio volumio[2337]: info: sendMpdCommand status took 2 milliseconds Sep 17 07:48:36 volumio volumio[2337]: info: sendMpdCommand status took 2 milliseconds Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand add "USB/HIKSEMI/试音1-41/04/三峡.flac" Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:48:36 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:36 volumio volumio[2337]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 17 07:48:36 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::syncState stateService stop Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus stop Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:36 volumio volumio[2337]: info: No code Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:36 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:36 volumio volumio[2337]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 17 07:48:36 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::syncState stateService stop Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus stop Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:36 volumio volumio[2337]: info: No code Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:36 volumio volumio[2337]: info: ------------------------------ 35ms Sep 17 07:48:36 volumio volumio[2337]: info: ------------------------------ 35ms Sep 17 07:48:36 volumio volumio[2337]: info: Sep 17 07:48:36 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:48:36 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:48:36 volumio volumio[2337]: info: Sep 17 07:48:36 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:48:36 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:48:36 volumio volumio[2337]: error: updateQueue error: null Sep 17 07:48:36 volumio volumio[2337]: info: Sep 17 07:48:36 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:48:36 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:48:36 volumio volumio[2337]: info: ------------------------------ 38ms Sep 17 07:48:36 volumio volumio[2337]: info: sendMpdCommand playlistinfo took 37 milliseconds Sep 17 07:48:36 volumio volumio[2337]: info: sendMpdCommand add "USB/HIKSEMI/试音1-41/04/三峡.flac" took 37 milliseconds Sep 17 07:48:36 volumio volumio[2337]: info: ------------------------------ 4ms Sep 17 07:48:36 volumio volumio[2337]: info: ------------------------------ 3ms Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::parseTrackInfo Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand play Sep 17 07:48:36 volumio volumio[2337]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 17 07:48:36 volumio volumio[2337]: info: ------------------------------ 43ms Sep 17 07:48:36 volumio volumio[2337]: info: Sep 17 07:48:36 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:48:36 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:48:36 volumio volumio[2337]: info: Sep 17 07:48:36 volumio volumio[2337]: ---------------------------- MPD announces system playlist update Sep 17 07:48:36 volumio volumio[2337]: info: Ignoring MPD Status Update Sep 17 07:48:36 volumio volumio[2337]: info: Sep 17 07:48:36 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:48:36 volumio volumio[2337]: info: ------------------------------ 10ms Sep 17 07:48:36 volumio volumio[2337]: info: sendMpdCommand play took 8 milliseconds Sep 17 07:48:36 volumio volumio[2337]: info: ------------------------------ 7ms Sep 17 07:48:36 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:48:36 volumio volumio[2337]: info: Sep 17 07:48:36 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:48:36 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:48:36 volumio volumio[2337]: info: Sep 17 07:48:36 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:48:36 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:48:36 volumio volumio[2337]: info: Sep 17 07:48:36 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:48:36 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:48:36 volumio volumio[2337]: info: sendMpdCommand status took 6 milliseconds Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:48:36 volumio volumio[2337]: info: Sep 17 07:48:36 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:48:36 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:48:36 volumio volumio[2337]: info: Sep 17 07:48:36 volumio volumio[2337]: ---------------------------- MPD announces state update: player Sep 17 07:48:36 volumio volumio[2337]: info: ControllerMpd::getState Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand status Sep 17 07:48:36 volumio volumio[2337]: info: sendMpdCommand status took 13 milliseconds Sep 17 07:48:36 volumio volumio[2337]: info: sendMpdCommand playlistinfo took 10 milliseconds Sep 17 07:48:36 volumio volumio[2337]: info: sendMpdCommand playlistinfo took 11 milliseconds Sep 17 07:48:36 volumio volumio[2337]: info: sendMpdCommand status took 13 milliseconds Sep 17 07:48:36 volumio volumio[2337]: info: sendMpdCommand status took 8 milliseconds Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::parseTrackInfo Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::parseTrackInfo Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::parseState Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 17 07:48:36 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:36 volumio volumio[2337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":328,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"三峡","artist":"群星","album":"群星《试机四号》","uri":"USB/HIKSEMI/试音1-41/04/三峡.flac","trackType":"flac"} Sep 17 07:48:36 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::syncState stateService play Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus stop Sep 17 07:48:36 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:36 volumio volumio[2337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":328,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"三峡","artist":"群星","album":"群星《试机四号》","uri":"USB/HIKSEMI/试音1-41/04/三峡.flac","trackType":"flac"} Sep 17 07:48:36 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::syncState stateService play Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus play Sep 17 07:48:36 volumio volumio[2337]: info: Received an update from plugin. extracting info from payload Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:36 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:36 volumio volumio[2337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45,"duration":328,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4 Kbps","isStreaming":false,"title":"三峡","artist":"群星","album":"群星《试机四号》","uri":"USB/HIKSEMI/试音1-41/04/三峡.flac","trackType":"flac"} Sep 17 07:48:36 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::syncState stateService play Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus play Sep 17 07:48:36 volumio volumio[2337]: info: Received an update from plugin. extracting info from payload Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:36 volumio volumio[2337]: info: ------------------------------ 43ms Sep 17 07:48:36 volumio volumio[2337]: info: ------------------------------ 57ms Sep 17 07:48:36 volumio volumio[2337]: info: sendMpdCommand playlistinfo took 35 milliseconds Sep 17 07:48:36 volumio volumio[2337]: verbose: ControllerMpd::parseTrackInfo Sep 17 07:48:36 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:36 volumio volumio[2337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":328,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"602 Kbps","isStreaming":false,"title":"三峡","artist":"群星","album":"群星《试机四号》","uri":"USB/HIKSEMI/试音1-41/04/三峡.flac","trackType":"flac"} Sep 17 07:48:36 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::syncState stateService play Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus play Sep 17 07:48:36 volumio volumio[2337]: info: Received an update from plugin. extracting info from payload Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:36 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:36 volumio volumio[2337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":328,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"631 Kbps","isStreaming":false,"title":"三峡","artist":"群星","album":"群星《试机四号》","uri":"USB/HIKSEMI/试音1-41/04/三峡.flac","trackType":"flac"} Sep 17 07:48:36 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::syncState stateService play Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus play Sep 17 07:48:36 volumio volumio[2337]: info: Received an update from plugin. extracting info from payload Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:36 volumio volumio[2337]: info: ControllerMpd::pushState Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::servicePushState Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:36 volumio volumio[2337]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":328,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"610 Kbps","isStreaming":false,"title":"三峡","artist":"群星","album":"群星《试机四号》","uri":"USB/HIKSEMI/试音1-41/04/三峡.flac","trackType":"flac"} Sep 17 07:48:36 volumio volumio[2337]: verbose: CURRENT POSITION 0 Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::syncState stateService play Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::syncState currentStatus play Sep 17 07:48:36 volumio volumio[2337]: info: Received an update from plugin. extracting info from payload Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:36 volumio volumio[2337]: info: CoreStateMachine::pushState Sep 17 07:48:36 volumio volumio[2337]: info: CorePlayQueue::getTrack 0 Sep 17 07:48:36 volumio volumio[2337]: info: CoreCommandRouter::volumioPushState Sep 17 07:48:36 volumio volumio[2337]: info: ------------------------------ 87ms Sep 17 07:48:36 volumio volumio[2337]: info: ------------------------------ 84ms Sep 17 07:48:36 volumio volumio[2337]: info: ------------------------------ 84ms Sep 17 07:48:44 volumio volumio[2337]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 17 07:48:44 volumio volumio[2337]: Error: connect ETIMEDOUT 108.160.166.57:80 Sep 17 07:48:44 volumio volumio[2337]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Sep 17 07:48:44 volumio volumio[2337]: errno: -110, Sep 17 07:48:44 volumio volumio[2337]: code: 'ETIMEDOUT', Sep 17 07:48:44 volumio volumio[2337]: syscall: 'connect', Sep 17 07:48:44 volumio volumio[2337]: address: '108.160.166.57', Sep 17 07:48:44 volumio volumio[2337]: port: 80 Sep 17 07:48:44 volumio volumio[2337]: } Sep 17 07:48:44 volumio volumio[2337]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 17 07:48:44 volumio sudo[8090]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-17 07:47 Sep 17 07:48:44 volumio sudo[8090]: 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="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:08:46 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="9ef0bfa9b61509be20c9051562554f31"