-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Mon 2024-09-09 09:47:21 CST. -- Sep 09 09:46:08 volumio volumio[2284]: info: CoreCommandRouter::volumioGetState Sep 09 09:46:08 volumio volumio[2284]: info: CorePlayQueue::getTrack 27 Sep 09 09:46:10 volumio volumio[2284]: info: CoreCommandRouter::volumioPause Sep 09 09:46:10 volumio volumio[2284]: info: CoreStateMachine::pause Sep 09 09:46:10 volumio volumio[2284]: info: CoreStateMachine::stPlaybackTimer Sep 09 09:46:10 volumio volumio[2284]: info: CoreStateMachine::servicePause Sep 09 09:46:10 volumio volumio[2284]: info: CorePlayQueue::getTrack 27 Sep 09 09:46:10 volumio volumio[2284]: info: CoreCommandRouter::servicePause Sep 09 09:46:10 volumio volumio[2284]: info: ControllerMpd::pause Sep 09 09:46:10 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand pause Sep 09 09:46:10 volumio volumio[2284]: info: sendMpdCommand pause took 35 milliseconds Sep 09 09:46:10 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Sep 09 09:46:10 volumio volumio[2284]: info: Sep 09 09:46:10 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:10 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:10 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:10 volumio volumio[2284]: info: sendMpdCommand status took 2 milliseconds Sep 09 09:46:10 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:10 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:10 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 09 09:46:10 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:10 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:10 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:10 volumio volumio[2284]: info: CorePlayQueue::getTrack 27 Sep 09 09:46:10 volumio volumio[2284]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":38468,"duration":214,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1182 Kbps","isStreaming":false,"title":"夜夜夜夜熬(DJ版)","artist":"张鑫雨","album":"2024热歌DJ合辑-I","uri":"NAS/ds918/酷我音乐/张鑫雨-夜夜夜夜熬(DJ版).flac","trackType":"flac"} Sep 09 09:46:10 volumio volumio[2284]: verbose: CURRENT POSITION 27 Sep 09 09:46:10 volumio volumio[2284]: info: CoreStateMachine::syncState stateService pause Sep 09 09:46:10 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus pause Sep 09 09:46:10 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:10 volumio volumio[2284]: info: CorePlayQueue::getTrack 27 Sep 09 09:46:10 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:10 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:10 volumio volumio[2284]: info: CoreStateMachine::stPlaybackTimer Sep 09 09:46:10 volumio volumio[2284]: info: ------------------------------ 39ms Sep 09 09:46:12 volumio volumio[2284]: info: CoreCommandRouter::volumioPlay Sep 09 09:46:12 volumio volumio[2284]: info: CoreStateMachine::play index undefined Sep 09 09:46:12 volumio volumio[2284]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 09:46:12 volumio volumio[2284]: info: CorePlayQueue::getTrack 27 Sep 09 09:46:12 volumio volumio[2284]: info: CoreStateMachine::startPlaybackTimer Sep 09 09:46:12 volumio volumio[2284]: info: CorePlayQueue::getTrack 27 Sep 09 09:46:12 volumio volumio[2284]: info: ControllerMpd::resume Sep 09 09:46:12 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand play Sep 09 09:46:12 volumio volumio[2284]: info: Sep 09 09:46:12 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:12 volumio volumio[2284]: info: sendMpdCommand play took 5 milliseconds Sep 09 09:46:12 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:12 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:12 volumio volumio[2284]: info: sendMpdCommand status took 0 milliseconds Sep 09 09:46:12 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Sep 09 09:46:12 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:12 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:12 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 09 09:46:12 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:12 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:12 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:12 volumio volumio[2284]: info: CorePlayQueue::getTrack 27 Sep 09 09:46:12 volumio volumio[2284]: verbose: STATE SERVICE {"status":"play","position":0,"seek":39359,"duration":214,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1132 Kbps","isStreaming":false,"title":"夜夜夜夜熬(DJ版)","artist":"张鑫雨","album":"2024热歌DJ合辑-I","uri":"NAS/ds918/酷我音乐/张鑫雨-夜夜夜夜熬(DJ版).flac","trackType":"flac"} Sep 09 09:46:12 volumio volumio[2284]: verbose: CURRENT POSITION 27 Sep 09 09:46:12 volumio volumio[2284]: info: CoreStateMachine::syncState stateService play Sep 09 09:46:12 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus pause Sep 09 09:46:12 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:12 volumio volumio[2284]: info: CorePlayQueue::getTrack 27 Sep 09 09:46:12 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:12 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:12 volumio volumio[2284]: info: ------------------------------ 24ms Sep 09 09:46:12 volumio volumio[2284]: info: CoreCommandRouter::volumioNext Sep 09 09:46:12 volumio volumio[2284]: info: CoreStateMachine::next Sep 09 09:46:12 volumio volumio[2284]: info: CoreStateMachine::stop Sep 09 09:46:12 volumio volumio[2284]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 09:46:12 volumio volumio[2284]: info: CoreStateMachine::stPlaybackTimer Sep 09 09:46:12 volumio volumio[2284]: info: CoreStateMachine::updateTrackBlock Sep 09 09:46:12 volumio volumio[2284]: info: CorePlayQueue::getTrackBlock Sep 09 09:46:12 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:12 volumio volumio[2284]: info: CorePlayQueue::getTrack 27 Sep 09 09:46:12 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:12 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:12 volumio volumio[2284]: info: CoreStateMachine::serviceStop Sep 09 09:46:12 volumio volumio[2284]: info: CorePlayQueue::getTrack 27 Sep 09 09:46:12 volumio volumio[2284]: info: CoreCommandRouter::serviceStop Sep 09 09:46:12 volumio volumio[2284]: info: ControllerMpd::stop Sep 09 09:46:12 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 09:46:12 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Sep 09 09:46:13 volumio volumio[2284]: info: Sep 09 09:46:13 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:13 volumio volumio[2284]: info: sendMpdCommand stop took 75 milliseconds Sep 09 09:46:13 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:13 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:13 volumio volumio[2284]: info: CoreStateMachine::play index undefined Sep 09 09:46:13 volumio volumio[2284]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 09:46:13 volumio volumio[2284]: info: CorePlayQueue::getTrack 28 Sep 09 09:46:13 volumio volumio[2284]: info: CoreStateMachine::startPlaybackTimer Sep 09 09:46:13 volumio volumio[2284]: info: CorePlayQueue::getTrack 28 Sep 09 09:46:13 volumio volumio[2284]: verbose: ControllerMpd::clearAddPlayTracks NAS/ds918/酷我音乐/思雨-蜓儿点水蝶恋花DJ.flac Sep 09 09:46:13 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 09:46:13 volumio volumio[2284]: info: CoreStateMachine::updateTrackBlock Sep 09 09:46:13 volumio volumio[2284]: info: CorePlayQueue::getTrackBlock Sep 09 09:46:13 volumio volumio[2284]: info: sendMpdCommand status took 12 milliseconds Sep 09 09:46:13 volumio volumio[2284]: info: sendMpdCommand stop took 8 milliseconds Sep 09 09:46:13 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:13 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:13 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand clear Sep 09 09:46:13 volumio volumio[2284]: info: Sep 09 09:46:13 volumio volumio[2284]: ---------------------------- MPD announces system playlist update Sep 09 09:46:13 volumio volumio[2284]: info: Ignoring MPD Status Update Sep 09 09:46:13 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 10 milliseconds Sep 09 09:46:13 volumio volumio[2284]: info: sendMpdCommand clear took 10 milliseconds Sep 09 09:46:13 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:13 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand add "NAS/ds918/酷我音乐/思雨-蜓儿点水蝶恋花DJ.flac" Sep 09 09:46:13 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:13 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:13 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:13 volumio volumio[2284]: info: CorePlayQueue::getTrack 28 Sep 09 09:46:13 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:13 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:13 volumio volumio[2284]: info: CorePlayQueue::getTrack 28 Sep 09 09:46:13 volumio volumio[2284]: 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":"夜夜夜夜熬(DJ版)","artist":"张鑫雨","album":"2024热歌DJ合辑-I","uri":"NAS/ds918/酷我音乐/张鑫雨-夜夜夜夜熬(DJ版).flac","trackType":"flac"} Sep 09 09:46:13 volumio volumio[2284]: verbose: CURRENT POSITION 28 Sep 09 09:46:13 volumio volumio[2284]: info: CoreStateMachine::syncState stateService stop Sep 09 09:46:13 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus stop Sep 09 09:46:13 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:13 volumio volumio[2284]: info: CorePlayQueue::getTrack 28 Sep 09 09:46:13 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:13 volumio volumio[2284]: info: No code Sep 09 09:46:13 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:13 volumio volumio[2284]: info: CorePlayQueue::getTrack 28 Sep 09 09:46:13 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:13 volumio volumio[2284]: info: ------------------------------ 116ms Sep 09 09:46:13 volumio volumio[2284]: error: updateQueue error: null Sep 09 09:46:13 volumio volumio[2284]: info: Sep 09 09:46:13 volumio volumio[2284]: ---------------------------- MPD announces system playlist update Sep 09 09:46:13 volumio volumio[2284]: info: Ignoring MPD Status Update Sep 09 09:46:13 volumio volumio[2284]: info: ------------------------------ 97ms Sep 09 09:46:13 volumio volumio[2284]: info: sendMpdCommand add "NAS/ds918/酷我音乐/思雨-蜓儿点水蝶恋花DJ.flac" took 95 milliseconds Sep 09 09:46:13 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand play Sep 09 09:46:13 volumio volumio[2284]: info: ------------------------------ 31ms Sep 09 09:46:13 volumio volumio[2284]: info: sendMpdCommand play took 27 milliseconds Sep 09 09:46:13 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Sep 09 09:46:13 volumio volumio[2284]: info: Sep 09 09:46:13 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:13 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:13 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:13 volumio volumio[2284]: info: Sep 09 09:46:13 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:13 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:13 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:13 volumio volumio[2284]: info: sendMpdCommand status took 8 milliseconds Sep 09 09:46:13 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:13 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:13 volumio volumio[2284]: info: sendMpdCommand status took 7 milliseconds Sep 09 09:46:13 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 4 milliseconds Sep 09 09:46:13 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:13 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:13 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:13 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:13 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:13 volumio volumio[2284]: info: CorePlayQueue::getTrack 28 Sep 09 09:46:13 volumio volumio[2284]: verbose: STATE SERVICE {"status":"play","position":0,"seek":868,"duration":244,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1073 Kbps","isStreaming":false,"title":"蜓儿点水蝶恋花DJ","artist":"思雨","album":"蜓儿点水蝶恋花DJ","uri":"NAS/ds918/酷我音乐/思雨-蜓儿点水蝶恋花DJ.flac","trackType":"flac"} Sep 09 09:46:13 volumio volumio[2284]: verbose: CURRENT POSITION 28 Sep 09 09:46:13 volumio volumio[2284]: info: CoreStateMachine::syncState stateService play Sep 09 09:46:13 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus stop Sep 09 09:46:13 volumio volumio[2284]: info: ------------------------------ 35ms Sep 09 09:46:13 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 13 milliseconds Sep 09 09:46:13 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:13 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:13 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:13 volumio volumio[2284]: info: CorePlayQueue::getTrack 28 Sep 09 09:46:13 volumio volumio[2284]: verbose: STATE SERVICE {"status":"play","position":0,"seek":868,"duration":244,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1073 Kbps","isStreaming":false,"title":"蜓儿点水蝶恋花DJ","artist":"思雨","album":"蜓儿点水蝶恋花DJ","uri":"NAS/ds918/酷我音乐/思雨-蜓儿点水蝶恋花DJ.flac","trackType":"flac"} Sep 09 09:46:13 volumio volumio[2284]: verbose: CURRENT POSITION 28 Sep 09 09:46:13 volumio volumio[2284]: info: CoreStateMachine::syncState stateService play Sep 09 09:46:13 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus play Sep 09 09:46:13 volumio volumio[2284]: info: Received an update from plugin. extracting info from payload Sep 09 09:46:13 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:13 volumio volumio[2284]: info: CorePlayQueue::getTrack 28 Sep 09 09:46:13 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:13 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:13 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:13 volumio volumio[2284]: info: CorePlayQueue::getTrack 28 Sep 09 09:46:13 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:13 volumio volumio[2284]: info: ------------------------------ 122ms Sep 09 09:46:16 volumio volumio[2284]: info: CoreCommandRouter::volumioNext Sep 09 09:46:16 volumio volumio[2284]: info: CoreStateMachine::next Sep 09 09:46:16 volumio volumio[2284]: info: CoreStateMachine::stop Sep 09 09:46:16 volumio volumio[2284]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 09:46:16 volumio volumio[2284]: info: CoreStateMachine::stPlaybackTimer Sep 09 09:46:16 volumio volumio[2284]: info: CoreStateMachine::updateTrackBlock Sep 09 09:46:16 volumio volumio[2284]: info: CorePlayQueue::getTrackBlock Sep 09 09:46:16 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:16 volumio volumio[2284]: info: CorePlayQueue::getTrack 28 Sep 09 09:46:16 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:16 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:16 volumio volumio[2284]: info: CoreStateMachine::serviceStop Sep 09 09:46:16 volumio volumio[2284]: info: CorePlayQueue::getTrack 28 Sep 09 09:46:16 volumio volumio[2284]: info: CoreCommandRouter::serviceStop Sep 09 09:46:16 volumio volumio[2284]: info: ControllerMpd::stop Sep 09 09:46:16 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 09:46:16 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Sep 09 09:46:16 volumio volumio[2284]: info: Sep 09 09:46:16 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:16 volumio volumio[2284]: info: sendMpdCommand stop took 84 milliseconds Sep 09 09:46:16 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:16 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:16 volumio volumio[2284]: info: CoreStateMachine::play index undefined Sep 09 09:46:16 volumio volumio[2284]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 09:46:16 volumio volumio[2284]: info: CorePlayQueue::getTrack 29 Sep 09 09:46:16 volumio volumio[2284]: info: CoreStateMachine::startPlaybackTimer Sep 09 09:46:16 volumio volumio[2284]: info: CorePlayQueue::getTrack 29 Sep 09 09:46:16 volumio volumio[2284]: verbose: ControllerMpd::clearAddPlayTracks NAS/ds918/酷我音乐/李常超（Lao乾妈）-盗墓笔记·十年人间.flac Sep 09 09:46:16 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 09:46:16 volumio volumio[2284]: info: CoreStateMachine::updateTrackBlock Sep 09 09:46:16 volumio volumio[2284]: info: CorePlayQueue::getTrackBlock Sep 09 09:46:16 volumio volumio[2284]: info: sendMpdCommand status took 15 milliseconds Sep 09 09:46:16 volumio volumio[2284]: info: sendMpdCommand stop took 10 milliseconds Sep 09 09:46:16 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:16 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:16 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand clear Sep 09 09:46:16 volumio volumio[2284]: info: Sep 09 09:46:16 volumio volumio[2284]: ---------------------------- MPD announces system playlist update Sep 09 09:46:16 volumio volumio[2284]: info: Ignoring MPD Status Update Sep 09 09:46:16 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 5 milliseconds Sep 09 09:46:16 volumio volumio[2284]: info: sendMpdCommand clear took 5 milliseconds Sep 09 09:46:16 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:16 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand add "NAS/ds918/酷我音乐/李常超（Lao乾妈）-盗墓笔记·十年人间.flac" Sep 09 09:46:16 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:16 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:16 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:16 volumio volumio[2284]: info: CorePlayQueue::getTrack 29 Sep 09 09:46:16 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:16 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:16 volumio volumio[2284]: info: CorePlayQueue::getTrack 29 Sep 09 09:46:16 volumio volumio[2284]: 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":"蜓儿点水蝶恋花DJ","artist":"思雨","album":"蜓儿点水蝶恋花DJ","uri":"NAS/ds918/酷我音乐/思雨-蜓儿点水蝶恋花DJ.flac","trackType":"flac"} Sep 09 09:46:16 volumio volumio[2284]: verbose: CURRENT POSITION 29 Sep 09 09:46:16 volumio volumio[2284]: info: CoreStateMachine::syncState stateService stop Sep 09 09:46:16 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus stop Sep 09 09:46:16 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:16 volumio volumio[2284]: info: CorePlayQueue::getTrack 29 Sep 09 09:46:16 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:16 volumio volumio[2284]: info: No code Sep 09 09:46:16 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:16 volumio volumio[2284]: info: CorePlayQueue::getTrack 29 Sep 09 09:46:16 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:16 volumio volumio[2284]: info: ------------------------------ 128ms Sep 09 09:46:16 volumio volumio[2284]: error: updateQueue error: null Sep 09 09:46:16 volumio volumio[2284]: info: Sep 09 09:46:16 volumio volumio[2284]: ---------------------------- MPD announces system playlist update Sep 09 09:46:16 volumio volumio[2284]: info: Ignoring MPD Status Update Sep 09 09:46:16 volumio volumio[2284]: info: ------------------------------ 111ms Sep 09 09:46:16 volumio volumio[2284]: info: sendMpdCommand add "NAS/ds918/酷我音乐/李常超（Lao乾妈）-盗墓笔记·十年人间.flac" took 108 milliseconds Sep 09 09:46:16 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand play Sep 09 09:46:16 volumio volumio[2284]: info: ------------------------------ 33ms Sep 09 09:46:16 volumio volumio[2284]: info: sendMpdCommand play took 30 milliseconds Sep 09 09:46:16 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Sep 09 09:46:17 volumio volumio[2284]: info: Sep 09 09:46:17 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:17 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:17 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:17 volumio volumio[2284]: info: Sep 09 09:46:17 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:17 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:17 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:17 volumio volumio[2284]: info: sendMpdCommand status took 4 milliseconds Sep 09 09:46:17 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:17 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:17 volumio volumio[2284]: info: sendMpdCommand status took 5 milliseconds Sep 09 09:46:17 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 09 09:46:17 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:17 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:17 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:17 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:17 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:17 volumio volumio[2284]: info: CorePlayQueue::getTrack 29 Sep 09 09:46:17 volumio volumio[2284]: verbose: STATE SERVICE {"status":"play","position":0,"seek":868,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"689 Kbps","isStreaming":false,"title":"盗墓笔记·十年人间","artist":"李常超（Lao乾妈）","album":"盗墓笔记·十年人间","uri":"NAS/ds918/酷我音乐/李常超（Lao乾妈）-盗墓笔记·十年人间.flac","trackType":"flac"} Sep 09 09:46:17 volumio volumio[2284]: verbose: CURRENT POSITION 29 Sep 09 09:46:17 volumio volumio[2284]: info: CoreStateMachine::syncState stateService play Sep 09 09:46:17 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus stop Sep 09 09:46:17 volumio volumio[2284]: info: ------------------------------ 21ms Sep 09 09:46:17 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 11 milliseconds Sep 09 09:46:17 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:17 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:17 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:17 volumio volumio[2284]: info: CorePlayQueue::getTrack 29 Sep 09 09:46:17 volumio volumio[2284]: verbose: STATE SERVICE {"status":"play","position":0,"seek":868,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"689 Kbps","isStreaming":false,"title":"盗墓笔记·十年人间","artist":"李常超（Lao乾妈）","album":"盗墓笔记·十年人间","uri":"NAS/ds918/酷我音乐/李常超（Lao乾妈）-盗墓笔记·十年人间.flac","trackType":"flac"} Sep 09 09:46:17 volumio volumio[2284]: verbose: CURRENT POSITION 29 Sep 09 09:46:17 volumio volumio[2284]: info: CoreStateMachine::syncState stateService play Sep 09 09:46:17 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus play Sep 09 09:46:17 volumio volumio[2284]: info: Received an update from plugin. extracting info from payload Sep 09 09:46:17 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:17 volumio volumio[2284]: info: CorePlayQueue::getTrack 29 Sep 09 09:46:17 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:17 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:17 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:17 volumio volumio[2284]: info: CorePlayQueue::getTrack 29 Sep 09 09:46:17 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:17 volumio volumio[2284]: info: ------------------------------ 89ms Sep 09 09:46:18 volumio volumio[2284]: info: CoreCommandRouter::volumioGetState Sep 09 09:46:18 volumio volumio[2284]: info: CorePlayQueue::getTrack 29 Sep 09 09:46:18 volumio volumio[2284]: info: Listing playlists Sep 09 09:46:18 volumio volumio[2284]: info: Listing playlists Sep 09 09:46:18 volumio volumio[2284]: info: CoreCommandRouter::volumioNext Sep 09 09:46:18 volumio volumio[2284]: info: CoreStateMachine::next Sep 09 09:46:18 volumio volumio[2284]: info: CoreStateMachine::stop Sep 09 09:46:18 volumio volumio[2284]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 09:46:18 volumio volumio[2284]: info: CoreStateMachine::stPlaybackTimer Sep 09 09:46:18 volumio volumio[2284]: info: CoreStateMachine::updateTrackBlock Sep 09 09:46:18 volumio volumio[2284]: info: CorePlayQueue::getTrackBlock Sep 09 09:46:18 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:18 volumio volumio[2284]: info: CorePlayQueue::getTrack 29 Sep 09 09:46:18 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:18 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:18 volumio volumio[2284]: info: CoreStateMachine::serviceStop Sep 09 09:46:18 volumio volumio[2284]: info: CorePlayQueue::getTrack 29 Sep 09 09:46:18 volumio volumio[2284]: info: CoreCommandRouter::serviceStop Sep 09 09:46:18 volumio volumio[2284]: info: ControllerMpd::stop Sep 09 09:46:18 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 09:46:18 volumio volumio[2284]: info: Sep 09 09:46:18 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:18 volumio volumio[2284]: info: sendMpdCommand stop took 29 milliseconds Sep 09 09:46:18 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Sep 09 09:46:18 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:18 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:18 volumio volumio[2284]: info: CoreStateMachine::play index undefined Sep 09 09:46:18 volumio volumio[2284]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 09:46:18 volumio volumio[2284]: info: CorePlayQueue::getTrack 30 Sep 09 09:46:18 volumio volumio[2284]: info: CoreStateMachine::startPlaybackTimer Sep 09 09:46:18 volumio volumio[2284]: info: CorePlayQueue::getTrack 30 Sep 09 09:46:18 volumio volumio[2284]: verbose: ControllerMpd::clearAddPlayTracks NAS/ds918/酷我音乐/温奕心-一路生花.flac Sep 09 09:46:18 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 09:46:18 volumio volumio[2284]: info: CoreStateMachine::updateTrackBlock Sep 09 09:46:18 volumio volumio[2284]: info: CorePlayQueue::getTrackBlock Sep 09 09:46:18 volumio volumio[2284]: info: sendMpdCommand status took 8 milliseconds Sep 09 09:46:18 volumio volumio[2284]: info: sendMpdCommand stop took 4 milliseconds Sep 09 09:46:18 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:18 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:18 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand clear Sep 09 09:46:18 volumio volumio[2284]: info: Sep 09 09:46:18 volumio volumio[2284]: ---------------------------- MPD announces system playlist update Sep 09 09:46:18 volumio volumio[2284]: info: Ignoring MPD Status Update Sep 09 09:46:18 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 9 milliseconds Sep 09 09:46:18 volumio volumio[2284]: info: sendMpdCommand clear took 9 milliseconds Sep 09 09:46:18 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:18 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand add "NAS/ds918/酷我音乐/温奕心-一路生花.flac" Sep 09 09:46:18 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:18 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:18 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:18 volumio volumio[2284]: info: CorePlayQueue::getTrack 30 Sep 09 09:46:18 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:18 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:18 volumio volumio[2284]: info: CorePlayQueue::getTrack 30 Sep 09 09:46:18 volumio volumio[2284]: 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":"盗墓笔记·十年人间","artist":"李常超（Lao乾妈）","album":"盗墓笔记·十年人间","uri":"NAS/ds918/酷我音乐/李常超（Lao乾妈）-盗墓笔记·十年人间.flac","trackType":"flac"} Sep 09 09:46:18 volumio volumio[2284]: verbose: CURRENT POSITION 30 Sep 09 09:46:18 volumio volumio[2284]: info: CoreStateMachine::syncState stateService stop Sep 09 09:46:18 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus stop Sep 09 09:46:18 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:18 volumio volumio[2284]: info: CorePlayQueue::getTrack 30 Sep 09 09:46:18 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:18 volumio volumio[2284]: info: No code Sep 09 09:46:18 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:18 volumio volumio[2284]: info: CorePlayQueue::getTrack 30 Sep 09 09:46:18 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:18 volumio volumio[2284]: info: ------------------------------ 100ms Sep 09 09:46:18 volumio volumio[2284]: error: updateQueue error: null Sep 09 09:46:18 volumio volumio[2284]: info: Sep 09 09:46:18 volumio volumio[2284]: ---------------------------- MPD announces system playlist update Sep 09 09:46:18 volumio volumio[2284]: info: Ignoring MPD Status Update Sep 09 09:46:18 volumio volumio[2284]: info: ------------------------------ 97ms Sep 09 09:46:18 volumio volumio[2284]: info: sendMpdCommand add "NAS/ds918/酷我音乐/温奕心-一路生花.flac" took 94 milliseconds Sep 09 09:46:18 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand play Sep 09 09:46:18 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Sep 09 09:46:18 volumio volumio[2284]: info: Sep 09 09:46:18 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:18 volumio volumio[2284]: info: ------------------------------ 145ms Sep 09 09:46:18 volumio volumio[2284]: info: sendMpdCommand play took 144 milliseconds Sep 09 09:46:18 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:18 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:18 volumio volumio[2284]: info: Sep 09 09:46:18 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:18 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:18 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:18 volumio volumio[2284]: info: sendMpdCommand status took 18 milliseconds Sep 09 09:46:18 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:18 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:18 volumio volumio[2284]: info: sendMpdCommand status took 75 milliseconds Sep 09 09:46:18 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 72 milliseconds Sep 09 09:46:18 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:18 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:18 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:18 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:18 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:18 volumio volumio[2284]: info: CorePlayQueue::getTrack 30 Sep 09 09:46:18 volumio volumio[2284]: verbose: STATE SERVICE {"status":"play","position":0,"seek":868,"duration":256,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"370 Kbps","isStreaming":false,"title":"一路生花","artist":"温奕心","album":"一路生花","uri":"NAS/ds918/酷我音乐/温奕心-一路生花.flac","trackType":"flac"} Sep 09 09:46:18 volumio volumio[2284]: verbose: CURRENT POSITION 30 Sep 09 09:46:18 volumio volumio[2284]: info: CoreStateMachine::syncState stateService play Sep 09 09:46:18 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus stop Sep 09 09:46:18 volumio volumio[2284]: info: ------------------------------ 104ms Sep 09 09:46:18 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 7 milliseconds Sep 09 09:46:18 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:18 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:18 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:18 volumio volumio[2284]: info: CorePlayQueue::getTrack 30 Sep 09 09:46:18 volumio volumio[2284]: verbose: STATE SERVICE {"status":"play","position":0,"seek":868,"duration":256,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"370 Kbps","isStreaming":false,"title":"一路生花","artist":"温奕心","album":"一路生花","uri":"NAS/ds918/酷我音乐/温奕心-一路生花.flac","trackType":"flac"} Sep 09 09:46:18 volumio volumio[2284]: verbose: CURRENT POSITION 30 Sep 09 09:46:18 volumio volumio[2284]: info: CoreStateMachine::syncState stateService play Sep 09 09:46:18 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus play Sep 09 09:46:18 volumio volumio[2284]: info: Received an update from plugin. extracting info from payload Sep 09 09:46:18 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:18 volumio volumio[2284]: info: CorePlayQueue::getTrack 30 Sep 09 09:46:18 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:18 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:18 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:18 volumio volumio[2284]: info: CorePlayQueue::getTrack 30 Sep 09 09:46:18 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:18 volumio volumio[2284]: info: ------------------------------ 143ms Sep 09 09:46:19 volumio volumio[2284]: info: CoreCommandRouter::volumioNext Sep 09 09:46:19 volumio volumio[2284]: info: CoreStateMachine::next Sep 09 09:46:19 volumio volumio[2284]: info: CoreStateMachine::stop Sep 09 09:46:19 volumio volumio[2284]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 09:46:19 volumio volumio[2284]: info: CoreStateMachine::stPlaybackTimer Sep 09 09:46:19 volumio volumio[2284]: info: CoreStateMachine::updateTrackBlock Sep 09 09:46:19 volumio volumio[2284]: info: CorePlayQueue::getTrackBlock Sep 09 09:46:19 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:19 volumio volumio[2284]: info: CorePlayQueue::getTrack 30 Sep 09 09:46:19 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:19 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:19 volumio volumio[2284]: info: CoreStateMachine::serviceStop Sep 09 09:46:19 volumio volumio[2284]: info: CorePlayQueue::getTrack 30 Sep 09 09:46:19 volumio volumio[2284]: info: CoreCommandRouter::serviceStop Sep 09 09:46:19 volumio volumio[2284]: info: ControllerMpd::stop Sep 09 09:46:19 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 09:46:19 volumio volumio[2284]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%B8%A9%E5%A5%95%E5%BF%83/%E4%B8%80%E8%B7%AF%E7%94%9F%E8%8A%B1/9dd110b0-1157-4e4a-bbde-7a0be1bc0d23.jpg' Sep 09 09:46:19 volumio volumio[2284]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%B8%A9%E5%A5%95%E5%BF%83/%E4%B8%80%E8%B7%AF%E7%94%9F%E8%8A%B1/9dd110b0-1157-4e4a-bbde-7a0be1bc0d23.jpg' Sep 09 09:46:19 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Sep 09 09:46:19 volumio volumio[2284]: info: Sep 09 09:46:19 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:19 volumio volumio[2284]: info: sendMpdCommand stop took 112 milliseconds Sep 09 09:46:19 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:19 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:19 volumio volumio[2284]: info: CoreStateMachine::play index undefined Sep 09 09:46:19 volumio volumio[2284]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 09:46:19 volumio volumio[2284]: info: CorePlayQueue::getTrack 31 Sep 09 09:46:19 volumio volumio[2284]: info: CoreStateMachine::startPlaybackTimer Sep 09 09:46:19 volumio volumio[2284]: info: CorePlayQueue::getTrack 31 Sep 09 09:46:19 volumio volumio[2284]: verbose: ControllerMpd::clearAddPlayTracks NAS/ds918/酷我音乐/湘西深山乐队-月亮里的阿妹.flac Sep 09 09:46:19 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 09:46:19 volumio volumio[2284]: info: CoreStateMachine::updateTrackBlock Sep 09 09:46:19 volumio volumio[2284]: info: CorePlayQueue::getTrackBlock Sep 09 09:46:19 volumio volumio[2284]: info: sendMpdCommand status took 7 milliseconds Sep 09 09:46:19 volumio volumio[2284]: info: sendMpdCommand stop took 4 milliseconds Sep 09 09:46:19 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:19 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:19 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand clear Sep 09 09:46:19 volumio volumio[2284]: info: Sep 09 09:46:19 volumio volumio[2284]: ---------------------------- MPD announces system playlist update Sep 09 09:46:19 volumio volumio[2284]: info: Ignoring MPD Status Update Sep 09 09:46:19 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 6 milliseconds Sep 09 09:46:19 volumio volumio[2284]: info: sendMpdCommand clear took 7 milliseconds Sep 09 09:46:19 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:19 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand add "NAS/ds918/酷我音乐/湘西深山乐队-月亮里的阿妹.flac" Sep 09 09:46:19 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:19 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:19 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:19 volumio volumio[2284]: info: CorePlayQueue::getTrack 31 Sep 09 09:46:19 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:19 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:19 volumio volumio[2284]: info: CorePlayQueue::getTrack 31 Sep 09 09:46:19 volumio volumio[2284]: 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":"一路生花","artist":"温奕心","album":"一路生花","uri":"NAS/ds918/酷我音乐/温奕心-一路生花.flac","trackType":"flac"} Sep 09 09:46:19 volumio volumio[2284]: verbose: CURRENT POSITION 31 Sep 09 09:46:19 volumio volumio[2284]: info: CoreStateMachine::syncState stateService stop Sep 09 09:46:19 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus stop Sep 09 09:46:19 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:19 volumio volumio[2284]: info: CorePlayQueue::getTrack 31 Sep 09 09:46:19 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:19 volumio volumio[2284]: info: No code Sep 09 09:46:19 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:19 volumio volumio[2284]: info: CorePlayQueue::getTrack 31 Sep 09 09:46:19 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:19 volumio volumio[2284]: info: ------------------------------ 120ms Sep 09 09:46:19 volumio volumio[2284]: error: updateQueue error: null Sep 09 09:46:19 volumio volumio[2284]: info: Sep 09 09:46:19 volumio volumio[2284]: ---------------------------- MPD announces system playlist update Sep 09 09:46:19 volumio volumio[2284]: info: Ignoring MPD Status Update Sep 09 09:46:19 volumio volumio[2284]: info: ------------------------------ 126ms Sep 09 09:46:19 volumio volumio[2284]: info: sendMpdCommand add "NAS/ds918/酷我音乐/湘西深山乐队-月亮里的阿妹.flac" took 122 milliseconds Sep 09 09:46:19 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand play Sep 09 09:46:19 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Sep 09 09:46:19 volumio volumio[2284]: info: Sep 09 09:46:19 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:19 volumio volumio[2284]: info: ------------------------------ 39ms Sep 09 09:46:19 volumio volumio[2284]: info: sendMpdCommand play took 37 milliseconds Sep 09 09:46:19 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:19 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:19 volumio volumio[2284]: info: sendMpdCommand status took 15 milliseconds Sep 09 09:46:19 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:19 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:19 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 93 milliseconds Sep 09 09:46:19 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:19 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:19 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:19 volumio volumio[2284]: info: CorePlayQueue::getTrack 31 Sep 09 09:46:19 volumio volumio[2284]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":231,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"月亮里的阿妹","artist":"湘西深山乐队","album":"月亮里的阿妹（想你想你我真的好想你）","uri":"NAS/ds918/酷我音乐/湘西深山乐队-月亮里的阿妹.flac","trackType":"flac"} Sep 09 09:46:19 volumio volumio[2284]: verbose: CURRENT POSITION 31 Sep 09 09:46:19 volumio volumio[2284]: info: CoreStateMachine::syncState stateService play Sep 09 09:46:19 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus stop Sep 09 09:46:19 volumio volumio[2284]: info: ------------------------------ 122ms Sep 09 09:46:20 volumio volumio[2284]: info: CoreCommandRouter::volumioNext Sep 09 09:46:20 volumio volumio[2284]: info: CoreStateMachine::next Sep 09 09:46:20 volumio volumio[2284]: info: CoreStateMachine::stop Sep 09 09:46:20 volumio volumio[2284]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 09:46:20 volumio volumio[2284]: info: CoreStateMachine::stPlaybackTimer Sep 09 09:46:20 volumio volumio[2284]: info: CoreStateMachine::updateTrackBlock Sep 09 09:46:20 volumio volumio[2284]: info: CorePlayQueue::getTrackBlock Sep 09 09:46:20 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:20 volumio volumio[2284]: info: CorePlayQueue::getTrack 31 Sep 09 09:46:20 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:20 volumio volumio[2284]: info: CoreStateMachine::serviceStop Sep 09 09:46:20 volumio volumio[2284]: info: CorePlayQueue::getTrack 31 Sep 09 09:46:20 volumio volumio[2284]: info: CoreCommandRouter::serviceStop Sep 09 09:46:20 volumio volumio[2284]: info: ControllerMpd::stop Sep 09 09:46:20 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 09:46:20 volumio volumio[2284]: info: Sep 09 09:46:20 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:20 volumio volumio[2284]: info: sendMpdCommand stop took 81 milliseconds Sep 09 09:46:20 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Sep 09 09:46:20 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:20 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:20 volumio volumio[2284]: info: CoreStateMachine::play index undefined Sep 09 09:46:20 volumio volumio[2284]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 09:46:20 volumio volumio[2284]: info: CorePlayQueue::getTrack 32 Sep 09 09:46:20 volumio volumio[2284]: info: CoreStateMachine::startPlaybackTimer Sep 09 09:46:20 volumio volumio[2284]: info: CorePlayQueue::getTrack 32 Sep 09 09:46:20 volumio volumio[2284]: verbose: ControllerMpd::clearAddPlayTracks NAS/ds918/酷我音乐/龙飘飘-惜别的海岸.flac Sep 09 09:46:20 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 09:46:20 volumio volumio[2284]: info: CoreStateMachine::updateTrackBlock Sep 09 09:46:20 volumio volumio[2284]: info: CorePlayQueue::getTrackBlock Sep 09 09:46:20 volumio volumio[2284]: info: sendMpdCommand status took 10 milliseconds Sep 09 09:46:20 volumio volumio[2284]: info: sendMpdCommand stop took 5 milliseconds Sep 09 09:46:20 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:20 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:20 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand clear Sep 09 09:46:20 volumio volumio[2284]: info: Sep 09 09:46:20 volumio volumio[2284]: ---------------------------- MPD announces system playlist update Sep 09 09:46:20 volumio volumio[2284]: info: Ignoring MPD Status Update Sep 09 09:46:20 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 7 milliseconds Sep 09 09:46:20 volumio volumio[2284]: info: sendMpdCommand clear took 7 milliseconds Sep 09 09:46:20 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:20 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand add "NAS/ds918/酷我音乐/龙飘飘-惜别的海岸.flac" Sep 09 09:46:20 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:20 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:20 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:20 volumio volumio[2284]: info: CorePlayQueue::getTrack 32 Sep 09 09:46:20 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:20 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:21 volumio volumio[2284]: info: CorePlayQueue::getTrack 32 Sep 09 09:46:21 volumio volumio[2284]: 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":"月亮里的阿妹","artist":"湘西深山乐队","album":"月亮里的阿妹（想你想你我真的好想你）","uri":"NAS/ds918/酷我音乐/湘西深山乐队-月亮里的阿妹.flac","trackType":"flac"} Sep 09 09:46:21 volumio volumio[2284]: verbose: CURRENT POSITION 32 Sep 09 09:46:21 volumio volumio[2284]: info: CoreStateMachine::syncState stateService stop Sep 09 09:46:21 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus stop Sep 09 09:46:21 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:21 volumio volumio[2284]: info: CorePlayQueue::getTrack 32 Sep 09 09:46:21 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:21 volumio volumio[2284]: info: No code Sep 09 09:46:21 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:21 volumio volumio[2284]: info: CorePlayQueue::getTrack 32 Sep 09 09:46:21 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:21 volumio volumio[2284]: info: ------------------------------ 132ms Sep 09 09:46:21 volumio volumio[2284]: error: updateQueue error: null Sep 09 09:46:21 volumio volumio[2284]: info: Sep 09 09:46:21 volumio volumio[2284]: ---------------------------- MPD announces system playlist update Sep 09 09:46:21 volumio volumio[2284]: info: Ignoring MPD Status Update Sep 09 09:46:21 volumio volumio[2284]: info: ------------------------------ 118ms Sep 09 09:46:21 volumio volumio[2284]: info: sendMpdCommand add "NAS/ds918/酷我音乐/龙飘飘-惜别的海岸.flac" took 115 milliseconds Sep 09 09:46:21 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand play Sep 09 09:46:21 volumio volumio[2284]: info: ------------------------------ 39ms Sep 09 09:46:21 volumio volumio[2284]: info: sendMpdCommand play took 37 milliseconds Sep 09 09:46:21 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Sep 09 09:46:21 volumio volumio[2284]: info: Sep 09 09:46:21 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:21 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:21 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:21 volumio volumio[2284]: info: Sep 09 09:46:21 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:21 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:21 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:21 volumio volumio[2284]: info: sendMpdCommand status took 6 milliseconds Sep 09 09:46:21 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:21 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:21 volumio volumio[2284]: info: sendMpdCommand status took 8 milliseconds Sep 09 09:46:21 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 5 milliseconds Sep 09 09:46:21 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:21 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:21 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:21 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:21 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:21 volumio volumio[2284]: info: CorePlayQueue::getTrack 32 Sep 09 09:46:21 volumio volumio[2284]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":208,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"695 Kbps","isStreaming":false,"title":"惜别的海岸","artist":"龙飘飘","album":"畅销精选辑","uri":"NAS/ds918/酷我音乐/龙飘飘-惜别的海岸.flac","trackType":"flac"} Sep 09 09:46:21 volumio volumio[2284]: verbose: CURRENT POSITION 32 Sep 09 09:46:21 volumio volumio[2284]: info: CoreStateMachine::syncState stateService play Sep 09 09:46:21 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus stop Sep 09 09:46:21 volumio volumio[2284]: info: ------------------------------ 23ms Sep 09 09:46:21 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 5 milliseconds Sep 09 09:46:21 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:21 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:21 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:21 volumio volumio[2284]: info: CorePlayQueue::getTrack 32 Sep 09 09:46:21 volumio volumio[2284]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":208,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"695 Kbps","isStreaming":false,"title":"惜别的海岸","artist":"龙飘飘","album":"畅销精选辑","uri":"NAS/ds918/酷我音乐/龙飘飘-惜别的海岸.flac","trackType":"flac"} Sep 09 09:46:21 volumio volumio[2284]: verbose: CURRENT POSITION 32 Sep 09 09:46:21 volumio volumio[2284]: info: CoreStateMachine::syncState stateService play Sep 09 09:46:21 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus play Sep 09 09:46:21 volumio volumio[2284]: info: Received an update from plugin. extracting info from payload Sep 09 09:46:21 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:21 volumio volumio[2284]: info: CorePlayQueue::getTrack 32 Sep 09 09:46:21 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:21 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:21 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:21 volumio volumio[2284]: info: CorePlayQueue::getTrack 32 Sep 09 09:46:21 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:21 volumio volumio[2284]: info: ------------------------------ 94ms Sep 09 09:46:22 volumio volumio[2284]: info: CoreCommandRouter::volumioNext Sep 09 09:46:22 volumio volumio[2284]: info: CoreStateMachine::next Sep 09 09:46:22 volumio volumio[2284]: info: CoreStateMachine::stop Sep 09 09:46:22 volumio volumio[2284]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 09:46:22 volumio volumio[2284]: info: CoreStateMachine::stPlaybackTimer Sep 09 09:46:22 volumio volumio[2284]: info: CoreStateMachine::updateTrackBlock Sep 09 09:46:22 volumio volumio[2284]: info: CorePlayQueue::getTrackBlock Sep 09 09:46:22 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:22 volumio volumio[2284]: info: CorePlayQueue::getTrack 32 Sep 09 09:46:22 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:22 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:22 volumio volumio[2284]: info: CoreStateMachine::serviceStop Sep 09 09:46:22 volumio volumio[2284]: info: CorePlayQueue::getTrack 32 Sep 09 09:46:22 volumio volumio[2284]: info: CoreCommandRouter::serviceStop Sep 09 09:46:22 volumio volumio[2284]: info: ControllerMpd::stop Sep 09 09:46:22 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 09:46:22 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Sep 09 09:46:22 volumio volumio[2284]: info: Sep 09 09:46:22 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:22 volumio volumio[2284]: info: sendMpdCommand stop took 119 milliseconds Sep 09 09:46:22 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:22 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:22 volumio volumio[2284]: info: CoreStateMachine::play index undefined Sep 09 09:46:22 volumio volumio[2284]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 09:46:22 volumio volumio[2284]: info: CorePlayQueue::getTrack 33 Sep 09 09:46:22 volumio volumio[2284]: info: CoreStateMachine::startPlaybackTimer Sep 09 09:46:22 volumio volumio[2284]: info: CorePlayQueue::getTrack 33 Sep 09 09:46:22 volumio volumio[2284]: verbose: ControllerMpd::clearAddPlayTracks NAS/ds918/酷我音乐/龙飘飘-新年好.mp3 Sep 09 09:46:22 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 09:46:22 volumio volumio[2284]: info: CoreStateMachine::updateTrackBlock Sep 09 09:46:22 volumio volumio[2284]: info: CorePlayQueue::getTrackBlock Sep 09 09:46:22 volumio volumio[2284]: info: sendMpdCommand status took 6 milliseconds Sep 09 09:46:22 volumio volumio[2284]: info: sendMpdCommand stop took 4 milliseconds Sep 09 09:46:22 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:22 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:22 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand clear Sep 09 09:46:22 volumio volumio[2284]: info: Sep 09 09:46:22 volumio volumio[2284]: ---------------------------- MPD announces system playlist update Sep 09 09:46:22 volumio volumio[2284]: info: Ignoring MPD Status Update Sep 09 09:46:22 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 5 milliseconds Sep 09 09:46:22 volumio volumio[2284]: info: sendMpdCommand clear took 4 milliseconds Sep 09 09:46:22 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:22 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand add "NAS/ds918/酷我音乐/龙飘飘-新年好.mp3" Sep 09 09:46:22 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:22 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:22 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:22 volumio volumio[2284]: info: CorePlayQueue::getTrack 33 Sep 09 09:46:22 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:22 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:22 volumio volumio[2284]: info: CorePlayQueue::getTrack 33 Sep 09 09:46:22 volumio volumio[2284]: 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":"惜别的海岸","artist":"龙飘飘","album":"畅销精选辑","uri":"NAS/ds918/酷我音乐/龙飘飘-惜别的海岸.flac","trackType":"flac"} Sep 09 09:46:22 volumio volumio[2284]: verbose: CURRENT POSITION 33 Sep 09 09:46:22 volumio volumio[2284]: info: CoreStateMachine::syncState stateService stop Sep 09 09:46:22 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus stop Sep 09 09:46:22 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:22 volumio volumio[2284]: info: CorePlayQueue::getTrack 33 Sep 09 09:46:22 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:22 volumio volumio[2284]: info: No code Sep 09 09:46:22 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:22 volumio volumio[2284]: info: CorePlayQueue::getTrack 33 Sep 09 09:46:22 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:22 volumio volumio[2284]: info: ------------------------------ 89ms Sep 09 09:46:22 volumio volumio[2284]: error: updateQueue error: null Sep 09 09:46:22 volumio volumio[2284]: info: Sep 09 09:46:22 volumio volumio[2284]: ---------------------------- MPD announces system playlist update Sep 09 09:46:22 volumio volumio[2284]: info: Ignoring MPD Status Update Sep 09 09:46:22 volumio volumio[2284]: info: ------------------------------ 81ms Sep 09 09:46:22 volumio volumio[2284]: info: sendMpdCommand add "NAS/ds918/酷我音乐/龙飘飘-新年好.mp3" took 78 milliseconds Sep 09 09:46:22 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand play Sep 09 09:46:22 volumio volumio[2284]: info: ------------------------------ 27ms Sep 09 09:46:22 volumio volumio[2284]: info: sendMpdCommand play took 26 milliseconds Sep 09 09:46:22 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Sep 09 09:46:22 volumio volumio[2284]: info: Sep 09 09:46:22 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:22 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:22 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:22 volumio volumio[2284]: info: Sep 09 09:46:22 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:22 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:22 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:22 volumio volumio[2284]: info: sendMpdCommand status took 24 milliseconds Sep 09 09:46:22 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:22 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:22 volumio volumio[2284]: info: sendMpdCommand status took 5 milliseconds Sep 09 09:46:22 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 09 09:46:22 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:22 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:22 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:22 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:22 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:22 volumio volumio[2284]: info: CorePlayQueue::getTrack 33 Sep 09 09:46:22 volumio volumio[2284]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":158,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"新年好","artist":"龙飘飘","album":"龙飘飘经典新年歌曲100首","uri":"NAS/ds918/酷我音乐/龙飘飘-新年好.mp3","trackType":"mp3"} Sep 09 09:46:22 volumio volumio[2284]: verbose: CURRENT POSITION 33 Sep 09 09:46:22 volumio volumio[2284]: info: CoreStateMachine::syncState stateService play Sep 09 09:46:22 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus stop Sep 09 09:46:22 volumio volumio[2284]: info: ------------------------------ 35ms Sep 09 09:46:22 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 7 milliseconds Sep 09 09:46:22 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:22 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:22 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:22 volumio volumio[2284]: info: CorePlayQueue::getTrack 33 Sep 09 09:46:22 volumio volumio[2284]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":158,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"新年好","artist":"龙飘飘","album":"龙飘飘经典新年歌曲100首","uri":"NAS/ds918/酷我音乐/龙飘飘-新年好.mp3","trackType":"mp3"} Sep 09 09:46:22 volumio volumio[2284]: verbose: CURRENT POSITION 33 Sep 09 09:46:22 volumio volumio[2284]: info: CoreStateMachine::syncState stateService play Sep 09 09:46:22 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus play Sep 09 09:46:22 volumio volumio[2284]: info: Received an update from plugin. extracting info from payload Sep 09 09:46:22 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:22 volumio volumio[2284]: info: CorePlayQueue::getTrack 33 Sep 09 09:46:22 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:22 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:22 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:22 volumio volumio[2284]: info: CorePlayQueue::getTrack 33 Sep 09 09:46:22 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:22 volumio volumio[2284]: info: ------------------------------ 90ms Sep 09 09:46:24 volumio volumio[2284]: info: CoreCommandRouter::volumioNext Sep 09 09:46:24 volumio volumio[2284]: info: CoreStateMachine::next Sep 09 09:46:24 volumio volumio[2284]: info: CoreStateMachine::stop Sep 09 09:46:24 volumio volumio[2284]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 09:46:24 volumio volumio[2284]: info: CoreStateMachine::stPlaybackTimer Sep 09 09:46:24 volumio volumio[2284]: info: CoreStateMachine::updateTrackBlock Sep 09 09:46:24 volumio volumio[2284]: info: CorePlayQueue::getTrackBlock Sep 09 09:46:24 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:24 volumio volumio[2284]: info: CorePlayQueue::getTrack 33 Sep 09 09:46:24 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:24 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:24 volumio volumio[2284]: info: CoreStateMachine::serviceStop Sep 09 09:46:24 volumio volumio[2284]: info: CorePlayQueue::getTrack 33 Sep 09 09:46:24 volumio volumio[2284]: info: CoreCommandRouter::serviceStop Sep 09 09:46:24 volumio volumio[2284]: info: ControllerMpd::stop Sep 09 09:46:24 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 09:46:24 volumio volumio[2284]: info: Sep 09 09:46:24 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:24 volumio volumio[2284]: info: sendMpdCommand stop took 34 milliseconds Sep 09 09:46:24 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Sep 09 09:46:24 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:24 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:24 volumio volumio[2284]: info: CoreStateMachine::play index undefined Sep 09 09:46:24 volumio volumio[2284]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 09:46:24 volumio volumio[2284]: info: CorePlayQueue::getTrack 34 Sep 09 09:46:24 volumio volumio[2284]: info: CoreStateMachine::startPlaybackTimer Sep 09 09:46:24 volumio volumio[2284]: info: CorePlayQueue::getTrack 34 Sep 09 09:46:24 volumio volumio[2284]: verbose: ControllerMpd::clearAddPlayTracks NAS/ds918/酷我音乐/龚玥-喜乐年华.flac Sep 09 09:46:24 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 09:46:24 volumio volumio[2284]: info: CoreStateMachine::updateTrackBlock Sep 09 09:46:24 volumio volumio[2284]: info: CorePlayQueue::getTrackBlock Sep 09 09:46:24 volumio volumio[2284]: info: sendMpdCommand status took 7 milliseconds Sep 09 09:46:24 volumio volumio[2284]: info: sendMpdCommand stop took 4 milliseconds Sep 09 09:46:24 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:24 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:24 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand clear Sep 09 09:46:24 volumio volumio[2284]: info: Sep 09 09:46:24 volumio volumio[2284]: ---------------------------- MPD announces system playlist update Sep 09 09:46:24 volumio volumio[2284]: info: Ignoring MPD Status Update Sep 09 09:46:24 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 7 milliseconds Sep 09 09:46:24 volumio volumio[2284]: info: sendMpdCommand clear took 8 milliseconds Sep 09 09:46:24 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:24 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand add "NAS/ds918/酷我音乐/龚玥-喜乐年华.flac" Sep 09 09:46:24 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:24 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:24 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:24 volumio volumio[2284]: info: CorePlayQueue::getTrack 34 Sep 09 09:46:24 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:24 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:24 volumio volumio[2284]: info: CorePlayQueue::getTrack 34 Sep 09 09:46:24 volumio volumio[2284]: 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":"新年好","artist":"龙飘飘","album":"龙飘飘经典新年歌曲100首","uri":"NAS/ds918/酷我音乐/龙飘飘-新年好.mp3","trackType":"mp3"} Sep 09 09:46:24 volumio volumio[2284]: verbose: CURRENT POSITION 34 Sep 09 09:46:24 volumio volumio[2284]: info: CoreStateMachine::syncState stateService stop Sep 09 09:46:24 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus stop Sep 09 09:46:24 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:24 volumio volumio[2284]: info: CorePlayQueue::getTrack 34 Sep 09 09:46:24 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:24 volumio volumio[2284]: info: No code Sep 09 09:46:24 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:24 volumio volumio[2284]: info: CorePlayQueue::getTrack 34 Sep 09 09:46:24 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:24 volumio volumio[2284]: info: ------------------------------ 101ms Sep 09 09:46:24 volumio volumio[2284]: error: updateQueue error: null Sep 09 09:46:24 volumio volumio[2284]: info: Sep 09 09:46:24 volumio volumio[2284]: ---------------------------- MPD announces system playlist update Sep 09 09:46:24 volumio volumio[2284]: info: Ignoring MPD Status Update Sep 09 09:46:24 volumio volumio[2284]: info: ------------------------------ 97ms Sep 09 09:46:24 volumio volumio[2284]: info: sendMpdCommand add "NAS/ds918/酷我音乐/龚玥-喜乐年华.flac" took 94 milliseconds Sep 09 09:46:24 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand play Sep 09 09:46:24 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Sep 09 09:46:24 volumio volumio[2284]: info: Sep 09 09:46:24 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:24 volumio volumio[2284]: info: ------------------------------ 37ms Sep 09 09:46:24 volumio volumio[2284]: info: sendMpdCommand play took 35 milliseconds Sep 09 09:46:24 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:24 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:24 volumio volumio[2284]: info: Sep 09 09:46:24 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:24 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:24 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:24 volumio volumio[2284]: info: sendMpdCommand status took 123 milliseconds Sep 09 09:46:24 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:24 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:24 volumio volumio[2284]: info: sendMpdCommand status took 10 milliseconds Sep 09 09:46:24 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 8 milliseconds Sep 09 09:46:24 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:24 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:24 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:24 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:24 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:24 volumio volumio[2284]: info: CorePlayQueue::getTrack 34 Sep 09 09:46:24 volumio volumio[2284]: verbose: STATE SERVICE {"status":"play","position":0,"seek":868,"duration":261,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"910 Kbps","isStreaming":false,"title":"喜乐年华","artist":"龚玥","album":"中国年·2012贺年心曲","uri":"NAS/ds918/酷我音乐/龚玥-喜乐年华.flac","trackType":"flac"} Sep 09 09:46:24 volumio volumio[2284]: verbose: CURRENT POSITION 34 Sep 09 09:46:24 volumio volumio[2284]: info: CoreStateMachine::syncState stateService play Sep 09 09:46:24 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus stop Sep 09 09:46:24 volumio volumio[2284]: info: ------------------------------ 142ms Sep 09 09:46:24 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 24 milliseconds Sep 09 09:46:24 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:24 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:24 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:24 volumio volumio[2284]: info: CorePlayQueue::getTrack 34 Sep 09 09:46:24 volumio volumio[2284]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":261,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"745 Kbps","isStreaming":false,"title":"喜乐年华","artist":"龚玥","album":"中国年·2012贺年心曲","uri":"NAS/ds918/酷我音乐/龚玥-喜乐年华.flac","trackType":"flac"} Sep 09 09:46:24 volumio volumio[2284]: verbose: CURRENT POSITION 34 Sep 09 09:46:24 volumio volumio[2284]: info: CoreStateMachine::syncState stateService play Sep 09 09:46:24 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus play Sep 09 09:46:24 volumio volumio[2284]: info: Received an update from plugin. extracting info from payload Sep 09 09:46:24 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:24 volumio volumio[2284]: info: CorePlayQueue::getTrack 34 Sep 09 09:46:24 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:24 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:24 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:24 volumio volumio[2284]: info: CorePlayQueue::getTrack 34 Sep 09 09:46:24 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:24 volumio volumio[2284]: info: ------------------------------ 98ms Sep 09 09:46:26 volumio volumio[2284]: info: CoreCommandRouter::volumioNext Sep 09 09:46:26 volumio volumio[2284]: info: CoreStateMachine::next Sep 09 09:46:26 volumio volumio[2284]: info: CoreStateMachine::stop Sep 09 09:46:26 volumio volumio[2284]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 09:46:26 volumio volumio[2284]: info: CoreStateMachine::stPlaybackTimer Sep 09 09:46:26 volumio volumio[2284]: info: CoreStateMachine::updateTrackBlock Sep 09 09:46:26 volumio volumio[2284]: info: CorePlayQueue::getTrackBlock Sep 09 09:46:26 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:26 volumio volumio[2284]: info: CorePlayQueue::getTrack 34 Sep 09 09:46:26 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:26 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:26 volumio volumio[2284]: info: CoreStateMachine::serviceStop Sep 09 09:46:26 volumio volumio[2284]: info: CorePlayQueue::getTrack 34 Sep 09 09:46:26 volumio volumio[2284]: info: CoreCommandRouter::serviceStop Sep 09 09:46:26 volumio volumio[2284]: info: ControllerMpd::stop Sep 09 09:46:26 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 09:46:26 volumio volumio[2284]: info: Sep 09 09:46:26 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:26 volumio volumio[2284]: info: sendMpdCommand stop took 22 milliseconds Sep 09 09:46:26 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Sep 09 09:46:26 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:26 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:26 volumio volumio[2284]: info: CoreStateMachine::play index undefined Sep 09 09:46:26 volumio volumio[2284]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 09:46:26 volumio volumio[2284]: info: CorePlayQueue::getTrack 35 Sep 09 09:46:26 volumio volumio[2284]: info: CoreStateMachine::startPlaybackTimer Sep 09 09:46:26 volumio volumio[2284]: info: CorePlayQueue::getTrack 35 Sep 09 09:46:26 volumio volumio[2284]: verbose: ControllerMpd::clearAddPlayTracks NAS/ds918/酷我音乐/龚玥-心想唱歌就唱歌.flac Sep 09 09:46:26 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 09:46:26 volumio volumio[2284]: info: CoreStateMachine::updateTrackBlock Sep 09 09:46:26 volumio volumio[2284]: info: CorePlayQueue::getTrackBlock Sep 09 09:46:26 volumio volumio[2284]: info: sendMpdCommand status took 6 milliseconds Sep 09 09:46:26 volumio volumio[2284]: info: sendMpdCommand stop took 4 milliseconds Sep 09 09:46:26 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:26 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:26 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand clear Sep 09 09:46:26 volumio volumio[2284]: info: Sep 09 09:46:26 volumio volumio[2284]: ---------------------------- MPD announces system playlist update Sep 09 09:46:26 volumio volumio[2284]: info: Ignoring MPD Status Update Sep 09 09:46:26 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 4 milliseconds Sep 09 09:46:26 volumio volumio[2284]: info: sendMpdCommand clear took 5 milliseconds Sep 09 09:46:26 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:26 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand add "NAS/ds918/酷我音乐/龚玥-心想唱歌就唱歌.flac" Sep 09 09:46:26 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:26 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:26 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:26 volumio volumio[2284]: info: CorePlayQueue::getTrack 35 Sep 09 09:46:26 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:26 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:26 volumio volumio[2284]: info: CorePlayQueue::getTrack 35 Sep 09 09:46:26 volumio volumio[2284]: 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":"喜乐年华","artist":"龚玥","album":"中国年·2012贺年心曲","uri":"NAS/ds918/酷我音乐/龚玥-喜乐年华.flac","trackType":"flac"} Sep 09 09:46:26 volumio volumio[2284]: verbose: CURRENT POSITION 35 Sep 09 09:46:26 volumio volumio[2284]: info: CoreStateMachine::syncState stateService stop Sep 09 09:46:26 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus stop Sep 09 09:46:26 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:26 volumio volumio[2284]: info: CorePlayQueue::getTrack 35 Sep 09 09:46:26 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:26 volumio volumio[2284]: info: No code Sep 09 09:46:26 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:26 volumio volumio[2284]: info: CorePlayQueue::getTrack 35 Sep 09 09:46:26 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:26 volumio volumio[2284]: info: ------------------------------ 98ms Sep 09 09:46:26 volumio volumio[2284]: error: updateQueue error: null Sep 09 09:46:26 volumio volumio[2284]: info: Sep 09 09:46:26 volumio volumio[2284]: ---------------------------- MPD announces system playlist update Sep 09 09:46:26 volumio volumio[2284]: info: Ignoring MPD Status Update Sep 09 09:46:26 volumio volumio[2284]: info: ------------------------------ 91ms Sep 09 09:46:26 volumio volumio[2284]: info: sendMpdCommand add "NAS/ds918/酷我音乐/龚玥-心想唱歌就唱歌.flac" took 85 milliseconds Sep 09 09:46:26 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand play Sep 09 09:46:26 volumio volumio[2284]: info: ------------------------------ 63ms Sep 09 09:46:26 volumio volumio[2284]: info: sendMpdCommand play took 61 milliseconds Sep 09 09:46:26 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Sep 09 09:46:26 volumio volumio[2284]: info: Sep 09 09:46:26 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:26 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:26 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:26 volumio volumio[2284]: info: Sep 09 09:46:26 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:26 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:26 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:26 volumio volumio[2284]: info: sendMpdCommand status took 140 milliseconds Sep 09 09:46:26 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:26 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:26 volumio volumio[2284]: info: sendMpdCommand status took 25 milliseconds Sep 09 09:46:26 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 23 milliseconds Sep 09 09:46:26 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:26 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:26 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:26 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:26 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:26 volumio volumio[2284]: info: CorePlayQueue::getTrack 35 Sep 09 09:46:26 volumio volumio[2284]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":347,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"心想唱歌就唱歌","artist":"龚玥","album":"金装龚玥情歌篇","uri":"NAS/ds918/酷我音乐/龚玥-心想唱歌就唱歌.flac","trackType":"flac"} Sep 09 09:46:26 volumio volumio[2284]: verbose: CURRENT POSITION 35 Sep 09 09:46:26 volumio volumio[2284]: info: CoreStateMachine::syncState stateService play Sep 09 09:46:26 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus stop Sep 09 09:46:26 volumio volumio[2284]: info: ------------------------------ 172ms Sep 09 09:46:26 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 6 milliseconds Sep 09 09:46:26 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:26 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:26 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:26 volumio volumio[2284]: info: CorePlayQueue::getTrack 35 Sep 09 09:46:26 volumio volumio[2284]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":347,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"342 Kbps","isStreaming":false,"title":"心想唱歌就唱歌","artist":"龚玥","album":"金装龚玥情歌篇","uri":"NAS/ds918/酷我音乐/龚玥-心想唱歌就唱歌.flac","trackType":"flac"} Sep 09 09:46:26 volumio volumio[2284]: verbose: CURRENT POSITION 35 Sep 09 09:46:26 volumio volumio[2284]: info: CoreStateMachine::syncState stateService play Sep 09 09:46:26 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus play Sep 09 09:46:26 volumio volumio[2284]: info: Received an update from plugin. extracting info from payload Sep 09 09:46:26 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:26 volumio volumio[2284]: info: CorePlayQueue::getTrack 35 Sep 09 09:46:26 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:26 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:26 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:26 volumio volumio[2284]: info: CorePlayQueue::getTrack 35 Sep 09 09:46:26 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:26 volumio volumio[2284]: info: ------------------------------ 81ms Sep 09 09:46:27 volumio volumio[2284]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Sep 09 09:46:27 volumio volumio[2284]: info: Retrying Login Due to Network Error Sep 09 09:46:28 volumio volumio[2284]: info: CoreCommandRouter::volumioGetState Sep 09 09:46:28 volumio volumio[2284]: info: CorePlayQueue::getTrack 35 Sep 09 09:46:30 volumio volumio[2284]: info: CoreCommandRouter::volumioSeek Sep 09 09:46:30 volumio volumio[2284]: info: CoreStateMachine::seek Sep 09 09:46:30 volumio volumio[2284]: info: CorePlayQueue::getTrack 35 Sep 09 09:46:30 volumio volumio[2284]: info: TRACKBLOCK {"uri":"mnt/NAS/ds918/酷我音乐/龚玥-心想唱歌就唱歌.flac","service":"mpd","name":"心想唱歌就唱歌","artist":"龚玥","album":"金装龚玥情歌篇","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=572&web=%E9%BE%9A%E7%8E%A5/%E9%87%91%E8%A3%85%E9%BE%9A%E7%8E%A5%E6%83%85%E6%AD%8C%E7%AF%87/extralarge&path=%2FNAS%2Fds918%2F%E9%85%B7%E6%88%91%E9%9F%B3%E4%B9%90&metadata=false","duration":347,"trackType":"flac","samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2} Sep 09 09:46:30 volumio volumio[2284]: info: CoreStateMachine::startPlaybackTimer Sep 09 09:46:30 volumio volumio[2284]: info: CorePlayQueue::getTrack 35 Sep 09 09:46:30 volumio volumio[2284]: info: ControllerMpd::seek Sep 09 09:46:30 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:30 volumio volumio[2284]: info: CorePlayQueue::getTrack 35 Sep 09 09:46:30 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:30 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:30 volumio systemd[1]: Starting Cleanup of Temporary Directories... Sep 09 09:46:30 volumio systemd[1]: systemd-tmpfiles-clean.service: Succeeded. Sep 09 09:46:30 volumio systemd[1]: Started Cleanup of Temporary Directories. Sep 09 09:46:30 volumio volumio[2284]: error: null Sep 09 09:46:30 volumio volumio[2284]: info: Sep 09 09:46:30 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:30 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:30 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:30 volumio volumio[2284]: info: sendMpdCommand status took 3 milliseconds Sep 09 09:46:30 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:30 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:30 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 6 milliseconds Sep 09 09:46:30 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:30 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:30 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:30 volumio volumio[2284]: info: CorePlayQueue::getTrack 35 Sep 09 09:46:30 volumio volumio[2284]: verbose: STATE SERVICE {"status":"play","position":0,"seek":120000,"duration":347,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"367 Kbps","isStreaming":false,"title":"心想唱歌就唱歌","artist":"龚玥","album":"金装龚玥情歌篇","uri":"NAS/ds918/酷我音乐/龚玥-心想唱歌就唱歌.flac","trackType":"flac"} Sep 09 09:46:30 volumio volumio[2284]: verbose: CURRENT POSITION 35 Sep 09 09:46:30 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Sep 09 09:46:30 volumio volumio[2284]: info: CoreStateMachine::syncState stateService play Sep 09 09:46:30 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus play Sep 09 09:46:30 volumio volumio[2284]: info: Received an update from plugin. extracting info from payload Sep 09 09:46:30 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:30 volumio volumio[2284]: info: CorePlayQueue::getTrack 35 Sep 09 09:46:30 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:30 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:30 volumio volumio[2284]: info: CorePlayQueue::getTrack 35 Sep 09 09:46:30 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:30 volumio volumio[2284]: info: ------------------------------ 66ms Sep 09 09:46:36 volumio volumio[2284]: info: CoreCommandRouter::volumioNext Sep 09 09:46:36 volumio volumio[2284]: info: CoreStateMachine::next Sep 09 09:46:36 volumio volumio[2284]: info: CoreStateMachine::stop Sep 09 09:46:36 volumio volumio[2284]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 09:46:36 volumio volumio[2284]: info: CoreStateMachine::stPlaybackTimer Sep 09 09:46:36 volumio volumio[2284]: info: CoreStateMachine::updateTrackBlock Sep 09 09:46:36 volumio volumio[2284]: info: CorePlayQueue::getTrackBlock Sep 09 09:46:36 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:36 volumio volumio[2284]: info: CorePlayQueue::getTrack 35 Sep 09 09:46:36 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:36 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:36 volumio volumio[2284]: info: CoreStateMachine::serviceStop Sep 09 09:46:36 volumio volumio[2284]: info: CorePlayQueue::getTrack 35 Sep 09 09:46:36 volumio volumio[2284]: info: CoreCommandRouter::serviceStop Sep 09 09:46:36 volumio volumio[2284]: info: ControllerMpd::stop Sep 09 09:46:36 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 09:46:36 volumio volumio[2284]: info: sendMpdCommand stop took 37 milliseconds Sep 09 09:46:36 volumio volumio[2284]: info: CoreStateMachine::play index undefined Sep 09 09:46:36 volumio volumio[2284]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 09:46:36 volumio volumio[2284]: info: CorePlayQueue::getTrack 36 Sep 09 09:46:36 volumio volumio[2284]: info: Sep 09 09:46:36 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:36 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:36 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:36 volumio volumio[2284]: info: sendMpdCommand status took 2 milliseconds Sep 09 09:46:36 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Sep 09 09:46:36 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:36 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:36 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 09 09:46:36 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:36 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:36 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:36 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:36 volumio volumio[2284]: info: CorePlayQueue::getTrack 0 Sep 09 09:46:36 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:36 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:37 volumio volumio[2284]: info: CorePlayQueue::getTrack 0 Sep 09 09:46:37 volumio volumio[2284]: 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":"心想唱歌就唱歌","artist":"龚玥","album":"金装龚玥情歌篇","uri":"NAS/ds918/酷我音乐/龚玥-心想唱歌就唱歌.flac","trackType":"flac"} Sep 09 09:46:37 volumio volumio[2284]: verbose: CURRENT POSITION 0 Sep 09 09:46:37 volumio volumio[2284]: info: CoreStateMachine::syncState stateService stop Sep 09 09:46:37 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus stop Sep 09 09:46:37 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:37 volumio volumio[2284]: info: CorePlayQueue::getTrack 0 Sep 09 09:46:37 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:37 volumio volumio[2284]: info: No code Sep 09 09:46:37 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:37 volumio volumio[2284]: info: CorePlayQueue::getTrack 0 Sep 09 09:46:37 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:37 volumio volumio[2284]: info: ------------------------------ 78ms Sep 09 09:46:37 volumio volumio[2284]: info: MyVolumio login type: Token Sep 09 09:46:38 volumio volumio[2284]: info: CoreCommandRouter::volumioGetState Sep 09 09:46:38 volumio volumio[2284]: info: CorePlayQueue::getTrack 0 Sep 09 09:46:38 volumio volumio[2284]: info: Listing playlists Sep 09 09:46:38 volumio volumio[2284]: info: Listing playlists Sep 09 09:46:38 volumio volumio[2284]: info: CoreCommandRouter::volumioNext Sep 09 09:46:38 volumio volumio[2284]: info: CoreStateMachine::next Sep 09 09:46:38 volumio volumio[2284]: info: CoreStateMachine::stop Sep 09 09:46:38 volumio volumio[2284]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 09:46:38 volumio volumio[2284]: info: CoreStateMachine::play index undefined Sep 09 09:46:38 volumio volumio[2284]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 09:46:38 volumio volumio[2284]: info: CorePlayQueue::getTrack 1 Sep 09 09:46:38 volumio volumio[2284]: info: CoreStateMachine::startPlaybackTimer Sep 09 09:46:38 volumio volumio[2284]: info: CorePlayQueue::getTrack 1 Sep 09 09:46:38 volumio volumio[2284]: verbose: ControllerMpd::clearAddPlayTracks NAS/ds918/酷我音乐/Brothers-Album selecta mix.flac Sep 09 09:46:38 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 09:46:38 volumio volumio[2284]: info: CoreStateMachine::updateTrackBlock Sep 09 09:46:38 volumio volumio[2284]: info: CorePlayQueue::getTrackBlock Sep 09 09:46:38 volumio volumio[2284]: info: sendMpdCommand stop took 2 milliseconds Sep 09 09:46:38 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand clear Sep 09 09:46:38 volumio volumio[2284]: info: Sep 09 09:46:38 volumio volumio[2284]: ---------------------------- MPD announces system playlist update Sep 09 09:46:38 volumio volumio[2284]: info: Ignoring MPD Status Update Sep 09 09:46:38 volumio volumio[2284]: info: sendMpdCommand clear took 3 milliseconds Sep 09 09:46:38 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand add "NAS/ds918/酷我音乐/Brothers-Album selecta mix.flac" Sep 09 09:46:38 volumio volumio[2284]: error: updateQueue error: null Sep 09 09:46:38 volumio volumio[2284]: info: ------------------------------ 4ms Sep 09 09:46:38 volumio volumio[2284]: info: sendMpdCommand add "NAS/ds918/酷我音乐/Brothers-Album selecta mix.flac" took 3 milliseconds Sep 09 09:46:38 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand play Sep 09 09:46:38 volumio volumio[2284]: info: Sep 09 09:46:38 volumio volumio[2284]: ---------------------------- MPD announces system playlist update Sep 09 09:46:38 volumio volumio[2284]: info: Ignoring MPD Status Update Sep 09 09:46:38 volumio volumio[2284]: info: sendMpdCommand play took 4 milliseconds Sep 09 09:46:38 volumio volumio[2284]: info: ------------------------------ 4ms Sep 09 09:46:38 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Sep 09 09:46:38 volumio volumio[2284]: info: Sep 09 09:46:38 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:38 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:38 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:38 volumio volumio[2284]: info: Sep 09 09:46:38 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:38 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:38 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:38 volumio volumio[2284]: info: sendMpdCommand status took 9 milliseconds Sep 09 09:46:38 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:38 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:38 volumio volumio[2284]: info: sendMpdCommand status took 10 milliseconds Sep 09 09:46:38 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 09 09:46:38 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:38 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:38 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:38 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:38 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:38 volumio volumio[2284]: info: CorePlayQueue::getTrack 1 Sep 09 09:46:38 volumio volumio[2284]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":687,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"700 Kbps","isStreaming":false,"title":"Album selecta mix","artist":"Brothers","album":"Dieci Cento Mille","uri":"NAS/ds918/酷我音乐/Brothers-Album selecta mix.flac","trackType":"flac"} Sep 09 09:46:38 volumio volumio[2284]: verbose: CURRENT POSITION 1 Sep 09 09:46:38 volumio volumio[2284]: info: CoreStateMachine::syncState stateService play Sep 09 09:46:38 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus stop Sep 09 09:46:38 volumio volumio[2284]: info: ------------------------------ 37ms Sep 09 09:46:38 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 5 milliseconds Sep 09 09:46:38 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:38 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:38 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:38 volumio volumio[2284]: info: CorePlayQueue::getTrack 1 Sep 09 09:46:38 volumio volumio[2284]: verbose: STATE SERVICE {"status":"play","position":0,"seek":868,"duration":687,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"692 Kbps","isStreaming":false,"title":"Album selecta mix","artist":"Brothers","album":"Dieci Cento Mille","uri":"NAS/ds918/酷我音乐/Brothers-Album selecta mix.flac","trackType":"flac"} Sep 09 09:46:38 volumio volumio[2284]: verbose: CURRENT POSITION 1 Sep 09 09:46:38 volumio volumio[2284]: info: CoreStateMachine::syncState stateService play Sep 09 09:46:38 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus play Sep 09 09:46:38 volumio volumio[2284]: info: Received an update from plugin. extracting info from payload Sep 09 09:46:38 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:38 volumio volumio[2284]: info: CorePlayQueue::getTrack 1 Sep 09 09:46:38 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:38 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:38 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:38 volumio volumio[2284]: info: CorePlayQueue::getTrack 1 Sep 09 09:46:38 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:38 volumio volumio[2284]: info: ------------------------------ 115ms Sep 09 09:46:38 volumio volumio[2284]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Brothers/Dieci%20Cento%20Mille/5d03e947-07b4-477d-a7af-dbc8c704071e.png' Sep 09 09:46:41 volumio volumio[2284]: info: CoreCommandRouter::volumioNext Sep 09 09:46:41 volumio volumio[2284]: info: CoreStateMachine::next Sep 09 09:46:41 volumio volumio[2284]: info: CoreStateMachine::stop Sep 09 09:46:41 volumio volumio[2284]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 09:46:41 volumio volumio[2284]: info: CoreStateMachine::stPlaybackTimer Sep 09 09:46:41 volumio volumio[2284]: info: CoreStateMachine::updateTrackBlock Sep 09 09:46:41 volumio volumio[2284]: info: CorePlayQueue::getTrackBlock Sep 09 09:46:41 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:41 volumio volumio[2284]: info: CorePlayQueue::getTrack 1 Sep 09 09:46:41 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:41 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:41 volumio volumio[2284]: info: CoreStateMachine::serviceStop Sep 09 09:46:41 volumio volumio[2284]: info: CorePlayQueue::getTrack 1 Sep 09 09:46:41 volumio volumio[2284]: info: CoreCommandRouter::serviceStop Sep 09 09:46:41 volumio volumio[2284]: info: ControllerMpd::stop Sep 09 09:46:41 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 09:46:41 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Sep 09 09:46:41 volumio volumio[2284]: info: Sep 09 09:46:41 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:41 volumio volumio[2284]: info: sendMpdCommand stop took 70 milliseconds Sep 09 09:46:41 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:41 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:41 volumio volumio[2284]: info: CoreStateMachine::play index undefined Sep 09 09:46:41 volumio volumio[2284]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 09:46:41 volumio volumio[2284]: info: CorePlayQueue::getTrack 2 Sep 09 09:46:41 volumio volumio[2284]: info: CoreStateMachine::startPlaybackTimer Sep 09 09:46:41 volumio volumio[2284]: info: CorePlayQueue::getTrack 2 Sep 09 09:46:41 volumio volumio[2284]: verbose: ControllerMpd::clearAddPlayTracks NAS/ds918/酷我音乐/Brothers-Dance now.flac Sep 09 09:46:41 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 09:46:41 volumio volumio[2284]: info: CoreStateMachine::updateTrackBlock Sep 09 09:46:41 volumio volumio[2284]: info: CorePlayQueue::getTrackBlock Sep 09 09:46:41 volumio volumio[2284]: info: sendMpdCommand status took 6 milliseconds Sep 09 09:46:41 volumio volumio[2284]: info: sendMpdCommand stop took 3 milliseconds Sep 09 09:46:41 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:41 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:41 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand clear Sep 09 09:46:41 volumio volumio[2284]: info: Sep 09 09:46:41 volumio volumio[2284]: ---------------------------- MPD announces system playlist update Sep 09 09:46:41 volumio volumio[2284]: info: Ignoring MPD Status Update Sep 09 09:46:41 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 09 09:46:41 volumio volumio[2284]: info: sendMpdCommand clear took 3 milliseconds Sep 09 09:46:41 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:41 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand add "NAS/ds918/酷我音乐/Brothers-Dance now.flac" Sep 09 09:46:41 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:41 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:41 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:41 volumio volumio[2284]: info: CorePlayQueue::getTrack 2 Sep 09 09:46:41 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:41 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:41 volumio volumio[2284]: info: CorePlayQueue::getTrack 2 Sep 09 09:46:41 volumio volumio[2284]: 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":"Album selecta mix","artist":"Brothers","album":"Dieci Cento Mille","uri":"NAS/ds918/酷我音乐/Brothers-Album selecta mix.flac","trackType":"flac"} Sep 09 09:46:41 volumio volumio[2284]: verbose: CURRENT POSITION 2 Sep 09 09:46:41 volumio volumio[2284]: info: CoreStateMachine::syncState stateService stop Sep 09 09:46:41 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus stop Sep 09 09:46:41 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:41 volumio volumio[2284]: info: CorePlayQueue::getTrack 2 Sep 09 09:46:41 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:41 volumio volumio[2284]: info: No code Sep 09 09:46:41 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:41 volumio volumio[2284]: info: CorePlayQueue::getTrack 2 Sep 09 09:46:41 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:41 volumio volumio[2284]: info: ------------------------------ 95ms Sep 09 09:46:41 volumio volumio[2284]: error: updateQueue error: null Sep 09 09:46:41 volumio volumio[2284]: info: Sep 09 09:46:41 volumio volumio[2284]: ---------------------------- MPD announces system playlist update Sep 09 09:46:41 volumio volumio[2284]: info: Ignoring MPD Status Update Sep 09 09:46:41 volumio volumio[2284]: info: ------------------------------ 87ms Sep 09 09:46:41 volumio volumio[2284]: info: sendMpdCommand add "NAS/ds918/酷我音乐/Brothers-Dance now.flac" took 84 milliseconds Sep 09 09:46:41 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand play Sep 09 09:46:41 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Sep 09 09:46:41 volumio volumio[2284]: info: Sep 09 09:46:41 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:41 volumio volumio[2284]: info: ------------------------------ 38ms Sep 09 09:46:41 volumio volumio[2284]: info: sendMpdCommand play took 36 milliseconds Sep 09 09:46:41 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:41 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:41 volumio volumio[2284]: info: Sep 09 09:46:41 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:41 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:41 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:41 volumio volumio[2284]: info: sendMpdCommand status took 4 milliseconds Sep 09 09:46:41 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:41 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:41 volumio volumio[2284]: info: sendMpdCommand status took 5 milliseconds Sep 09 09:46:41 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 09 09:46:41 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:41 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:41 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:41 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:41 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:41 volumio volumio[2284]: info: CorePlayQueue::getTrack 2 Sep 09 09:46:41 volumio volumio[2284]: verbose: STATE SERVICE {"status":"play","position":0,"seek":868,"duration":234,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"939 Kbps","isStreaming":false,"title":"Dance now","artist":"Brothers","album":"Dieci Cento Mille","uri":"NAS/ds918/酷我音乐/Brothers-Dance now.flac","trackType":"flac"} Sep 09 09:46:41 volumio volumio[2284]: verbose: CURRENT POSITION 2 Sep 09 09:46:41 volumio volumio[2284]: info: CoreStateMachine::syncState stateService play Sep 09 09:46:41 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus stop Sep 09 09:46:41 volumio volumio[2284]: info: ------------------------------ 16ms Sep 09 09:46:41 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 9 milliseconds Sep 09 09:46:41 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:41 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:41 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:41 volumio volumio[2284]: info: CorePlayQueue::getTrack 2 Sep 09 09:46:41 volumio volumio[2284]: verbose: STATE SERVICE {"status":"play","position":0,"seek":868,"duration":234,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"791 Kbps","isStreaming":false,"title":"Dance now","artist":"Brothers","album":"Dieci Cento Mille","uri":"NAS/ds918/酷我音乐/Brothers-Dance now.flac","trackType":"flac"} Sep 09 09:46:41 volumio volumio[2284]: verbose: CURRENT POSITION 2 Sep 09 09:46:41 volumio volumio[2284]: info: CoreStateMachine::syncState stateService play Sep 09 09:46:41 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus play Sep 09 09:46:41 volumio volumio[2284]: info: Received an update from plugin. extracting info from payload Sep 09 09:46:41 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:41 volumio volumio[2284]: info: CorePlayQueue::getTrack 2 Sep 09 09:46:41 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:41 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:41 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:41 volumio volumio[2284]: info: CorePlayQueue::getTrack 2 Sep 09 09:46:41 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:41 volumio volumio[2284]: info: ------------------------------ 72ms Sep 09 09:46:48 volumio volumio[2284]: info: CoreCommandRouter::volumioPause Sep 09 09:46:48 volumio volumio[2284]: info: CoreStateMachine::pause Sep 09 09:46:48 volumio volumio[2284]: info: CoreStateMachine::stPlaybackTimer Sep 09 09:46:48 volumio volumio[2284]: info: CoreStateMachine::servicePause Sep 09 09:46:48 volumio volumio[2284]: info: CorePlayQueue::getTrack 2 Sep 09 09:46:48 volumio volumio[2284]: info: CoreCommandRouter::servicePause Sep 09 09:46:48 volumio volumio[2284]: info: ControllerMpd::pause Sep 09 09:46:48 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand pause Sep 09 09:46:48 volumio volumio[2284]: info: CoreCommandRouter::volumioGetState Sep 09 09:46:48 volumio volumio[2284]: info: CorePlayQueue::getTrack 2 Sep 09 09:46:48 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Sep 09 09:46:49 volumio volumio[2284]: info: Sep 09 09:46:49 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:49 volumio volumio[2284]: info: sendMpdCommand pause took 95 milliseconds Sep 09 09:46:49 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:49 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:49 volumio volumio[2284]: info: sendMpdCommand status took 33 milliseconds Sep 09 09:46:49 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:49 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:49 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 49 milliseconds Sep 09 09:46:49 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:49 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:49 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:49 volumio volumio[2284]: info: CorePlayQueue::getTrack 2 Sep 09 09:46:49 volumio volumio[2284]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":8274,"duration":234,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"948 Kbps","isStreaming":false,"title":"Dance now","artist":"Brothers","album":"Dieci Cento Mille","uri":"NAS/ds918/酷我音乐/Brothers-Dance now.flac","trackType":"flac"} Sep 09 09:46:49 volumio volumio[2284]: verbose: CURRENT POSITION 2 Sep 09 09:46:49 volumio volumio[2284]: info: CoreStateMachine::syncState stateService pause Sep 09 09:46:49 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus pause Sep 09 09:46:49 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:49 volumio volumio[2284]: info: CorePlayQueue::getTrack 2 Sep 09 09:46:49 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:49 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:49 volumio volumio[2284]: info: CoreStateMachine::stPlaybackTimer Sep 09 09:46:49 volumio volumio[2284]: info: ------------------------------ 121ms Sep 09 09:46:51 volumio volumio[2284]: info: CoreCommandRouter::volumioPlay Sep 09 09:46:51 volumio volumio[2284]: info: CoreStateMachine::play index undefined Sep 09 09:46:51 volumio volumio[2284]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 09:46:51 volumio volumio[2284]: info: CorePlayQueue::getTrack 2 Sep 09 09:46:51 volumio volumio[2284]: info: CoreStateMachine::startPlaybackTimer Sep 09 09:46:51 volumio volumio[2284]: info: CorePlayQueue::getTrack 2 Sep 09 09:46:51 volumio volumio[2284]: info: ControllerMpd::resume Sep 09 09:46:51 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand play Sep 09 09:46:51 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Sep 09 09:46:51 volumio volumio[2284]: info: Sep 09 09:46:51 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:51 volumio volumio[2284]: info: sendMpdCommand play took 46 milliseconds Sep 09 09:46:51 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:51 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:51 volumio volumio[2284]: info: sendMpdCommand status took 97 milliseconds Sep 09 09:46:51 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:51 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:51 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 8 milliseconds Sep 09 09:46:51 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:51 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:51 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:51 volumio volumio[2284]: info: CorePlayQueue::getTrack 2 Sep 09 09:46:51 volumio volumio[2284]: verbose: STATE SERVICE {"status":"play","position":0,"seek":9165,"duration":234,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"836 Kbps","isStreaming":false,"title":"Dance now","artist":"Brothers","album":"Dieci Cento Mille","uri":"NAS/ds918/酷我音乐/Brothers-Dance now.flac","trackType":"flac"} Sep 09 09:46:51 volumio volumio[2284]: verbose: CURRENT POSITION 2 Sep 09 09:46:51 volumio volumio[2284]: info: CoreStateMachine::syncState stateService play Sep 09 09:46:51 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus pause Sep 09 09:46:51 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:51 volumio volumio[2284]: info: CorePlayQueue::getTrack 2 Sep 09 09:46:51 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:51 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:51 volumio volumio[2284]: info: ------------------------------ 151ms Sep 09 09:46:58 volumio volumio[2284]: info: CoreCommandRouter::volumioGetState Sep 09 09:46:58 volumio volumio[2284]: info: CorePlayQueue::getTrack 2 Sep 09 09:46:58 volumio volumio[2284]: info: Listing playlists Sep 09 09:46:58 volumio volumio[2284]: info: Listing playlists Sep 09 09:46:59 volumio volumio[2284]: info: Preload queue cleared Sep 09 09:46:59 volumio volumio[2284]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 09 09:46:59 volumio volumio[2284]: info: CoreStateMachine::ClearQueue Sep 09 09:46:59 volumio volumio[2284]: info: CoreStateMachine::stop Sep 09 09:46:59 volumio volumio[2284]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 09:46:59 volumio volumio[2284]: info: CoreStateMachine::stPlaybackTimer Sep 09 09:46:59 volumio volumio[2284]: info: CoreStateMachine::updateTrackBlock Sep 09 09:46:59 volumio volumio[2284]: info: CorePlayQueue::getTrackBlock Sep 09 09:46:59 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:59 volumio volumio[2284]: info: CorePlayQueue::getTrack 2 Sep 09 09:46:59 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:59 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:59 volumio volumio[2284]: info: CoreStateMachine::serviceStop Sep 09 09:46:59 volumio volumio[2284]: info: CorePlayQueue::getTrack 2 Sep 09 09:46:59 volumio volumio[2284]: info: CoreCommandRouter::serviceStop Sep 09 09:46:59 volumio volumio[2284]: info: ControllerMpd::stop Sep 09 09:46:59 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 09:46:59 volumio volumio[2284]: info: CorePlayQueue::clearPlayQueue Sep 09 09:46:59 volumio volumio[2284]: info: CorePlayQueue::saveQueue Sep 09 09:46:59 volumio volumio[2284]: info: CoreCommandRouter::volumioPushQueue Sep 09 09:46:59 volumio volumio[2284]: info: CoreStateMachine::addQueueItems Sep 09 09:46:59 volumio volumio[2284]: info: CorePlayQueue::addQueueItems Sep 09 09:46:59 volumio volumio[2284]: info: Preload queue cleared Sep 09 09:46:59 volumio volumio[2284]: info: Adding Item to queue: music-library/NAS/ds918/陈慧娴《经典重逢DSD[银合金CD]》立体声WAV整轨+CUE Sep 09 09:46:59 volumio volumio[2284]: info: Exploding uri music-library/NAS/ds918/陈慧娴《经典重逢DSD[银合金CD]》立体声WAV整轨+CUE in service mpd Sep 09 09:46:59 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Sep 09 09:46:59 volumio volumio[2284]: info: Sep 09 09:46:59 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:59 volumio volumio[2284]: info: sendMpdCommand stop took 84 milliseconds Sep 09 09:46:59 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:59 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:59 volumio volumio[2284]: info: ALBUMART /albumart?cacheid=572&web=%3F%3F%3F/%3F%3F%3F%3FDSD%5B%3F%3F%3FCD%5D/extralarge&path=%2Fmnt%2FNAS%2Fds918%2F%E9%99%88%E6%85%A7%E5%A8%B4%E3%80%8A%E7%BB%8F%E5%85%B8%E9%87%8D%E9%80%A2DSD%5B%E9%93%B6%E5%90%88%E9%87%91CD%5D%E3%80%8B%E7%AB%8B%E4%BD%93%E5%A3%B0WAV%E6%95%B4%E8%BD%A8%2BCUE%2F%E4%B8%8E%E6%B3%AA%E6%8B%A5%E6%8A%B1.wav&metadata=false Sep 09 09:46:59 volumio volumio[2284]: info: URI /mnt/NAS/ds918/陈慧娴《经典重逢DSD[银合金CD]》立体声WAV整轨+CUE/与泪拥抱.wav Sep 09 09:46:59 volumio volumio[2284]: info: ALBUMART /albumart?cacheid=572&web=%3F%3F%3F/%3F%3F%3F%3FDSD%5B%3F%3F%3FCD%5D/extralarge&path=%2Fmnt%2FNAS%2Fds918%2F%E9%99%88%E6%85%A7%E5%A8%B4%E3%80%8A%E7%BB%8F%E5%85%B8%E9%87%8D%E9%80%A2DSD%5B%E9%93%B6%E5%90%88%E9%87%91CD%5D%E3%80%8B%E7%AB%8B%E4%BD%93%E5%A3%B0WAV%E6%95%B4%E8%BD%A8%2BCUE%2F%E4%BA%BA%E7%94%9F%E4%BD%95%E5%A4%84%E4%B8%8D%E7%9B%B8%E9%80%A2.wav&metadata=false Sep 09 09:46:59 volumio volumio[2284]: info: URI /mnt/NAS/ds918/陈慧娴《经典重逢DSD[银合金CD]》立体声WAV整轨+CUE/人生何处不相逢.wav Sep 09 09:46:59 volumio volumio[2284]: info: ALBUMART /albumart?cacheid=572&web=%3F%3F%3F/%3F%3F%3F%3FDSD%5B%3F%3F%3FCD%5D/extralarge&path=%2Fmnt%2FNAS%2Fds918%2F%E9%99%88%E6%85%A7%E5%A8%B4%E3%80%8A%E7%BB%8F%E5%85%B8%E9%87%8D%E9%80%A2DSD%5B%E9%93%B6%E5%90%88%E9%87%91CD%5D%E3%80%8B%E7%AB%8B%E4%BD%93%E5%A3%B0WAV%E6%95%B4%E8%BD%A8%2BCUE%2F%E4%BB%8A%E5%A4%A9%E5%A4%9C%E9%87%8C%E4%B8%8D%E4%B8%8B%E9%9B%A8.wav&metadata=false Sep 09 09:46:59 volumio volumio[2284]: info: URI /mnt/NAS/ds918/陈慧娴《经典重逢DSD[银合金CD]》立体声WAV整轨+CUE/今天夜里不下雨.wav Sep 09 09:46:59 volumio volumio[2284]: info: ALBUMART /albumart?cacheid=572&web=%3F%3F%3F/%3F%3F%3F%3FDSD%5B%3F%3F%3FCD%5D/extralarge&path=%2Fmnt%2FNAS%2Fds918%2F%E9%99%88%E6%85%A7%E5%A8%B4%E3%80%8A%E7%BB%8F%E5%85%B8%E9%87%8D%E9%80%A2DSD%5B%E9%93%B6%E5%90%88%E9%87%91CD%5D%E3%80%8B%E7%AB%8B%E4%BD%93%E5%A3%B0WAV%E6%95%B4%E8%BD%A8%2BCUE%2F%E5%82%BB%E5%A5%B3.wav&metadata=false Sep 09 09:46:59 volumio volumio[2284]: info: URI /mnt/NAS/ds918/陈慧娴《经典重逢DSD[银合金CD]》立体声WAV整轨+CUE/傻女.wav Sep 09 09:46:59 volumio volumio[2284]: info: ALBUMART /albumart?cacheid=572&web=%3F%3F%3F/%3F%3F%3F%3FDSD%5B%3F%3F%3FCD%5D/extralarge&path=%2Fmnt%2FNAS%2Fds918%2F%E9%99%88%E6%85%A7%E5%A8%B4%E3%80%8A%E7%BB%8F%E5%85%B8%E9%87%8D%E9%80%A2DSD%5B%E9%93%B6%E5%90%88%E9%87%91CD%5D%E3%80%8B%E7%AB%8B%E4%BD%93%E5%A3%B0WAV%E6%95%B4%E8%BD%A8%2BCUE%2F%E5%8D%83%E5%8D%83%E9%98%99%E6%AD%8C.wav&metadata=false Sep 09 09:46:59 volumio volumio[2284]: info: URI /mnt/NAS/ds918/陈慧娴《经典重逢DSD[银合金CD]》立体声WAV整轨+CUE/千千阙歌.wav Sep 09 09:46:59 volumio volumio[2284]: info: ALBUMART /albumart?cacheid=572&web=%3F%3F%3F/%3F%3F%3F%3FDSD%5B%3F%3F%3FCD%5D/extralarge&path=%2Fmnt%2FNAS%2Fds918%2F%E9%99%88%E6%85%A7%E5%A8%B4%E3%80%8A%E7%BB%8F%E5%85%B8%E9%87%8D%E9%80%A2DSD%5B%E9%93%B6%E5%90%88%E9%87%91CD%5D%E3%80%8B%E7%AB%8B%E4%BD%93%E5%A3%B0WAV%E6%95%B4%E8%BD%A8%2BCUE%2F%E5%AD%A4%E5%8D%95%E8%83%8C%E5%BD%B1.wav&metadata=false Sep 09 09:46:59 volumio volumio[2284]: info: URI /mnt/NAS/ds918/陈慧娴《经典重逢DSD[银合金CD]》立体声WAV整轨+CUE/孤单背影.wav Sep 09 09:46:59 volumio volumio[2284]: info: ALBUMART /albumart?cacheid=572&web=%3F%3F%3F/%3F%3F%3F%3FDSD%5B%3F%3F%3FCD%5D/extralarge&path=%2Fmnt%2FNAS%2Fds918%2F%E9%99%88%E6%85%A7%E5%A8%B4%E3%80%8A%E7%BB%8F%E5%85%B8%E9%87%8D%E9%80%A2DSD%5B%E9%93%B6%E5%90%88%E9%87%91CD%5D%E3%80%8B%E7%AB%8B%E4%BD%93%E5%A3%B0WAV%E6%95%B4%E8%BD%A8%2BCUE%2F%E5%BD%92%E6%9D%A5%E5%90%A7.wav&metadata=false Sep 09 09:46:59 volumio volumio[2284]: info: URI /mnt/NAS/ds918/陈慧娴《经典重逢DSD[银合金CD]》立体声WAV整轨+CUE/归来吧.wav Sep 09 09:46:59 volumio volumio[2284]: info: ALBUMART /albumart?cacheid=572&web=%3F%3F%3F/%3F%3F%3F%3FDSD%5B%3F%3F%3FCD%5D/extralarge&path=%2Fmnt%2FNAS%2Fds918%2F%E9%99%88%E6%85%A7%E5%A8%B4%E3%80%8A%E7%BB%8F%E5%85%B8%E9%87%8D%E9%80%A2DSD%5B%E9%93%B6%E5%90%88%E9%87%91CD%5D%E3%80%8B%E7%AB%8B%E4%BD%93%E5%A3%B0WAV%E6%95%B4%E8%BD%A8%2BCUE%2F%E6%88%91%E5%AF%82%E5%AF%9E.wav&metadata=false Sep 09 09:46:59 volumio volumio[2284]: info: URI /mnt/NAS/ds918/陈慧娴《经典重逢DSD[银合金CD]》立体声WAV整轨+CUE/我寂寞.wav Sep 09 09:46:59 volumio volumio[2284]: info: ALBUMART /albumart?cacheid=572&web=%3F%3F%3F/%3F%3F%3F%3FDSD%5B%3F%3F%3FCD%5D/extralarge&path=%2Fmnt%2FNAS%2Fds918%2F%E9%99%88%E6%85%A7%E5%A8%B4%E3%80%8A%E7%BB%8F%E5%85%B8%E9%87%8D%E9%80%A2DSD%5B%E9%93%B6%E5%90%88%E9%87%91CD%5D%E3%80%8B%E7%AB%8B%E4%BD%93%E5%A3%B0WAV%E6%95%B4%E8%BD%A8%2BCUE%2F%E6%9C%88%E4%BA%AE.wav&metadata=false Sep 09 09:46:59 volumio volumio[2284]: info: URI /mnt/NAS/ds918/陈慧娴《经典重逢DSD[银合金CD]》立体声WAV整轨+CUE/月亮.wav Sep 09 09:46:59 volumio volumio[2284]: info: ALBUMART /albumart?cacheid=572&web=%3F%3F%3F/%3F%3F%3F%3FDSD%5B%3F%3F%3FCD%5D/extralarge&path=%2Fmnt%2FNAS%2Fds918%2F%E9%99%88%E6%85%A7%E5%A8%B4%E3%80%8A%E7%BB%8F%E5%85%B8%E9%87%8D%E9%80%A2DSD%5B%E9%93%B6%E5%90%88%E9%87%91CD%5D%E3%80%8B%E7%AB%8B%E4%BD%93%E5%A3%B0WAV%E6%95%B4%E8%BD%A8%2BCUE%2F%E7%8E%BB%E7%92%83%E7%AA%97%E7%9A%84%E7%88%B1.wav&metadata=false Sep 09 09:46:59 volumio volumio[2284]: info: URI /mnt/NAS/ds918/陈慧娴《经典重逢DSD[银合金CD]》立体声WAV整轨+CUE/玻璃窗的爱.wav Sep 09 09:46:59 volumio volumio[2284]: info: ALBUMART /albumart?cacheid=572&web=%3F%3F%3F/%3F%3F%3F%3FDSD%5B%3F%3F%3FCD%5D/extralarge&path=%2Fmnt%2FNAS%2Fds918%2F%E9%99%88%E6%85%A7%E5%A8%B4%E3%80%8A%E7%BB%8F%E5%85%B8%E9%87%8D%E9%80%A2DSD%5B%E9%93%B6%E5%90%88%E9%87%91CD%5D%E3%80%8B%E7%AB%8B%E4%BD%93%E5%A3%B0WAV%E6%95%B4%E8%BD%A8%2BCUE%2F%E7%97%B4%E6%83%85%E6%84%8F%E5%A4%96.wav&metadata=false Sep 09 09:46:59 volumio volumio[2284]: info: URI /mnt/NAS/ds918/陈慧娴《经典重逢DSD[银合金CD]》立体声WAV整轨+CUE/痴情意外.wav Sep 09 09:46:59 volumio volumio[2284]: info: ALBUMART /albumart?cacheid=572&web=%3F%3F%3F/%3F%3F%3F%3FDSD%5B%3F%3F%3FCD%5D/extralarge&path=%2Fmnt%2FNAS%2Fds918%2F%E9%99%88%E6%85%A7%E5%A8%B4%E3%80%8A%E7%BB%8F%E5%85%B8%E9%87%8D%E9%80%A2DSD%5B%E9%93%B6%E5%90%88%E9%87%91CD%5D%E3%80%8B%E7%AB%8B%E4%BD%93%E5%A3%B0WAV%E6%95%B4%E8%BD%A8%2BCUE%2F%E7%BA%A2%E8%8C%B6%E9%A6%86.wav&metadata=false Sep 09 09:46:59 volumio volumio[2284]: info: URI /mnt/NAS/ds918/陈慧娴《经典重逢DSD[银合金CD]》立体声WAV整轨+CUE/红茶馆.wav Sep 09 09:46:59 volumio volumio[2284]: info: ALBUMART /albumart?cacheid=572&web=%3F%3F%3F/%3F%3F%3F%3FDSD%5B%3F%3F%3FCD%5D/extralarge&path=%2Fmnt%2FNAS%2Fds918%2F%E9%99%88%E6%85%A7%E5%A8%B4%E3%80%8A%E7%BB%8F%E5%85%B8%E9%87%8D%E9%80%A2DSD%5B%E9%93%B6%E5%90%88%E9%87%91CD%5D%E3%80%8B%E7%AB%8B%E4%BD%93%E5%A3%B0WAV%E6%95%B4%E8%BD%A8%2BCUE%2F%E9%80%9D%E5%8E%BB%E7%9A%84%E8%AF%BA%E8%A8%80.wav&metadata=false Sep 09 09:46:59 volumio volumio[2284]: info: URI /mnt/NAS/ds918/陈慧娴《经典重逢DSD[银合金CD]》立体声WAV整轨+CUE/逝去的诺言.wav Sep 09 09:46:59 volumio volumio[2284]: info: ALBUMART /albumart?cacheid=572&web=%3F%3F%3F/%3F%3F%3F%3FDSD%5B%3F%3F%3FCD%5D/extralarge&path=%2Fmnt%2FNAS%2Fds918%2F%E9%99%88%E6%85%A7%E5%A8%B4%E3%80%8A%E7%BB%8F%E5%85%B8%E9%87%8D%E9%80%A2DSD%5B%E9%93%B6%E5%90%88%E9%87%91CD%5D%E3%80%8B%E7%AB%8B%E4%BD%93%E5%A3%B0WAV%E6%95%B4%E8%BD%A8%2BCUE%2F%E9%A3%98%E9%9B%AA.wav&metadata=false Sep 09 09:46:59 volumio volumio[2284]: info: URI /mnt/NAS/ds918/陈慧娴《经典重逢DSD[银合金CD]》立体声WAV整轨+CUE/飘雪.wav Sep 09 09:46:59 volumio volumio[2284]: info: CoreCommandRouter::volumioPushQueue Sep 09 09:46:59 volumio volumio[2284]: info: CorePlayQueue::saveQueue Sep 09 09:46:59 volumio volumio[2284]: info: CoreStateMachine::updateTrackBlock Sep 09 09:46:59 volumio volumio[2284]: info: CorePlayQueue::getTrackBlock Sep 09 09:46:59 volumio volumio[2284]: info: CoreCommandRouter::volumioPlay Sep 09 09:46:59 volumio volumio[2284]: info: CoreStateMachine::play index 0 Sep 09 09:46:59 volumio volumio[2284]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 09:46:59 volumio volumio[2284]: info: CoreStateMachine::stop Sep 09 09:46:59 volumio volumio[2284]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 09:46:59 volumio volumio[2284]: info: CoreStateMachine::play index undefined Sep 09 09:46:59 volumio volumio[2284]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 09:46:59 volumio volumio[2284]: info: CorePlayQueue::getTrack 0 Sep 09 09:46:59 volumio volumio[2284]: info: CoreStateMachine::startPlaybackTimer Sep 09 09:46:59 volumio volumio[2284]: info: CorePlayQueue::getTrack 0 Sep 09 09:46:59 volumio volumio[2284]: verbose: ControllerMpd::clearAddPlayTracks NAS/ds918/陈慧娴《经典重逢DSD[银合金CD]》立体声WAV整轨+CUE/与泪拥抱.wav Sep 09 09:46:59 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 09:46:59 volumio volumio[2284]: info: sendMpdCommand status took 87 milliseconds Sep 09 09:46:59 volumio volumio[2284]: info: sendMpdCommand stop took 2 milliseconds Sep 09 09:46:59 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:59 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:59 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand clear Sep 09 09:46:59 volumio volumio[2284]: info: Sep 09 09:46:59 volumio volumio[2284]: ---------------------------- MPD announces system playlist update Sep 09 09:46:59 volumio volumio[2284]: info: Ignoring MPD Status Update Sep 09 09:46:59 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 7 milliseconds Sep 09 09:46:59 volumio volumio[2284]: info: sendMpdCommand clear took 6 milliseconds Sep 09 09:46:59 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:59 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand add "NAS/ds918/陈慧娴《经典重逢DSD[银合金CD]》立体声WAV整轨+CUE/与泪拥抱.wav" Sep 09 09:46:59 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:59 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:59 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:59 volumio volumio[2284]: info: CorePlayQueue::getTrack 0 Sep 09 09:46:59 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:46:59 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:59 volumio volumio[2284]: info: CorePlayQueue::getTrack 0 Sep 09 09:46:59 volumio volumio[2284]: 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":"Dance now","artist":"Brothers","album":"Dieci Cento Mille","uri":"NAS/ds918/酷我音乐/Brothers-Dance now.flac","trackType":"flac"} Sep 09 09:46:59 volumio volumio[2284]: verbose: CURRENT POSITION 0 Sep 09 09:46:59 volumio volumio[2284]: info: CoreStateMachine::syncState stateService stop Sep 09 09:46:59 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus stop Sep 09 09:46:59 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:59 volumio volumio[2284]: info: CorePlayQueue::getTrack 0 Sep 09 09:46:59 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:59 volumio volumio[2284]: info: No code Sep 09 09:46:59 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:46:59 volumio volumio[2284]: info: CorePlayQueue::getTrack 0 Sep 09 09:46:59 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:46:59 volumio volumio[2284]: info: ------------------------------ 153ms Sep 09 09:46:59 volumio volumio[2284]: error: updateQueue error: null Sep 09 09:46:59 volumio volumio[2284]: info: Sep 09 09:46:59 volumio volumio[2284]: ---------------------------- MPD announces system playlist update Sep 09 09:46:59 volumio volumio[2284]: info: Ignoring MPD Status Update Sep 09 09:46:59 volumio volumio[2284]: info: ------------------------------ 89ms Sep 09 09:46:59 volumio volumio[2284]: info: sendMpdCommand add "NAS/ds918/陈慧娴《经典重逢DSD[银合金CD]》立体声WAV整轨+CUE/与泪拥抱.wav" took 86 milliseconds Sep 09 09:46:59 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand play Sep 09 09:46:59 volumio volumio[2284]: info: ------------------------------ 44ms Sep 09 09:46:59 volumio volumio[2284]: info: sendMpdCommand play took 42 milliseconds Sep 09 09:46:59 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048: -121 Sep 09 09:46:59 volumio volumio[2284]: info: Sep 09 09:46:59 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:59 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:59 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:59 volumio volumio[2284]: info: Sep 09 09:46:59 volumio volumio[2284]: ---------------------------- MPD announces state update: player Sep 09 09:46:59 volumio volumio[2284]: info: ControllerMpd::getState Sep 09 09:46:59 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand status Sep 09 09:46:59 volumio volumio[2284]: info: sendMpdCommand status took 3 milliseconds Sep 09 09:46:59 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:59 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:59 volumio volumio[2284]: info: sendMpdCommand status took 7 milliseconds Sep 09 09:46:59 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 5 milliseconds Sep 09 09:46:59 volumio volumio[2284]: verbose: ControllerMpd::parseState Sep 09 09:46:59 volumio volumio[2284]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 09:46:59 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:46:59 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:46:59 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:46:59 volumio volumio[2284]: info: CorePlayQueue::getTrack 0 Sep 09 09:46:59 volumio volumio[2284]: verbose: STATE SERVICE {"status":"play","position":0,"seek":868,"duration":273,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????","artist":"???","album":"????DSD[???CD]","uri":"NAS/ds918/陈慧娴《经典重逢DSD[银合金CD]》立体声WAV整轨+CUE/与泪拥抱.wav","trackType":"wav"} Sep 09 09:46:59 volumio volumio[2284]: verbose: CURRENT POSITION 0 Sep 09 09:46:59 volumio volumio[2284]: info: CoreStateMachine::syncState stateService play Sep 09 09:46:59 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus stop Sep 09 09:46:59 volumio volumio[2284]: info: ------------------------------ 16ms Sep 09 09:47:00 volumio volumio[2284]: info: sendMpdCommand playlistinfo took 19 milliseconds Sep 09 09:47:00 volumio volumio[2284]: verbose: ControllerMpd::parseTrackInfo Sep 09 09:47:00 volumio volumio[2284]: info: ControllerMpd::pushState Sep 09 09:47:00 volumio volumio[2284]: info: CoreCommandRouter::servicePushState Sep 09 09:47:00 volumio volumio[2284]: info: CorePlayQueue::getTrack 0 Sep 09 09:47:00 volumio volumio[2284]: verbose: STATE SERVICE {"status":"play","position":0,"seek":868,"duration":273,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"????","artist":"???","album":"????DSD[???CD]","uri":"NAS/ds918/陈慧娴《经典重逢DSD[银合金CD]》立体声WAV整轨+CUE/与泪拥抱.wav","trackType":"wav"} Sep 09 09:47:00 volumio volumio[2284]: verbose: CURRENT POSITION 0 Sep 09 09:47:00 volumio volumio[2284]: info: CoreStateMachine::syncState stateService play Sep 09 09:47:00 volumio volumio[2284]: info: CoreStateMachine::syncState currentStatus play Sep 09 09:47:00 volumio volumio[2284]: info: Received an update from plugin. extracting info from payload Sep 09 09:47:00 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:47:00 volumio volumio[2284]: info: CorePlayQueue::getTrack 0 Sep 09 09:47:00 volumio volumio[2284]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 09:47:00 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:47:00 volumio volumio[2284]: info: CoreStateMachine::pushState Sep 09 09:47:00 volumio volumio[2284]: info: CorePlayQueue::getTrack 0 Sep 09 09:47:00 volumio volumio[2284]: info: CoreCommandRouter::volumioPushState Sep 09 09:47:00 volumio volumio[2284]: info: ------------------------------ 99ms Sep 09 09:47:07 volumio volumio[2284]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Sep 09 09:47:07 volumio volumio[2284]: info: Retrying Login Due to Network Error Sep 09 09:47:08 volumio volumio[2284]: info: CoreCommandRouter::volumioGetState Sep 09 09:47:08 volumio volumio[2284]: info: CorePlayQueue::getTrack 0 Sep 09 09:47:17 volumio volumio[2284]: info: MyVolumio login type: Token Sep 09 09:47:18 volumio volumio[2284]: info: CoreCommandRouter::volumioGetState Sep 09 09:47:18 volumio volumio[2284]: info: CorePlayQueue::getTrack 0 Sep 09 09:47:18 volumio volumio[2284]: info: Listing playlists Sep 09 09:47:18 volumio volumio[2284]: info: Listing playlists Sep 09 09:47:20 volumio volumio[2284]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 09 09:47:20 volumio volumio[2284]: Error: connect ETIMEDOUT 173.252.88.67:80 Sep 09 09:47:20 volumio volumio[2284]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Sep 09 09:47:20 volumio volumio[2284]: errno: -110, Sep 09 09:47:20 volumio volumio[2284]: code: 'ETIMEDOUT', Sep 09 09:47:20 volumio volumio[2284]: syscall: 'connect', Sep 09 09:47:20 volumio volumio[2284]: address: '173.252.88.67', Sep 09 09:47:20 volumio volumio[2284]: port: 80 Sep 09 09:47:20 volumio volumio[2284]: } Sep 09 09:47:20 volumio volumio[2284]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 09 09:47:21 volumio sudo[2501]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-09 09:46 Sep 09 09:47:21 volumio sudo[2501]: 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="c87c6e2b1ae33dc5801986cbcbe970898b92e7b4" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="b949d6001d7e656b4668f31c119d2247cdf45158" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 30 Mar 2023 05:45:03 PM CEST" VOLUMIO_VERSION="3.449" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="6428d8e2c06e98483f5c5d77e8f01989"