-- Logs begin at Thu 2019-02-14 18:12:00 CST, end at Thu 2025-05-01 10:48:40 CST. -- May 01 10:47:03 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 10369 milliseconds May 01 10:47:03 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 10379 milliseconds May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:47:03 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:47:03 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:47:03 volumio volumio[21264]: info: CorePlayQueue::getTrack 0 May 01 10:47:03 volumio volumio[21264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":193,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track07.wav","artist":null,"album":null,"uri":"NAS/Music/Track07.wav","trackType":"wav"} May 01 10:47:03 volumio volumio[21264]: verbose: CURRENT POSITION 0 May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::syncState stateService play May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus play May 01 10:47:03 volumio volumio[21264]: info: Received an update from plugin. extracting info from payload May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:03 volumio volumio[21264]: info: CorePlayQueue::getTrack 0 May 01 10:47:03 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:03 volumio volumio[21264]: info: CorePlayQueue::getTrack 0 May 01 10:47:03 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:03 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:47:03 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:47:03 volumio volumio[21264]: info: CorePlayQueue::getTrack 0 May 01 10:47:03 volumio volumio[21264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":193,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track07.wav","artist":null,"album":null,"uri":"NAS/Music/Track07.wav","trackType":"wav"} May 01 10:47:03 volumio volumio[21264]: verbose: CURRENT POSITION 0 May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::syncState stateService play May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus play May 01 10:47:03 volumio volumio[21264]: info: Received an update from plugin. extracting info from payload May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:03 volumio volumio[21264]: info: CorePlayQueue::getTrack 0 May 01 10:47:03 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:03 volumio volumio[21264]: info: CorePlayQueue::getTrack 0 May 01 10:47:03 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:03 volumio volumio[21264]: info: ------------------------------ 10529ms May 01 10:47:03 volumio volumio[21264]: info: ------------------------------ 10529ms May 01 10:47:03 volumio volumio[21264]: info: CoreCommandRouter::volumioNext May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::next May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::stop May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::stPlaybackTimer May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::updateTrackBlock May 01 10:47:03 volumio volumio[21264]: info: CorePlayQueue::getTrackBlock May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:03 volumio volumio[21264]: info: CorePlayQueue::getTrack 0 May 01 10:47:03 volumio volumio[21264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 10:47:03 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::serviceStop May 01 10:47:03 volumio volumio[21264]: info: CorePlayQueue::getTrack 0 May 01 10:47:03 volumio volumio[21264]: info: CoreCommandRouter::serviceStop May 01 10:47:03 volumio volumio[21264]: info: ControllerMpd::stop May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand stop May 01 10:47:03 volumio volumio[21264]: info: May 01 10:47:03 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:47:03 volumio volumio[21264]: info: sendMpdCommand stop took 22 milliseconds May 01 10:47:03 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::play index undefined May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 10:47:03 volumio volumio[21264]: info: CorePlayQueue::getTrack 1 May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::startPlaybackTimer May 01 10:47:03 volumio volumio[21264]: info: CorePlayQueue::getTrack 1 May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/Track08.wav May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand stop May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::updateTrackBlock May 01 10:47:03 volumio volumio[21264]: info: CorePlayQueue::getTrackBlock May 01 10:47:03 volumio volumio[21264]: info: May 01 10:47:03 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:47:03 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:47:03 volumio volumio[21264]: info: May 01 10:47:03 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:47:03 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:47:03 volumio volumio[21264]: info: sendMpdCommand status took 16 milliseconds May 01 10:47:03 volumio volumio[21264]: info: sendMpdCommand stop took 12 milliseconds May 01 10:47:03 volumio volumio[21264]: info: sendMpdCommand status took 6 milliseconds May 01 10:47:03 volumio volumio[21264]: info: sendMpdCommand status took 4 milliseconds May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand clear May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:47:03 volumio volumio[21264]: info: May 01 10:47:03 volumio volumio[21264]: ---------------------------- MPD announces system playlist update May 01 10:47:03 volumio volumio[21264]: info: Ignoring MPD Status Update May 01 10:47:03 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 8 milliseconds May 01 10:47:03 volumio volumio[21264]: info: sendMpdCommand clear took 9 milliseconds May 01 10:47:03 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 8 milliseconds May 01 10:47:03 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 8 milliseconds May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/Track08.wav" May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:47:03 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:47:03 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:03 volumio volumio[21264]: info: CorePlayQueue::getTrack 1 May 01 10:47:03 volumio volumio[21264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 10:47:03 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:03 volumio volumio[21264]: info: CorePlayQueue::getTrack 1 May 01 10:47:03 volumio volumio[21264]: 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":"Track07.wav","artist":null,"album":null,"uri":"NAS/Music/Track07.wav","trackType":"wav"} May 01 10:47:03 volumio volumio[21264]: verbose: CURRENT POSITION 1 May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::syncState stateService stop May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus stop May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:03 volumio volumio[21264]: info: CorePlayQueue::getTrack 1 May 01 10:47:03 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:03 volumio volumio[21264]: info: No code May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:03 volumio volumio[21264]: info: CorePlayQueue::getTrack 1 May 01 10:47:03 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:03 volumio volumio[21264]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 01 10:47:03 volumio volumio[21264]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 01 10:47:03 volumio volumio[21264]: info: ------------------------------ 85ms May 01 10:47:03 volumio volumio[21264]: info: ------------------------------ 73ms May 01 10:47:03 volumio volumio[21264]: info: ------------------------------ 72ms May 01 10:47:03 volumio volumio[21264]: info: May 01 10:47:03 volumio volumio[21264]: ---------------------------- MPD announces system playlist update May 01 10:47:03 volumio volumio[21264]: info: Ignoring MPD Status Update May 01 10:47:03 volumio volumio[21264]: info: May 01 10:47:03 volumio volumio[21264]: ---------------------------- MPD announces system playlist update May 01 10:47:03 volumio volumio[21264]: info: Ignoring MPD Status Update May 01 10:47:03 volumio volumio[21264]: error: updateQueue error: null May 01 10:47:03 volumio volumio[21264]: info: May 01 10:47:03 volumio volumio[21264]: ---------------------------- MPD announces system playlist update May 01 10:47:03 volumio volumio[21264]: info: Ignoring MPD Status Update May 01 10:47:03 volumio volumio[21264]: info: ------------------------------ 69ms May 01 10:47:03 volumio volumio[21264]: info: sendMpdCommand add "NAS/Music/Track08.wav" took 67 milliseconds May 01 10:47:03 volumio volumio[21264]: info: ------------------------------ 7ms May 01 10:47:03 volumio volumio[21264]: info: ------------------------------ 5ms May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand play May 01 10:47:03 volumio volumio[21264]: info: May 01 10:47:03 volumio volumio[21264]: ---------------------------- MPD announces system playlist update May 01 10:47:03 volumio volumio[21264]: info: Ignoring MPD Status Update May 01 10:47:03 volumio volumio[21264]: info: May 01 10:47:03 volumio volumio[21264]: ---------------------------- MPD announces system playlist update May 01 10:47:03 volumio volumio[21264]: info: Ignoring MPD Status Update May 01 10:47:03 volumio volumio[21264]: info: ------------------------------ 16ms May 01 10:47:03 volumio volumio[21264]: info: sendMpdCommand play took 13 milliseconds May 01 10:47:03 volumio volumio[21264]: info: ------------------------------ 12ms May 01 10:47:03 volumio volumio[21264]: info: ------------------------------ 10ms May 01 10:47:03 volumio volumio[21264]: info: May 01 10:47:03 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:47:03 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:47:03 volumio volumio[21264]: info: May 01 10:47:03 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:47:03 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:47:03 volumio volumio[21264]: info: May 01 10:47:03 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:47:03 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:47:03 volumio volumio[21264]: info: sendMpdCommand status took 43 milliseconds May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:47:03 volumio volumio[21264]: info: May 01 10:47:03 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:47:03 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:47:03 volumio volumio[21264]: info: sendMpdCommand status took 46 milliseconds May 01 10:47:03 volumio volumio[21264]: info: sendMpdCommand status took 44 milliseconds May 01 10:47:03 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 4 milliseconds May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:47:03 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:47:03 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:47:03 volumio volumio[21264]: info: CorePlayQueue::getTrack 1 May 01 10:47:03 volumio volumio[21264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":267,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track08.wav","artist":null,"album":null,"uri":"NAS/Music/Track08.wav","trackType":"wav"} May 01 10:47:03 volumio volumio[21264]: verbose: CURRENT POSITION 1 May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::syncState stateService play May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus stop May 01 10:47:03 volumio volumio[21264]: info: ------------------------------ 57ms May 01 10:47:03 volumio volumio[21264]: info: May 01 10:47:03 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:47:03 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:47:03 volumio volumio[21264]: info: May 01 10:47:03 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:47:03 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:47:03 volumio volumio[21264]: info: sendMpdCommand status took 14 milliseconds May 01 10:47:03 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 12 milliseconds May 01 10:47:03 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 11 milliseconds May 01 10:47:03 volumio volumio[21264]: info: sendMpdCommand status took 5 milliseconds May 01 10:47:03 volumio volumio[21264]: info: sendMpdCommand status took 4 milliseconds May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:47:03 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:47:03 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:47:03 volumio volumio[21264]: info: CorePlayQueue::getTrack 1 May 01 10:47:03 volumio volumio[21264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":267,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track08.wav","artist":null,"album":null,"uri":"NAS/Music/Track08.wav","trackType":"wav"} May 01 10:47:03 volumio volumio[21264]: verbose: CURRENT POSITION 1 May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::syncState stateService play May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus play May 01 10:47:03 volumio volumio[21264]: info: Received an update from plugin. extracting info from payload May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:03 volumio volumio[21264]: info: CorePlayQueue::getTrack 1 May 01 10:47:03 volumio volumio[21264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 10:47:03 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:03 volumio volumio[21264]: info: CorePlayQueue::getTrack 1 May 01 10:47:03 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:03 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:47:03 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:47:03 volumio volumio[21264]: info: CorePlayQueue::getTrack 1 May 01 10:47:03 volumio volumio[21264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":267,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track08.wav","artist":null,"album":null,"uri":"NAS/Music/Track08.wav","trackType":"wav"} May 01 10:47:03 volumio volumio[21264]: verbose: CURRENT POSITION 1 May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::syncState stateService play May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus play May 01 10:47:03 volumio volumio[21264]: info: Received an update from plugin. extracting info from payload May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:03 volumio volumio[21264]: info: CorePlayQueue::getTrack 1 May 01 10:47:03 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:03 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:03 volumio volumio[21264]: info: CorePlayQueue::getTrack 1 May 01 10:47:03 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:03 volumio volumio[21264]: info: ------------------------------ 137ms May 01 10:47:03 volumio volumio[21264]: info: ------------------------------ 136ms May 01 10:47:03 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 78 milliseconds May 01 10:47:03 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 78 milliseconds May 01 10:47:03 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 78 milliseconds May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:47:03 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:47:03 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:47:03 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:47:03 volumio volumio[21264]: info: CorePlayQueue::getTrack 1 May 01 10:47:03 volumio volumio[21264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":267,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track08.wav","artist":null,"album":null,"uri":"NAS/Music/Track08.wav","trackType":"wav"} May 01 10:47:03 volumio volumio[21264]: verbose: CURRENT POSITION 1 May 01 10:47:04 volumio volumio[21264]: info: CoreStateMachine::syncState stateService play May 01 10:47:04 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus play May 01 10:47:04 volumio volumio[21264]: info: Received an update from plugin. extracting info from payload May 01 10:47:04 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:04 volumio volumio[21264]: info: CorePlayQueue::getTrack 1 May 01 10:47:04 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:04 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:04 volumio volumio[21264]: info: CorePlayQueue::getTrack 1 May 01 10:47:04 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:04 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:47:04 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:47:04 volumio volumio[21264]: info: CorePlayQueue::getTrack 1 May 01 10:47:04 volumio volumio[21264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":267,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track08.wav","artist":null,"album":null,"uri":"NAS/Music/Track08.wav","trackType":"wav"} May 01 10:47:04 volumio volumio[21264]: verbose: CURRENT POSITION 1 May 01 10:47:04 volumio volumio[21264]: info: CoreStateMachine::syncState stateService play May 01 10:47:04 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus play May 01 10:47:04 volumio volumio[21264]: info: Received an update from plugin. extracting info from payload May 01 10:47:04 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:04 volumio volumio[21264]: info: CorePlayQueue::getTrack 1 May 01 10:47:04 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:04 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:04 volumio volumio[21264]: info: CorePlayQueue::getTrack 1 May 01 10:47:04 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:04 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:47:04 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:47:04 volumio volumio[21264]: info: CorePlayQueue::getTrack 1 May 01 10:47:04 volumio volumio[21264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":267,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track08.wav","artist":null,"album":null,"uri":"NAS/Music/Track08.wav","trackType":"wav"} May 01 10:47:04 volumio volumio[21264]: verbose: CURRENT POSITION 1 May 01 10:47:04 volumio volumio[21264]: info: CoreStateMachine::syncState stateService play May 01 10:47:04 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus play May 01 10:47:04 volumio volumio[21264]: info: Received an update from plugin. extracting info from payload May 01 10:47:04 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:04 volumio volumio[21264]: info: CorePlayQueue::getTrack 1 May 01 10:47:04 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:04 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:04 volumio volumio[21264]: info: CorePlayQueue::getTrack 1 May 01 10:47:04 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:04 volumio volumio[21264]: info: ------------------------------ 194ms May 01 10:47:04 volumio volumio[21264]: info: ------------------------------ 187ms May 01 10:47:04 volumio volumio[21264]: info: ------------------------------ 185ms May 01 10:47:15 volumio volumio[21264]: info: CoreCommandRouter::volumioNext May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::next May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::stop May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::stPlaybackTimer May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::updateTrackBlock May 01 10:47:15 volumio volumio[21264]: info: CorePlayQueue::getTrackBlock May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:15 volumio volumio[21264]: info: CorePlayQueue::getTrack 1 May 01 10:47:15 volumio volumio[21264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 10:47:15 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::serviceStop May 01 10:47:15 volumio volumio[21264]: info: CorePlayQueue::getTrack 1 May 01 10:47:15 volumio volumio[21264]: info: CoreCommandRouter::serviceStop May 01 10:47:15 volumio volumio[21264]: info: ControllerMpd::stop May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand stop May 01 10:47:15 volumio volumio[21264]: info: May 01 10:47:15 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:47:15 volumio volumio[21264]: info: sendMpdCommand stop took 43 milliseconds May 01 10:47:15 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::play index undefined May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 10:47:15 volumio volumio[21264]: info: CorePlayQueue::getTrack 2 May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::startPlaybackTimer May 01 10:47:15 volumio volumio[21264]: info: CorePlayQueue::getTrack 2 May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/Track09.wav May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand stop May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::updateTrackBlock May 01 10:47:15 volumio volumio[21264]: info: CorePlayQueue::getTrackBlock May 01 10:47:15 volumio volumio[21264]: info: May 01 10:47:15 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:47:15 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:47:15 volumio volumio[21264]: info: May 01 10:47:15 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:47:15 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:47:15 volumio volumio[21264]: info: sendMpdCommand status took 16 milliseconds May 01 10:47:15 volumio volumio[21264]: info: sendMpdCommand stop took 13 milliseconds May 01 10:47:15 volumio volumio[21264]: info: sendMpdCommand status took 7 milliseconds May 01 10:47:15 volumio volumio[21264]: info: sendMpdCommand status took 4 milliseconds May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand clear May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:47:15 volumio volumio[21264]: info: May 01 10:47:15 volumio volumio[21264]: ---------------------------- MPD announces system playlist update May 01 10:47:15 volumio volumio[21264]: info: Ignoring MPD Status Update May 01 10:47:15 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 9 milliseconds May 01 10:47:15 volumio volumio[21264]: info: sendMpdCommand clear took 9 milliseconds May 01 10:47:15 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 9 milliseconds May 01 10:47:15 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 9 milliseconds May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/Track09.wav" May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:47:15 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:47:15 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:15 volumio volumio[21264]: info: CorePlayQueue::getTrack 2 May 01 10:47:15 volumio volumio[21264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 10:47:15 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:15 volumio volumio[21264]: info: CorePlayQueue::getTrack 2 May 01 10:47:15 volumio volumio[21264]: 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":"Track08.wav","artist":null,"album":null,"uri":"NAS/Music/Track08.wav","trackType":"wav"} May 01 10:47:15 volumio volumio[21264]: verbose: CURRENT POSITION 2 May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::syncState stateService stop May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus stop May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:15 volumio volumio[21264]: info: CorePlayQueue::getTrack 2 May 01 10:47:15 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:15 volumio volumio[21264]: info: No code May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:15 volumio volumio[21264]: info: CorePlayQueue::getTrack 2 May 01 10:47:15 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:15 volumio volumio[21264]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 01 10:47:15 volumio volumio[21264]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 01 10:47:15 volumio volumio[21264]: info: ------------------------------ 95ms May 01 10:47:15 volumio volumio[21264]: info: ------------------------------ 84ms May 01 10:47:15 volumio volumio[21264]: info: ------------------------------ 82ms May 01 10:47:15 volumio volumio[21264]: info: May 01 10:47:15 volumio volumio[21264]: ---------------------------- MPD announces system playlist update May 01 10:47:15 volumio volumio[21264]: info: Ignoring MPD Status Update May 01 10:47:15 volumio volumio[21264]: info: May 01 10:47:15 volumio volumio[21264]: ---------------------------- MPD announces system playlist update May 01 10:47:15 volumio volumio[21264]: info: Ignoring MPD Status Update May 01 10:47:15 volumio volumio[21264]: error: updateQueue error: null May 01 10:47:15 volumio volumio[21264]: info: May 01 10:47:15 volumio volumio[21264]: ---------------------------- MPD announces system playlist update May 01 10:47:15 volumio volumio[21264]: info: Ignoring MPD Status Update May 01 10:47:15 volumio volumio[21264]: info: ------------------------------ 79ms May 01 10:47:15 volumio volumio[21264]: info: sendMpdCommand add "NAS/Music/Track09.wav" took 75 milliseconds May 01 10:47:15 volumio volumio[21264]: info: ------------------------------ 12ms May 01 10:47:15 volumio volumio[21264]: info: ------------------------------ 10ms May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand play May 01 10:47:15 volumio volumio[21264]: info: May 01 10:47:15 volumio volumio[21264]: ---------------------------- MPD announces system playlist update May 01 10:47:15 volumio volumio[21264]: info: Ignoring MPD Status Update May 01 10:47:15 volumio volumio[21264]: info: May 01 10:47:15 volumio volumio[21264]: ---------------------------- MPD announces system playlist update May 01 10:47:15 volumio volumio[21264]: info: Ignoring MPD Status Update May 01 10:47:15 volumio volumio[21264]: info: ------------------------------ 19ms May 01 10:47:15 volumio volumio[21264]: info: sendMpdCommand play took 15 milliseconds May 01 10:47:15 volumio volumio[21264]: info: ------------------------------ 14ms May 01 10:47:15 volumio volumio[21264]: info: ------------------------------ 13ms May 01 10:47:15 volumio volumio[21264]: info: May 01 10:47:15 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:47:15 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:47:15 volumio volumio[21264]: info: May 01 10:47:15 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:47:15 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:47:15 volumio volumio[21264]: info: May 01 10:47:15 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:47:15 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:47:15 volumio volumio[21264]: info: sendMpdCommand status took 41 milliseconds May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:47:15 volumio volumio[21264]: info: May 01 10:47:15 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:47:15 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:47:15 volumio volumio[21264]: info: sendMpdCommand status took 45 milliseconds May 01 10:47:15 volumio volumio[21264]: info: sendMpdCommand status took 42 milliseconds May 01 10:47:15 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 5 milliseconds May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:47:15 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:47:15 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:47:15 volumio volumio[21264]: info: CorePlayQueue::getTrack 2 May 01 10:47:15 volumio volumio[21264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":241,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track09.wav","artist":null,"album":null,"uri":"NAS/Music/Track09.wav","trackType":"wav"} May 01 10:47:15 volumio volumio[21264]: verbose: CURRENT POSITION 2 May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::syncState stateService play May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus stop May 01 10:47:15 volumio volumio[21264]: info: ------------------------------ 57ms May 01 10:47:15 volumio volumio[21264]: info: May 01 10:47:15 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:47:15 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:47:15 volumio volumio[21264]: info: May 01 10:47:15 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:47:15 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:47:15 volumio volumio[21264]: info: sendMpdCommand status took 20 milliseconds May 01 10:47:15 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 16 milliseconds May 01 10:47:15 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 16 milliseconds May 01 10:47:15 volumio volumio[21264]: info: sendMpdCommand status took 10 milliseconds May 01 10:47:15 volumio volumio[21264]: info: sendMpdCommand status took 8 milliseconds May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:47:15 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:47:15 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:47:15 volumio volumio[21264]: info: CorePlayQueue::getTrack 2 May 01 10:47:15 volumio volumio[21264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":241,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track09.wav","artist":null,"album":null,"uri":"NAS/Music/Track09.wav","trackType":"wav"} May 01 10:47:15 volumio volumio[21264]: verbose: CURRENT POSITION 2 May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::syncState stateService play May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus play May 01 10:47:15 volumio volumio[21264]: info: Received an update from plugin. extracting info from payload May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:15 volumio volumio[21264]: info: CorePlayQueue::getTrack 2 May 01 10:47:15 volumio volumio[21264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 10:47:15 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:15 volumio volumio[21264]: info: CorePlayQueue::getTrack 2 May 01 10:47:15 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:15 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:47:15 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:47:15 volumio volumio[21264]: info: CorePlayQueue::getTrack 2 May 01 10:47:15 volumio volumio[21264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":241,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track09.wav","artist":null,"album":null,"uri":"NAS/Music/Track09.wav","trackType":"wav"} May 01 10:47:15 volumio volumio[21264]: verbose: CURRENT POSITION 2 May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::syncState stateService play May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus play May 01 10:47:15 volumio volumio[21264]: info: Received an update from plugin. extracting info from payload May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:15 volumio volumio[21264]: info: CorePlayQueue::getTrack 2 May 01 10:47:15 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:15 volumio volumio[21264]: info: CorePlayQueue::getTrack 2 May 01 10:47:15 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:15 volumio volumio[21264]: info: ------------------------------ 149ms May 01 10:47:15 volumio volumio[21264]: info: ------------------------------ 148ms May 01 10:47:15 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 91 milliseconds May 01 10:47:15 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 91 milliseconds May 01 10:47:15 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 91 milliseconds May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:47:15 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:47:15 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:47:15 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:47:15 volumio volumio[21264]: info: CorePlayQueue::getTrack 2 May 01 10:47:15 volumio volumio[21264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":241,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track09.wav","artist":null,"album":null,"uri":"NAS/Music/Track09.wav","trackType":"wav"} May 01 10:47:15 volumio volumio[21264]: verbose: CURRENT POSITION 2 May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::syncState stateService play May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus play May 01 10:47:15 volumio volumio[21264]: info: Received an update from plugin. extracting info from payload May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:15 volumio volumio[21264]: info: CorePlayQueue::getTrack 2 May 01 10:47:15 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:15 volumio volumio[21264]: info: CorePlayQueue::getTrack 2 May 01 10:47:15 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:15 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:47:15 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:47:15 volumio volumio[21264]: info: CorePlayQueue::getTrack 2 May 01 10:47:15 volumio volumio[21264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":241,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track09.wav","artist":null,"album":null,"uri":"NAS/Music/Track09.wav","trackType":"wav"} May 01 10:47:15 volumio volumio[21264]: verbose: CURRENT POSITION 2 May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::syncState stateService play May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus play May 01 10:47:15 volumio volumio[21264]: info: Received an update from plugin. extracting info from payload May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:15 volumio volumio[21264]: info: CorePlayQueue::getTrack 2 May 01 10:47:15 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:15 volumio volumio[21264]: info: CorePlayQueue::getTrack 2 May 01 10:47:15 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:15 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:47:15 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:47:15 volumio volumio[21264]: info: CorePlayQueue::getTrack 2 May 01 10:47:15 volumio volumio[21264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":241,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Track09.wav","artist":null,"album":null,"uri":"NAS/Music/Track09.wav","trackType":"wav"} May 01 10:47:15 volumio volumio[21264]: verbose: CURRENT POSITION 2 May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::syncState stateService play May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus play May 01 10:47:15 volumio volumio[21264]: info: Received an update from plugin. extracting info from payload May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:15 volumio volumio[21264]: info: CorePlayQueue::getTrack 2 May 01 10:47:15 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:15 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:15 volumio volumio[21264]: info: CorePlayQueue::getTrack 2 May 01 10:47:15 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:15 volumio volumio[21264]: info: ------------------------------ 256ms May 01 10:47:15 volumio volumio[21264]: info: ------------------------------ 246ms May 01 10:47:15 volumio volumio[21264]: info: ------------------------------ 244ms May 01 10:47:15 volumio volumio[21264]: info: CoreCommandRouter::volumioPlay May 01 10:47:16 volumio volumio[21264]: info: CoreStateMachine::play index 5 May 01 10:47:16 volumio volumio[21264]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 10:47:16 volumio volumio[21264]: info: CoreStateMachine::stop May 01 10:47:16 volumio volumio[21264]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 10:47:16 volumio volumio[21264]: info: CoreStateMachine::stPlaybackTimer May 01 10:47:16 volumio volumio[21264]: info: CoreStateMachine::updateTrackBlock May 01 10:47:16 volumio volumio[21264]: info: CorePlayQueue::getTrackBlock May 01 10:47:16 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:16 volumio volumio[21264]: info: CorePlayQueue::getTrack 2 May 01 10:47:16 volumio volumio[21264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 10:47:16 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:16 volumio volumio[21264]: info: CoreStateMachine::serviceStop May 01 10:47:16 volumio volumio[21264]: info: CorePlayQueue::getTrack 2 May 01 10:47:16 volumio volumio[21264]: info: CoreCommandRouter::serviceStop May 01 10:47:16 volumio volumio[21264]: info: ControllerMpd::stop May 01 10:47:16 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand stop May 01 10:47:17 volumio volumio[21264]: info: May 01 10:47:17 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:47:17 volumio volumio[21264]: info: sendMpdCommand stop took 1773 milliseconds May 01 10:47:17 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:47:17 volumio volumio[21264]: info: CoreStateMachine::play index undefined May 01 10:47:17 volumio volumio[21264]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 10:47:17 volumio volumio[21264]: info: CorePlayQueue::getTrack 5 May 01 10:47:17 volumio volumio[21264]: info: CoreStateMachine::startPlaybackTimer May 01 10:47:17 volumio volumio[21264]: info: CorePlayQueue::getTrack 5 May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/下辈子如果我还记得你-童丽-7599081.flac May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand stop May 01 10:47:17 volumio volumio[21264]: info: May 01 10:47:17 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:47:17 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:47:17 volumio volumio[21264]: info: May 01 10:47:17 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:47:17 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:47:17 volumio volumio[21264]: info: sendMpdCommand status took 24 milliseconds May 01 10:47:17 volumio volumio[21264]: info: sendMpdCommand stop took 20 milliseconds May 01 10:47:17 volumio volumio[21264]: info: sendMpdCommand status took 18 milliseconds May 01 10:47:17 volumio volumio[21264]: info: sendMpdCommand status took 17 milliseconds May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand clear May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:47:17 volumio volumio[21264]: info: May 01 10:47:17 volumio volumio[21264]: ---------------------------- MPD announces system playlist update May 01 10:47:17 volumio volumio[21264]: info: Ignoring MPD Status Update May 01 10:47:17 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 7 milliseconds May 01 10:47:17 volumio volumio[21264]: info: sendMpdCommand clear took 8 milliseconds May 01 10:47:17 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 7 milliseconds May 01 10:47:17 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 7 milliseconds May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/下辈子如果我还记得你-童丽-7599081.flac" May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:47:17 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:47:17 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:47:17 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:17 volumio volumio[21264]: info: CorePlayQueue::getTrack 5 May 01 10:47:17 volumio volumio[21264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 10:47:17 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:17 volumio volumio[21264]: info: CorePlayQueue::getTrack 5 May 01 10:47:17 volumio volumio[21264]: 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":"Track09.wav","artist":null,"album":null,"uri":"NAS/Music/Track09.wav","trackType":"wav"} May 01 10:47:17 volumio volumio[21264]: verbose: CURRENT POSITION 5 May 01 10:47:17 volumio volumio[21264]: info: CoreStateMachine::syncState stateService stop May 01 10:47:17 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus stop May 01 10:47:17 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:17 volumio volumio[21264]: info: CorePlayQueue::getTrack 5 May 01 10:47:17 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:17 volumio volumio[21264]: info: No code May 01 10:47:17 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:17 volumio volumio[21264]: info: CorePlayQueue::getTrack 5 May 01 10:47:17 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:17 volumio volumio[21264]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 01 10:47:17 volumio volumio[21264]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 01 10:47:17 volumio volumio[21264]: info: ------------------------------ 99ms May 01 10:47:17 volumio volumio[21264]: info: ------------------------------ 92ms May 01 10:47:17 volumio volumio[21264]: info: ------------------------------ 90ms May 01 10:47:17 volumio volumio[21264]: info: May 01 10:47:17 volumio volumio[21264]: ---------------------------- MPD announces system playlist update May 01 10:47:17 volumio volumio[21264]: info: Ignoring MPD Status Update May 01 10:47:17 volumio volumio[21264]: info: May 01 10:47:17 volumio volumio[21264]: ---------------------------- MPD announces system playlist update May 01 10:47:17 volumio volumio[21264]: info: Ignoring MPD Status Update May 01 10:47:17 volumio volumio[21264]: error: updateQueue error: null May 01 10:47:17 volumio volumio[21264]: info: May 01 10:47:17 volumio volumio[21264]: ---------------------------- MPD announces system playlist update May 01 10:47:17 volumio volumio[21264]: info: Ignoring MPD Status Update May 01 10:47:17 volumio volumio[21264]: info: ------------------------------ 76ms May 01 10:47:17 volumio volumio[21264]: info: sendMpdCommand add "NAS/Music/下辈子如果我还记得你-童丽-7599081.flac" took 73 milliseconds May 01 10:47:17 volumio volumio[21264]: info: ------------------------------ 11ms May 01 10:47:17 volumio volumio[21264]: info: ------------------------------ 10ms May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand play May 01 10:47:17 volumio volumio[21264]: info: May 01 10:47:17 volumio volumio[21264]: ---------------------------- MPD announces system playlist update May 01 10:47:17 volumio volumio[21264]: info: Ignoring MPD Status Update May 01 10:47:17 volumio volumio[21264]: info: May 01 10:47:17 volumio volumio[21264]: ---------------------------- MPD announces system playlist update May 01 10:47:17 volumio volumio[21264]: info: Ignoring MPD Status Update May 01 10:47:17 volumio volumio[21264]: info: ------------------------------ 19ms May 01 10:47:17 volumio volumio[21264]: info: sendMpdCommand play took 15 milliseconds May 01 10:47:17 volumio volumio[21264]: info: ------------------------------ 14ms May 01 10:47:17 volumio volumio[21264]: info: ------------------------------ 12ms May 01 10:47:17 volumio volumio[21264]: info: May 01 10:47:17 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:47:17 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:47:17 volumio volumio[21264]: info: May 01 10:47:17 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:47:17 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:47:17 volumio volumio[21264]: info: May 01 10:47:17 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:47:17 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:47:17 volumio volumio[21264]: info: sendMpdCommand status took 43 milliseconds May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:47:17 volumio volumio[21264]: info: May 01 10:47:17 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:47:17 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:47:17 volumio volumio[21264]: info: sendMpdCommand status took 46 milliseconds May 01 10:47:17 volumio volumio[21264]: info: sendMpdCommand status took 44 milliseconds May 01 10:47:17 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 7 milliseconds May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:47:17 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:47:17 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:47:17 volumio volumio[21264]: info: CorePlayQueue::getTrack 5 May 01 10:47:17 volumio volumio[21264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":266,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"下辈子如果我还记得你","artist":"童丽","album":null,"uri":"NAS/Music/下辈子如果我还记得你-童丽-7599081.flac","trackType":"flac"} May 01 10:47:17 volumio volumio[21264]: verbose: CURRENT POSITION 5 May 01 10:47:17 volumio volumio[21264]: info: CoreStateMachine::syncState stateService play May 01 10:47:17 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus stop May 01 10:47:17 volumio volumio[21264]: info: ------------------------------ 61ms May 01 10:47:17 volumio volumio[21264]: info: May 01 10:47:17 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:47:17 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:47:17 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:47:18 volumio volumio[21264]: info: May 01 10:47:18 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:47:18 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:47:18 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:47:18 volumio volumio[21264]: info: sendMpdCommand status took 24 milliseconds May 01 10:47:18 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 20 milliseconds May 01 10:47:18 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 20 milliseconds May 01 10:47:18 volumio volumio[21264]: info: sendMpdCommand status took 13 milliseconds May 01 10:47:18 volumio volumio[21264]: info: sendMpdCommand status took 5 milliseconds May 01 10:47:18 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:47:18 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:47:18 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:47:18 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:47:18 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:47:18 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:47:18 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:47:18 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:47:18 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:47:18 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:47:18 volumio volumio[21264]: info: CorePlayQueue::getTrack 5 May 01 10:47:18 volumio volumio[21264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":266,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"下辈子如果我还记得你","artist":"童丽","album":null,"uri":"NAS/Music/下辈子如果我还记得你-童丽-7599081.flac","trackType":"flac"} May 01 10:47:18 volumio volumio[21264]: verbose: CURRENT POSITION 5 May 01 10:47:18 volumio volumio[21264]: info: CoreStateMachine::syncState stateService play May 01 10:47:18 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus play May 01 10:47:18 volumio volumio[21264]: info: Received an update from plugin. extracting info from payload May 01 10:47:18 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:18 volumio volumio[21264]: info: CorePlayQueue::getTrack 5 May 01 10:47:18 volumio volumio[21264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 10:47:18 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:18 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:18 volumio volumio[21264]: info: CorePlayQueue::getTrack 5 May 01 10:47:18 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:18 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:47:18 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:47:18 volumio volumio[21264]: info: CorePlayQueue::getTrack 5 May 01 10:47:18 volumio volumio[21264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":266,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"下辈子如果我还记得你","artist":"童丽","album":null,"uri":"NAS/Music/下辈子如果我还记得你-童丽-7599081.flac","trackType":"flac"} May 01 10:47:18 volumio volumio[21264]: verbose: CURRENT POSITION 5 May 01 10:47:18 volumio volumio[21264]: info: CoreStateMachine::syncState stateService play May 01 10:47:18 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus play May 01 10:47:18 volumio volumio[21264]: info: Received an update from plugin. extracting info from payload May 01 10:47:18 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:18 volumio volumio[21264]: info: CorePlayQueue::getTrack 5 May 01 10:47:18 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:18 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:18 volumio volumio[21264]: info: CorePlayQueue::getTrack 5 May 01 10:47:18 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:18 volumio volumio[21264]: info: ------------------------------ 144ms May 01 10:47:18 volumio volumio[21264]: info: ------------------------------ 142ms May 01 10:47:18 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 72 milliseconds May 01 10:47:18 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 71 milliseconds May 01 10:47:18 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 70 milliseconds May 01 10:47:18 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:47:18 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:47:18 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:47:18 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:47:18 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:47:18 volumio volumio[21264]: info: CorePlayQueue::getTrack 5 May 01 10:47:18 volumio volumio[21264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":266,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"下辈子如果我还记得你","artist":"童丽","album":null,"uri":"NAS/Music/下辈子如果我还记得你-童丽-7599081.flac","trackType":"flac"} May 01 10:47:18 volumio volumio[21264]: verbose: CURRENT POSITION 5 May 01 10:47:18 volumio volumio[21264]: info: CoreStateMachine::syncState stateService play May 01 10:47:18 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus play May 01 10:47:18 volumio volumio[21264]: info: Received an update from plugin. extracting info from payload May 01 10:47:18 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:18 volumio volumio[21264]: info: CorePlayQueue::getTrack 5 May 01 10:47:18 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:18 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:18 volumio volumio[21264]: info: CorePlayQueue::getTrack 5 May 01 10:47:18 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:18 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:47:18 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:47:18 volumio volumio[21264]: info: CorePlayQueue::getTrack 5 May 01 10:47:18 volumio volumio[21264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":266,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"下辈子如果我还记得你","artist":"童丽","album":null,"uri":"NAS/Music/下辈子如果我还记得你-童丽-7599081.flac","trackType":"flac"} May 01 10:47:18 volumio volumio[21264]: verbose: CURRENT POSITION 5 May 01 10:47:18 volumio volumio[21264]: info: CoreStateMachine::syncState stateService play May 01 10:47:18 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus play May 01 10:47:18 volumio volumio[21264]: info: Received an update from plugin. extracting info from payload May 01 10:47:18 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:18 volumio volumio[21264]: info: CorePlayQueue::getTrack 5 May 01 10:47:18 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:18 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:18 volumio volumio[21264]: info: CorePlayQueue::getTrack 5 May 01 10:47:18 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:18 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:47:18 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:47:18 volumio volumio[21264]: info: CorePlayQueue::getTrack 5 May 01 10:47:18 volumio volumio[21264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":266,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"下辈子如果我还记得你","artist":"童丽","album":null,"uri":"NAS/Music/下辈子如果我还记得你-童丽-7599081.flac","trackType":"flac"} May 01 10:47:18 volumio volumio[21264]: verbose: CURRENT POSITION 5 May 01 10:47:18 volumio volumio[21264]: info: CoreStateMachine::syncState stateService play May 01 10:47:18 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus play May 01 10:47:18 volumio volumio[21264]: info: Received an update from plugin. extracting info from payload May 01 10:47:18 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:18 volumio volumio[21264]: info: CorePlayQueue::getTrack 5 May 01 10:47:18 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:18 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:18 volumio volumio[21264]: info: CorePlayQueue::getTrack 5 May 01 10:47:18 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:18 volumio volumio[21264]: info: ------------------------------ 217ms May 01 10:47:18 volumio volumio[21264]: info: ------------------------------ 205ms May 01 10:47:18 volumio volumio[21264]: info: ------------------------------ 199ms May 01 10:47:27 volumio volumio[21264]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%BB%91%E9%B8%AD%E5%AD%90/21806434-3fcd-4102-a2b9-2e31e993a1ab.jpg' May 01 10:47:34 volumio volumio[21264]: info: VolumeController::SetAlsaVolume- May 01 10:47:34 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:34 volumio volumio[21264]: info: CorePlayQueue::getTrack 5 May 01 10:47:34 volumio volumio[21264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 10:47:34 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:34 volumio volumio[21264]: info: VolumeController::SetAlsaVolume- May 01 10:47:34 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:34 volumio volumio[21264]: info: CorePlayQueue::getTrack 5 May 01 10:47:34 volumio volumio[21264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 10:47:34 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:36 volumio volumio[21264]: info: VolumeController::SetAlsaVolume- May 01 10:47:36 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:47:36 volumio volumio[21264]: info: CorePlayQueue::getTrack 5 May 01 10:47:36 volumio volumio[21264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 10:47:36 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:47:55 volumio volumio[21264]: info: CoreCommandRouter::executeOnPlugin: last_100 , handleBrowseUri May 01 10:47:55 volumio volumio[21264]: info: Preload queue cleared May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/USB/DAPHILELIVE/Music/巫娜 - 茶界9.wav May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/USB/DAPHILELIVE/Music/《回家的路》-老猫猴乐队.flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/USB/DAPHILELIVE/Music/周华健 - 朋友.flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/USB/黑鸭子演唱组 - 山楂树(1).flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/USB/我家住在桃花山_(cover__陈姿羽er)-小石头和孩子们-187939926-320.mp3 May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/李英 - 我的思念你能否感受.flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/李英 - 放下世界放不下你.flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/李英 - 情深似海 (新版).flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/李英 - 情海无边回头无岸 (Live合唱版)(1).flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/李英 - 情海无边回头无岸 (Live合唱版).flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/李英 - 多年以后的我.flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/李英 - 回忆在午夜重叠.flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/李英 - 你是我放不下的牵挂.flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/李英 - 今夜的雨是谁的眼泪 (DJ默涵版).flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/李英 - 人生需自渡.flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/李英 - 一次心动铭记一生.flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/风语 - 放不下的牵挂.flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/马健涛 - 搀扶 (二胡版).flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/杨雯梓 - 搀扶.flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/刀郎 - 情人.ape May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/黄昏-周传雄-1044318.flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/Casablanca-Bertie_Higgins-40937857.flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/哈密瓜 - 斯卡布罗集市.flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/Going_Home-Kenny_G-3192579.flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/那拉提的养蜂女-阿娣围裙姐-165617951.flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/彩云追月-爱戴-159248.flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/弯弯的月亮-扎西平措_旦增尼玛-59453052.flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/一生有你-张辛怡-28822028.flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/群星 - 山茶花.flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/李英 - 相思炉中受熬煎 (Live合唱版).flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/李英 - 熟悉变陌生.flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/李英 - 没有你的城市里 (伤感流泪版).flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/李英 - 放手是最后的体面.flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/Eagles - Hotel California.flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/Hayley Westenra - Scarborough Fair.flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/水木年华 - 一生有你 (Live).flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/伽菲珈而 - 潜海姑娘.flac May 01 10:47:55 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/不了情-赵鹏-28630308.flac May 01 10:47:55 volumio volumio[21264]: info: Exploding uri mnt/USB/DAPHILELIVE/Music/巫娜 - 茶界9.wav in service mpd May 01 10:47:55 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%3F%3F%3F%C8%B9%3F%3F%3F/%3F%3F%3F%3F9/extralarge&path=%2Fmnt%2FUSB%2FDAPHILELIVE%2FMusic%2F%E5%B7%AB%E5%A8%9C%20-%20%E8%8C%B6%E7%95%8C9.wav&metadata=false May 01 10:47:55 volumio volumio[21264]: info: URI /mnt/USB/DAPHILELIVE/Music/巫娜 - 茶界9.wav May 01 10:47:55 volumio volumio[21264]: info: Exploding uri mnt/USB/DAPHILELIVE/Music/《回家的路》-老猫猴乐队.flac in service mpd May 01 10:47:55 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E8%80%81%E7%8C%AB%E7%8C%B4%E4%B9%90%E9%98%9F/%E3%80%8A%E9%85%A5%E9%B1%BC%E9%94%85%E3%80%8B/extralarge&path=%2Fmnt%2FUSB%2FDAPHILELIVE%2FMusic%2F%E3%80%8A%E5%9B%9E%E5%AE%B6%E7%9A%84%E8%B7%AF%E3%80%8B-%E8%80%81%E7%8C%AB%E7%8C%B4%E4%B9%90%E9%98%9F.flac&metadata=false May 01 10:47:55 volumio volumio[21264]: info: URI /mnt/USB/DAPHILELIVE/Music/《回家的路》-老猫猴乐队.flac May 01 10:47:55 volumio volumio[21264]: info: Exploding uri mnt/USB/DAPHILELIVE/Music/周华健 - 朋友.flac in service mpd May 01 10:47:55 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E5%91%A8%E5%8D%8E%E5%81%A5/%E6%96%B0%E5%8F%B0%E6%B9%BE%E7%88%B1%E4%BA%BA/extralarge&path=%2Fmnt%2FUSB%2FDAPHILELIVE%2FMusic%2F%E5%91%A8%E5%8D%8E%E5%81%A5%20-%20%E6%9C%8B%E5%8F%8B.flac&metadata=false May 01 10:47:55 volumio volumio[21264]: info: URI /mnt/USB/DAPHILELIVE/Music/周华健 - 朋友.flac May 01 10:47:55 volumio volumio[21264]: info: Exploding uri mnt/USB/黑鸭子演唱组 - 山楂树(1).flac in service mpd May 01 10:47:56 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E9%BB%91%E9%B8%AD%E5%AD%90%E6%BC%94%E5%94%B1%E7%BB%84/%E4%BF%84%E7%BD%97%E6%96%AF%E5%90%8D%E6%9B%B2/extralarge&path=%2Fmnt%2FUSB%2F%E9%BB%91%E9%B8%AD%E5%AD%90%E6%BC%94%E5%94%B1%E7%BB%84%20-%20%E5%B1%B1%E6%A5%82%E6%A0%91(1).flac&metadata=false May 01 10:47:56 volumio volumio[21264]: info: URI /mnt/USB/黑鸭子演唱组 - 山楂树(1).flac May 01 10:47:56 volumio volumio[21264]: info: Exploding uri mnt/USB/我家住在桃花山_(cover__陈姿羽er)-小石头和孩子们-187939926-320.mp3 in service mpd May 01 10:47:56 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E5%B0%8F%E7%9F%B3%E5%A4%B4%E5%92%8C%E5%AD%A9%E5%AD%90%E4%BB%AC/%E6%88%91%E5%AE%B6%E4%BD%8F%E5%9C%A8%E6%A1%83%E8%8A%B1%E5%B1%B1/extralarge&path=%2Fmnt%2FUSB%2F%E6%88%91%E5%AE%B6%E4%BD%8F%E5%9C%A8%E6%A1%83%E8%8A%B1%E5%B1%B1_(cover__%E9%99%88%E5%A7%BF%E7%BE%BDer)-%E5%B0%8F%E7%9F%B3%E5%A4%B4%E5%92%8C%E5%AD%A9%E5%AD%90%E4%BB%AC-187939926-320.mp3&metadata=false May 01 10:47:56 volumio volumio[21264]: info: URI /mnt/USB/我家住在桃花山_(cover__陈姿羽er)-小石头和孩子们-187939926-320.mp3 May 01 10:47:56 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/李英 - 我的思念你能否感受.flac in service mpd May 01 10:47:56 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E6%9D%8E%E8%8B%B1/%E6%88%91%E7%9A%84%E6%80%9D%E5%BF%B5%E4%BD%A0%E8%83%BD%E5%90%A6%E6%84%9F%E5%8F%97/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E6%9D%8E%E8%8B%B1%20-%20%E6%88%91%E7%9A%84%E6%80%9D%E5%BF%B5%E4%BD%A0%E8%83%BD%E5%90%A6%E6%84%9F%E5%8F%97.flac&metadata=false May 01 10:47:56 volumio volumio[21264]: info: URI /mnt/NAS/Music/李英 - 我的思念你能否感受.flac May 01 10:47:56 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/李英 - 放下世界放不下你.flac in service mpd May 01 10:47:56 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E6%9D%8E%E8%8B%B1/%E6%94%BE%E4%B8%8B%E4%B8%96%E7%95%8C%E6%94%BE%E4%B8%8D%E4%B8%8B%E4%BD%A0/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E6%9D%8E%E8%8B%B1%20-%20%E6%94%BE%E4%B8%8B%E4%B8%96%E7%95%8C%E6%94%BE%E4%B8%8D%E4%B8%8B%E4%BD%A0.flac&metadata=false May 01 10:47:56 volumio volumio[21264]: info: URI /mnt/NAS/Music/李英 - 放下世界放不下你.flac May 01 10:47:56 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/李英 - 情深似海 (新版).flac in service mpd May 01 10:47:56 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E6%9D%8E%E8%8B%B1/%E6%83%85%E6%B7%B1%E4%BC%BC%E6%B5%B7/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E6%9D%8E%E8%8B%B1%20-%20%E6%83%85%E6%B7%B1%E4%BC%BC%E6%B5%B7%20(%E6%96%B0%E7%89%88).flac&metadata=false May 01 10:47:56 volumio volumio[21264]: info: URI /mnt/NAS/Music/李英 - 情深似海 (新版).flac May 01 10:47:56 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/李英 - 情海无边回头无岸 (Live合唱版)(1).flac in service mpd May 01 10:47:56 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E6%9D%8E%E8%8B%B1/%E6%83%85%E6%B5%B7%E6%97%A0%E8%BE%B9%E5%9B%9E%E5%A4%B4%E6%97%A0%E5%B2%B8/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E6%9D%8E%E8%8B%B1%20-%20%E6%83%85%E6%B5%B7%E6%97%A0%E8%BE%B9%E5%9B%9E%E5%A4%B4%E6%97%A0%E5%B2%B8%20(Live%E5%90%88%E5%94%B1%E7%89%88)(1).flac&metadata=false May 01 10:47:56 volumio volumio[21264]: info: URI /mnt/NAS/Music/李英 - 情海无边回头无岸 (Live合唱版)(1).flac May 01 10:47:56 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/李英 - 情海无边回头无岸 (Live合唱版).flac in service mpd May 01 10:47:56 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E6%9D%8E%E8%8B%B1/%E6%83%85%E6%B5%B7%E6%97%A0%E8%BE%B9%E5%9B%9E%E5%A4%B4%E6%97%A0%E5%B2%B8/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E6%9D%8E%E8%8B%B1%20-%20%E6%83%85%E6%B5%B7%E6%97%A0%E8%BE%B9%E5%9B%9E%E5%A4%B4%E6%97%A0%E5%B2%B8%20(Live%E5%90%88%E5%94%B1%E7%89%88).flac&metadata=false May 01 10:47:56 volumio volumio[21264]: info: URI /mnt/NAS/Music/李英 - 情海无边回头无岸 (Live合唱版).flac May 01 10:47:56 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/李英 - 多年以后的我.flac in service mpd May 01 10:47:56 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E6%9D%8E%E8%8B%B1/%E5%A4%9A%E5%B9%B4%E4%BB%A5%E5%90%8E%E7%9A%84%E6%88%91/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E6%9D%8E%E8%8B%B1%20-%20%E5%A4%9A%E5%B9%B4%E4%BB%A5%E5%90%8E%E7%9A%84%E6%88%91.flac&metadata=false May 01 10:47:56 volumio volumio[21264]: info: URI /mnt/NAS/Music/李英 - 多年以后的我.flac May 01 10:47:56 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/李英 - 回忆在午夜重叠.flac in service mpd May 01 10:47:56 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E6%9D%8E%E8%8B%B1/%E5%9B%9E%E5%BF%86%E5%9C%A8%E5%8D%88%E5%A4%9C%E9%87%8D%E5%8F%A0/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E6%9D%8E%E8%8B%B1%20-%20%E5%9B%9E%E5%BF%86%E5%9C%A8%E5%8D%88%E5%A4%9C%E9%87%8D%E5%8F%A0.flac&metadata=false May 01 10:47:56 volumio volumio[21264]: info: URI /mnt/NAS/Music/李英 - 回忆在午夜重叠.flac May 01 10:47:56 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/李英 - 你是我放不下的牵挂.flac in service mpd May 01 10:47:56 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E6%9D%8E%E8%8B%B1/%E4%BD%A0%E6%98%AF%E6%88%91%E6%94%BE%E4%B8%8D%E4%B8%8B%E7%9A%84%E7%89%B5%E6%8C%82/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E6%9D%8E%E8%8B%B1%20-%20%E4%BD%A0%E6%98%AF%E6%88%91%E6%94%BE%E4%B8%8D%E4%B8%8B%E7%9A%84%E7%89%B5%E6%8C%82.flac&metadata=false May 01 10:47:56 volumio volumio[21264]: info: URI /mnt/NAS/Music/李英 - 你是我放不下的牵挂.flac May 01 10:47:56 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/李英 - 今夜的雨是谁的眼泪 (DJ默涵版).flac in service mpd May 01 10:47:56 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E6%9D%8E%E8%8B%B1/%E4%BB%8A%E5%A4%9C%E7%9A%84%E9%9B%A8%E6%98%AF%E8%B0%81%E7%9A%84%E7%9C%BC%E6%B3%AA/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E6%9D%8E%E8%8B%B1%20-%20%E4%BB%8A%E5%A4%9C%E7%9A%84%E9%9B%A8%E6%98%AF%E8%B0%81%E7%9A%84%E7%9C%BC%E6%B3%AA%20(DJ%E9%BB%98%E6%B6%B5%E7%89%88).flac&metadata=false May 01 10:47:56 volumio volumio[21264]: info: URI /mnt/NAS/Music/李英 - 今夜的雨是谁的眼泪 (DJ默涵版).flac May 01 10:47:56 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/李英 - 人生需自渡.flac in service mpd May 01 10:47:56 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E6%9D%8E%E8%8B%B1/%E4%BA%BA%E7%94%9F%E9%9C%80%E8%87%AA%E6%B8%A1/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E6%9D%8E%E8%8B%B1%20-%20%E4%BA%BA%E7%94%9F%E9%9C%80%E8%87%AA%E6%B8%A1.flac&metadata=false May 01 10:47:56 volumio volumio[21264]: info: URI /mnt/NAS/Music/李英 - 人生需自渡.flac May 01 10:47:56 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/李英 - 一次心动铭记一生.flac in service mpd May 01 10:47:56 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E6%9D%8E%E8%8B%B1/%E4%B8%80%E6%AC%A1%E5%BF%83%E5%8A%A8%E9%93%AD%E8%AE%B0%E4%B8%80%E7%94%9F/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E6%9D%8E%E8%8B%B1%20-%20%E4%B8%80%E6%AC%A1%E5%BF%83%E5%8A%A8%E9%93%AD%E8%AE%B0%E4%B8%80%E7%94%9F.flac&metadata=false May 01 10:47:56 volumio volumio[21264]: info: URI /mnt/NAS/Music/李英 - 一次心动铭记一生.flac May 01 10:47:56 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/风语 - 放不下的牵挂.flac in service mpd May 01 10:47:56 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E9%A3%8E%E8%AF%AD/%E4%BD%A0%E6%98%AF%E6%88%91%E7%9A%84%E7%BE%8E%E4%B8%BD%E5%A5%B3%E7%A5%9E/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E9%A3%8E%E8%AF%AD%20-%20%E6%94%BE%E4%B8%8D%E4%B8%8B%E7%9A%84%E7%89%B5%E6%8C%82.flac&metadata=false May 01 10:47:56 volumio volumio[21264]: info: URI /mnt/NAS/Music/风语 - 放不下的牵挂.flac May 01 10:47:56 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/马健涛 - 搀扶 (二胡版).flac in service mpd May 01 10:47:56 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E9%A9%AC%E5%81%A5%E6%B6%9B/%E6%90%80%E6%89%B6%20(%E4%BA%8C%E8%83%A1%E7%89%88)/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E9%A9%AC%E5%81%A5%E6%B6%9B%20-%20%E6%90%80%E6%89%B6%20(%E4%BA%8C%E8%83%A1%E7%89%88).flac&metadata=false May 01 10:47:56 volumio volumio[21264]: info: URI /mnt/NAS/Music/马健涛 - 搀扶 (二胡版).flac May 01 10:47:56 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/杨雯梓 - 搀扶.flac in service mpd May 01 10:47:56 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E6%9D%A8%E9%9B%AF%E6%A2%93/%E6%90%80%20%E6%89%B6/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E6%9D%A8%E9%9B%AF%E6%A2%93%20-%20%E6%90%80%E6%89%B6.flac&metadata=false May 01 10:47:56 volumio volumio[21264]: info: URI /mnt/NAS/Music/杨雯梓 - 搀扶.flac May 01 10:47:56 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/刀郎 - 情人.ape in service mpd May 01 10:47:56 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E5%88%80%E9%83%8E/www.520hjl.com%E6%B5%B7%E7%B2%BE%E7%81%B5%E9%9F%B3%E4%B9%90%E7%BE%8E%E5%9B%BE%E8%AE%BA%E5%9D%9B/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E5%88%80%E9%83%8E%20-%20%E6%83%85%E4%BA%BA.ape&metadata=false May 01 10:47:56 volumio volumio[21264]: info: URI /mnt/NAS/Music/刀郎 - 情人.ape May 01 10:47:56 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/黄昏-周传雄-1044318.flac in service mpd May 01 10:47:56 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E5%91%A8%E4%BC%A0%E9%9B%84/transfer/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E9%BB%84%E6%98%8F-%E5%91%A8%E4%BC%A0%E9%9B%84-1044318.flac&metadata=false May 01 10:47:56 volumio volumio[21264]: info: URI /mnt/NAS/Music/黄昏-周传雄-1044318.flac May 01 10:47:56 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/Casablanca-Bertie_Higgins-40937857.flac in service mpd May 01 10:47:56 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=Bertie%20Higgins/SONY%E6%9E%81%E5%93%81%E8%AF%95%E9%9F%B3%E7%A2%9F/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FCasablanca-Bertie_Higgins-40937857.flac&metadata=false May 01 10:47:56 volumio volumio[21264]: info: URI /mnt/NAS/Music/Casablanca-Bertie_Higgins-40937857.flac May 01 10:47:56 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/哈密瓜 - 斯卡布罗集市.flac in service mpd May 01 10:47:56 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E5%93%88%E5%AF%86%E7%93%9C/SCARBOROUGH%20FAIR/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E5%93%88%E5%AF%86%E7%93%9C%20-%20%E6%96%AF%E5%8D%A1%E5%B8%83%E7%BD%97%E9%9B%86%E5%B8%82.flac&metadata=false May 01 10:47:56 volumio volumio[21264]: info: URI /mnt/NAS/Music/哈密瓜 - 斯卡布罗集市.flac May 01 10:47:57 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/Going_Home-Kenny_G-3192579.flac in service mpd May 01 10:47:57 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=Kenny%20G/Love%20Ballads/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FGoing_Home-Kenny_G-3192579.flac&metadata=false May 01 10:47:57 volumio volumio[21264]: info: URI /mnt/NAS/Music/Going_Home-Kenny_G-3192579.flac May 01 10:47:57 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/那拉提的养蜂女-阿娣围裙姐-165617951.flac in service mpd May 01 10:47:57 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E9%98%BF%E5%A8%A3%E5%9B%B4%E8%A3%99%E5%A7%90/kuwo/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E9%82%A3%E6%8B%89%E6%8F%90%E7%9A%84%E5%85%BB%E8%9C%82%E5%A5%B3-%E9%98%BF%E5%A8%A3%E5%9B%B4%E8%A3%99%E5%A7%90-165617951.flac&metadata=false May 01 10:47:57 volumio volumio[21264]: info: URI /mnt/NAS/Music/那拉提的养蜂女-阿娣围裙姐-165617951.flac May 01 10:47:57 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/彩云追月-爱戴-159248.flac in service mpd May 01 10:47:57 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E7%88%B1%E6%88%B4/Edell.love/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E5%BD%A9%E4%BA%91%E8%BF%BD%E6%9C%88-%E7%88%B1%E6%88%B4-159248.flac&metadata=false May 01 10:47:57 volumio volumio[21264]: info: URI /mnt/NAS/Music/彩云追月-爱戴-159248.flac May 01 10:47:57 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/弯弯的月亮-扎西平措_旦增尼玛-59453052.flac in service mpd May 01 10:47:57 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E6%89%8E%E8%A5%BF%E5%B9%B3%E6%8E%AA%2F%E6%97%A6%E5%A2%9E%E5%B0%BC%E7%8E%9B/2018%E5%A4%A9%E7%B1%81%E4%B9%8B%E9%9F%B3%E4%B8%AD%E5%9B%BD%E8%97%8F%E6%AD%8C%E4%BC%9A%20%E7%AC%AC10%E6%9C%9F/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E5%BC%AF%E5%BC%AF%E7%9A%84%E6%9C%88%E4%BA%AE-%E6%89%8E%E8%A5%BF%E5%B9%B3%E6%8E%AA_%E6%97%A6%E5%A2%9E%E5%B0%BC%E7%8E%9B-59453052.flac&metadata=false May 01 10:47:57 volumio volumio[21264]: info: URI /mnt/NAS/Music/弯弯的月亮-扎西平措_旦增尼玛-59453052.flac May 01 10:47:57 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/一生有你-张辛怡-28822028.flac in service mpd May 01 10:47:57 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E5%BC%A0%E8%BE%9B%E6%80%A1/%E4%B8%80%E7%94%9F%E6%9C%89%E4%BD%A0/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E4%B8%80%E7%94%9F%E6%9C%89%E4%BD%A0-%E5%BC%A0%E8%BE%9B%E6%80%A1-28822028.flac&metadata=false May 01 10:47:57 volumio volumio[21264]: info: URI /mnt/NAS/Music/一生有你-张辛怡-28822028.flac May 01 10:47:57 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/群星 - 山茶花.flac in service mpd May 01 10:47:57 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E7%BE%A4%E6%98%9F/%E4%B8%80%E5%90%AC%E5%85%A5%E8%BF%B7/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E7%BE%A4%E6%98%9F%20-%20%E5%B1%B1%E8%8C%B6%E8%8A%B1.flac&metadata=false May 01 10:47:57 volumio volumio[21264]: info: URI /mnt/NAS/Music/群星 - 山茶花.flac May 01 10:47:57 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/李英 - 相思炉中受熬煎 (Live合唱版).flac in service mpd May 01 10:47:57 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E6%9D%8E%E8%8B%B1/%E7%9B%B8%E6%80%9D%E7%82%89%E4%B8%AD%E5%8F%97%E7%86%AC%E7%85%8E/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E6%9D%8E%E8%8B%B1%20-%20%E7%9B%B8%E6%80%9D%E7%82%89%E4%B8%AD%E5%8F%97%E7%86%AC%E7%85%8E%20(Live%E5%90%88%E5%94%B1%E7%89%88).flac&metadata=false May 01 10:47:57 volumio volumio[21264]: info: URI /mnt/NAS/Music/李英 - 相思炉中受熬煎 (Live合唱版).flac May 01 10:47:57 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/李英 - 熟悉变陌生.flac in service mpd May 01 10:47:57 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E6%9D%8E%E8%8B%B1/%E7%86%9F%E6%82%89%E5%8F%98%E9%99%8C%E7%94%9F/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E6%9D%8E%E8%8B%B1%20-%20%E7%86%9F%E6%82%89%E5%8F%98%E9%99%8C%E7%94%9F.flac&metadata=false May 01 10:47:57 volumio volumio[21264]: info: URI /mnt/NAS/Music/李英 - 熟悉变陌生.flac May 01 10:47:57 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/李英 - 没有你的城市里 (伤感流泪版).flac in service mpd May 01 10:47:57 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E6%9D%8E%E8%8B%B1/%E6%B2%A1%E6%9C%89%E4%BD%A0%E7%9A%84%E5%9F%8E%E5%B8%82%E9%87%8C%20(%E4%BC%A4%E6%84%9F%E6%B5%81%E6%B3%AA%E7%89%88)/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E6%9D%8E%E8%8B%B1%20-%20%E6%B2%A1%E6%9C%89%E4%BD%A0%E7%9A%84%E5%9F%8E%E5%B8%82%E9%87%8C%20(%E4%BC%A4%E6%84%9F%E6%B5%81%E6%B3%AA%E7%89%88).flac&metadata=false May 01 10:47:57 volumio volumio[21264]: info: URI /mnt/NAS/Music/李英 - 没有你的城市里 (伤感流泪版).flac May 01 10:47:57 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/李英 - 放手是最后的体面.flac in service mpd May 01 10:47:57 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E6%9D%8E%E8%8B%B1/%E6%94%BE%E6%89%8B%E6%98%AF%E6%9C%80%E5%90%8E%E7%9A%84%E4%BD%93%E9%9D%A2/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E6%9D%8E%E8%8B%B1%20-%20%E6%94%BE%E6%89%8B%E6%98%AF%E6%9C%80%E5%90%8E%E7%9A%84%E4%BD%93%E9%9D%A2.flac&metadata=false May 01 10:47:57 volumio volumio[21264]: info: URI /mnt/NAS/Music/李英 - 放手是最后的体面.flac May 01 10:47:57 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/Eagles - Hotel California.flac in service mpd May 01 10:47:57 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=Eagles/Hotel%20California%20/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FEagles%20-%20Hotel%20California.flac&metadata=false May 01 10:47:57 volumio volumio[21264]: info: URI /mnt/NAS/Music/Eagles - Hotel California.flac May 01 10:47:57 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/Hayley Westenra - Scarborough Fair.flac in service mpd May 01 10:47:57 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=Hayley%20Westenra/Celtic%20Treasures/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FHayley%20Westenra%20-%20Scarborough%20Fair.flac&metadata=false May 01 10:47:57 volumio volumio[21264]: info: URI /mnt/NAS/Music/Hayley Westenra - Scarborough Fair.flac May 01 10:47:57 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/水木年华 - 一生有你 (Live).flac in service mpd May 01 10:47:57 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E6%B0%B4%E6%9C%A8%E5%B9%B4%E5%8D%8E/2014%E6%81%92%E5%A4%A7%E9%9F%B3%E4%B9%90%E8%8A%82%E7%8E%B0%E5%9C%BA%E7%89%88/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E6%B0%B4%E6%9C%A8%E5%B9%B4%E5%8D%8E%20-%20%E4%B8%80%E7%94%9F%E6%9C%89%E4%BD%A0%20(Live).flac&metadata=false May 01 10:47:57 volumio volumio[21264]: info: URI /mnt/NAS/Music/水木年华 - 一生有你 (Live).flac May 01 10:47:57 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/伽菲珈而 - 潜海姑娘.flac in service mpd May 01 10:47:57 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E4%BC%BD%E8%8F%B2%E7%8F%88%E8%80%8C/HIFI%E5%B9%B4%E4%BB%A3%E7%B2%BE%E9%80%89/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E4%BC%BD%E8%8F%B2%E7%8F%88%E8%80%8C%20-%20%E6%BD%9C%E6%B5%B7%E5%A7%91%E5%A8%98.flac&metadata=false May 01 10:47:57 volumio volumio[21264]: info: URI /mnt/NAS/Music/伽菲珈而 - 潜海姑娘.flac May 01 10:47:57 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/不了情-赵鹏-28630308.flac in service mpd May 01 10:47:57 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E8%B5%B5%E9%B9%8F/%E4%BA%BA%E5%A3%B0%E4%BD%8E%E9%9F%B3%E7%82%AE%20Vol.2%20%E6%9C%88%E5%85%89%E6%A3%AE%E6%9E%97/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E4%B8%8D%E4%BA%86%E6%83%85-%E8%B5%B5%E9%B9%8F-28630308.flac&metadata=false May 01 10:47:57 volumio volumio[21264]: info: URI /mnt/NAS/Music/不了情-赵鹏-28630308.flac May 01 10:48:10 volumio volumio[21264]: info: Preload queue cleared May 01 10:48:10 volumio volumio[21264]: info: CoreCommandRouter::volumioReplaceandPlayItems May 01 10:48:10 volumio volumio[21264]: info: CoreStateMachine::ClearQueue May 01 10:48:10 volumio volumio[21264]: info: CoreStateMachine::stop May 01 10:48:10 volumio volumio[21264]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 10:48:10 volumio volumio[21264]: info: CoreStateMachine::stPlaybackTimer May 01 10:48:10 volumio volumio[21264]: info: CoreStateMachine::updateTrackBlock May 01 10:48:10 volumio volumio[21264]: info: CorePlayQueue::getTrackBlock May 01 10:48:10 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:48:10 volumio volumio[21264]: info: CorePlayQueue::getTrack 5 May 01 10:48:10 volumio volumio[21264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 10:48:10 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:48:10 volumio volumio[21264]: info: CoreStateMachine::serviceStop May 01 10:48:10 volumio volumio[21264]: info: CorePlayQueue::getTrack 5 May 01 10:48:10 volumio volumio[21264]: info: CoreCommandRouter::serviceStop May 01 10:48:10 volumio volumio[21264]: info: ControllerMpd::stop May 01 10:48:10 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand stop May 01 10:48:10 volumio volumio[21264]: info: CorePlayQueue::clearPlayQueue May 01 10:48:10 volumio volumio[21264]: info: CorePlayQueue::saveQueue May 01 10:48:10 volumio volumio[21264]: info: CoreCommandRouter::volumioPushQueue May 01 10:48:10 volumio volumio[21264]: info: CoreStateMachine::addQueueItems May 01 10:48:10 volumio volumio[21264]: info: CorePlayQueue::addQueueItems May 01 10:48:10 volumio volumio[21264]: info: Preload queue cleared May 01 10:48:10 volumio volumio[21264]: info: Adding Item to queue: music-library/NAS/Music/陈星 - 流浪歌.flac May 01 10:48:10 volumio volumio[21264]: info: Using cached record of: music-library/NAS/Music/陈星 - 流浪歌.flac May 01 10:48:10 volumio volumio[21264]: info: Adding Item to queue: music-library/NAS/Music/一场游戏一场梦-雷婷-613776.flac May 01 10:48:10 volumio volumio[21264]: info: Using cached record of: music-library/NAS/Music/一场游戏一场梦-雷婷-613776.flac May 01 10:48:10 volumio volumio[21264]: info: Adding Item to queue: mnt/USB/DAPHILELIVE/Music/巫娜 - 茶界9.wav May 01 10:48:10 volumio volumio[21264]: info: Using cached record of: mnt/USB/DAPHILELIVE/Music/巫娜 - 茶界9.wav May 01 10:48:10 volumio volumio[21264]: info: Adding Item to queue: mnt/USB/DAPHILELIVE/Music/《回家的路》-老猫猴乐队.flac May 01 10:48:10 volumio volumio[21264]: info: Using cached record of: mnt/USB/DAPHILELIVE/Music/《回家的路》-老猫猴乐队.flac May 01 10:48:10 volumio volumio[21264]: info: Adding Item to queue: mnt/USB/DAPHILELIVE/Music/周华健 - 朋友.flac May 01 10:48:10 volumio volumio[21264]: info: Using cached record of: mnt/USB/DAPHILELIVE/Music/周华健 - 朋友.flac May 01 10:48:10 volumio volumio[21264]: info: Adding Item to queue: mnt/USB/黑鸭子演唱组 - 山楂树(1).flac May 01 10:48:10 volumio volumio[21264]: info: Using cached record of: mnt/USB/黑鸭子演唱组 - 山楂树(1).flac May 01 10:48:10 volumio volumio[21264]: info: Adding Item to queue: mnt/USB/我家住在桃花山_(cover__陈姿羽er)-小石头和孩子们-187939926-320.mp3 May 01 10:48:10 volumio volumio[21264]: info: Using cached record of: mnt/USB/我家住在桃花山_(cover__陈姿羽er)-小石头和孩子们-187939926-320.mp3 May 01 10:48:10 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/李英 - 我的思念你能否感受.flac May 01 10:48:10 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/李英 - 我的思念你能否感受.flac May 01 10:48:10 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/李英 - 放下世界放不下你.flac May 01 10:48:10 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/李英 - 放下世界放不下你.flac May 01 10:48:10 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/李英 - 情深似海 (新版).flac May 01 10:48:10 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/李英 - 情深似海 (新版).flac May 01 10:48:10 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/李英 - 情海无边回头无岸 (Live合唱版)(1).flac May 01 10:48:10 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/李英 - 情海无边回头无岸 (Live合唱版)(1).flac May 01 10:48:10 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/李英 - 情海无边回头无岸 (Live合唱版).flac May 01 10:48:10 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/李英 - 情海无边回头无岸 (Live合唱版).flac May 01 10:48:10 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/李英 - 多年以后的我.flac May 01 10:48:10 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/李英 - 多年以后的我.flac May 01 10:48:10 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/李英 - 回忆在午夜重叠.flac May 01 10:48:10 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/李英 - 回忆在午夜重叠.flac May 01 10:48:10 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/李英 - 你是我放不下的牵挂.flac May 01 10:48:10 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/李英 - 你是我放不下的牵挂.flac May 01 10:48:10 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/李英 - 今夜的雨是谁的眼泪 (DJ默涵版).flac May 01 10:48:10 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/李英 - 今夜的雨是谁的眼泪 (DJ默涵版).flac May 01 10:48:10 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/李英 - 人生需自渡.flac May 01 10:48:10 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/李英 - 人生需自渡.flac May 01 10:48:10 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/李英 - 一次心动铭记一生.flac May 01 10:48:10 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/李英 - 一次心动铭记一生.flac May 01 10:48:10 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/风语 - 放不下的牵挂.flac May 01 10:48:10 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/风语 - 放不下的牵挂.flac May 01 10:48:10 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/马健涛 - 搀扶 (二胡版).flac May 01 10:48:10 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/马健涛 - 搀扶 (二胡版).flac May 01 10:48:10 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/杨雯梓 - 搀扶.flac May 01 10:48:10 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/杨雯梓 - 搀扶.flac May 01 10:48:10 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/刀郎 - 情人.ape May 01 10:48:10 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/刀郎 - 情人.ape May 01 10:48:10 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/黄昏-周传雄-1044318.flac May 01 10:48:10 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/黄昏-周传雄-1044318.flac May 01 10:48:10 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/Casablanca-Bertie_Higgins-40937857.flac May 01 10:48:10 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/Casablanca-Bertie_Higgins-40937857.flac May 01 10:48:10 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/哈密瓜 - 斯卡布罗集市.flac May 01 10:48:10 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/哈密瓜 - 斯卡布罗集市.flac May 01 10:48:10 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/Going_Home-Kenny_G-3192579.flac May 01 10:48:10 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/Going_Home-Kenny_G-3192579.flac May 01 10:48:10 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/那拉提的养蜂女-阿娣围裙姐-165617951.flac May 01 10:48:10 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/那拉提的养蜂女-阿娣围裙姐-165617951.flac May 01 10:48:10 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/彩云追月-爱戴-159248.flac May 01 10:48:10 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/彩云追月-爱戴-159248.flac May 01 10:48:10 volumio volumio[21264]: info: CoreCommandRouter::volumioPushQueue May 01 10:48:10 volumio volumio[21264]: info: CorePlayQueue::saveQueue May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::updateTrackBlock May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::getTrackBlock May 01 10:48:11 volumio volumio[21264]: info: CoreCommandRouter::volumioPlay May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::play index 27 May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::addQueueItems May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::addQueueItems May 01 10:48:11 volumio volumio[21264]: info: Preload queue cleared May 01 10:48:11 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/弯弯的月亮-扎西平措_旦增尼玛-59453052.flac May 01 10:48:11 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/弯弯的月亮-扎西平措_旦增尼玛-59453052.flac May 01 10:48:11 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/一生有你-张辛怡-28822028.flac May 01 10:48:11 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/一生有你-张辛怡-28822028.flac May 01 10:48:11 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/群星 - 山茶花.flac May 01 10:48:11 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/群星 - 山茶花.flac May 01 10:48:11 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/李英 - 相思炉中受熬煎 (Live合唱版).flac May 01 10:48:11 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/李英 - 相思炉中受熬煎 (Live合唱版).flac May 01 10:48:11 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/李英 - 熟悉变陌生.flac May 01 10:48:11 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/李英 - 熟悉变陌生.flac May 01 10:48:11 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/李英 - 没有你的城市里 (伤感流泪版).flac May 01 10:48:11 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/李英 - 没有你的城市里 (伤感流泪版).flac May 01 10:48:11 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/李英 - 放手是最后的体面.flac May 01 10:48:11 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/李英 - 放手是最后的体面.flac May 01 10:48:11 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/Eagles - Hotel California.flac May 01 10:48:11 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/Eagles - Hotel California.flac May 01 10:48:11 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/Hayley Westenra - Scarborough Fair.flac May 01 10:48:11 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/Hayley Westenra - Scarborough Fair.flac May 01 10:48:11 volumio volumio[21264]: info: Adding Item to queue: music-library/NAS/Music/一生有你-张辛怡-28822028.flac May 01 10:48:11 volumio volumio[21264]: info: Using cached record of: music-library/NAS/Music/一生有你-张辛怡-28822028.flac May 01 10:48:11 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/水木年华 - 一生有你 (Live).flac May 01 10:48:11 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/水木年华 - 一生有你 (Live).flac May 01 10:48:11 volumio volumio[21264]: info: Adding Item to queue: music-library/NAS/Music/魏佳艺 - 搀扶.flac May 01 10:48:11 volumio volumio[21264]: info: Using cached record of: music-library/NAS/Music/魏佳艺 - 搀扶.flac May 01 10:48:11 volumio volumio[21264]: info: Adding Item to queue: music-library/NAS/Music/马健涛 - 搀扶 (二胡版).flac May 01 10:48:11 volumio volumio[21264]: info: Using cached record of: music-library/NAS/Music/马健涛 - 搀扶 (二胡版).flac May 01 10:48:11 volumio volumio[21264]: info: Adding Item to queue: music-library/NAS/Music/杨雯梓 - 搀扶.flac May 01 10:48:11 volumio volumio[21264]: info: Using cached record of: music-library/NAS/Music/杨雯梓 - 搀扶.flac May 01 10:48:11 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/伽菲珈而 - 潜海姑娘.flac May 01 10:48:11 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/伽菲珈而 - 潜海姑娘.flac May 01 10:48:11 volumio volumio[21264]: info: Adding Item to queue: music-library/NAS/Music/刘春美 - 不离不弃.flac May 01 10:48:11 volumio volumio[21264]: info: Using cached record of: music-library/NAS/Music/刘春美 - 不离不弃.flac May 01 10:48:11 volumio volumio[21264]: info: Adding Item to queue: mnt/NAS/Music/不了情-赵鹏-28630308.flac May 01 10:48:11 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/不了情-赵鹏-28630308.flac May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::stop May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 10:48:11 volumio volumio[21264]: info: CoreCommandRouter::volumioPushQueue May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::saveQueue May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::play index undefined May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::updateTrackBlock May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::getTrackBlock May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::getTrack 27 May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::startPlaybackTimer May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::getTrack 27 May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/彩云追月-爱戴-159248.flac May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand stop May 01 10:48:11 volumio volumio[21264]: info: May 01 10:48:11 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:48:11 volumio volumio[21264]: info: sendMpdCommand stop took 168 milliseconds May 01 10:48:11 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:48:11 volumio volumio[21264]: info: sendMpdCommand stop took 31 milliseconds May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand clear May 01 10:48:11 volumio volumio[21264]: info: May 01 10:48:11 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:48:11 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:48:11 volumio volumio[21264]: info: May 01 10:48:11 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:48:11 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:48:11 volumio volumio[21264]: info: May 01 10:48:11 volumio volumio[21264]: ---------------------------- MPD announces system playlist update May 01 10:48:11 volumio volumio[21264]: info: Ignoring MPD Status Update May 01 10:48:11 volumio volumio[21264]: info: sendMpdCommand status took 13 milliseconds May 01 10:48:11 volumio volumio[21264]: info: sendMpdCommand clear took 12 milliseconds May 01 10:48:11 volumio volumio[21264]: info: sendMpdCommand status took 7 milliseconds May 01 10:48:11 volumio volumio[21264]: info: sendMpdCommand status took 5 milliseconds May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/彩云追月-爱戴-159248.flac" May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:48:11 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:48:11 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::getTrack 27 May 01 10:48:11 volumio volumio[21264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 10:48:11 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::getTrack 27 May 01 10:48:11 volumio volumio[21264]: 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} May 01 10:48:11 volumio volumio[21264]: verbose: CURRENT POSITION 27 May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::syncState stateService stop May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus stop May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::getTrack 27 May 01 10:48:11 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:48:11 volumio volumio[21264]: info: No code May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::getTrack 27 May 01 10:48:11 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:48:11 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:48:11 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::getTrack 27 May 01 10:48:11 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::getTrack 27 May 01 10:48:11 volumio volumio[21264]: 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} May 01 10:48:11 volumio volumio[21264]: verbose: CURRENT POSITION 27 May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::syncState stateService stop May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus stop May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::getTrack 27 May 01 10:48:11 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:48:11 volumio volumio[21264]: info: No code May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::getTrack 27 May 01 10:48:11 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:48:11 volumio volumio[21264]: info: ------------------------------ 108ms May 01 10:48:11 volumio volumio[21264]: info: ------------------------------ 108ms May 01 10:48:11 volumio volumio[21264]: info: May 01 10:48:11 volumio volumio[21264]: ---------------------------- MPD announces system playlist update May 01 10:48:11 volumio volumio[21264]: info: Ignoring MPD Status Update May 01 10:48:11 volumio volumio[21264]: info: May 01 10:48:11 volumio volumio[21264]: ---------------------------- MPD announces system playlist update May 01 10:48:11 volumio volumio[21264]: info: Ignoring MPD Status Update May 01 10:48:11 volumio volumio[21264]: error: updateQueue error: null May 01 10:48:11 volumio volumio[21264]: info: May 01 10:48:11 volumio volumio[21264]: ---------------------------- MPD announces system playlist update May 01 10:48:11 volumio volumio[21264]: info: Ignoring MPD Status Update May 01 10:48:11 volumio volumio[21264]: info: ------------------------------ 116ms May 01 10:48:11 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 112 milliseconds May 01 10:48:11 volumio volumio[21264]: info: sendMpdCommand add "NAS/Music/彩云追月-爱戴-159248.flac" took 112 milliseconds May 01 10:48:11 volumio volumio[21264]: info: ------------------------------ 11ms May 01 10:48:11 volumio volumio[21264]: info: ------------------------------ 9ms May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand play May 01 10:48:11 volumio volumio[21264]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 01 10:48:11 volumio volumio[21264]: info: ------------------------------ 135ms May 01 10:48:11 volumio volumio[21264]: info: May 01 10:48:11 volumio volumio[21264]: ---------------------------- MPD announces system playlist update May 01 10:48:11 volumio volumio[21264]: info: Ignoring MPD Status Update May 01 10:48:11 volumio volumio[21264]: info: May 01 10:48:11 volumio volumio[21264]: ---------------------------- MPD announces system playlist update May 01 10:48:11 volumio volumio[21264]: info: Ignoring MPD Status Update May 01 10:48:11 volumio volumio[21264]: info: ------------------------------ 27ms May 01 10:48:11 volumio volumio[21264]: info: sendMpdCommand play took 22 milliseconds May 01 10:48:11 volumio volumio[21264]: info: ------------------------------ 20ms May 01 10:48:11 volumio volumio[21264]: info: ------------------------------ 18ms May 01 10:48:11 volumio volumio[21264]: info: May 01 10:48:11 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:48:11 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:48:11 volumio volumio[21264]: info: May 01 10:48:11 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:48:11 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:48:11 volumio volumio[21264]: info: May 01 10:48:11 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:48:11 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:48:11 volumio volumio[21264]: info: sendMpdCommand status took 47 milliseconds May 01 10:48:11 volumio volumio[21264]: info: sendMpdCommand status took 45 milliseconds May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:48:11 volumio volumio[21264]: info: May 01 10:48:11 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:48:11 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:48:11 volumio volumio[21264]: info: May 01 10:48:11 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:48:11 volumio volumio[21264]: info: sendMpdCommand status took 54 milliseconds May 01 10:48:11 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:48:11 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 9 milliseconds May 01 10:48:11 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 9 milliseconds May 01 10:48:11 volumio volumio[21264]: info: sendMpdCommand status took 5 milliseconds May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:48:11 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:48:11 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::getTrack 27 May 01 10:48:11 volumio volumio[21264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"彩云追月","artist":"爱戴","album":"Edell.love","uri":"NAS/Music/彩云追月-爱戴-159248.flac","trackType":"flac"} May 01 10:48:11 volumio volumio[21264]: verbose: CURRENT POSITION 27 May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::syncState stateService play May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus stop May 01 10:48:11 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:48:11 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::getTrack 27 May 01 10:48:11 volumio volumio[21264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"彩云追月","artist":"爱戴","album":"Edell.love","uri":"NAS/Music/彩云追月-爱戴-159248.flac","trackType":"flac"} May 01 10:48:11 volumio volumio[21264]: verbose: CURRENT POSITION 27 May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::syncState stateService play May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus play May 01 10:48:11 volumio volumio[21264]: info: Received an update from plugin. extracting info from payload May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::getTrack 27 May 01 10:48:11 volumio volumio[21264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 10:48:11 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::getTrack 27 May 01 10:48:11 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:48:11 volumio volumio[21264]: info: ------------------------------ 91ms May 01 10:48:11 volumio volumio[21264]: info: ------------------------------ 106ms May 01 10:48:11 volumio volumio[21264]: info: May 01 10:48:11 volumio volumio[21264]: ---------------------------- MPD announces state update: player May 01 10:48:11 volumio volumio[21264]: info: ControllerMpd::getState May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand status May 01 10:48:11 volumio volumio[21264]: info: sendMpdCommand status took 52 milliseconds May 01 10:48:11 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 50 milliseconds May 01 10:48:11 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 47 milliseconds May 01 10:48:11 volumio volumio[21264]: info: sendMpdCommand status took 5 milliseconds May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::parseState May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 10:48:11 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:48:11 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::getTrack 27 May 01 10:48:11 volumio volumio[21264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"彩云追月","artist":"爱戴","album":"Edell.love","uri":"NAS/Music/彩云追月-爱戴-159248.flac","trackType":"flac"} May 01 10:48:11 volumio volumio[21264]: verbose: CURRENT POSITION 27 May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::syncState stateService play May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus play May 01 10:48:11 volumio volumio[21264]: info: Received an update from plugin. extracting info from payload May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::getTrack 27 May 01 10:48:11 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::getTrack 27 May 01 10:48:11 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:48:11 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:48:11 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::getTrack 27 May 01 10:48:11 volumio volumio[21264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"彩云追月","artist":"爱戴","album":"Edell.love","uri":"NAS/Music/彩云追月-爱戴-159248.flac","trackType":"flac"} May 01 10:48:11 volumio volumio[21264]: verbose: CURRENT POSITION 27 May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::syncState stateService play May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus play May 01 10:48:11 volumio volumio[21264]: info: Received an update from plugin. extracting info from payload May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::getTrack 27 May 01 10:48:11 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::getTrack 27 May 01 10:48:11 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:48:11 volumio volumio[21264]: info: ------------------------------ 190ms May 01 10:48:11 volumio volumio[21264]: info: ------------------------------ 139ms May 01 10:48:11 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 103 milliseconds May 01 10:48:11 volumio volumio[21264]: info: sendMpdCommand playlistinfo took 103 milliseconds May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:48:11 volumio volumio[21264]: verbose: ControllerMpd::parseTrackInfo May 01 10:48:11 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:48:11 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::getTrack 27 May 01 10:48:11 volumio volumio[21264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"彩云追月","artist":"爱戴","album":"Edell.love","uri":"NAS/Music/彩云追月-爱戴-159248.flac","trackType":"flac"} May 01 10:48:11 volumio volumio[21264]: verbose: CURRENT POSITION 27 May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::syncState stateService play May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus play May 01 10:48:11 volumio volumio[21264]: info: Received an update from plugin. extracting info from payload May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::getTrack 27 May 01 10:48:11 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::getTrack 27 May 01 10:48:11 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:48:11 volumio volumio[21264]: info: ControllerMpd::pushState May 01 10:48:11 volumio volumio[21264]: info: CoreCommandRouter::servicePushState May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::getTrack 27 May 01 10:48:11 volumio volumio[21264]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"彩云追月","artist":"爱戴","album":"Edell.love","uri":"NAS/Music/彩云追月-爱戴-159248.flac","trackType":"flac"} May 01 10:48:11 volumio volumio[21264]: verbose: CURRENT POSITION 27 May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::syncState stateService play May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::syncState currentStatus play May 01 10:48:11 volumio volumio[21264]: info: Received an update from plugin. extracting info from payload May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::getTrack 27 May 01 10:48:11 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:48:11 volumio volumio[21264]: info: CoreStateMachine::pushState May 01 10:48:11 volumio volumio[21264]: info: CorePlayQueue::getTrack 27 May 01 10:48:11 volumio volumio[21264]: info: CoreCommandRouter::volumioPushState May 01 10:48:11 volumio volumio[21264]: info: ------------------------------ 242ms May 01 10:48:11 volumio volumio[21264]: info: ------------------------------ 195ms May 01 10:48:28 volumio volumio[21264]: info: Preload queue cleared May 01 10:48:28 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/刘欢 - 怀念战友.flac May 01 10:48:28 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/刘芳 - 情深缘浅.flac May 01 10:48:28 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/刘芳 - 窗外.flac May 01 10:48:28 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/外婆澎湖湾-赵鹏-92859.flac May 01 10:48:28 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/庞龙 - 两只蝴蝶.flac May 01 10:48:28 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/廖昌永 - 喀秋莎.flac May 01 10:48:28 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/曹磊 - 车站.ape May 01 10:48:28 volumio volumio[21264]: info: Preloading song: mnt/NAS/Music/外婆澎湖湾-赵鹏-92859.flac May 01 10:48:28 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/刘欢 - 怀念战友.flac in service mpd May 01 10:48:28 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=//extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E5%88%98%E6%AC%A2%20-%20%E6%80%80%E5%BF%B5%E6%88%98%E5%8F%8B.flac&metadata=false May 01 10:48:28 volumio volumio[21264]: info: URI /mnt/NAS/Music/刘欢 - 怀念战友.flac May 01 10:48:29 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/刘芳 - 情深缘浅.flac in service mpd May 01 10:48:29 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=//extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E5%88%98%E8%8A%B3%20-%20%E6%83%85%E6%B7%B1%E7%BC%98%E6%B5%85.flac&metadata=false May 01 10:48:29 volumio volumio[21264]: info: URI /mnt/NAS/Music/刘芳 - 情深缘浅.flac May 01 10:48:29 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/刘芳 - 窗外.flac in service mpd May 01 10:48:29 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=//extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E5%88%98%E8%8A%B3%20-%20%E7%AA%97%E5%A4%96.flac&metadata=false May 01 10:48:29 volumio volumio[21264]: info: URI /mnt/NAS/Music/刘芳 - 窗外.flac May 01 10:48:29 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/外婆澎湖湾-赵鹏-92859.flac in service mpd May 01 10:48:29 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=%E8%B5%B5%E9%B9%8F//extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E5%A4%96%E5%A9%86%E6%BE%8E%E6%B9%96%E6%B9%BE-%E8%B5%B5%E9%B9%8F-92859.flac&metadata=false May 01 10:48:29 volumio volumio[21264]: info: URI /mnt/NAS/Music/外婆澎湖湾-赵鹏-92859.flac May 01 10:48:29 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/庞龙 - 两只蝴蝶.flac in service mpd May 01 10:48:29 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=(2004)%E5%BA%9E%E9%BE%99//extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E5%BA%9E%E9%BE%99%20-%20%E4%B8%A4%E5%8F%AA%E8%9D%B4%E8%9D%B6.flac&metadata=false May 01 10:48:29 volumio volumio[21264]: info: URI /mnt/NAS/Music/庞龙 - 两只蝴蝶.flac May 01 10:48:29 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/廖昌永 - 喀秋莎.flac in service mpd May 01 10:48:29 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=//extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E5%BB%96%E6%98%8C%E6%B0%B8%20-%20%E5%96%80%E7%A7%8B%E8%8E%8E.flac&metadata=false May 01 10:48:29 volumio volumio[21264]: info: URI /mnt/NAS/Music/廖昌永 - 喀秋莎.flac May 01 10:48:29 volumio volumio[21264]: info: Exploding uri mnt/NAS/Music/曹磊 - 车站.ape in service mpd May 01 10:48:29 volumio volumio[21264]: info: ALBUMART /albumart?cacheid=852&web=//extralarge&path=%2Fmnt%2FNAS%2FMusic%2F%E6%9B%B9%E7%A3%8A%20-%20%E8%BD%A6%E7%AB%99.ape&metadata=false May 01 10:48:29 volumio volumio[21264]: info: URI /mnt/NAS/Music/曹磊 - 车站.ape May 01 10:48:29 volumio volumio[21264]: info: Using cached record of: mnt/NAS/Music/外婆澎湖湾-赵鹏-92859.flac May 01 10:48:35 volumio volumio[21264]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 01 10:48:35 volumio volumio[21264]: info: CURURI: genres:// May 01 10:48:35 volumio volumio[21264]: info: Preload queue cleared May 01 10:48:39 volumio volumio[21264]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 10:48:39 volumio volumio[21264]: Error: connect ETIMEDOUT 199.59.150.12:80 May 01 10:48:39 volumio volumio[21264]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { May 01 10:48:39 volumio volumio[21264]: errno: -110, May 01 10:48:39 volumio volumio[21264]: code: 'ETIMEDOUT', May 01 10:48:39 volumio volumio[21264]: syscall: 'connect', May 01 10:48:39 volumio volumio[21264]: address: '199.59.150.12', May 01 10:48:39 volumio volumio[21264]: port: 80 May 01 10:48:39 volumio volumio[21264]: } May 01 10:48:39 volumio volumio[21264]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 10:48:40 volumio sudo[21897]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-01 10:47 May 01 10:48:40 volumio sudo[21897]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 09:33:57 AM CEST" VOLUMIO_VERSION="3.804" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="354f95cf0a6c2cbcd57b1aca3179c81c"