-- Logs begin at Sat 2024-11-09 01:57:21 CST, end at Fri 2024-11-29 12:10:46 CST. -- Nov 29 12:09:05 volumio volumio[8611]: info: CoreCommandRouter::volumioPlay Nov 29 12:09:05 volumio volumio[8611]: info: CoreStateMachine::play index 21 Nov 29 12:09:05 volumio volumio[8611]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 12:09:05 volumio volumio[8611]: info: CoreStateMachine::stop Nov 29 12:09:05 volumio volumio[8611]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 12:09:05 volumio volumio[8611]: info: CoreStateMachine::stPlaybackTimer Nov 29 12:09:05 volumio volumio[8611]: info: CoreStateMachine::updateTrackBlock Nov 29 12:09:05 volumio volumio[8611]: info: CorePlayQueue::getTrackBlock Nov 29 12:09:05 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:05 volumio volumio[8611]: info: CorePlayQueue::getTrack 6 Nov 29 12:09:05 volumio volumio[8611]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 12:09:05 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:05 volumio volumio[8611]: info: CoreStateMachine::serviceStop Nov 29 12:09:05 volumio volumio[8611]: info: CorePlayQueue::getTrack 6 Nov 29 12:09:05 volumio volumio[8611]: info: CoreCommandRouter::serviceStop Nov 29 12:09:05 volumio volumio[8611]: info: ControllerMpd::stop Nov 29 12:09:05 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand stop Nov 29 12:09:05 volumio volumio[8611]: info: sendMpdCommand stop took 10 milliseconds Nov 29 12:09:05 volumio volumio[8611]: info: CoreStateMachine::play index undefined Nov 29 12:09:05 volumio volumio[8611]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 12:09:05 volumio volumio[8611]: info: CorePlayQueue::getTrack 21 Nov 29 12:09:05 volumio volumio[8611]: info: CoreStateMachine::startPlaybackTimer Nov 29 12:09:05 volumio volumio[8611]: info: CorePlayQueue::getTrack 21 Nov 29 12:09:05 volumio volumio[8611]: verbose: ControllerMpd::clearAddPlayTracks NAS/918/music/你的样子-罗大佑-29293465.flac Nov 29 12:09:05 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand stop Nov 29 12:09:05 volumio volumio[8611]: info: Nov 29 12:09:05 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:09:05 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:09:05 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:09:05 volumio volumio[8611]: info: sendMpdCommand stop took 2 milliseconds Nov 29 12:09:05 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand clear Nov 29 12:09:05 volumio volumio[8611]: info: Nov 29 12:09:05 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:09:05 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:09:05 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:09:05 volumio volumio[8611]: info: Nov 29 12:09:05 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:09:05 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:09:05 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:09:05 volumio volumio[8611]: info: Nov 29 12:09:05 volumio volumio[8611]: ---------------------------- MPD announces system playlist update Nov 29 12:09:05 volumio volumio[8611]: info: Ignoring MPD Status Update Nov 29 12:09:05 volumio volumio[8611]: info: sendMpdCommand status took 6 milliseconds Nov 29 12:09:05 volumio volumio[8611]: info: sendMpdCommand clear took 6 milliseconds Nov 29 12:09:05 volumio volumio[8611]: info: sendMpdCommand status took 4 milliseconds Nov 29 12:09:05 volumio volumio[8611]: info: sendMpdCommand status took 3 milliseconds Nov 29 12:09:05 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:09:05 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 12:09:05 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand add "NAS/918/music/你的样子-罗大佑-29293465.flac" Nov 29 12:09:05 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:09:05 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:09:05 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:09:05 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:09:05 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:05 volumio volumio[8611]: info: CorePlayQueue::getTrack 21 Nov 29 12:09:05 volumio volumio[8611]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 12:09:05 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:05 volumio volumio[8611]: info: CorePlayQueue::getTrack 21 Nov 29 12:09:05 volumio volumio[8611]: 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} Nov 29 12:09:05 volumio volumio[8611]: verbose: CURRENT POSITION 21 Nov 29 12:09:05 volumio volumio[8611]: info: CoreStateMachine::syncState stateService stop Nov 29 12:09:05 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus stop Nov 29 12:09:05 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:05 volumio volumio[8611]: info: CorePlayQueue::getTrack 21 Nov 29 12:09:05 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:05 volumio volumio[8611]: info: No code Nov 29 12:09:05 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:05 volumio volumio[8611]: info: CorePlayQueue::getTrack 21 Nov 29 12:09:05 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:05 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:09:05 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:09:05 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:05 volumio volumio[8611]: info: CorePlayQueue::getTrack 21 Nov 29 12:09:05 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:05 volumio volumio[8611]: info: CorePlayQueue::getTrack 21 Nov 29 12:09:05 volumio volumio[8611]: 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} Nov 29 12:09:05 volumio volumio[8611]: verbose: CURRENT POSITION 21 Nov 29 12:09:05 volumio volumio[8611]: info: CoreStateMachine::syncState stateService stop Nov 29 12:09:05 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus stop Nov 29 12:09:05 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:05 volumio volumio[8611]: info: CorePlayQueue::getTrack 21 Nov 29 12:09:05 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:05 volumio volumio[8611]: info: No code Nov 29 12:09:05 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:05 volumio volumio[8611]: info: CorePlayQueue::getTrack 21 Nov 29 12:09:05 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:05 volumio volumio[8611]: info: ------------------------------ 53ms Nov 29 12:09:05 volumio volumio[8611]: info: ------------------------------ 53ms Nov 29 12:09:05 volumio volumio[8611]: info: Nov 29 12:09:05 volumio volumio[8611]: ---------------------------- MPD announces system playlist update Nov 29 12:09:05 volumio volumio[8611]: info: Ignoring MPD Status Update Nov 29 12:09:05 volumio volumio[8611]: info: Nov 29 12:09:05 volumio volumio[8611]: ---------------------------- MPD announces system playlist update Nov 29 12:09:05 volumio volumio[8611]: info: Ignoring MPD Status Update Nov 29 12:09:05 volumio volumio[8611]: error: updateQueue error: null Nov 29 12:09:05 volumio volumio[8611]: info: Nov 29 12:09:05 volumio volumio[8611]: ---------------------------- MPD announces system playlist update Nov 29 12:09:05 volumio volumio[8611]: info: Ignoring MPD Status Update Nov 29 12:09:05 volumio volumio[8611]: info: ------------------------------ 60ms Nov 29 12:09:05 volumio volumio[8611]: info: sendMpdCommand playlistinfo took 57 milliseconds Nov 29 12:09:05 volumio volumio[8611]: info: sendMpdCommand add "NAS/918/music/你的样子-罗大佑-29293465.flac" took 58 milliseconds Nov 29 12:09:05 volumio volumio[8611]: info: ------------------------------ 8ms Nov 29 12:09:05 volumio volumio[8611]: info: ------------------------------ 7ms Nov 29 12:09:05 volumio volumio[8611]: verbose: ControllerMpd::parseTrackInfo Nov 29 12:09:05 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand play Nov 29 12:09:05 volumio volumio[8611]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 29 12:09:05 volumio volumio[8611]: info: ------------------------------ 70ms Nov 29 12:09:05 volumio volumio[8611]: info: Nov 29 12:09:05 volumio volumio[8611]: ---------------------------- MPD announces system playlist update Nov 29 12:09:05 volumio volumio[8611]: info: Ignoring MPD Status Update Nov 29 12:09:05 volumio volumio[8611]: info: Nov 29 12:09:05 volumio volumio[8611]: ---------------------------- MPD announces system playlist update Nov 29 12:09:05 volumio volumio[8611]: info: Ignoring MPD Status Update Nov 29 12:09:05 volumio volumio[8611]: info: ------------------------------ 12ms Nov 29 12:09:05 volumio volumio[8611]: info: sendMpdCommand play took 10 milliseconds Nov 29 12:09:05 volumio volumio[8611]: info: ------------------------------ 8ms Nov 29 12:09:05 volumio volumio[8611]: info: ------------------------------ 8ms Nov 29 12:09:06 volumio volumio[8611]: info: Nov 29 12:09:06 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:09:06 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:09:06 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:09:06 volumio volumio[8611]: info: Nov 29 12:09:06 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:09:06 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:09:06 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:09:06 volumio volumio[8611]: info: Nov 29 12:09:06 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:09:06 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:09:06 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:09:06 volumio volumio[8611]: info: Nov 29 12:09:06 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:09:06 volumio volumio[8611]: info: sendMpdCommand status took 5 milliseconds Nov 29 12:09:06 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:09:06 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:09:06 volumio volumio[8611]: info: sendMpdCommand status took 4 milliseconds Nov 29 12:09:06 volumio volumio[8611]: info: sendMpdCommand status took 3 milliseconds Nov 29 12:09:06 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:09:06 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 12:09:06 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:09:06 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 12:09:06 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:09:06 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 12:09:06 volumio volumio[8611]: info: Nov 29 12:09:06 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:09:06 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:09:06 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:09:06 volumio volumio[8611]: info: Nov 29 12:09:06 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:09:06 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:09:06 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:09:06 volumio volumio[8611]: info: sendMpdCommand status took 10 milliseconds Nov 29 12:09:06 volumio volumio[8611]: info: sendMpdCommand playlistinfo took 9 milliseconds Nov 29 12:09:06 volumio volumio[8611]: info: sendMpdCommand playlistinfo took 9 milliseconds Nov 29 12:09:06 volumio volumio[8611]: info: sendMpdCommand playlistinfo took 10 milliseconds Nov 29 12:09:06 volumio volumio[8611]: info: sendMpdCommand status took 9 milliseconds Nov 29 12:09:06 volumio volumio[8611]: info: sendMpdCommand status took 6 milliseconds Nov 29 12:09:06 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:09:06 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 12:09:06 volumio volumio[8611]: verbose: ControllerMpd::parseTrackInfo Nov 29 12:09:06 volumio volumio[8611]: verbose: ControllerMpd::parseTrackInfo Nov 29 12:09:06 volumio volumio[8611]: verbose: ControllerMpd::parseTrackInfo Nov 29 12:09:06 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:09:06 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 12:09:06 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:09:06 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 12:09:06 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:09:06 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:09:06 volumio volumio[8611]: info: CorePlayQueue::getTrack 21 Nov 29 12:09:06 volumio volumio[8611]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":210,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"你的样子","artist":"罗大佑","album":"10年朋友 6","uri":"NAS/918/music/你的样子-罗大佑-29293465.flac","trackType":"flac"} Nov 29 12:09:06 volumio volumio[8611]: verbose: CURRENT POSITION 21 Nov 29 12:09:06 volumio volumio[8611]: info: CoreStateMachine::syncState stateService play Nov 29 12:09:06 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus stop Nov 29 12:09:06 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:09:06 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:09:06 volumio volumio[8611]: info: CorePlayQueue::getTrack 21 Nov 29 12:09:06 volumio volumio[8611]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":210,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"你的样子","artist":"罗大佑","album":"10年朋友 6","uri":"NAS/918/music/你的样子-罗大佑-29293465.flac","trackType":"flac"} Nov 29 12:09:06 volumio volumio[8611]: verbose: CURRENT POSITION 21 Nov 29 12:09:06 volumio volumio[8611]: info: CoreStateMachine::syncState stateService play Nov 29 12:09:06 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus play Nov 29 12:09:06 volumio volumio[8611]: info: Received an update from plugin. extracting info from payload Nov 29 12:09:06 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:06 volumio volumio[8611]: info: CorePlayQueue::getTrack 21 Nov 29 12:09:06 volumio volumio[8611]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 12:09:06 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:06 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:06 volumio volumio[8611]: info: CorePlayQueue::getTrack 21 Nov 29 12:09:06 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:06 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:09:06 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:09:06 volumio volumio[8611]: info: CorePlayQueue::getTrack 21 Nov 29 12:09:06 volumio volumio[8611]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":210,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"你的样子","artist":"罗大佑","album":"10年朋友 6","uri":"NAS/918/music/你的样子-罗大佑-29293465.flac","trackType":"flac"} Nov 29 12:09:06 volumio volumio[8611]: verbose: CURRENT POSITION 21 Nov 29 12:09:06 volumio volumio[8611]: info: CoreStateMachine::syncState stateService play Nov 29 12:09:06 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus play Nov 29 12:09:06 volumio volumio[8611]: info: Received an update from plugin. extracting info from payload Nov 29 12:09:06 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:06 volumio volumio[8611]: info: CorePlayQueue::getTrack 21 Nov 29 12:09:06 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:06 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:06 volumio volumio[8611]: info: CorePlayQueue::getTrack 21 Nov 29 12:09:06 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:06 volumio volumio[8611]: info: ------------------------------ 54ms Nov 29 12:09:06 volumio volumio[8611]: info: ------------------------------ 81ms Nov 29 12:09:06 volumio volumio[8611]: info: ------------------------------ 79ms Nov 29 12:09:06 volumio volumio[8611]: info: sendMpdCommand playlistinfo took 64 milliseconds Nov 29 12:09:06 volumio volumio[8611]: info: sendMpdCommand playlistinfo took 60 milliseconds Nov 29 12:09:06 volumio volumio[8611]: info: sendMpdCommand playlistinfo took 60 milliseconds Nov 29 12:09:06 volumio volumio[8611]: verbose: ControllerMpd::parseTrackInfo Nov 29 12:09:06 volumio volumio[8611]: verbose: ControllerMpd::parseTrackInfo Nov 29 12:09:06 volumio volumio[8611]: verbose: ControllerMpd::parseTrackInfo Nov 29 12:09:06 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:09:06 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:09:06 volumio volumio[8611]: info: CorePlayQueue::getTrack 21 Nov 29 12:09:06 volumio volumio[8611]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":210,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"你的样子","artist":"罗大佑","album":"10年朋友 6","uri":"NAS/918/music/你的样子-罗大佑-29293465.flac","trackType":"flac"} Nov 29 12:09:06 volumio volumio[8611]: verbose: CURRENT POSITION 21 Nov 29 12:09:06 volumio volumio[8611]: info: CoreStateMachine::syncState stateService play Nov 29 12:09:06 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus play Nov 29 12:09:06 volumio volumio[8611]: info: Received an update from plugin. extracting info from payload Nov 29 12:09:06 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:06 volumio volumio[8611]: info: CorePlayQueue::getTrack 21 Nov 29 12:09:06 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:06 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:06 volumio volumio[8611]: info: CorePlayQueue::getTrack 21 Nov 29 12:09:06 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:06 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:09:06 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:09:06 volumio volumio[8611]: info: CorePlayQueue::getTrack 21 Nov 29 12:09:06 volumio volumio[8611]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":210,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"你的样子","artist":"罗大佑","album":"10年朋友 6","uri":"NAS/918/music/你的样子-罗大佑-29293465.flac","trackType":"flac"} Nov 29 12:09:06 volumio volumio[8611]: verbose: CURRENT POSITION 21 Nov 29 12:09:06 volumio volumio[8611]: info: CoreStateMachine::syncState stateService play Nov 29 12:09:06 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus play Nov 29 12:09:06 volumio volumio[8611]: info: Received an update from plugin. extracting info from payload Nov 29 12:09:06 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:06 volumio volumio[8611]: info: CorePlayQueue::getTrack 21 Nov 29 12:09:06 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:06 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:06 volumio volumio[8611]: info: CorePlayQueue::getTrack 21 Nov 29 12:09:06 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:06 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:09:06 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:09:06 volumio volumio[8611]: info: CorePlayQueue::getTrack 21 Nov 29 12:09:06 volumio volumio[8611]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":210,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"你的样子","artist":"罗大佑","album":"10年朋友 6","uri":"NAS/918/music/你的样子-罗大佑-29293465.flac","trackType":"flac"} Nov 29 12:09:06 volumio volumio[8611]: verbose: CURRENT POSITION 21 Nov 29 12:09:06 volumio volumio[8611]: info: CoreStateMachine::syncState stateService play Nov 29 12:09:06 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus play Nov 29 12:09:06 volumio volumio[8611]: info: Received an update from plugin. extracting info from payload Nov 29 12:09:06 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:06 volumio volumio[8611]: info: CorePlayQueue::getTrack 21 Nov 29 12:09:06 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:06 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:06 volumio volumio[8611]: info: CorePlayQueue::getTrack 21 Nov 29 12:09:06 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:06 volumio volumio[8611]: info: ------------------------------ 157ms Nov 29 12:09:06 volumio volumio[8611]: info: ------------------------------ 154ms Nov 29 12:09:06 volumio volumio[8611]: info: ------------------------------ 153ms Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::volumioPlay Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::play index 36 Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::stop Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::stPlaybackTimer Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::updateTrackBlock Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrackBlock Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrack 21 Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::serviceStop Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrack 21 Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::serviceStop Nov 29 12:09:22 volumio volumio[8611]: info: ControllerMpd::stop Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand stop Nov 29 12:09:22 volumio volumio[8611]: info: sendMpdCommand stop took 12 milliseconds Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::play index undefined Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::startPlaybackTimer Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::clearAddPlayTracks NAS/918/music/一千年以后-林俊杰-96902215.mp3 Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand stop Nov 29 12:09:22 volumio volumio[8611]: info: Nov 29 12:09:22 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:09:22 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:09:22 volumio volumio[8611]: info: sendMpdCommand stop took 2 milliseconds Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand clear Nov 29 12:09:22 volumio volumio[8611]: info: Nov 29 12:09:22 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:09:22 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:09:22 volumio volumio[8611]: info: Nov 29 12:09:22 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:09:22 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:09:22 volumio volumio[8611]: info: Nov 29 12:09:22 volumio volumio[8611]: ---------------------------- MPD announces system playlist update Nov 29 12:09:22 volumio volumio[8611]: info: Ignoring MPD Status Update Nov 29 12:09:22 volumio volumio[8611]: info: sendMpdCommand status took 7 milliseconds Nov 29 12:09:22 volumio volumio[8611]: info: sendMpdCommand clear took 6 milliseconds Nov 29 12:09:22 volumio volumio[8611]: info: sendMpdCommand status took 4 milliseconds Nov 29 12:09:22 volumio volumio[8611]: info: sendMpdCommand status took 3 milliseconds Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand add "NAS/918/music/一千年以后-林俊杰-96902215.mp3" Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:09:22 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:22 volumio volumio[8611]: 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} Nov 29 12:09:22 volumio volumio[8611]: verbose: CURRENT POSITION 36 Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::syncState stateService stop Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus stop Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:22 volumio volumio[8611]: info: No code Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:22 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:22 volumio volumio[8611]: 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} Nov 29 12:09:22 volumio volumio[8611]: verbose: CURRENT POSITION 36 Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::syncState stateService stop Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus stop Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:22 volumio volumio[8611]: info: No code Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:22 volumio volumio[8611]: info: ------------------------------ 58ms Nov 29 12:09:22 volumio volumio[8611]: info: ------------------------------ 57ms Nov 29 12:09:22 volumio volumio[8611]: info: Nov 29 12:09:22 volumio volumio[8611]: ---------------------------- MPD announces system playlist update Nov 29 12:09:22 volumio volumio[8611]: info: Ignoring MPD Status Update Nov 29 12:09:22 volumio volumio[8611]: info: Nov 29 12:09:22 volumio volumio[8611]: ---------------------------- MPD announces system playlist update Nov 29 12:09:22 volumio volumio[8611]: info: Ignoring MPD Status Update Nov 29 12:09:22 volumio volumio[8611]: error: updateQueue error: null Nov 29 12:09:22 volumio volumio[8611]: info: Nov 29 12:09:22 volumio volumio[8611]: ---------------------------- MPD announces system playlist update Nov 29 12:09:22 volumio volumio[8611]: info: Ignoring MPD Status Update Nov 29 12:09:22 volumio volumio[8611]: info: ------------------------------ 61ms Nov 29 12:09:22 volumio volumio[8611]: info: sendMpdCommand playlistinfo took 59 milliseconds Nov 29 12:09:22 volumio volumio[8611]: info: sendMpdCommand add "NAS/918/music/一千年以后-林俊杰-96902215.mp3" took 58 milliseconds Nov 29 12:09:22 volumio volumio[8611]: info: ------------------------------ 6ms Nov 29 12:09:22 volumio volumio[8611]: info: ------------------------------ 5ms Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::parseTrackInfo Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand play Nov 29 12:09:22 volumio volumio[8611]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 29 12:09:22 volumio volumio[8611]: info: ------------------------------ 73ms Nov 29 12:09:22 volumio volumio[8611]: info: Nov 29 12:09:22 volumio volumio[8611]: ---------------------------- MPD announces system playlist update Nov 29 12:09:22 volumio volumio[8611]: info: Ignoring MPD Status Update Nov 29 12:09:22 volumio volumio[8611]: info: Nov 29 12:09:22 volumio volumio[8611]: ---------------------------- MPD announces system playlist update Nov 29 12:09:22 volumio volumio[8611]: info: Ignoring MPD Status Update Nov 29 12:09:22 volumio volumio[8611]: info: ------------------------------ 15ms Nov 29 12:09:22 volumio volumio[8611]: info: sendMpdCommand play took 12 milliseconds Nov 29 12:09:22 volumio volumio[8611]: info: ------------------------------ 9ms Nov 29 12:09:22 volumio volumio[8611]: info: ------------------------------ 7ms Nov 29 12:09:22 volumio volumio[8611]: info: Nov 29 12:09:22 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:09:22 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:09:22 volumio volumio[8611]: info: Nov 29 12:09:22 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:09:22 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:09:22 volumio volumio[8611]: info: Nov 29 12:09:22 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:09:22 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:09:22 volumio volumio[8611]: info: Nov 29 12:09:22 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:09:22 volumio volumio[8611]: info: sendMpdCommand status took 5 milliseconds Nov 29 12:09:22 volumio volumio[8611]: info: sendMpdCommand status took 5 milliseconds Nov 29 12:09:22 volumio volumio[8611]: info: sendMpdCommand status took 3 milliseconds Nov 29 12:09:22 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 12:09:22 volumio volumio[8611]: info: Nov 29 12:09:22 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:09:22 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:09:22 volumio volumio[8611]: info: Nov 29 12:09:22 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:09:22 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:09:22 volumio volumio[8611]: info: sendMpdCommand status took 8 milliseconds Nov 29 12:09:22 volumio volumio[8611]: info: sendMpdCommand playlistinfo took 8 milliseconds Nov 29 12:09:22 volumio volumio[8611]: info: sendMpdCommand playlistinfo took 7 milliseconds Nov 29 12:09:22 volumio volumio[8611]: info: sendMpdCommand playlistinfo took 8 milliseconds Nov 29 12:09:22 volumio volumio[8611]: info: sendMpdCommand status took 5 milliseconds Nov 29 12:09:22 volumio volumio[8611]: info: sendMpdCommand status took 4 milliseconds Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::parseTrackInfo Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::parseTrackInfo Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::parseTrackInfo Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 12:09:22 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:22 volumio volumio[8611]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"一千年以后","artist":"林俊杰","album":"2003年-2010年作品精选集","uri":"NAS/918/music/一千年以后-林俊杰-96902215.mp3","trackType":"mp3"} Nov 29 12:09:22 volumio volumio[8611]: verbose: CURRENT POSITION 36 Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::syncState stateService play Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus stop Nov 29 12:09:22 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:22 volumio volumio[8611]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"一千年以后","artist":"林俊杰","album":"2003年-2010年作品精选集","uri":"NAS/918/music/一千年以后-林俊杰-96902215.mp3","trackType":"mp3"} Nov 29 12:09:22 volumio volumio[8611]: verbose: CURRENT POSITION 36 Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::syncState stateService play Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus play Nov 29 12:09:22 volumio volumio[8611]: info: Received an update from plugin. extracting info from payload Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:22 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:22 volumio volumio[8611]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"一千年以后","artist":"林俊杰","album":"2003年-2010年作品精选集","uri":"NAS/918/music/一千年以后-林俊杰-96902215.mp3","trackType":"mp3"} Nov 29 12:09:22 volumio volumio[8611]: verbose: CURRENT POSITION 36 Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::syncState stateService play Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus play Nov 29 12:09:22 volumio volumio[8611]: info: Received an update from plugin. extracting info from payload Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:22 volumio volumio[8611]: info: ------------------------------ 47ms Nov 29 12:09:22 volumio volumio[8611]: info: ------------------------------ 70ms Nov 29 12:09:22 volumio volumio[8611]: info: ------------------------------ 69ms Nov 29 12:09:22 volumio volumio[8611]: info: sendMpdCommand playlistinfo took 54 milliseconds Nov 29 12:09:22 volumio volumio[8611]: info: sendMpdCommand playlistinfo took 52 milliseconds Nov 29 12:09:22 volumio volumio[8611]: info: sendMpdCommand playlistinfo took 51 milliseconds Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::parseTrackInfo Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::parseTrackInfo Nov 29 12:09:22 volumio volumio[8611]: verbose: ControllerMpd::parseTrackInfo Nov 29 12:09:22 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:22 volumio volumio[8611]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"一千年以后","artist":"林俊杰","album":"2003年-2010年作品精选集","uri":"NAS/918/music/一千年以后-林俊杰-96902215.mp3","trackType":"mp3"} Nov 29 12:09:22 volumio volumio[8611]: verbose: CURRENT POSITION 36 Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::syncState stateService play Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus play Nov 29 12:09:22 volumio volumio[8611]: info: Received an update from plugin. extracting info from payload Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:22 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:22 volumio volumio[8611]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"一千年以后","artist":"林俊杰","album":"2003年-2010年作品精选集","uri":"NAS/918/music/一千年以后-林俊杰-96902215.mp3","trackType":"mp3"} Nov 29 12:09:22 volumio volumio[8611]: verbose: CURRENT POSITION 36 Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::syncState stateService play Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus play Nov 29 12:09:22 volumio volumio[8611]: info: Received an update from plugin. extracting info from payload Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:22 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:22 volumio volumio[8611]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"一千年以后","artist":"林俊杰","album":"2003年-2010年作品精选集","uri":"NAS/918/music/一千年以后-林俊杰-96902215.mp3","trackType":"mp3"} Nov 29 12:09:22 volumio volumio[8611]: verbose: CURRENT POSITION 36 Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::syncState stateService play Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus play Nov 29 12:09:22 volumio volumio[8611]: info: Received an update from plugin. extracting info from payload Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:22 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:22 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:22 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:22 volumio volumio[8611]: info: ------------------------------ 134ms Nov 29 12:09:22 volumio volumio[8611]: info: ------------------------------ 129ms Nov 29 12:09:22 volumio volumio[8611]: info: ------------------------------ 128ms Nov 29 12:09:26 volumio volumio[8611]: info: CoreCommandRouter::volumioSeek Nov 29 12:09:26 volumio volumio[8611]: info: CoreStateMachine::seek Nov 29 12:09:26 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:26 volumio volumio[8611]: info: TRACKBLOCK {"uri":"mnt/NAS/918/music/一千年以后-林俊杰-96902215.mp3","service":"mpd","name":"一千年以后","artist":"林俊杰","album":"2003年-2010年作品精选集","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=647&web=%E6%9E%97%E4%BF%8A%E6%9D%B0/2003%E5%B9%B4-2010%E5%B9%B4%E4%BD%9C%E5%93%81%E7%B2%BE%E9%80%89%E9%9B%86/extralarge&path=%2FNAS%2F918%2Fmusic&metadata=false","duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","trackType":"mp3","channels":2} Nov 29 12:09:26 volumio volumio[8611]: info: CoreStateMachine::startPlaybackTimer Nov 29 12:09:26 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:26 volumio volumio[8611]: info: ControllerMpd::seek Nov 29 12:09:26 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:26 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:26 volumio volumio[8611]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 12:09:26 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:26 volumio volumio[8611]: error: null Nov 29 12:09:26 volumio volumio[8611]: info: Nov 29 12:09:26 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:09:26 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:09:26 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:09:26 volumio volumio[8611]: info: Nov 29 12:09:26 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:09:26 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:09:26 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:09:26 volumio volumio[8611]: info: Nov 29 12:09:26 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:09:26 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:09:26 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:09:26 volumio volumio[8611]: info: sendMpdCommand status took 8 milliseconds Nov 29 12:09:26 volumio volumio[8611]: info: sendMpdCommand status took 6 milliseconds Nov 29 12:09:26 volumio volumio[8611]: info: sendMpdCommand status took 4 milliseconds Nov 29 12:09:26 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:09:26 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 12:09:26 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:09:26 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 12:09:26 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:09:26 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 12:09:26 volumio volumio[8611]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 29 12:09:26 volumio volumio[8611]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 29 12:09:26 volumio volumio[8611]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 29 12:09:26 volumio volumio[8611]: verbose: ControllerMpd::parseTrackInfo Nov 29 12:09:26 volumio volumio[8611]: verbose: ControllerMpd::parseTrackInfo Nov 29 12:09:26 volumio volumio[8611]: verbose: ControllerMpd::parseTrackInfo Nov 29 12:09:26 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:09:26 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:09:26 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:26 volumio volumio[8611]: verbose: STATE SERVICE {"status":"play","position":0,"seek":34000,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"一千年以后","artist":"林俊杰","album":"2003年-2010年作品精选集","uri":"NAS/918/music/一千年以后-林俊杰-96902215.mp3","trackType":"mp3"} Nov 29 12:09:26 volumio volumio[8611]: verbose: CURRENT POSITION 36 Nov 29 12:09:26 volumio volumio[8611]: info: CoreStateMachine::syncState stateService play Nov 29 12:09:26 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus play Nov 29 12:09:26 volumio volumio[8611]: info: Received an update from plugin. extracting info from payload Nov 29 12:09:26 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:26 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:26 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:26 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:26 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:26 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:26 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:09:26 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:09:26 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:26 volumio volumio[8611]: verbose: STATE SERVICE {"status":"play","position":0,"seek":34000,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"一千年以后","artist":"林俊杰","album":"2003年-2010年作品精选集","uri":"NAS/918/music/一千年以后-林俊杰-96902215.mp3","trackType":"mp3"} Nov 29 12:09:26 volumio volumio[8611]: verbose: CURRENT POSITION 36 Nov 29 12:09:26 volumio volumio[8611]: info: CoreStateMachine::syncState stateService play Nov 29 12:09:26 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus play Nov 29 12:09:26 volumio volumio[8611]: info: Received an update from plugin. extracting info from payload Nov 29 12:09:26 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:26 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:26 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:26 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:26 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:26 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:26 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:09:26 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:09:26 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:26 volumio volumio[8611]: verbose: STATE SERVICE {"status":"play","position":0,"seek":34000,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"一千年以后","artist":"林俊杰","album":"2003年-2010年作品精选集","uri":"NAS/918/music/一千年以后-林俊杰-96902215.mp3","trackType":"mp3"} Nov 29 12:09:26 volumio volumio[8611]: verbose: CURRENT POSITION 36 Nov 29 12:09:26 volumio volumio[8611]: info: CoreStateMachine::syncState stateService play Nov 29 12:09:26 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus play Nov 29 12:09:26 volumio volumio[8611]: info: Received an update from plugin. extracting info from payload Nov 29 12:09:26 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:26 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:26 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:26 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:09:26 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:26 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:09:26 volumio volumio[8611]: info: ------------------------------ 81ms Nov 29 12:09:26 volumio volumio[8611]: info: ------------------------------ 79ms Nov 29 12:09:26 volumio volumio[8611]: info: ------------------------------ 78ms Nov 29 12:09:36 volumio volumio[8611]: info: CoreCommandRouter::volumioGetState Nov 29 12:09:36 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:09:52 volumio volumio[8611]: Searching plugin music_service/mpd Nov 29 12:09:52 volumio volumio[8611]: info: CoreCommandRouter::executeOnPlugin: mpd , search Nov 29 12:09:52 volumio volumio[8611]: info: All search sources collected, pushing search results Nov 29 12:09:53 volumio volumio[8611]: Searching plugin music_service/mpd Nov 29 12:09:53 volumio volumio[8611]: info: CoreCommandRouter::executeOnPlugin: mpd , search Nov 29 12:09:53 volumio volumio[8611]: info: All search sources collected, pushing search results Nov 29 12:10:12 volumio volumio[8611]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::ClearQueue Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::stop Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::stPlaybackTimer Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::updateTrackBlock Nov 29 12:10:12 volumio volumio[8611]: info: CorePlayQueue::getTrackBlock Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:10:12 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:10:12 volumio volumio[8611]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 12:10:12 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::serviceStop Nov 29 12:10:12 volumio volumio[8611]: info: CorePlayQueue::getTrack 36 Nov 29 12:10:12 volumio volumio[8611]: info: CoreCommandRouter::serviceStop Nov 29 12:10:12 volumio volumio[8611]: info: ControllerMpd::stop Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand stop Nov 29 12:10:12 volumio volumio[8611]: info: CorePlayQueue::clearPlayQueue Nov 29 12:10:12 volumio volumio[8611]: info: CorePlayQueue::saveQueue Nov 29 12:10:12 volumio volumio[8611]: info: CoreCommandRouter::volumioPushQueue Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::addQueueItems Nov 29 12:10:12 volumio volumio[8611]: info: CorePlayQueue::addQueueItems Nov 29 12:10:12 volumio volumio[8611]: info: Preload queue cleared Nov 29 12:10:12 volumio volumio[8611]: info: Adding Item to queue: music-library/NAS/918/music/喜欢你-G_E_M_邓紫棋-5245130.flac Nov 29 12:10:12 volumio volumio[8611]: info: Using cached record of: music-library/NAS/918/music/喜欢你-G_E_M_邓紫棋-5245130.flac Nov 29 12:10:12 volumio volumio[8611]: info: CoreCommandRouter::volumioPushQueue Nov 29 12:10:12 volumio volumio[8611]: info: CorePlayQueue::saveQueue Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::updateTrackBlock Nov 29 12:10:12 volumio volumio[8611]: info: CorePlayQueue::getTrackBlock Nov 29 12:10:12 volumio volumio[8611]: info: CoreCommandRouter::volumioPlay Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::play index 0 Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::stop Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::play index undefined Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 12:10:12 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::startPlaybackTimer Nov 29 12:10:12 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::clearAddPlayTracks NAS/918/music/喜欢你-G_E_M_邓紫棋-5245130.flac Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand stop Nov 29 12:10:12 volumio volumio[8611]: info: Nov 29 12:10:12 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:10:12 volumio volumio[8611]: info: sendMpdCommand stop took 35 milliseconds Nov 29 12:10:12 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:10:12 volumio volumio[8611]: info: sendMpdCommand stop took 4 milliseconds Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand clear Nov 29 12:10:12 volumio volumio[8611]: info: Nov 29 12:10:12 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:10:12 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:10:12 volumio volumio[8611]: info: Nov 29 12:10:12 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:10:12 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:10:12 volumio volumio[8611]: info: Nov 29 12:10:12 volumio volumio[8611]: ---------------------------- MPD announces system playlist update Nov 29 12:10:12 volumio volumio[8611]: info: Ignoring MPD Status Update Nov 29 12:10:12 volumio volumio[8611]: info: sendMpdCommand status took 7 milliseconds Nov 29 12:10:12 volumio volumio[8611]: info: sendMpdCommand clear took 7 milliseconds Nov 29 12:10:12 volumio volumio[8611]: info: sendMpdCommand status took 5 milliseconds Nov 29 12:10:12 volumio volumio[8611]: info: sendMpdCommand status took 4 milliseconds Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand add "NAS/918/music/喜欢你-G_E_M_邓紫棋-5245130.flac" Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:10:12 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:10:12 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:10:12 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:12 volumio volumio[8611]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 12:10:12 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:10:12 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:12 volumio volumio[8611]: 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} Nov 29 12:10:12 volumio volumio[8611]: verbose: CURRENT POSITION 0 Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::syncState stateService stop Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus stop Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:10:12 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:12 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:10:12 volumio volumio[8611]: info: No code Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:10:12 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:12 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:10:12 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:10:12 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:10:12 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:12 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:10:12 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:12 volumio volumio[8611]: 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} Nov 29 12:10:12 volumio volumio[8611]: verbose: CURRENT POSITION 0 Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::syncState stateService stop Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus stop Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:10:12 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:12 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:10:12 volumio volumio[8611]: info: No code Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:10:12 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:12 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:10:12 volumio volumio[8611]: info: ------------------------------ 62ms Nov 29 12:10:12 volumio volumio[8611]: info: ------------------------------ 61ms Nov 29 12:10:12 volumio volumio[8611]: info: Nov 29 12:10:12 volumio volumio[8611]: ---------------------------- MPD announces system playlist update Nov 29 12:10:12 volumio volumio[8611]: info: Ignoring MPD Status Update Nov 29 12:10:12 volumio volumio[8611]: info: Nov 29 12:10:12 volumio volumio[8611]: ---------------------------- MPD announces system playlist update Nov 29 12:10:12 volumio volumio[8611]: info: Ignoring MPD Status Update Nov 29 12:10:12 volumio volumio[8611]: error: updateQueue error: null Nov 29 12:10:12 volumio volumio[8611]: info: Nov 29 12:10:12 volumio volumio[8611]: ---------------------------- MPD announces system playlist update Nov 29 12:10:12 volumio volumio[8611]: info: Ignoring MPD Status Update Nov 29 12:10:12 volumio volumio[8611]: info: ------------------------------ 67ms Nov 29 12:10:12 volumio volumio[8611]: info: sendMpdCommand playlistinfo took 65 milliseconds Nov 29 12:10:12 volumio volumio[8611]: info: sendMpdCommand add "NAS/918/music/喜欢你-G_E_M_邓紫棋-5245130.flac" took 64 milliseconds Nov 29 12:10:12 volumio volumio[8611]: info: ------------------------------ 9ms Nov 29 12:10:12 volumio volumio[8611]: info: ------------------------------ 8ms Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::parseTrackInfo Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand play Nov 29 12:10:12 volumio volumio[8611]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 29 12:10:12 volumio volumio[8611]: info: ------------------------------ 80ms Nov 29 12:10:12 volumio volumio[8611]: info: Nov 29 12:10:12 volumio volumio[8611]: ---------------------------- MPD announces system playlist update Nov 29 12:10:12 volumio volumio[8611]: info: Ignoring MPD Status Update Nov 29 12:10:12 volumio volumio[8611]: info: Nov 29 12:10:12 volumio volumio[8611]: ---------------------------- MPD announces system playlist update Nov 29 12:10:12 volumio volumio[8611]: info: Ignoring MPD Status Update Nov 29 12:10:12 volumio volumio[8611]: info: ------------------------------ 14ms Nov 29 12:10:12 volumio volumio[8611]: info: sendMpdCommand play took 11 milliseconds Nov 29 12:10:12 volumio volumio[8611]: info: ------------------------------ 9ms Nov 29 12:10:12 volumio volumio[8611]: info: ------------------------------ 7ms Nov 29 12:10:12 volumio volumio[8611]: info: Nov 29 12:10:12 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:10:12 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:10:12 volumio volumio[8611]: info: Nov 29 12:10:12 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:10:12 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:10:12 volumio volumio[8611]: info: Nov 29 12:10:12 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:10:12 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:10:12 volumio volumio[8611]: info: Nov 29 12:10:12 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:10:12 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:10:12 volumio volumio[8611]: info: sendMpdCommand status took 10 milliseconds Nov 29 12:10:12 volumio volumio[8611]: info: sendMpdCommand status took 8 milliseconds Nov 29 12:10:12 volumio volumio[8611]: info: sendMpdCommand status took 7 milliseconds Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 12:10:12 volumio volumio[8611]: info: Nov 29 12:10:12 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:10:12 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:10:12 volumio volumio[8611]: info: Nov 29 12:10:12 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:10:12 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:10:12 volumio volumio[8611]: info: sendMpdCommand status took 10 milliseconds Nov 29 12:10:12 volumio volumio[8611]: info: sendMpdCommand playlistinfo took 7 milliseconds Nov 29 12:10:12 volumio volumio[8611]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 29 12:10:12 volumio volumio[8611]: info: sendMpdCommand playlistinfo took 7 milliseconds Nov 29 12:10:12 volumio volumio[8611]: info: sendMpdCommand status took 4 milliseconds Nov 29 12:10:12 volumio volumio[8611]: info: sendMpdCommand status took 4 milliseconds Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::parseTrackInfo Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::parseTrackInfo Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::parseTrackInfo Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:10:12 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 12:10:12 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:10:12 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:10:12 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:12 volumio volumio[8611]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":239,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"喜欢你","artist":"G.E.M.邓紫棋","album":"喜欢你","uri":"NAS/918/music/喜欢你-G_E_M_邓紫棋-5245130.flac","trackType":"flac"} Nov 29 12:10:12 volumio volumio[8611]: verbose: CURRENT POSITION 0 Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::syncState stateService play Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus stop Nov 29 12:10:12 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:10:12 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:10:12 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:12 volumio volumio[8611]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":239,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"喜欢你","artist":"G.E.M.邓紫棋","album":"喜欢你","uri":"NAS/918/music/喜欢你-G_E_M_邓紫棋-5245130.flac","trackType":"flac"} Nov 29 12:10:12 volumio volumio[8611]: verbose: CURRENT POSITION 0 Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::syncState stateService play Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus play Nov 29 12:10:12 volumio volumio[8611]: info: Received an update from plugin. extracting info from payload Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:10:12 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:12 volumio volumio[8611]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 12:10:12 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:10:12 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:12 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:10:12 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:10:12 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:10:12 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:12 volumio volumio[8611]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":239,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"喜欢你","artist":"G.E.M.邓紫棋","album":"喜欢你","uri":"NAS/918/music/喜欢你-G_E_M_邓紫棋-5245130.flac","trackType":"flac"} Nov 29 12:10:12 volumio volumio[8611]: verbose: CURRENT POSITION 0 Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::syncState stateService play Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus play Nov 29 12:10:12 volumio volumio[8611]: info: Received an update from plugin. extracting info from payload Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:10:12 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:12 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:10:12 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:10:12 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:12 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:10:12 volumio volumio[8611]: info: ------------------------------ 43ms Nov 29 12:10:12 volumio volumio[8611]: info: ------------------------------ 61ms Nov 29 12:10:13 volumio volumio[8611]: info: ------------------------------ 60ms Nov 29 12:10:13 volumio volumio[8611]: info: sendMpdCommand playlistinfo took 43 milliseconds Nov 29 12:10:13 volumio volumio[8611]: info: sendMpdCommand playlistinfo took 42 milliseconds Nov 29 12:10:13 volumio volumio[8611]: info: sendMpdCommand playlistinfo took 42 milliseconds Nov 29 12:10:13 volumio volumio[8611]: verbose: ControllerMpd::parseTrackInfo Nov 29 12:10:13 volumio volumio[8611]: verbose: ControllerMpd::parseTrackInfo Nov 29 12:10:13 volumio volumio[8611]: verbose: ControllerMpd::parseTrackInfo Nov 29 12:10:13 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:10:13 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:10:13 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:13 volumio volumio[8611]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":239,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"喜欢你","artist":"G.E.M.邓紫棋","album":"喜欢你","uri":"NAS/918/music/喜欢你-G_E_M_邓紫棋-5245130.flac","trackType":"flac"} Nov 29 12:10:13 volumio volumio[8611]: verbose: CURRENT POSITION 0 Nov 29 12:10:13 volumio volumio[8611]: info: CoreStateMachine::syncState stateService play Nov 29 12:10:13 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus play Nov 29 12:10:13 volumio volumio[8611]: info: Received an update from plugin. extracting info from payload Nov 29 12:10:13 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:10:13 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:13 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:10:13 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:10:13 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:13 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:10:13 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:10:13 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:10:13 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:13 volumio volumio[8611]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":239,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"喜欢你","artist":"G.E.M.邓紫棋","album":"喜欢你","uri":"NAS/918/music/喜欢你-G_E_M_邓紫棋-5245130.flac","trackType":"flac"} Nov 29 12:10:13 volumio volumio[8611]: verbose: CURRENT POSITION 0 Nov 29 12:10:13 volumio volumio[8611]: info: CoreStateMachine::syncState stateService play Nov 29 12:10:13 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus play Nov 29 12:10:13 volumio volumio[8611]: info: Received an update from plugin. extracting info from payload Nov 29 12:10:13 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:10:13 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:13 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:10:13 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:10:13 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:13 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:10:13 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:10:13 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:10:13 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:13 volumio volumio[8611]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":239,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"喜欢你","artist":"G.E.M.邓紫棋","album":"喜欢你","uri":"NAS/918/music/喜欢你-G_E_M_邓紫棋-5245130.flac","trackType":"flac"} Nov 29 12:10:13 volumio volumio[8611]: verbose: CURRENT POSITION 0 Nov 29 12:10:13 volumio volumio[8611]: info: CoreStateMachine::syncState stateService play Nov 29 12:10:13 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus play Nov 29 12:10:13 volumio volumio[8611]: info: Received an update from plugin. extracting info from payload Nov 29 12:10:13 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:10:13 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:13 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:10:13 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:10:13 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:13 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:10:13 volumio volumio[8611]: info: ------------------------------ 113ms Nov 29 12:10:13 volumio volumio[8611]: info: ------------------------------ 104ms Nov 29 12:10:13 volumio volumio[8611]: info: ------------------------------ 104ms Nov 29 12:10:17 volumio volumio[8611]: info: CoreCommandRouter::volumioSeek Nov 29 12:10:17 volumio volumio[8611]: info: CoreStateMachine::seek Nov 29 12:10:17 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:17 volumio volumio[8611]: info: TRACKBLOCK {"uri":"mnt/NAS/918/music/喜欢你-G_E_M_邓紫棋-5245130.flac","service":"mpd","name":"喜欢你","artist":"G.E.M.邓紫棋","album":"喜欢你","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=647&web=G.E.M.%E9%82%93%E7%B4%AB%E6%A3%8B/%E5%96%9C%E6%AC%A2%E4%BD%A0/extralarge&path=%2FNAS%2F918%2Fmusic&metadata=false","duration":239,"samplerate":"44.1 kHz","bitdepth":"16 bit","trackType":"flac","channels":2} Nov 29 12:10:17 volumio volumio[8611]: info: CoreStateMachine::startPlaybackTimer Nov 29 12:10:17 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:17 volumio volumio[8611]: info: ControllerMpd::seek Nov 29 12:10:17 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:10:17 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:17 volumio volumio[8611]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 12:10:17 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:10:17 volumio volumio[8611]: error: null Nov 29 12:10:17 volumio volumio[8611]: info: Nov 29 12:10:17 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:10:17 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:10:17 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:10:17 volumio volumio[8611]: info: Nov 29 12:10:17 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:10:17 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:10:17 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:10:17 volumio volumio[8611]: info: Nov 29 12:10:17 volumio volumio[8611]: ---------------------------- MPD announces state update: player Nov 29 12:10:17 volumio volumio[8611]: info: ControllerMpd::getState Nov 29 12:10:17 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand status Nov 29 12:10:17 volumio volumio[8611]: info: sendMpdCommand status took 8 milliseconds Nov 29 12:10:17 volumio volumio[8611]: info: sendMpdCommand status took 5 milliseconds Nov 29 12:10:17 volumio volumio[8611]: info: sendMpdCommand status took 4 milliseconds Nov 29 12:10:17 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:10:17 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 12:10:17 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:10:17 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 12:10:17 volumio volumio[8611]: verbose: ControllerMpd::parseState Nov 29 12:10:17 volumio volumio[8611]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 12:10:17 volumio volumio[8611]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 29 12:10:17 volumio volumio[8611]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 29 12:10:17 volumio volumio[8611]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 29 12:10:17 volumio volumio[8611]: verbose: ControllerMpd::parseTrackInfo Nov 29 12:10:17 volumio volumio[8611]: verbose: ControllerMpd::parseTrackInfo Nov 29 12:10:17 volumio volumio[8611]: verbose: ControllerMpd::parseTrackInfo Nov 29 12:10:17 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:10:17 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:10:17 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:17 volumio volumio[8611]: verbose: STATE SERVICE {"status":"play","position":0,"seek":17960,"duration":239,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"929 Kbps","isStreaming":false,"title":"喜欢你","artist":"G.E.M.邓紫棋","album":"喜欢你","uri":"NAS/918/music/喜欢你-G_E_M_邓紫棋-5245130.flac","trackType":"flac"} Nov 29 12:10:17 volumio volumio[8611]: verbose: CURRENT POSITION 0 Nov 29 12:10:17 volumio volumio[8611]: info: CoreStateMachine::syncState stateService play Nov 29 12:10:17 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus play Nov 29 12:10:17 volumio volumio[8611]: info: Received an update from plugin. extracting info from payload Nov 29 12:10:17 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:10:17 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:17 volumio volumio[8611]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 12:10:17 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:10:17 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:10:17 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:17 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:10:17 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:10:17 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:10:17 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:17 volumio volumio[8611]: verbose: STATE SERVICE {"status":"play","position":0,"seek":17960,"duration":239,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"929 Kbps","isStreaming":false,"title":"喜欢你","artist":"G.E.M.邓紫棋","album":"喜欢你","uri":"NAS/918/music/喜欢你-G_E_M_邓紫棋-5245130.flac","trackType":"flac"} Nov 29 12:10:17 volumio volumio[8611]: verbose: CURRENT POSITION 0 Nov 29 12:10:17 volumio volumio[8611]: info: CoreStateMachine::syncState stateService play Nov 29 12:10:17 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus play Nov 29 12:10:17 volumio volumio[8611]: info: Received an update from plugin. extracting info from payload Nov 29 12:10:17 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:10:17 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:17 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:10:17 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:10:17 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:17 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:10:17 volumio volumio[8611]: info: ControllerMpd::pushState Nov 29 12:10:17 volumio volumio[8611]: info: CoreCommandRouter::servicePushState Nov 29 12:10:17 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:17 volumio volumio[8611]: verbose: STATE SERVICE {"status":"play","position":0,"seek":17960,"duration":239,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"929 Kbps","isStreaming":false,"title":"喜欢你","artist":"G.E.M.邓紫棋","album":"喜欢你","uri":"NAS/918/music/喜欢你-G_E_M_邓紫棋-5245130.flac","trackType":"flac"} Nov 29 12:10:17 volumio volumio[8611]: verbose: CURRENT POSITION 0 Nov 29 12:10:17 volumio volumio[8611]: info: CoreStateMachine::syncState stateService play Nov 29 12:10:17 volumio volumio[8611]: info: CoreStateMachine::syncState currentStatus play Nov 29 12:10:17 volumio volumio[8611]: info: Received an update from plugin. extracting info from payload Nov 29 12:10:17 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:10:17 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:17 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:10:17 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:10:17 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:17 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:10:17 volumio volumio[8611]: info: ------------------------------ 78ms Nov 29 12:10:17 volumio volumio[8611]: info: ------------------------------ 75ms Nov 29 12:10:17 volumio volumio[8611]: info: ------------------------------ 74ms Nov 29 12:10:31 volumio nmbd[760]: [2024/11/29 12:10:31.020141, 0] ../source3/libsmb/nmblib.c:917(send_udp) Nov 29 12:10:31 volumio nmbd[760]: Packet send failed to 192.168.211.255(138) ERRNO=Network is unreachable Nov 29 12:10:38 volumio volumio[8611]: info: CoreCommandRouter::volumioGetState Nov 29 12:10:38 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:40 volumio volumio[8611]: info: VolumeController::SetAlsaVolume81 Nov 29 12:10:40 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:10:40 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:40 volumio volumio[8611]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 12:10:40 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:10:43 volumio volumio[8611]: info: VolumeController::SetAlsaVolume79 Nov 29 12:10:43 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:10:43 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:43 volumio volumio[8611]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 12:10:43 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:10:44 volumio volumio[8611]: info: VolumeController::SetAlsaVolume80 Nov 29 12:10:44 volumio volumio[8611]: info: CoreStateMachine::pushState Nov 29 12:10:44 volumio volumio[8611]: info: CorePlayQueue::getTrack 0 Nov 29 12:10:44 volumio volumio[8611]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 12:10:44 volumio volumio[8611]: info: CoreCommandRouter::volumioPushState Nov 29 12:10:46 volumio volumio[8611]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 29 12:10:46 volumio volumio[8611]: Error: connect ETIMEDOUT 114.43.24.59:80 Nov 29 12:10:46 volumio volumio[8611]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Nov 29 12:10:46 volumio volumio[8611]: errno: -110, Nov 29 12:10:46 volumio volumio[8611]: code: 'ETIMEDOUT', Nov 29 12:10:46 volumio volumio[8611]: syscall: 'connect', Nov 29 12:10:46 volumio volumio[8611]: address: '114.43.24.59', Nov 29 12:10:46 volumio volumio[8611]: port: 80 Nov 29 12:10:46 volumio volumio[8611]: } Nov 29 12:10:46 volumio volumio[8611]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 29 12:10:46 volumio sudo[24704]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-29 12:09 Nov 29 12:10:46 volumio sudo[24704]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"