-- Logs begin at Thu 2020-09-24 20:42:43 UTC, end at Sun 2024-05-12 10:17:29 UTC. -- May 12 10:16:00 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 12 10:16:00 volumio volumio[1214]: info: CURURI: music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲 May 12 10:16:02 volumio volumio[1214]: info: CoreCommandRouter::volumioReplaceandPlayItems May 12 10:16:02 volumio volumio[1214]: info: CoreStateMachine::ClearQueue May 12 10:16:02 volumio volumio[1214]: info: CoreStateMachine::stop May 12 10:16:02 volumio volumio[1214]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 10:16:02 volumio volumio[1214]: UNSET VOLATILE May 12 10:16:02 volumio volumio[1214]: info: CorePlayQueue::clearPlayQueue May 12 10:16:02 volumio volumio[1214]: info: CorePlayQueue::saveQueue May 12 10:16:02 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 12 10:16:02 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:16:02 volumio volumio[1214]: info: CoreCommandRouter::volumioPushQueue May 12 10:16:02 volumio volumio[1214]: info: CoreStateMachine::addQueueItems May 12 10:16:02 volumio volumio[1214]: info: CorePlayQueue::addQueueItems May 12 10:16:02 volumio volumio[1214]: info: Adding Item to queue: music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 暗涌.flac May 12 10:16:02 volumio volumio[1214]: info: Exploding uri music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 暗涌.flac in service mpd May 12 10:16:02 volumio volumio[1214]: info: Adding Item to queue: music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 你在终点等我.flac May 12 10:16:02 volumio volumio[1214]: info: Exploding uri music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 你在终点等我.flac in service mpd May 12 10:16:02 volumio volumio[1214]: info: Adding Item to queue: music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 如愿.flac May 12 10:16:02 volumio volumio[1214]: info: Exploding uri music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 如愿.flac in service mpd May 12 10:16:02 volumio volumio[1214]: info: Adding Item to queue: music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 容易受伤的女人（粤语）.flac May 12 10:16:02 volumio volumio[1214]: info: Exploding uri music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 容易受伤的女人（粤语）.flac in service mpd May 12 10:16:02 volumio volumio[1214]: info: Adding Item to queue: music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 岁月.flac May 12 10:16:02 volumio volumio[1214]: info: Exploding uri music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 岁月.flac in service mpd May 12 10:16:02 volumio volumio[1214]: info: Adding Item to queue: music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 我也不想这样.flac May 12 10:16:02 volumio volumio[1214]: info: Exploding uri music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 我也不想这样.flac in service mpd May 12 10:16:02 volumio volumio[1214]: info: Adding Item to queue: music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 我愿意.flac May 12 10:16:02 volumio volumio[1214]: info: Exploding uri music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 我愿意.flac in service mpd May 12 10:16:02 volumio volumio[1214]: info: Adding Item to queue: music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 清风徐来.flac May 12 10:16:02 volumio volumio[1214]: info: Exploding uri music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 清风徐来.flac in service mpd May 12 10:16:02 volumio volumio[1214]: info: Adding Item to queue: music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 百年孤寂.flac May 12 10:16:02 volumio volumio[1214]: info: Exploding uri music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 百年孤寂.flac in service mpd May 12 10:16:02 volumio volumio[1214]: info: Adding Item to queue: music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 矜持.flac May 12 10:16:02 volumio volumio[1214]: info: Exploding uri music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 矜持.flac in service mpd May 12 10:16:02 volumio volumio[1214]: info: Adding Item to queue: music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 笑忘书.flac May 12 10:16:02 volumio volumio[1214]: info: Exploding uri music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 笑忘书.flac in service mpd May 12 10:16:02 volumio volumio[1214]: info: Adding Item to queue: music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 致青春.flac May 12 10:16:02 volumio volumio[1214]: info: Exploding uri music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 致青春.flac in service mpd May 12 10:16:02 volumio volumio[1214]: info: Adding Item to queue: music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲&那英 - 执迷不悔（粤语）.flac May 12 10:16:02 volumio volumio[1214]: info: Exploding uri music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲&那英 - 执迷不悔（粤语）.flac in service mpd May 12 10:16:02 volumio volumio[1214]: info: ALBUMART /albumart?cacheid=969&web=%E7%8E%8B%E8%8F%B2%20/%E5%A6%82%E6%84%BF/extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%20SSD%2F%E5%9B%BD%E5%86%85%2F%E4%BA%BA%E5%A3%B0%2F%E5%A6%82%E6%84%BF-%E7%8E%8B%E8%8F%B2%2F%E7%8E%8B%E8%8F%B2%20%20-%20%E6%9A%97%E6%B6%8C.flac&metadata=false May 12 10:16:02 volumio volumio[1214]: info: URI /mnt/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 暗涌.flac May 12 10:16:02 volumio volumio[1214]: info: ALBUMART /albumart?cacheid=969&web=%E7%8E%8B%E8%8F%B2/%E5%A6%82%E6%84%BF/extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%20SSD%2F%E5%9B%BD%E5%86%85%2F%E4%BA%BA%E5%A3%B0%2F%E5%A6%82%E6%84%BF-%E7%8E%8B%E8%8F%B2%2F%E7%8E%8B%E8%8F%B2%20-%20%E4%BD%A0%E5%9C%A8%E7%BB%88%E7%82%B9%E7%AD%89%E6%88%91.flac&metadata=false May 12 10:16:02 volumio volumio[1214]: info: URI /mnt/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 你在终点等我.flac May 12 10:16:02 volumio volumio[1214]: info: ALBUMART /albumart?cacheid=969&web=%E7%8E%8B%E8%8F%B2/%E5%A6%82%E6%84%BF/extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%20SSD%2F%E5%9B%BD%E5%86%85%2F%E4%BA%BA%E5%A3%B0%2F%E5%A6%82%E6%84%BF-%E7%8E%8B%E8%8F%B2%2F%E7%8E%8B%E8%8F%B2%20-%20%E5%A6%82%E6%84%BF.flac&metadata=false May 12 10:16:02 volumio volumio[1214]: info: URI /mnt/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 如愿.flac May 12 10:16:02 volumio volumio[1214]: info: ALBUMART /albumart?cacheid=969&web=%E7%8E%8B%E8%8F%B2/%E5%A6%82%E6%84%BF/extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%20SSD%2F%E5%9B%BD%E5%86%85%2F%E4%BA%BA%E5%A3%B0%2F%E5%A6%82%E6%84%BF-%E7%8E%8B%E8%8F%B2%2F%E7%8E%8B%E8%8F%B2%20-%20%E5%AE%B9%E6%98%93%E5%8F%97%E4%BC%A4%E7%9A%84%E5%A5%B3%E4%BA%BA%EF%BC%88%E7%B2%A4%E8%AF%AD%EF%BC%89.flac&metadata=false May 12 10:16:02 volumio volumio[1214]: info: URI /mnt/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 容易受伤的女人（粤语）.flac May 12 10:16:02 volumio volumio[1214]: info: ALBUMART /albumart?cacheid=969&web=%E7%8E%8B%E8%8F%B2/%E5%A6%82%E6%84%BF/extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%20SSD%2F%E5%9B%BD%E5%86%85%2F%E4%BA%BA%E5%A3%B0%2F%E5%A6%82%E6%84%BF-%E7%8E%8B%E8%8F%B2%2F%E7%8E%8B%E8%8F%B2%20-%20%E5%B2%81%E6%9C%88.flac&metadata=false May 12 10:16:02 volumio volumio[1214]: info: URI /mnt/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 岁月.flac May 12 10:16:02 volumio volumio[1214]: info: ALBUMART /albumart?cacheid=969&web=%E7%8E%8B%E8%8F%B2/%E5%A6%82%E6%84%BF/extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%20SSD%2F%E5%9B%BD%E5%86%85%2F%E4%BA%BA%E5%A3%B0%2F%E5%A6%82%E6%84%BF-%E7%8E%8B%E8%8F%B2%2F%E7%8E%8B%E8%8F%B2%20-%20%E6%88%91%E4%B9%9F%E4%B8%8D%E6%83%B3%E8%BF%99%E6%A0%B7.flac&metadata=false May 12 10:16:02 volumio volumio[1214]: info: URI /mnt/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 我也不想这样.flac May 12 10:16:02 volumio volumio[1214]: info: ALBUMART /albumart?cacheid=969&web=%E7%8E%8B%E8%8F%B2/%E5%A6%82%E6%84%BF/extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%20SSD%2F%E5%9B%BD%E5%86%85%2F%E4%BA%BA%E5%A3%B0%2F%E5%A6%82%E6%84%BF-%E7%8E%8B%E8%8F%B2%2F%E7%8E%8B%E8%8F%B2%20-%20%E6%88%91%E6%84%BF%E6%84%8F.flac&metadata=false May 12 10:16:02 volumio volumio[1214]: info: URI /mnt/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 我愿意.flac May 12 10:16:02 volumio volumio[1214]: info: ALBUMART /albumart?cacheid=969&web=%E7%8E%8B%E8%8F%B2/%E5%A6%82%E6%84%BF/extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%20SSD%2F%E5%9B%BD%E5%86%85%2F%E4%BA%BA%E5%A3%B0%2F%E5%A6%82%E6%84%BF-%E7%8E%8B%E8%8F%B2%2F%E7%8E%8B%E8%8F%B2%20-%20%E6%B8%85%E9%A3%8E%E5%BE%90%E6%9D%A5.flac&metadata=false May 12 10:16:02 volumio volumio[1214]: info: URI /mnt/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 清风徐来.flac May 12 10:16:02 volumio volumio[1214]: info: ALBUMART /albumart?cacheid=969&web=%E7%8E%8B%E8%8F%B2/%E5%A6%82%E6%84%BF/extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%20SSD%2F%E5%9B%BD%E5%86%85%2F%E4%BA%BA%E5%A3%B0%2F%E5%A6%82%E6%84%BF-%E7%8E%8B%E8%8F%B2%2F%E7%8E%8B%E8%8F%B2%20-%20%E7%99%BE%E5%B9%B4%E5%AD%A4%E5%AF%82.flac&metadata=false May 12 10:16:02 volumio volumio[1214]: info: URI /mnt/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 百年孤寂.flac May 12 10:16:02 volumio volumio[1214]: info: ALBUMART /albumart?cacheid=969&web=%E7%8E%8B%E8%8F%B2/%E5%A6%82%E6%84%BF/extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%20SSD%2F%E5%9B%BD%E5%86%85%2F%E4%BA%BA%E5%A3%B0%2F%E5%A6%82%E6%84%BF-%E7%8E%8B%E8%8F%B2%2F%E7%8E%8B%E8%8F%B2%20-%20%E7%9F%9C%E6%8C%81.flac&metadata=false May 12 10:16:02 volumio volumio[1214]: info: URI /mnt/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 矜持.flac May 12 10:16:02 volumio volumio[1214]: info: ALBUMART /albumart?cacheid=969&web=%E7%8E%8B%E8%8F%B2/%E5%A6%82%E6%84%BF/extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%20SSD%2F%E5%9B%BD%E5%86%85%2F%E4%BA%BA%E5%A3%B0%2F%E5%A6%82%E6%84%BF-%E7%8E%8B%E8%8F%B2%2F%E7%8E%8B%E8%8F%B2%20-%20%E7%AC%91%E5%BF%98%E4%B9%A6.flac&metadata=false May 12 10:16:02 volumio volumio[1214]: info: URI /mnt/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 笑忘书.flac May 12 10:16:02 volumio volumio[1214]: info: ALBUMART /albumart?cacheid=969&web=%E7%8E%8B%E8%8F%B2/%E5%A6%82%E6%84%BF/extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%20SSD%2F%E5%9B%BD%E5%86%85%2F%E4%BA%BA%E5%A3%B0%2F%E5%A6%82%E6%84%BF-%E7%8E%8B%E8%8F%B2%2F%E7%8E%8B%E8%8F%B2%20-%20%E8%87%B4%E9%9D%92%E6%98%A5.flac&metadata=false May 12 10:16:02 volumio volumio[1214]: info: URI /mnt/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 致青春.flac May 12 10:16:02 volumio volumio[1214]: info: ALBUMART /albumart?cacheid=969&web=%E7%8E%8B%E8%8F%B2%26%E9%82%A3%E8%8B%B1/%E5%A6%82%E6%84%BF/extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%20SSD%2F%E5%9B%BD%E5%86%85%2F%E4%BA%BA%E5%A3%B0%2F%E5%A6%82%E6%84%BF-%E7%8E%8B%E8%8F%B2%2F%E7%8E%8B%E8%8F%B2%26%E9%82%A3%E8%8B%B1%20-%20%E6%89%A7%E8%BF%B7%E4%B8%8D%E6%82%94%EF%BC%88%E7%B2%A4%E8%AF%AD%EF%BC%89.flac&metadata=false May 12 10:16:02 volumio volumio[1214]: info: URI /mnt/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲&那英 - 执迷不悔（粤语）.flac May 12 10:16:02 volumio volumio[1214]: info: CorePlayQueue::saveQueue May 12 10:16:02 volumio volumio[1214]: info: CoreCommandRouter::volumioPushQueue May 12 10:16:02 volumio volumio[1214]: info: CoreStateMachine::updateTrackBlock May 12 10:16:02 volumio volumio[1214]: info: CorePlayQueue::getTrackBlock May 12 10:16:02 volumio volumio[1214]: info: CoreCommandRouter::volumioPlay May 12 10:16:02 volumio volumio[1214]: UNSET VOLATILE May 12 10:16:02 volumio volumio[1214]: info: CoreStateMachine::play index 2 May 12 10:16:02 volumio volumio[1214]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 10:16:02 volumio volumio[1214]: info: CoreStateMachine::stop May 12 10:16:02 volumio volumio[1214]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 10:16:02 volumio volumio[1214]: UNSET VOLATILE May 12 10:16:02 volumio volumio[1214]: info: CoreStateMachine::play index undefined May 12 10:16:02 volumio volumio[1214]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 10:16:02 volumio volumio[1214]: info: CorePlayQueue::getTrack 2 May 12 10:16:02 volumio volumio[1214]: info: CoreStateMachine::startPlaybackTimer May 12 10:16:02 volumio volumio[1214]: info: CorePlayQueue::getTrack 2 May 12 10:16:02 volumio volumio[1214]: verbose: ControllerMpd::clearAddPlayTracks USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 如愿.flac May 12 10:16:02 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand stop May 12 10:16:02 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand clear May 12 10:16:02 volumio volumio[1214]: info: May 12 10:16:02 volumio volumio[1214]: ---------------------------- MPD announces system playlist update May 12 10:16:02 volumio volumio[1214]: info: Ignoring MPD Status Update May 12 10:16:02 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand add "USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 如愿.flac" May 12 10:16:02 volumio volumio[1214]: error: updateQueue error: null May 12 10:16:02 volumio volumio[1214]: info: May 12 10:16:02 volumio volumio[1214]: ---------------------------- MPD announces system playlist update May 12 10:16:02 volumio volumio[1214]: info: Ignoring MPD Status Update May 12 10:16:02 volumio volumio[1214]: info: ------------------------------ 11ms May 12 10:16:02 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand play May 12 10:16:02 volumio volumio[1214]: info: ------------------------------ 9ms May 12 10:16:02 volumio volumio[1214]: info: May 12 10:16:02 volumio volumio[1214]: ---------------------------- MPD announces state update: player May 12 10:16:02 volumio volumio[1214]: info: ControllerMpd::getState May 12 10:16:02 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand status May 12 10:16:02 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 May 12 10:16:02 volumio volumio[1214]: info: May 12 10:16:02 volumio volumio[1214]: ---------------------------- MPD announces state update: player May 12 10:16:02 volumio volumio[1214]: info: ControllerMpd::getState May 12 10:16:02 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand status May 12 10:16:02 volumio volumio[1214]: verbose: ControllerMpd::parseState May 12 10:16:02 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 10:16:02 volumio volumio[1214]: verbose: ControllerMpd::parseState May 12 10:16:02 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 10:16:02 volumio volumio[1214]: verbose: ControllerMpd::parseTrackInfo May 12 10:16:02 volumio volumio[1214]: info: ControllerMpd::pushState May 12 10:16:02 volumio volumio[1214]: info: CoreCommandRouter::servicePushState May 12 10:16:02 volumio volumio[1214]: info: CorePlayQueue::getTrack 2 May 12 10:16:02 volumio volumio[1214]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"如愿","artist":"王菲","album":"如愿","uri":"USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 如愿.flac","trackType":"flac"} May 12 10:16:02 volumio volumio[1214]: verbose: CURRENT POSITION 2 May 12 10:16:02 volumio volumio[1214]: info: CoreStateMachine::syncState stateService play May 12 10:16:02 volumio volumio[1214]: info: CoreStateMachine::syncState currentStatus stop May 12 10:16:02 volumio volumio[1214]: info: CoreStateMachine::pushState May 12 10:16:02 volumio volumio[1214]: info: CorePlayQueue::getTrack 2 May 12 10:16:02 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 12 10:16:02 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:16:02 volumio volumio[1214]: info: ------------------------------ 64ms May 12 10:16:02 volumio volumio[1214]: verbose: ControllerMpd::parseTrackInfo May 12 10:16:02 volumio volumio[1214]: info: ControllerMpd::pushState May 12 10:16:02 volumio volumio[1214]: info: CoreCommandRouter::servicePushState May 12 10:16:02 volumio volumio[1214]: info: CorePlayQueue::getTrack 2 May 12 10:16:02 volumio volumio[1214]: verbose: STATE SERVICE {"status":"play","position":0,"seek":23,"duration":264,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"如愿","artist":"王菲","album":"如愿","uri":"USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 如愿.flac","trackType":"flac"} May 12 10:16:02 volumio volumio[1214]: verbose: CURRENT POSITION 2 May 12 10:16:02 volumio volumio[1214]: info: CoreStateMachine::syncState stateService play May 12 10:16:02 volumio volumio[1214]: info: CoreStateMachine::syncState currentStatus play May 12 10:16:02 volumio volumio[1214]: info: Received an update from plugin. extracting info from payload May 12 10:16:02 volumio volumio[1214]: info: CoreStateMachine::pushState May 12 10:16:02 volumio volumio[1214]: info: CorePlayQueue::getTrack 2 May 12 10:16:02 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 12 10:16:02 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:16:02 volumio volumio[1214]: info: CoreStateMachine::pushState May 12 10:16:02 volumio volumio[1214]: info: CorePlayQueue::getTrack 2 May 12 10:16:02 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 12 10:16:02 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:16:02 volumio volumio[1214]: info: ------------------------------ 58ms May 12 10:16:05 volumio wpa_supplicant[967]: wlan0: Failed to initiate sched scan May 12 10:16:06 volumio volumio[1214]: info: MPD Database updated - AlbumList cache refreshed May 12 10:16:06 volumio volumio[1214]: info: May 12 10:16:06 volumio volumio[1214]: ---------------------------- MPD announces state update: database May 12 10:16:06 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand status May 12 10:16:06 volumio volumio[1214]: info: May 12 10:16:06 volumio volumio[1214]: ---------------------------- MPD announces state update: update May 12 10:16:06 volumio volumio[1214]: info: ControllerMpd::getState May 12 10:16:06 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand status May 12 10:16:06 volumio volumio[1214]: info: ControllerMpd::getState May 12 10:16:06 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand status May 12 10:16:07 volumio volumio[1214]: verbose: ControllerMpd::parseState May 12 10:16:07 volumio volumio[1214]: info: Command Router : Notfying DB Updatefalse May 12 10:16:07 volumio volumio[1214]: info: CoreCommandRouter::Close All Modals sent May 12 10:16:07 volumio volumio[1214]: verbose: ControllerMpd::parseState May 12 10:16:07 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 10:16:07 volumio volumio[1214]: verbose: ControllerMpd::parseState May 12 10:16:07 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 10:16:07 volumio volumio[1214]: verbose: ControllerMpd::parseTrackInfo May 12 10:16:07 volumio volumio[1214]: verbose: ControllerMpd::parseTrackInfo May 12 10:16:07 volumio volumio[1214]: info: ControllerMpd::pushState May 12 10:16:07 volumio volumio[1214]: info: CoreCommandRouter::servicePushState May 12 10:16:07 volumio volumio[1214]: info: CorePlayQueue::getTrack 2 May 12 10:16:07 volumio volumio[1214]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4969,"duration":264,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"341 Kbps","isStreaming":false,"title":"如愿","artist":"王菲","album":"如愿","uri":"USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 如愿.flac","trackType":"flac"} May 12 10:16:07 volumio volumio[1214]: verbose: CURRENT POSITION 2 May 12 10:16:07 volumio volumio[1214]: info: CoreStateMachine::syncState stateService play May 12 10:16:07 volumio volumio[1214]: info: CoreStateMachine::syncState currentStatus play May 12 10:16:07 volumio volumio[1214]: info: Received an update from plugin. extracting info from payload May 12 10:16:07 volumio volumio[1214]: info: CoreStateMachine::pushState May 12 10:16:07 volumio volumio[1214]: info: CorePlayQueue::getTrack 2 May 12 10:16:07 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 12 10:16:07 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:16:07 volumio volumio[1214]: info: CoreStateMachine::pushState May 12 10:16:07 volumio volumio[1214]: info: CorePlayQueue::getTrack 2 May 12 10:16:07 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 12 10:16:07 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:16:07 volumio volumio[1214]: info: ControllerMpd::pushState May 12 10:16:07 volumio volumio[1214]: info: CoreCommandRouter::servicePushState May 12 10:16:07 volumio volumio[1214]: info: CorePlayQueue::getTrack 2 May 12 10:16:07 volumio volumio[1214]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4969,"duration":264,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"341 Kbps","isStreaming":false,"title":"如愿","artist":"王菲","album":"如愿","uri":"USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 如愿.flac","trackType":"flac"} May 12 10:16:07 volumio volumio[1214]: verbose: CURRENT POSITION 2 May 12 10:16:07 volumio volumio[1214]: info: CoreStateMachine::syncState stateService play May 12 10:16:07 volumio volumio[1214]: info: CoreStateMachine::syncState currentStatus play May 12 10:16:07 volumio volumio[1214]: info: Received an update from plugin. extracting info from payload May 12 10:16:07 volumio volumio[1214]: info: CoreStateMachine::pushState May 12 10:16:07 volumio volumio[1214]: info: CorePlayQueue::getTrack 2 May 12 10:16:07 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 12 10:16:07 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:16:07 volumio volumio[1214]: info: CoreStateMachine::pushState May 12 10:16:07 volumio volumio[1214]: info: CorePlayQueue::getTrack 2 May 12 10:16:07 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 12 10:16:07 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:16:07 volumio volumio[1214]: info: ------------------------------ 689ms May 12 10:16:07 volumio volumio[1214]: info: ------------------------------ 689ms May 12 10:16:12 volumio wpa_supplicant[967]: wlan0: Failed to initiate sched scan May 12 10:16:18 volumio kernel: sd 0:0:0:0: [sda] tag#15 sense submit err -19 uas-tag 1 inflight: s-st a-in s-in a-cmd s-cmd May 12 10:16:18 volumio kernel: sd 0:0:0:0: [sda] tag#15 CDB: opcode=0x28 28 00 28 3b db b8 00 01 00 00 May 12 10:16:18 volumio kernel: sd 0:0:0:0: [sda] tag#15 sense submit err -19 uas-tag 1 inflight: s-st a-in s-in a-cmd s-cmd May 12 10:16:18 volumio kernel: sd 0:0:0:0: [sda] tag#15 CDB: opcode=0x28 28 00 28 3b db b8 00 01 00 00 May 12 10:16:18 volumio kernel: usb 2-1: USB disconnect, device number 2 May 12 10:16:18 volumio ntfs-3g[2182]: ntfs_attr_pread error reading '/国内/人声/如愿-王菲/王菲 - 如愿.flac' at offset 1998848: 131072 <> 49152: Input/output error May 12 10:16:18 volumio ntfs-3g[2182]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 12 10:16:18 volumio ntfs-3g[2182]: ntfs_attr_pread error reading '/国内/人声/如愿-王菲/王菲 - 如愿.flac' at offset 2048000: 81920 <> -1: Input/output error May 12 10:16:18 volumio kernel: print_req_error: I/O error, dev sda, sector 675011512 May 12 10:16:18 volumio kernel: print_req_error: I/O error, dev sda, sector 675011768 May 12 10:16:18 volumio kernel: print_req_error: I/O error, dev sda, sector 675011512 May 12 10:16:18 volumio kernel: Buffer I/O error on dev sda1, logical block 84376183, async page read May 12 10:16:18 volumio kernel: print_req_error: I/O error, dev sda, sector 675011512 May 12 10:16:18 volumio kernel: Buffer I/O error on dev sda1, logical block 84376183, async page read May 12 10:16:18 volumio kernel: print_req_error: I/O error, dev sda, sector 675011512 May 12 10:16:18 volumio kernel: Buffer I/O error on dev sda1, logical block 84376183, async page read May 12 10:16:19 volumio kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache May 12 10:16:19 volumio udisks-glue[586]: Device file /dev/sda1 unmounted from /media/TOSHIBA SSD May 12 10:16:19 volumio udisks-glue[586]: Device file /dev/sda1 removed May 12 10:16:19 volumio udisks-glue[586]: Device file /dev/sda removed May 12 10:16:19 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand status May 12 10:16:19 volumio volumio[1214]: info: May 12 10:16:19 volumio volumio[1214]: ---------------------------- MPD announces state update: update May 12 10:16:19 volumio udisks-glue[586]: 王菲 - 如愿 May 12 10:16:19 volumio udisks-glue[586]: [playing] #1/1 0:17/4:24 (6%) May 12 10:16:19 volumio udisks-glue[586]: Updating DB (#5) ... May 12 10:16:19 volumio udisks-glue[586]: volume: 40% repeat: off random: off single: off consume: off May 12 10:16:19 volumio volumio[1214]: info: ControllerMpd::getState May 12 10:16:19 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand status May 12 10:16:19 volumio volumio[1214]: verbose: ControllerMpd::parseState May 12 10:16:19 volumio volumio[1214]: info: Command Router : Notfying DB Updatetrue May 12 10:16:19 volumio volumio[1214]: info: CoreCommandRouter::Close All Modals sent May 12 10:16:19 volumio volumio[1214]: verbose: ControllerMpd::parseState May 12 10:16:19 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 10:16:19 volumio udisks-glue[586]: 王菲 - 如愿 May 12 10:16:19 volumio udisks-glue[586]: [playing] #1/1 0:18/4:24 (6%) May 12 10:16:19 volumio udisks-glue[586]: Updating DB (#6) ... May 12 10:16:19 volumio udisks-glue[586]: volume: 40% repeat: off random: off single: off consume: off May 12 10:16:19 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand status May 12 10:16:19 volumio volumio[1214]: info: May 12 10:16:19 volumio volumio[1214]: ---------------------------- MPD announces state update: update May 12 10:16:19 volumio volumio[1214]: info: ControllerMpd::getState May 12 10:16:19 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand status May 12 10:16:19 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand status May 12 10:16:19 volumio volumio[1214]: info: May 12 10:16:19 volumio volumio[1214]: ---------------------------- MPD announces state update: update May 12 10:16:19 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand status May 12 10:16:19 volumio volumio[1214]: info: May 12 10:16:19 volumio volumio[1214]: ---------------------------- MPD announces state update: update May 12 10:16:19 volumio volumio[1214]: info: ControllerMpd::getState May 12 10:16:19 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand status May 12 10:16:19 volumio volumio[1214]: info: ControllerMpd::getState May 12 10:16:19 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand status May 12 10:16:19 volumio volumio[1214]: verbose: ControllerMpd::parseTrackInfo May 12 10:16:19 volumio volumio[1214]: verbose: ControllerMpd::parseState May 12 10:16:19 volumio volumio[1214]: info: Command Router : Notfying DB Updatefalse May 12 10:16:19 volumio volumio[1214]: info: CoreCommandRouter::Close All Modals sent May 12 10:16:19 volumio volumio[1214]: verbose: ControllerMpd::parseState May 12 10:16:19 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 10:16:19 volumio volumio[1214]: info: ControllerMpd::pushState May 12 10:16:19 volumio volumio[1214]: info: CoreCommandRouter::servicePushState May 12 10:16:19 volumio volumio[1214]: info: CorePlayQueue::getTrack 2 May 12 10:16:19 volumio volumio[1214]: verbose: STATE SERVICE {"status":"play","position":0,"seek":17461,"duration":264,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"771 Kbps","isStreaming":false,"title":"如愿","artist":"王菲","album":"如愿","uri":"USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 如愿.flac","trackType":"flac"} May 12 10:16:19 volumio volumio[1214]: verbose: CURRENT POSITION 2 May 12 10:16:19 volumio volumio[1214]: info: CoreStateMachine::syncState stateService play May 12 10:16:19 volumio volumio[1214]: info: CoreStateMachine::syncState currentStatus play May 12 10:16:19 volumio volumio[1214]: info: Received an update from plugin. extracting info from payload May 12 10:16:19 volumio volumio[1214]: info: CoreStateMachine::pushState May 12 10:16:19 volumio volumio[1214]: info: CorePlayQueue::getTrack 2 May 12 10:16:19 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 12 10:16:19 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:16:19 volumio volumio[1214]: info: CoreStateMachine::pushState May 12 10:16:19 volumio volumio[1214]: info: CorePlayQueue::getTrack 2 May 12 10:16:19 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 12 10:16:19 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:16:19 volumio volumio[1214]: info: ------------------------------ 192ms May 12 10:16:19 volumio volumio[1214]: verbose: ControllerMpd::parseState May 12 10:16:19 volumio volumio[1214]: info: Command Router : Notfying DB Updatefalse May 12 10:16:19 volumio volumio[1214]: info: CoreCommandRouter::Close All Modals sent May 12 10:16:19 volumio volumio[1214]: verbose: ControllerMpd::parseState May 12 10:16:19 volumio volumio[1214]: info: Command Router : Notfying DB Updatefalse May 12 10:16:19 volumio volumio[1214]: info: CoreCommandRouter::Close All Modals sent May 12 10:16:19 volumio volumio[1214]: verbose: ControllerMpd::parseState May 12 10:16:19 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 10:16:19 volumio volumio[1214]: verbose: ControllerMpd::parseState May 12 10:16:19 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 10:16:19 volumio volumio[1214]: verbose: ControllerMpd::parseTrackInfo May 12 10:16:19 volumio volumio[1214]: info: ControllerMpd::pushState May 12 10:16:19 volumio volumio[1214]: info: CoreCommandRouter::servicePushState May 12 10:16:19 volumio volumio[1214]: info: CorePlayQueue::getTrack 2 May 12 10:16:19 volumio volumio[1214]: verbose: STATE SERVICE {"status":"play","position":0,"seek":17554,"duration":264,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"666 Kbps","isStreaming":false,"title":"如愿","artist":"王菲","album":"如愿","uri":"USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 如愿.flac","trackType":"flac"} May 12 10:16:19 volumio volumio[1214]: verbose: CURRENT POSITION 2 May 12 10:16:19 volumio volumio[1214]: info: CoreStateMachine::syncState stateService play May 12 10:16:19 volumio volumio[1214]: info: CoreStateMachine::syncState currentStatus play May 12 10:16:19 volumio volumio[1214]: info: Received an update from plugin. extracting info from payload May 12 10:16:19 volumio volumio[1214]: info: CoreStateMachine::pushState May 12 10:16:19 volumio volumio[1214]: info: CorePlayQueue::getTrack 2 May 12 10:16:19 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 12 10:16:19 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:16:19 volumio volumio[1214]: info: CoreStateMachine::pushState May 12 10:16:19 volumio volumio[1214]: info: CorePlayQueue::getTrack 2 May 12 10:16:19 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 12 10:16:19 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:16:19 volumio volumio[1214]: info: ------------------------------ 165ms May 12 10:16:19 volumio volumio[1214]: verbose: ControllerMpd::parseTrackInfo May 12 10:16:19 volumio volumio[1214]: verbose: ControllerMpd::parseTrackInfo May 12 10:16:19 volumio volumio[1214]: info: ControllerMpd::pushState May 12 10:16:19 volumio volumio[1214]: info: CoreCommandRouter::servicePushState May 12 10:16:19 volumio volumio[1214]: info: CorePlayQueue::getTrack 2 May 12 10:16:19 volumio volumio[1214]: verbose: STATE SERVICE {"status":"play","position":0,"seek":17554,"duration":264,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"666 Kbps","isStreaming":false,"title":"如愿","artist":"王菲","album":"如愿","uri":"USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 如愿.flac","trackType":"flac"} May 12 10:16:19 volumio volumio[1214]: verbose: CURRENT POSITION 2 May 12 10:16:19 volumio volumio[1214]: info: CoreStateMachine::syncState stateService play May 12 10:16:19 volumio volumio[1214]: info: CoreStateMachine::syncState currentStatus play May 12 10:16:19 volumio volumio[1214]: info: Received an update from plugin. extracting info from payload May 12 10:16:19 volumio volumio[1214]: info: CoreStateMachine::pushState May 12 10:16:19 volumio volumio[1214]: info: CorePlayQueue::getTrack 2 May 12 10:16:19 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 12 10:16:19 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:16:19 volumio volumio[1214]: info: CoreStateMachine::pushState May 12 10:16:19 volumio volumio[1214]: info: CorePlayQueue::getTrack 2 May 12 10:16:19 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 12 10:16:19 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:16:19 volumio volumio[1214]: info: ControllerMpd::pushState May 12 10:16:19 volumio volumio[1214]: info: CoreCommandRouter::servicePushState May 12 10:16:19 volumio volumio[1214]: info: CorePlayQueue::getTrack 2 May 12 10:16:19 volumio volumio[1214]: verbose: STATE SERVICE {"status":"play","position":0,"seek":17554,"duration":264,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"666 Kbps","isStreaming":false,"title":"如愿","artist":"王菲","album":"如愿","uri":"USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 如愿.flac","trackType":"flac"} May 12 10:16:19 volumio volumio[1214]: verbose: CURRENT POSITION 2 May 12 10:16:19 volumio volumio[1214]: info: CoreStateMachine::syncState stateService play May 12 10:16:19 volumio volumio[1214]: info: CoreStateMachine::syncState currentStatus play May 12 10:16:19 volumio volumio[1214]: info: Received an update from plugin. extracting info from payload May 12 10:16:19 volumio volumio[1214]: info: CoreStateMachine::pushState May 12 10:16:19 volumio volumio[1214]: info: CorePlayQueue::getTrack 2 May 12 10:16:19 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 12 10:16:19 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:16:19 volumio volumio[1214]: info: CoreStateMachine::pushState May 12 10:16:19 volumio volumio[1214]: info: CorePlayQueue::getTrack 2 May 12 10:16:19 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 12 10:16:19 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:16:19 volumio volumio[1214]: info: ------------------------------ 198ms May 12 10:16:19 volumio volumio[1214]: info: ------------------------------ 198ms May 12 10:16:20 volumio kernel: sd 0:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x07 driverbyte=0x00 May 12 10:16:20 volumio wpa_supplicant[967]: wlan0: Failed to initiate sched scan May 12 10:16:20 volumio kernel: usb 2-1: new SuperSpeed Gen 1 USB device number 3 using xhci_hcd May 12 10:16:20 volumio kernel: usb 2-1: New USB device found, idVendor=0930, idProduct=140c, bcdDevice= 1.00 May 12 10:16:20 volumio kernel: usb 2-1: New USB device strings: Mfr=2, Product=3, SerialNumber=1 May 12 10:16:20 volumio kernel: usb 2-1: Product: XS700 May 12 10:16:20 volumio kernel: usb 2-1: Manufacturer: TOSHIBA May 12 10:16:20 volumio kernel: usb 2-1: SerialNumber: 20190107010058 May 12 10:16:20 volumio kernel: scsi host1: uas May 12 10:16:20 volumio kernel: scsi 1:0:0:0: Direct-Access TOSHIBA XS700 0 PQ: 0 ANSI: 6 May 12 10:16:20 volumio kernel: sd 1:0:0:0: [sdb] 937703088 512-byte logical blocks: (480 GB/447 GiB) May 12 10:16:20 volumio kernel: sd 1:0:0:0: [sdb] Write Protect is off May 12 10:16:20 volumio kernel: sd 1:0:0:0: [sdb] Mode Sense: 43 00 00 00 May 12 10:16:20 volumio kernel: sd 1:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA May 12 10:16:20 volumio kernel: sd 1:0:0:0: Attached scsi generic sg0 type 0 May 12 10:16:20 volumio kernel: sd 1:0:0:0: [sdb] Optimal transfer size 33553920 bytes May 12 10:16:20 volumio kernel: sdb: sdb1 May 12 10:16:20 volumio kernel: sd 1:0:0:0: [sdb] Attached SCSI disk May 12 10:16:20 volumio udisks-glue[586]: Device file /dev/sdb inserted May 12 10:16:20 volumio udisks-glue[586]: Device file /dev/sdb1 inserted May 12 10:16:20 volumio udisks-glue[586]: Trying to automount /dev/sdb1... May 12 10:16:20 volumio ntfs-3g[2354]: Version 2014.2.15AR.2 integrated FUSE 28 May 12 10:16:20 volumio ntfs-3g[2354]: Mounted /dev/sdb1 (Read-Write, label "TOSHIBA SSD", NTFS 3.1) May 12 10:16:20 volumio ntfs-3g[2354]: Cmdline options: rw,nodev,nosuid,noatime,uid=1000,gid=1000,dmask=0077,fmask=0177,dmask=0000,fmask=0000,uhelper=udisks May 12 10:16:20 volumio ntfs-3g[2354]: Mount options: rw,nodev,nosuid,uhelper=udisks,allow_other,nonempty,noatime,default_permissions,fsname=/dev/sdb1,blkdev,blksize=4096 May 12 10:16:20 volumio ntfs-3g[2354]: Global ownership and permissions enforced, configuration type 7 May 12 10:16:20 volumio udisks-glue[586]: Successfully automounted /dev/sdb1 at /media/TOSHIBA SSD May 12 10:16:20 volumio udisks-glue[586]: Device file /dev/sdb1 mounted at /media/TOSHIBA SSD May 12 10:16:20 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand status May 12 10:16:20 volumio udisks-glue[586]: 王菲 - 如愿 May 12 10:16:20 volumio udisks-glue[586]: [playing] #1/1 0:19/4:24 (7%) May 12 10:16:20 volumio udisks-glue[586]: Updating DB (#7) ... May 12 10:16:20 volumio udisks-glue[586]: volume: 40% repeat: off random: off single: off consume: off May 12 10:16:20 volumio volumio[1214]: info: May 12 10:16:20 volumio volumio[1214]: ---------------------------- MPD announces state update: update May 12 10:16:21 volumio volumio[1214]: info: ControllerMpd::getState May 12 10:16:21 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand status May 12 10:16:21 volumio volumio[1214]: verbose: ControllerMpd::parseState May 12 10:16:21 volumio volumio[1214]: info: Command Router : Notfying DB Updatetrue May 12 10:16:21 volumio volumio[1214]: info: CoreCommandRouter::Close All Modals sent May 12 10:16:21 volumio volumio[1214]: verbose: ControllerMpd::parseState May 12 10:16:21 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 10:16:21 volumio volumio[1214]: verbose: ControllerMpd::parseTrackInfo May 12 10:16:21 volumio volumio[1214]: info: ControllerMpd::pushState May 12 10:16:21 volumio volumio[1214]: info: CoreCommandRouter::servicePushState May 12 10:16:21 volumio volumio[1214]: info: CorePlayQueue::getTrack 2 May 12 10:16:21 volumio volumio[1214]: verbose: STATE SERVICE {"status":"play","position":0,"seek":18854,"duration":264,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"628 Kbps","isStreaming":false,"title":"如愿","artist":"王菲","album":"如愿","uri":"USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 如愿.flac","trackType":"flac"} May 12 10:16:21 volumio volumio[1214]: verbose: CURRENT POSITION 2 May 12 10:16:21 volumio volumio[1214]: info: CoreStateMachine::syncState stateService play May 12 10:16:21 volumio volumio[1214]: info: CoreStateMachine::syncState currentStatus play May 12 10:16:21 volumio volumio[1214]: info: Received an update from plugin. extracting info from payload May 12 10:16:21 volumio volumio[1214]: info: CoreStateMachine::pushState May 12 10:16:21 volumio volumio[1214]: info: CorePlayQueue::getTrack 2 May 12 10:16:21 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 12 10:16:21 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:16:21 volumio volumio[1214]: info: CoreStateMachine::pushState May 12 10:16:21 volumio volumio[1214]: info: CorePlayQueue::getTrack 2 May 12 10:16:21 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState May 12 10:16:21 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:16:21 volumio volumio[1214]: info: ------------------------------ 81ms May 12 10:16:21 volumio ntfs-3g[2182]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 12 10:16:21 volumio ntfs-3g[2182]: ntfs_attr_pread error reading '/国内/人声/如愿-王菲/王菲 - 如愿.flac' at offset 2129920: 131072 <> -1: Input/output error May 12 10:16:21 volumio ntfs-3g[2182]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 12 10:16:21 volumio ntfs-3g[2182]: ntfs_attr_pread error reading '/国内/人声/如愿-王菲/王菲 - 如愿.flac' at offset 2260992: 131072 <> -1: Input/output error May 12 10:16:21 volumio kernel: Buffer I/O error on dev sda1, logical block 84376203, async page read May 12 10:16:21 volumio kernel: Buffer I/O error on dev sda1, logical block 84376235, async page read May 12 10:16:22 volumio ntfs-3g[2182]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error May 12 10:16:22 volumio ntfs-3g[2182]: ntfs_attr_pread error reading '/国内/人声/如愿-王菲/王菲 - 如愿.flac' at offset 1998848: 4096 <> -1: Input/output error May 12 10:16:22 volumio ntfs-3g[2182]: Unmounting /dev/sda1 (TOSHIBA SSD) May 12 10:16:22 volumio ntfs-3g[2182]: Failed to sync device /dev/sda1: Input/output error May 12 10:16:22 volumio ntfs-3g[2182]: Failed to close volume /dev/sda1: Input/output error May 12 10:16:22 volumio kernel: Buffer I/O error on dev sda1, logical block 84376171, async page read May 12 10:16:27 volumio wpa_supplicant[967]: wlan0: Failed to initiate sched scan May 12 10:16:35 volumio volumio[1214]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 12 10:16:35 volumio volumio[1214]: { Error: connect ETIMEDOUT 199.59.149.202:443 May 12 10:16:35 volumio volumio[1214]: at Object._errnoException (util.js:1022:11) May 12 10:16:35 volumio volumio[1214]: at _exceptionWithHostPort (util.js:1044:20) May 12 10:16:35 volumio volumio[1214]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) May 12 10:16:35 volumio volumio[1214]: code: 'ETIMEDOUT', May 12 10:16:35 volumio volumio[1214]: errno: 'ETIMEDOUT', May 12 10:16:35 volumio volumio[1214]: syscall: 'connect', May 12 10:16:35 volumio volumio[1214]: address: '199.59.149.202', May 12 10:16:35 volumio volumio[1214]: port: 443 } May 12 10:16:35 volumio volumio[1214]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 12 10:16:35 volumio wpa_supplicant[967]: wlan0: Failed to initiate sched scan May 12 10:16:36 volumio sudo[2416]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-12 10:15 May 12 10:16:36 volumio sudo[2416]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 10:16:36 volumio sudo[2416]: pam_unix(sudo:session): session closed for user root May 12 10:16:39 volumio volumio-remote-updater[591]: [2024-05-12 10:16:39] [error] handle_read_frame error: websocketpp.transport:7 (End of File) May 12 10:16:39 volumio volumio-remote-updater[591]: [2024-05-12 10:16:39] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] May 12 10:16:39 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE May 12 10:16:39 volumio systemd[1]: Unit volumio.service entered failed state. May 12 10:16:39 volumio systemd[1]: Starting dynamicswap service... May 12 10:16:39 volumio systemd[1]: Started dynamicswap service. May 12 10:16:39 volumio systemd[1]: volumio.service holdoff time over, scheduling restart. May 12 10:16:39 volumio systemd[1]: Starting dynamicswap service... May 12 10:16:39 volumio systemd[1]: Started dynamicswap service. May 12 10:16:39 volumio systemd[1]: Stopping Volumio Backend Module... May 12 10:16:39 volumio systemd[1]: Starting Volumio Backend Module... May 12 10:16:39 volumio systemd[1]: Started Volumio Backend Module. May 12 10:16:42 volumio volumio[2441]: info: ------------------------------------------- May 12 10:16:42 volumio volumio[2441]: info: ----- Volumio2 ---- May 12 10:16:42 volumio volumio[2441]: info: ------------------------------------------- May 12 10:16:42 volumio volumio[2441]: info: ----- System startup ---- May 12 10:16:42 volumio volumio[2441]: info: ------------------------------------------- May 12 10:16:42 volumio wpa_supplicant[967]: wlan0: Failed to initiate sched scan May 12 10:16:43 volumio volumio[2441]: info: MYVOLUMIO Environment detected May 12 10:16:43 volumio volumio[2441]: info: Plugin folders cleanup May 12 10:16:43 volumio volumio[2441]: info: Scanning into folder /volumio/app/plugins/ May 12 10:16:43 volumio volumio[2441]: info: Scanning category audio_interface May 12 10:16:43 volumio volumio[2441]: info: Scanning category miscellanea May 12 10:16:43 volumio volumio[2441]: info: Scanning category music_service May 12 10:16:43 volumio volumio[2441]: info: Scanning category plugins.json May 12 10:16:43 volumio volumio[2441]: info: Scanning category system_controller May 12 10:16:43 volumio volumio[2441]: info: Scanning category user_interface May 12 10:16:43 volumio volumio[2441]: info: Scanning into folder /data/plugins/ May 12 10:16:43 volumio volumio[2441]: info: Plugin folders cleanup completed May 12 10:16:43 volumio volumio[2441]: info: ------------------------------------------- May 12 10:16:43 volumio volumio[2441]: info: ----- Core plugins startup ---- May 12 10:16:43 volumio volumio[2441]: info: ------------------------------------------- May 12 10:16:43 volumio volumio[2441]: info: Loading plugins from folder /volumio/app/plugins/ May 12 10:16:43 volumio volumio[2441]: info: Adding plugin upnp to MyMusic Plugins May 12 10:16:43 volumio volumio[2441]: info: Adding plugin airplay_emulation to MyMusic Plugins May 12 10:16:43 volumio volumio[2441]: info: Adding plugin upnp_browser to MyMusic Plugins May 12 10:16:43 volumio volumio[2441]: info: Loading plugins from folder /data/plugins/ May 12 10:16:43 volumio volumio[2441]: info: Loading plugin "system"... May 12 10:16:43 volumio volumio[2441]: info: Loading plugin "appearance"... May 12 10:16:44 volumio volumio-remote-updater[591]: [2024-05-12 10:16:44] [connect] Successful connection May 12 10:16:44 volumio volumio[2441]: info: Loading plugin "network"... May 12 10:16:44 volumio volumio[2441]: info: Refreshing Cached IP Addresses May 12 10:16:44 volumio sudo[2470]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 12 10:16:44 volumio volumio[2441]: info: Loading plugin "services"... May 12 10:16:44 volumio volumio[2441]: info: Loading plugin "alsa_controller"... May 12 10:16:44 volumio sudo[2470]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 10:16:45 volumio sudo[2472]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 12 10:16:45 volumio sudo[2470]: pam_unix(sudo:session): session closed for user root May 12 10:16:45 volumio sudo[2472]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 10:16:45 volumio sudo[2472]: pam_unix(sudo:session): session closed for user root May 12 10:16:45 volumio volumio[2441]: info: Loading plugin "wizard"... May 12 10:16:45 volumio volumio[2441]: info: Loading plugin "volumio_command_line_client"... May 12 10:16:45 volumio volumio[2441]: info: Loading plugin "upnp"... May 12 10:16:45 volumio volumio[2441]: info: [1715509005266] Starting Upmpd Daemon May 12 10:16:45 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 12 10:16:45 volumio volumio[2441]: info: Loading plugin "my_music"... May 12 10:16:45 volumio volumio[2441]: info: Loading plugin "mpd"... May 12 10:16:45 volumio volumio[2441]: info: Loading plugin "upnp_browser"... May 12 10:16:46 volumio volumio[2441]: info: Loading plugin "networkfs"... May 12 10:16:46 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 12 10:16:46 volumio volumio[2441]: info: Loading plugin "alarm-clock"... May 12 10:16:46 volumio sudo[2496]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //undefined/\\WIN-L3PLNSOHSGQ\Music /mnt/NAS/music May 12 10:16:46 volumio sudo[2496]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 10:16:46 volumio volumio[2441]: info: Loading plugin "airplay_emulation"... May 12 10:16:46 volumio volumio[2441]: info: Starting Shairport Sync May 12 10:16:46 volumio volumio[2441]: info: Loading plugin "last_100"... May 12 10:16:46 volumio volumio[2441]: info: Loading plugin "webradio"... May 12 10:16:47 volumio sudo[2496]: pam_unix(sudo:session): session closed for user root May 12 10:16:47 volumio volumio[2441]: info: Loading plugin "i2s_dacs"... May 12 10:16:47 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 10:16:47 volumio volumio[2441]: info: Loading plugin "volumiodiscovery"... May 12 10:16:47 volumio volumio[2441]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 12 10:16:47 volumio node[2441]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 12 10:16:47 volumio node[2441]: *** WARNING *** Please fix your application to use the native API of Avahi! May 12 10:16:47 volumio node[2441]: *** WARNING *** For more information see May 12 10:16:47 volumio node[2441]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 12 10:16:47 volumio node[2441]: *** WARNING *** Please fix your application to use the native API of Avahi! May 12 10:16:47 volumio node[2441]: *** WARNING *** For more information see May 12 10:16:47 volumio volumio[2441]: *** WARNING *** Please fix your application to use the native API of Avahi! May 12 10:16:47 volumio volumio[2441]: *** WARNING *** For more information see May 12 10:16:47 volumio volumio[2441]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 12 10:16:47 volumio volumio[2441]: *** WARNING *** Please fix your application to use the native API of Avahi! May 12 10:16:47 volumio volumio[2441]: *** WARNING *** For more information see May 12 10:16:47 volumio volumio[2441]: info: Applying required configuration parameters for plugin volumiodiscovery May 12 10:16:47 volumio volumio[2441]: Discovery: StartAdv! undefined May 12 10:16:47 volumio volumio[2441]: Discovery: Started advertising... Volumio - undefined May 12 10:16:47 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 12 10:16:47 volumio volumio[2441]: info: Loading plugin "outputs"... May 12 10:16:47 volumio volumio[2441]: info: Loading plugin "albumart"... May 12 10:16:47 volumio volumio[2441]: info: Plugin example_plugin is not enabled May 12 10:16:47 volumio volumio[2441]: info: Loading plugin "inputs"... May 12 10:16:47 volumio volumio[2441]: info: Loading plugin "updater_comm"... May 12 10:16:47 volumio volumio[2441]: info: Plugin mpdemulation is not enabled May 12 10:16:47 volumio volumio[2441]: info: Loading plugin "rest_api"... May 12 10:16:47 volumio volumio[2441]: info: Loading plugin "websocket"... May 12 10:16:47 volumio volumio[2441]: info: ___________ START PLUGINS ___________ May 12 10:16:47 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 12 10:16:47 volumio volumio[2441]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 12 10:16:47 volumio volumio[2441]: info: [1715509007546] CoreMusicLibrary::Adding element Media Servers May 12 10:16:47 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 12 10:16:47 volumio volumio[2441]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 12 10:16:47 volumio volumio[2441]: Forking 3 albumart workers May 12 10:16:47 volumio volumio[2441]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 12 10:16:47 volumio volumio[2441]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 12 10:16:47 volumio volumio[2441]: info: [1715509007749] CoreMusicLibrary::Adding element Last_100 May 12 10:16:47 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 12 10:16:47 volumio volumio[2441]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 12 10:16:47 volumio volumio[2441]: info: [1715509007755] CoreMusicLibrary::Adding element Webradio May 12 10:16:47 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 12 10:16:47 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 12 10:16:47 volumio volumio[2441]: info: ------------------------------------------- May 12 10:16:47 volumio volumio[2441]: info: ----- MyVolumio plugins startup ---- May 12 10:16:47 volumio volumio[2441]: info: ------------------------------------------- May 12 10:16:47 volumio volumio[2441]: info: [MyVolumio PluginManager] Fetching plans data.... May 12 10:16:47 volumio volumio[2441]: info: Loading i18n strings for locale zh May 12 10:16:47 volumio volumio[2441]: Updating browse sources language May 12 10:16:47 volumio volumio[2441]: Cannot find translation for sourceMedia Servers May 12 10:16:47 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 12 10:16:47 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 12 10:16:47 volumio volumio[2441]: info: CoreCommandRouter::initPlayerControls May 12 10:16:47 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 10:16:47 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards May 12 10:16:47 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 10:16:47 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 10:16:47 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 10:16:47 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 10:16:47 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 10:16:47 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 12 10:16:47 volumio volumio[2441]: info: BOOT COMPLETED May 12 10:16:47 volumio volumio[2441]: [Metrics] CommandRouter: 5s 672.06ms May 12 10:16:47 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 10:16:48 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 May 12 10:16:48 volumio volumio[2441]: Starting albumart workers May 12 10:16:48 volumio volumio[2441]: Starting albumart workers May 12 10:16:49 volumio volumio[2441]: Starting albumart workers May 12 10:16:50 volumio wpa_supplicant[967]: wlan0: Failed to initiate sched scan May 12 10:16:53 volumio volumio[2441]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo May 12 10:16:53 volumio volumio[2441]: info: CoreCommandRouter::Close All Modals sent May 12 10:16:53 volumio volumio[2441]: info: CoreCommandRouter::Close All Modals sent May 12 10:16:53 volumio volumio[2441]: Express server listening on port 3000 May 12 10:16:53 volumio volumio[2441]: [Metrics] WebUI: 11s 863.70ms May 12 10:16:53 volumio volumio[2441]: Volumio Calling Home May 12 10:16:53 volumio volumio[2441]: info: CoreStateMachine::resetVolumioState May 12 10:16:53 volumio volumio[2441]: info: CoreStateMachine::getcurrentVolume May 12 10:16:53 volumio volumio[2441]: info: CoreCommandRouter::volumioRetrievevolume May 12 10:16:53 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 10:16:53 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 10:16:53 volumio volumio[2441]: info: Setting Device type: Raspberry PI May 12 10:16:53 volumio volumio[2441]: info: Cannot mount NAS music at system boot, trial number 1 ,retrying in 5 seconds May 12 10:16:53 volumio volumio[2441]: info: MPD running with PID663 May 12 10:16:53 volumio volumio[2441]: ,establishing connection May 12 10:16:54 volumio volumio[2441]: info: VolumeController:: Volume=100 Mute =false May 12 10:16:54 volumio volumio[2441]: info: CoreStateMachine::pushState May 12 10:16:54 volumio volumio[2441]: info: CorePlayQueue::getTrack 0 May 12 10:16:54 volumio volumio[2441]: info: CoreCommandRouter::volumioPushState May 12 10:16:54 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:16:54 volumio volumio[2441]: info: CoreStateMachine::updateTrackBlock May 12 10:16:54 volumio volumio[2441]: info: CorePlayQueue::getTrackBlock May 12 10:16:54 volumio volumio[2441]: info: CoreCommandRouter::volumioRetrievevolume May 12 10:16:54 volumio volumio[2441]: info: Reloading queue from file May 12 10:16:54 volumio volumio[2441]: info: CoreStateMachine::setRepeat null single undefined May 12 10:16:54 volumio volumio[2441]: info: CoreStateMachine::pushState May 12 10:16:54 volumio volumio[2441]: info: CorePlayQueue::getTrack 0 May 12 10:16:54 volumio volumio[2441]: info: CoreCommandRouter::volumioPushState May 12 10:16:54 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:16:54 volumio volumio[2441]: info: CoreStateMachine::setRandom null May 12 10:16:54 volumio volumio[2441]: info: CoreStateMachine::pushState May 12 10:16:54 volumio volumio[2441]: info: CorePlayQueue::getTrack 0 May 12 10:16:54 volumio volumio[2441]: info: CoreCommandRouter::volumioPushState May 12 10:16:54 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:16:54 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable May 12 10:16:54 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 12 10:16:54 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect May 12 10:16:54 volumio volumio[2441]: info: Starting Shairport Sync May 12 10:16:54 volumio volumio[2441]: info: Starting Shairport Sync May 12 10:16:54 volumio sudo[2581]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 12 10:16:54 volumio volumio[2441]: info: CoreCommandRouter::volumioGetState May 12 10:16:54 volumio volumio[2441]: info: CorePlayQueue::getTrack 0 May 12 10:16:54 volumio sudo[2581]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 10:16:54 volumio sudo[2584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 12 10:16:54 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 12 10:16:54 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... May 12 10:16:54 volumio volumio[2441]: info: VolumeController:: Volume=100 Mute =false May 12 10:16:54 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 12 10:16:54 volumio sudo[2581]: pam_unix(sudo:session): session closed for user root May 12 10:16:54 volumio volumio[2441]: info: CoreStateMachine::pushState May 12 10:16:54 volumio volumio[2441]: info: CorePlayQueue::getTrack 0 May 12 10:16:54 volumio volumio[2441]: info: CoreCommandRouter::volumioPushState May 12 10:16:54 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:16:54 volumio sudo[2584]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 10:16:55 volumio volumio[2441]: Discovery: adding 6babe1f7-51ed-4aae-a577-5e132c634096 May 12 10:16:55 volumio volumio[2441]: info: mDNS: Found device musical-fidelity May 12 10:16:55 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 12 10:16:55 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... May 12 10:16:55 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 12 10:16:55 volumio sudo[2584]: pam_unix(sudo:session): session closed for user root May 12 10:16:55 volumio volumio[2441]: info: Shairport-Sync Started May 12 10:16:55 volumio volumio[2441]: Error adding Membership: Error: addMembership EINVAL May 12 10:16:55 volumio volumio[2441]: info: Shairport-Sync Started May 12 10:16:55 volumio volumio[2441]: Discovery: adding a906a7c0-5c86-4c95-be35-4033abd8d6b5 May 12 10:16:55 volumio volumio[2441]: info: mDNS: Found device Volumio May 12 10:16:55 volumio volumio[2441]: info: CoreCommandRouter::volumioGetState May 12 10:16:55 volumio volumio[2441]: info: CorePlayQueue::getTrack 0 May 12 10:16:55 volumio volumio[2441]: info: CoreCommandRouter::volumioGetState May 12 10:16:55 volumio volumio[2441]: info: CorePlayQueue::getTrack 0 May 12 10:16:55 volumio sudo[2619]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 12 10:16:55 volumio sudo[2619]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 10:16:55 volumio volumio[2441]: info: CoreCommandRouter::volumioGetState May 12 10:16:55 volumio volumio[2441]: info: CorePlayQueue::getTrack 0 May 12 10:16:55 volumio sudo[2619]: pam_unix(sudo:session): session closed for user root May 12 10:16:55 volumio sudo[2622]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 12 10:16:55 volumio sudo[2622]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 10:16:55 volumio sudo[2622]: pam_unix(sudo:session): session closed for user root May 12 10:16:55 volumio volumio[2441]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E7%8E%8B%E8%8F%B2/%E5%A6%82%E6%84%BF/b0606035-8941-4e24-bb3b-b4c6ee039fb8.jpg' May 12 10:16:55 volumio sudo[2637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 12 10:16:55 volumio sudo[2637]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 10:16:55 volumio systemd[1]: Started UPnP Renderer front-end to MPD. May 12 10:16:55 volumio sudo[2637]: pam_unix(sudo:session): session closed for user root May 12 10:16:55 volumio volumio[2441]: info: Upmpdcli Daemon Started May 12 10:16:56 volumio volumio[2441]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium May 12 10:16:56 volumio volumio[2441]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium May 12 10:16:56 volumio volumio[2441]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium May 12 10:16:56 volumio volumio[2441]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium May 12 10:16:56 volumio volumio[2441]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium May 12 10:16:56 volumio volumio[2441]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium May 12 10:16:56 volumio volumio[2441]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium May 12 10:16:56 volumio volumio[2441]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium May 12 10:16:56 volumio volumio[2441]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium May 12 10:16:56 volumio volumio[2441]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium May 12 10:16:56 volumio volumio[2441]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar May 12 10:16:56 volumio volumio[2441]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar May 12 10:16:56 volumio volumio[2441]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar May 12 10:16:56 volumio volumio[2441]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar May 12 10:16:56 volumio volumio[2441]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar May 12 10:16:56 volumio volumio[2441]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar May 12 10:16:56 volumio volumio[2441]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar May 12 10:16:56 volumio volumio[2441]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar May 12 10:16:56 volumio volumio[2441]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar May 12 10:16:56 volumio volumio[2441]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar May 12 10:16:56 volumio volumio[2441]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso May 12 10:16:56 volumio volumio[2441]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso May 12 10:16:56 volumio volumio[2441]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso May 12 10:16:56 volumio volumio[2441]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso May 12 10:16:56 volumio volumio[2441]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso May 12 10:16:56 volumio volumio[2441]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso May 12 10:16:56 volumio volumio[2441]: info: Adding plugin bluetooth to MyMusic Plugins May 12 10:16:56 volumio volumio[2441]: info: Adding plugin cd_controller to MyMusic Plugins May 12 10:16:56 volumio volumio[2441]: info: Adding plugin smart_inputs to MyMusic Plugins May 12 10:16:56 volumio volumio[2441]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... May 12 10:16:56 volumio volumio-remote-updater[591]: [2024-05-12 10:16:56] [connect] Successful connection May 12 10:16:57 volumio wpa_supplicant[967]: wlan0: Failed to initiate sched scan May 12 10:16:59 volumio volumio[2441]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... May 12 10:17:00 volumio volumio[2441]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded May 12 10:17:00 volumio volumio[2441]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio May 12 10:17:00 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 10:17:00 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 10:17:00 volumio volumio[2441]: info: Starting MyVolumio Remote Streaming Endpoints May 12 10:17:00 volumio volumio[2441]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded May 12 10:17:00 volumio volumio[2441]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services May 12 10:17:00 volumio volumio[2441]: info: Streaming services startup May 12 10:17:00 volumio volumio[2441]: info: Starting Streaming Daemon May 12 10:17:00 volumio volumio[2441]: info: MyVolumio not started May 12 10:17:00 volumio volumio[2441]: info: Initializing device activation check May 12 10:17:00 volumio sudo[2651]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 12 10:17:00 volumio sudo[2651]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 10:17:00 volumio volumio[2441]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started May 12 10:17:00 volumio systemd[1]: Stopping Volumio Streaming Daemon... May 12 10:17:00 volumio systemd[1]: Starting Volumio Streaming Daemon... May 12 10:17:00 volumio systemd[1]: Started Volumio Streaming Daemon. May 12 10:17:00 volumio sudo[2651]: pam_unix(sudo:session): session closed for user root May 12 10:17:00 volumio volumio-streaming-daemon[2657]: ############################ May 12 10:17:00 volumio volumio-streaming-daemon[2657]: # Volumio Streaming Daemon # May 12 10:17:00 volumio volumio-streaming-daemon[2657]: # Running on port 7777 # May 12 10:17:00 volumio volumio-streaming-daemon[2657]: ############################ May 12 10:17:00 volumio volumio-streaming-daemon[2657]: Environment: production May 12 10:17:00 volumio volumio[2441]: info: MPD Database updated - AlbumList cache refreshed May 12 10:17:00 volumio volumio[2441]: info: May 12 10:17:00 volumio volumio[2441]: ---------------------------- MPD announces state update: database May 12 10:17:00 volumio volumio[2441]: verbose: ControllerMpd::sendMpdCommand status May 12 10:17:00 volumio volumio[2441]: info: May 12 10:17:00 volumio volumio[2441]: ---------------------------- MPD announces state update: update May 12 10:17:00 volumio volumio[2441]: info: ControllerMpd::getState May 12 10:17:00 volumio volumio[2441]: verbose: ControllerMpd::sendMpdCommand status May 12 10:17:00 volumio volumio[2441]: info: ControllerMpd::getState May 12 10:17:00 volumio volumio[2441]: verbose: ControllerMpd::sendMpdCommand status May 12 10:17:00 volumio sudo[2665]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //undefined/\\WIN-L3PLNSOHSGQ\Music /mnt/NAS/music May 12 10:17:00 volumio volumio-remote-updater[591]: [2024-05-12 10:17:00] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1715509016 101 May 12 10:17:00 volumio sudo[2665]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 10:17:00 volumio volumio[2441]: verbose: ControllerMpd::parseState May 12 10:17:01 volumio sudo[2665]: pam_unix(sudo:session): session closed for user root May 12 10:17:01 volumio volumio[2441]: info: Command Router : Notfying DB Updatetrue May 12 10:17:01 volumio volumio[2441]: verbose: ControllerMpd::parseState May 12 10:17:01 volumio volumio[2441]: verbose: ControllerMpd::parseState May 12 10:17:01 volumio volumio[2441]: info: ControllerMpd::pushState May 12 10:17:01 volumio volumio[2441]: info: CoreCommandRouter::servicePushState May 12 10:17:01 volumio volumio[2441]: info: CoreStateMachine::pushState May 12 10:17:01 volumio volumio[2441]: info: CorePlayQueue::getTrack 0 May 12 10:17:01 volumio volumio[2441]: info: CoreCommandRouter::volumioPushState May 12 10:17:01 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:17:01 volumio volumio[2441]: info: CorePlayQueue::getTrack 0 May 12 10:17:01 volumio volumio[2441]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 12 10:17:01 volumio volumio[2441]: verbose: CURRENT POSITION 0 May 12 10:17:01 volumio volumio[2441]: info: CoreStateMachine::syncState stateService stop May 12 10:17:01 volumio volumio[2441]: info: CoreStateMachine::syncState currentStatus stop May 12 10:17:01 volumio volumio[2441]: info: CoreStateMachine::pushState May 12 10:17:01 volumio volumio[2441]: info: CorePlayQueue::getTrack 0 May 12 10:17:01 volumio volumio[2441]: info: CoreCommandRouter::volumioPushState May 12 10:17:01 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:17:01 volumio volumio[2441]: info: No code May 12 10:17:01 volumio volumio[2441]: info: CoreStateMachine::pushState May 12 10:17:01 volumio volumio[2441]: info: CorePlayQueue::getTrack 0 May 12 10:17:01 volumio volumio[2441]: info: CoreCommandRouter::volumioPushState May 12 10:17:01 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:17:01 volumio volumio[2441]: info: ControllerMpd::pushState May 12 10:17:01 volumio volumio[2441]: info: CoreCommandRouter::servicePushState May 12 10:17:01 volumio volumio[2441]: info: CoreStateMachine::pushState May 12 10:17:01 volumio volumio[2441]: info: CorePlayQueue::getTrack 0 May 12 10:17:01 volumio volumio[2441]: info: CoreCommandRouter::volumioPushState May 12 10:17:01 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:17:01 volumio volumio[2441]: info: CorePlayQueue::getTrack 0 May 12 10:17:01 volumio volumio[2441]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 12 10:17:01 volumio volumio[2441]: verbose: CURRENT POSITION 0 May 12 10:17:01 volumio volumio[2441]: info: CoreStateMachine::syncState stateService stop May 12 10:17:01 volumio volumio[2441]: info: CoreStateMachine::syncState currentStatus stop May 12 10:17:01 volumio volumio[2441]: info: CoreStateMachine::pushState May 12 10:17:01 volumio volumio[2441]: info: CorePlayQueue::getTrack 0 May 12 10:17:01 volumio volumio[2441]: info: CoreCommandRouter::volumioPushState May 12 10:17:01 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:17:01 volumio volumio[2441]: info: No code May 12 10:17:01 volumio volumio[2441]: info: CoreStateMachine::pushState May 12 10:17:01 volumio volumio[2441]: info: CorePlayQueue::getTrack 0 May 12 10:17:01 volumio volumio[2441]: info: CoreCommandRouter::volumioPushState May 12 10:17:01 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:17:01 volumio volumio[2441]: info: ------------------------------ 804ms May 12 10:17:01 volumio volumio[2441]: info: ------------------------------ 805ms May 12 10:17:01 volumio volumio[2441]: info: Cannot mount NAS music at system boot, trial number 2 ,retrying in 5 seconds May 12 10:17:02 volumio volumio[2441]: info: CoreCommandRouter::volumioGetState May 12 10:17:02 volumio volumio[2441]: info: CorePlayQueue::getTrack 0 May 12 10:17:03 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 12 10:17:03 volumio volumio[2441]: info: Listing playlists May 12 10:17:03 volumio volumio[2441]: info: CoreCommandRouter::volumioGetVisibleSources May 12 10:17:03 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 12 10:17:03 volumio volumio[2441]: info: CoreCommandRouter::volumioGetQueue May 12 10:17:03 volumio volumio[2441]: info: CoreStateMachine::getQueue May 12 10:17:03 volumio volumio[2441]: info: CorePlayQueue::getQueue May 12 10:17:03 volumio volumio[2441]: info: CoreCommandRouter::volumioGetState May 12 10:17:03 volumio volumio[2441]: info: CorePlayQueue::getTrack 0 May 12 10:17:03 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 12 10:17:03 volumio volumio[2441]: info: Listing playlists May 12 10:17:03 volumio volumio[2441]: info: CoreCommandRouter::volumioGetVisibleSources May 12 10:17:03 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 12 10:17:03 volumio volumio[2441]: info: CoreCommandRouter::volumioGetQueue May 12 10:17:03 volumio volumio[2441]: info: CoreStateMachine::getQueue May 12 10:17:03 volumio volumio[2441]: info: CorePlayQueue::getQueue May 12 10:17:03 volumio volumio[2441]: info: CoreCommandRouter::volumioGetState May 12 10:17:03 volumio volumio[2441]: info: CorePlayQueue::getTrack 0 May 12 10:17:03 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 12 10:17:03 volumio volumio[2441]: info: Listing playlists May 12 10:17:03 volumio volumio[2441]: info: CoreCommandRouter::volumioGetVisibleSources May 12 10:17:03 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 12 10:17:03 volumio volumio[2441]: info: CoreCommandRouter::volumioGetQueue May 12 10:17:03 volumio volumio[2441]: info: CoreStateMachine::getQueue May 12 10:17:03 volumio volumio[2441]: info: CorePlayQueue::getQueue May 12 10:17:03 volumio volumio-streaming-daemon[2657]: Environment: production May 12 10:17:03 volumio volumio[2441]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E7%8E%8B%E8%8F%B2%20/%E5%A6%82%E6%84%BF/99c48d92-d936-401d-9707-8c528c333241.jpg' May 12 10:17:03 volumio volumio[2441]: info: Fetching Streaming Services browse cache May 12 10:17:03 volumio volumio[2441]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL May 12 10:17:03 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 12 10:17:03 volumio volumio[2441]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ May 12 10:17:03 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 12 10:17:04 volumio volumio[2441]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.834&uuid=fca3d8b8433ae92262c46b4e498d216b" http://updates.volumio.org:7070/downloader-v1/track-device May 12 10:17:04 volumio volumio[2441]: % Total % Received % Xferd Average Speed Time Time Time Current May 12 10:17:04 volumio volumio[2441]: Dload Upload Total Spent Left Speed May 12 10:17:04 volumio volumio[2441]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused May 12 10:17:04 volumio volumio[2441]: retrying in 5 seconds, trial 0 May 12 10:17:04 volumio volumio[2441]: Volumio Calling Home May 12 10:17:05 volumio wpa_supplicant[967]: wlan0: Failed to initiate sched scan May 12 10:17:06 volumio sudo[2695]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //undefined/\\WIN-L3PLNSOHSGQ\Music /mnt/NAS/music May 12 10:17:06 volumio sudo[2695]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 10:17:07 volumio sudo[2695]: pam_unix(sudo:session): session closed for user root May 12 10:17:07 volumio volumio[2441]: info: Cannot mount NAS music at system boot, trial number 3 ,retrying in 5 seconds May 12 10:17:07 volumio volumio[2441]: verbose: ControllerMpd::sendMpdCommand status May 12 10:17:07 volumio volumio[2441]: info: May 12 10:17:07 volumio volumio[2441]: ---------------------------- MPD announces state update: update May 12 10:17:07 volumio volumio[2441]: info: ControllerMpd::getState May 12 10:17:07 volumio volumio[2441]: verbose: ControllerMpd::sendMpdCommand status May 12 10:17:07 volumio volumio[2441]: verbose: ControllerMpd::parseState May 12 10:17:07 volumio volumio[2441]: info: Command Router : Notfying DB Updatefalse May 12 10:17:07 volumio volumio[2441]: info: CoreCommandRouter::Close All Modals sent May 12 10:17:07 volumio volumio[2441]: verbose: ControllerMpd::parseState May 12 10:17:07 volumio volumio[2441]: info: ControllerMpd::pushState May 12 10:17:07 volumio volumio[2441]: info: CoreCommandRouter::servicePushState May 12 10:17:07 volumio volumio[2441]: info: CoreStateMachine::pushState May 12 10:17:07 volumio volumio[2441]: info: CorePlayQueue::getTrack 0 May 12 10:17:07 volumio volumio[2441]: info: CoreCommandRouter::volumioPushState May 12 10:17:07 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:17:07 volumio volumio[2441]: info: CorePlayQueue::getTrack 0 May 12 10:17:07 volumio volumio[2441]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 12 10:17:07 volumio volumio[2441]: verbose: CURRENT POSITION 0 May 12 10:17:07 volumio volumio[2441]: info: CoreStateMachine::syncState stateService stop May 12 10:17:07 volumio volumio[2441]: info: CoreStateMachine::syncState currentStatus stop May 12 10:17:07 volumio volumio[2441]: info: CoreStateMachine::pushState May 12 10:17:07 volumio volumio[2441]: info: CorePlayQueue::getTrack 0 May 12 10:17:07 volumio volumio[2441]: info: CoreCommandRouter::volumioPushState May 12 10:17:07 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:17:07 volumio volumio[2441]: info: No code May 12 10:17:07 volumio volumio[2441]: info: CoreStateMachine::pushState May 12 10:17:07 volumio volumio[2441]: info: CorePlayQueue::getTrack 0 May 12 10:17:07 volumio volumio[2441]: info: CoreCommandRouter::volumioPushState May 12 10:17:07 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:17:07 volumio volumio[2441]: info: ------------------------------ 84ms May 12 10:17:09 volumio volumio[2441]: info: CoreCommandRouter::volumioReplaceandPlayItems May 12 10:17:09 volumio volumio[2441]: info: CoreStateMachine::ClearQueue May 12 10:17:09 volumio volumio[2441]: info: CoreStateMachine::stop May 12 10:17:09 volumio volumio[2441]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 10:17:09 volumio volumio[2441]: UNSET VOLATILE May 12 10:17:09 volumio volumio[2441]: info: CorePlayQueue::clearPlayQueue May 12 10:17:09 volumio volumio[2441]: info: CorePlayQueue::saveQueue May 12 10:17:09 volumio volumio[2441]: info: CoreCommandRouter::volumioPushState May 12 10:17:09 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:17:09 volumio volumio[2441]: info: CoreCommandRouter::volumioPushQueue May 12 10:17:09 volumio volumio[2441]: info: CoreStateMachine::addQueueItems May 12 10:17:09 volumio volumio[2441]: info: CorePlayQueue::addQueueItems May 12 10:17:09 volumio volumio[2441]: info: Adding Item to queue: music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 暗涌.flac May 12 10:17:09 volumio volumio[2441]: info: Exploding uri music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 暗涌.flac in service mpd May 12 10:17:09 volumio volumio[2441]: info: Adding Item to queue: music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 你在终点等我.flac May 12 10:17:09 volumio volumio[2441]: info: Exploding uri music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 你在终点等我.flac in service mpd May 12 10:17:09 volumio volumio[2441]: info: Adding Item to queue: music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 如愿.flac May 12 10:17:09 volumio volumio[2441]: info: Exploding uri music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 如愿.flac in service mpd May 12 10:17:09 volumio volumio[2441]: info: Adding Item to queue: music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 容易受伤的女人（粤语）.flac May 12 10:17:09 volumio volumio[2441]: info: Exploding uri music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 容易受伤的女人（粤语）.flac in service mpd May 12 10:17:09 volumio volumio[2441]: info: Adding Item to queue: music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 岁月.flac May 12 10:17:09 volumio volumio[2441]: info: Exploding uri music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 岁月.flac in service mpd May 12 10:17:09 volumio volumio[2441]: info: Adding Item to queue: music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 我也不想这样.flac May 12 10:17:09 volumio volumio[2441]: info: Exploding uri music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 我也不想这样.flac in service mpd May 12 10:17:09 volumio volumio[2441]: info: Adding Item to queue: music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 我愿意.flac May 12 10:17:09 volumio volumio[2441]: info: Exploding uri music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 我愿意.flac in service mpd May 12 10:17:09 volumio volumio[2441]: info: Adding Item to queue: music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 清风徐来.flac May 12 10:17:09 volumio volumio[2441]: info: Exploding uri music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 清风徐来.flac in service mpd May 12 10:17:09 volumio volumio[2441]: info: Adding Item to queue: music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 百年孤寂.flac May 12 10:17:09 volumio volumio[2441]: info: Exploding uri music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 百年孤寂.flac in service mpd May 12 10:17:09 volumio volumio[2441]: info: Adding Item to queue: music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 矜持.flac May 12 10:17:09 volumio volumio[2441]: info: Exploding uri music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 矜持.flac in service mpd May 12 10:17:09 volumio volumio[2441]: info: Adding Item to queue: music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 笑忘书.flac May 12 10:17:09 volumio volumio[2441]: info: Exploding uri music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 笑忘书.flac in service mpd May 12 10:17:09 volumio volumio[2441]: info: Adding Item to queue: music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 致青春.flac May 12 10:17:09 volumio volumio[2441]: info: Exploding uri music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 致青春.flac in service mpd May 12 10:17:09 volumio volumio[2441]: info: Adding Item to queue: music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲&那英 - 执迷不悔（粤语）.flac May 12 10:17:09 volumio volumio[2441]: info: Exploding uri music-library/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲&那英 - 执迷不悔（粤语）.flac in service mpd May 12 10:17:09 volumio volumio[2441]: info: ALBUMART /albumart?cacheid=969&web=%E7%8E%8B%E8%8F%B2%20/%E5%A6%82%E6%84%BF/extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%20SSD%2F%E5%9B%BD%E5%86%85%2F%E4%BA%BA%E5%A3%B0%2F%E5%A6%82%E6%84%BF-%E7%8E%8B%E8%8F%B2%2F%E7%8E%8B%E8%8F%B2%20%20-%20%E6%9A%97%E6%B6%8C.flac&metadata=false May 12 10:17:09 volumio volumio[2441]: info: URI /mnt/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 暗涌.flac May 12 10:17:09 volumio volumio[2441]: info: ALBUMART /albumart?cacheid=969&web=%E7%8E%8B%E8%8F%B2/%E5%A6%82%E6%84%BF/extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%20SSD%2F%E5%9B%BD%E5%86%85%2F%E4%BA%BA%E5%A3%B0%2F%E5%A6%82%E6%84%BF-%E7%8E%8B%E8%8F%B2%2F%E7%8E%8B%E8%8F%B2%20-%20%E4%BD%A0%E5%9C%A8%E7%BB%88%E7%82%B9%E7%AD%89%E6%88%91.flac&metadata=false May 12 10:17:09 volumio volumio[2441]: info: URI /mnt/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 你在终点等我.flac May 12 10:17:09 volumio volumio[2441]: info: ALBUMART /albumart?cacheid=969&web=%E7%8E%8B%E8%8F%B2/%E5%A6%82%E6%84%BF/extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%20SSD%2F%E5%9B%BD%E5%86%85%2F%E4%BA%BA%E5%A3%B0%2F%E5%A6%82%E6%84%BF-%E7%8E%8B%E8%8F%B2%2F%E7%8E%8B%E8%8F%B2%20-%20%E5%A6%82%E6%84%BF.flac&metadata=false May 12 10:17:09 volumio volumio[2441]: info: URI /mnt/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 如愿.flac May 12 10:17:09 volumio volumio[2441]: info: ALBUMART /albumart?cacheid=969&web=%E7%8E%8B%E8%8F%B2/%E5%A6%82%E6%84%BF/extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%20SSD%2F%E5%9B%BD%E5%86%85%2F%E4%BA%BA%E5%A3%B0%2F%E5%A6%82%E6%84%BF-%E7%8E%8B%E8%8F%B2%2F%E7%8E%8B%E8%8F%B2%20-%20%E5%AE%B9%E6%98%93%E5%8F%97%E4%BC%A4%E7%9A%84%E5%A5%B3%E4%BA%BA%EF%BC%88%E7%B2%A4%E8%AF%AD%EF%BC%89.flac&metadata=false May 12 10:17:09 volumio volumio[2441]: info: URI /mnt/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 容易受伤的女人（粤语）.flac May 12 10:17:09 volumio volumio[2441]: info: ALBUMART /albumart?cacheid=969&web=%E7%8E%8B%E8%8F%B2/%E5%A6%82%E6%84%BF/extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%20SSD%2F%E5%9B%BD%E5%86%85%2F%E4%BA%BA%E5%A3%B0%2F%E5%A6%82%E6%84%BF-%E7%8E%8B%E8%8F%B2%2F%E7%8E%8B%E8%8F%B2%20-%20%E5%B2%81%E6%9C%88.flac&metadata=false May 12 10:17:09 volumio volumio[2441]: info: URI /mnt/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 岁月.flac May 12 10:17:09 volumio volumio[2441]: info: ALBUMART /albumart?cacheid=969&web=%E7%8E%8B%E8%8F%B2/%E5%A6%82%E6%84%BF/extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%20SSD%2F%E5%9B%BD%E5%86%85%2F%E4%BA%BA%E5%A3%B0%2F%E5%A6%82%E6%84%BF-%E7%8E%8B%E8%8F%B2%2F%E7%8E%8B%E8%8F%B2%20-%20%E6%88%91%E4%B9%9F%E4%B8%8D%E6%83%B3%E8%BF%99%E6%A0%B7.flac&metadata=false May 12 10:17:09 volumio volumio[2441]: info: URI /mnt/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 我也不想这样.flac May 12 10:17:09 volumio volumio[2441]: info: ALBUMART /albumart?cacheid=969&web=%E7%8E%8B%E8%8F%B2/%E5%A6%82%E6%84%BF/extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%20SSD%2F%E5%9B%BD%E5%86%85%2F%E4%BA%BA%E5%A3%B0%2F%E5%A6%82%E6%84%BF-%E7%8E%8B%E8%8F%B2%2F%E7%8E%8B%E8%8F%B2%20-%20%E6%88%91%E6%84%BF%E6%84%8F.flac&metadata=false May 12 10:17:09 volumio volumio[2441]: info: URI /mnt/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 我愿意.flac May 12 10:17:09 volumio volumio[2441]: info: ALBUMART /albumart?cacheid=969&web=%E7%8E%8B%E8%8F%B2/%E5%A6%82%E6%84%BF/extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%20SSD%2F%E5%9B%BD%E5%86%85%2F%E4%BA%BA%E5%A3%B0%2F%E5%A6%82%E6%84%BF-%E7%8E%8B%E8%8F%B2%2F%E7%8E%8B%E8%8F%B2%20-%20%E6%B8%85%E9%A3%8E%E5%BE%90%E6%9D%A5.flac&metadata=false May 12 10:17:09 volumio volumio[2441]: info: URI /mnt/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 清风徐来.flac May 12 10:17:09 volumio volumio[2441]: info: ALBUMART /albumart?cacheid=969&web=%E7%8E%8B%E8%8F%B2/%E5%A6%82%E6%84%BF/extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%20SSD%2F%E5%9B%BD%E5%86%85%2F%E4%BA%BA%E5%A3%B0%2F%E5%A6%82%E6%84%BF-%E7%8E%8B%E8%8F%B2%2F%E7%8E%8B%E8%8F%B2%20-%20%E7%99%BE%E5%B9%B4%E5%AD%A4%E5%AF%82.flac&metadata=false May 12 10:17:09 volumio volumio[2441]: info: URI /mnt/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 百年孤寂.flac May 12 10:17:09 volumio volumio[2441]: info: ALBUMART /albumart?cacheid=969&web=%E7%8E%8B%E8%8F%B2/%E5%A6%82%E6%84%BF/extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%20SSD%2F%E5%9B%BD%E5%86%85%2F%E4%BA%BA%E5%A3%B0%2F%E5%A6%82%E6%84%BF-%E7%8E%8B%E8%8F%B2%2F%E7%8E%8B%E8%8F%B2%20-%20%E7%9F%9C%E6%8C%81.flac&metadata=false May 12 10:17:09 volumio volumio[2441]: info: URI /mnt/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 矜持.flac May 12 10:17:09 volumio volumio[2441]: info: ALBUMART /albumart?cacheid=969&web=%E7%8E%8B%E8%8F%B2/%E5%A6%82%E6%84%BF/extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%20SSD%2F%E5%9B%BD%E5%86%85%2F%E4%BA%BA%E5%A3%B0%2F%E5%A6%82%E6%84%BF-%E7%8E%8B%E8%8F%B2%2F%E7%8E%8B%E8%8F%B2%20-%20%E7%AC%91%E5%BF%98%E4%B9%A6.flac&metadata=false May 12 10:17:09 volumio volumio[2441]: info: URI /mnt/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 笑忘书.flac May 12 10:17:09 volumio volumio[2441]: info: ALBUMART /albumart?cacheid=969&web=%E7%8E%8B%E8%8F%B2/%E5%A6%82%E6%84%BF/extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%20SSD%2F%E5%9B%BD%E5%86%85%2F%E4%BA%BA%E5%A3%B0%2F%E5%A6%82%E6%84%BF-%E7%8E%8B%E8%8F%B2%2F%E7%8E%8B%E8%8F%B2%20-%20%E8%87%B4%E9%9D%92%E6%98%A5.flac&metadata=false May 12 10:17:09 volumio volumio[2441]: info: URI /mnt/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 致青春.flac May 12 10:17:09 volumio volumio[2441]: info: ALBUMART /albumart?cacheid=969&web=%E7%8E%8B%E8%8F%B2%26%E9%82%A3%E8%8B%B1/%E5%A6%82%E6%84%BF/extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%20SSD%2F%E5%9B%BD%E5%86%85%2F%E4%BA%BA%E5%A3%B0%2F%E5%A6%82%E6%84%BF-%E7%8E%8B%E8%8F%B2%2F%E7%8E%8B%E8%8F%B2%26%E9%82%A3%E8%8B%B1%20-%20%E6%89%A7%E8%BF%B7%E4%B8%8D%E6%82%94%EF%BC%88%E7%B2%A4%E8%AF%AD%EF%BC%89.flac&metadata=false May 12 10:17:09 volumio volumio[2441]: info: URI /mnt/USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲&那英 - 执迷不悔（粤语）.flac May 12 10:17:09 volumio volumio[2441]: info: CorePlayQueue::saveQueue May 12 10:17:09 volumio volumio[2441]: info: CoreCommandRouter::volumioPushQueue May 12 10:17:09 volumio volumio[2441]: info: CoreStateMachine::updateTrackBlock May 12 10:17:09 volumio volumio[2441]: info: CorePlayQueue::getTrackBlock May 12 10:17:09 volumio volumio[2441]: info: CoreCommandRouter::volumioPlay May 12 10:17:09 volumio volumio[2441]: UNSET VOLATILE May 12 10:17:09 volumio volumio[2441]: info: CoreStateMachine::play index 2 May 12 10:17:09 volumio volumio[2441]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 10:17:09 volumio volumio[2441]: info: CoreStateMachine::stop May 12 10:17:09 volumio volumio[2441]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 10:17:09 volumio volumio[2441]: UNSET VOLATILE May 12 10:17:09 volumio volumio[2441]: info: CoreStateMachine::play index undefined May 12 10:17:09 volumio volumio[2441]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 10:17:09 volumio volumio[2441]: info: CorePlayQueue::getTrack 2 May 12 10:17:09 volumio volumio[2441]: info: CoreStateMachine::startPlaybackTimer May 12 10:17:09 volumio volumio[2441]: info: CorePlayQueue::getTrack 2 May 12 10:17:09 volumio volumio[2441]: verbose: ControllerMpd::clearAddPlayTracks USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 如愿.flac May 12 10:17:09 volumio volumio[2441]: verbose: ControllerMpd::sendMpdCommand stop May 12 10:17:09 volumio volumio[2441]: verbose: ControllerMpd::sendMpdCommand clear May 12 10:17:09 volumio volumio[2441]: info: May 12 10:17:09 volumio volumio[2441]: ---------------------------- MPD announces system playlist update May 12 10:17:09 volumio volumio[2441]: info: Ignoring MPD Status Update May 12 10:17:09 volumio volumio[2441]: verbose: ControllerMpd::sendMpdCommand add "USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 如愿.flac" May 12 10:17:09 volumio volumio[2441]: error: updateQueue error: null May 12 10:17:09 volumio volumio[2441]: info: May 12 10:17:09 volumio volumio[2441]: ---------------------------- MPD announces system playlist update May 12 10:17:09 volumio volumio[2441]: info: Ignoring MPD Status Update May 12 10:17:09 volumio volumio[2441]: info: ------------------------------ 5ms May 12 10:17:09 volumio volumio[2441]: verbose: ControllerMpd::sendMpdCommand play May 12 10:17:09 volumio volumio[2441]: info: ------------------------------ 7ms May 12 10:17:09 volumio volumio[2441]: info: May 12 10:17:09 volumio volumio[2441]: ---------------------------- MPD announces state update: player May 12 10:17:09 volumio volumio[2441]: info: ControllerMpd::getState May 12 10:17:09 volumio volumio[2441]: verbose: ControllerMpd::sendMpdCommand status May 12 10:17:09 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 May 12 10:17:09 volumio volumio[2441]: info: May 12 10:17:09 volumio volumio[2441]: ---------------------------- MPD announces state update: player May 12 10:17:09 volumio volumio[2441]: info: ControllerMpd::getState May 12 10:17:09 volumio volumio[2441]: verbose: ControllerMpd::sendMpdCommand status May 12 10:17:09 volumio volumio[2441]: verbose: ControllerMpd::parseState May 12 10:17:09 volumio volumio[2441]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 10:17:09 volumio volumio[2441]: verbose: ControllerMpd::parseState May 12 10:17:09 volumio volumio[2441]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 10:17:09 volumio volumio[2441]: verbose: ControllerMpd::parseTrackInfo May 12 10:17:09 volumio volumio[2441]: info: ControllerMpd::pushState May 12 10:17:09 volumio volumio[2441]: info: CoreCommandRouter::servicePushState May 12 10:17:09 volumio volumio[2441]: info: CorePlayQueue::getTrack 2 May 12 10:17:09 volumio volumio[2441]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":264,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"300 Kbps","isStreaming":false,"title":"如愿","artist":"王菲","album":"如愿","uri":"USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 如愿.flac","trackType":"flac"} May 12 10:17:09 volumio volumio[2441]: verbose: CURRENT POSITION 2 May 12 10:17:09 volumio volumio[2441]: info: CoreStateMachine::syncState stateService play May 12 10:17:09 volumio volumio[2441]: info: CoreStateMachine::syncState currentStatus stop May 12 10:17:09 volumio volumio[2441]: info: CoreStateMachine::pushState May 12 10:17:09 volumio volumio[2441]: info: CorePlayQueue::getTrack 2 May 12 10:17:09 volumio volumio[2441]: info: CoreCommandRouter::volumioPushState May 12 10:17:09 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:17:09 volumio volumio[2441]: info: ------------------------------ 47ms May 12 10:17:09 volumio volumio[2441]: verbose: ControllerMpd::parseTrackInfo May 12 10:17:09 volumio volumio[2441]: info: ControllerMpd::pushState May 12 10:17:09 volumio volumio[2441]: info: CoreCommandRouter::servicePushState May 12 10:17:09 volumio volumio[2441]: info: CorePlayQueue::getTrack 2 May 12 10:17:09 volumio volumio[2441]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":264,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"308 Kbps","isStreaming":false,"title":"如愿","artist":"王菲","album":"如愿","uri":"USB/TOSHIBA SSD/国内/人声/如愿-王菲/王菲 - 如愿.flac","trackType":"flac"} May 12 10:17:09 volumio volumio[2441]: verbose: CURRENT POSITION 2 May 12 10:17:09 volumio volumio[2441]: info: CoreStateMachine::syncState stateService play May 12 10:17:09 volumio volumio[2441]: info: CoreStateMachine::syncState currentStatus play May 12 10:17:09 volumio volumio[2441]: info: Received an update from plugin. extracting info from payload May 12 10:17:09 volumio volumio[2441]: info: CoreStateMachine::pushState May 12 10:17:09 volumio volumio[2441]: info: CorePlayQueue::getTrack 2 May 12 10:17:09 volumio volumio[2441]: info: CoreCommandRouter::volumioPushState May 12 10:17:09 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:17:09 volumio volumio[2441]: info: CoreStateMachine::pushState May 12 10:17:09 volumio volumio[2441]: info: CorePlayQueue::getTrack 2 May 12 10:17:09 volumio volumio[2441]: info: CoreCommandRouter::volumioPushState May 12 10:17:09 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 10:17:09 volumio volumio[2441]: info: ------------------------------ 46ms May 12 10:17:09 volumio volumio[2441]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E7%8E%8B%E8%8F%B2/%E5%A6%82%E6%84%BF/b0606035-8941-4e24-bb3b-b4c6ee039fb8.jpg' May 12 10:17:09 volumio volumio[2441]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E7%8E%8B%E8%8F%B2/%E5%A6%82%E6%84%BF/b0606035-8941-4e24-bb3b-b4c6ee039fb8.jpg' May 12 10:17:12 volumio sudo[2720]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //undefined/\\WIN-L3PLNSOHSGQ\Music /mnt/NAS/music May 12 10:17:12 volumio sudo[2720]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 10:17:12 volumio sudo[2720]: pam_unix(sudo:session): session closed for user root May 12 10:17:12 volumio volumio[2441]: info: Cannot mount NAS music at system boot, trial number 4 ,retrying in 5 seconds May 12 10:17:12 volumio wpa_supplicant[967]: wlan0: Failed to initiate sched scan May 12 10:17:14 volumio volumio[2441]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.834&uuid=fca3d8b8433ae92262c46b4e498d216b" http://updates.volumio.org:7070/downloader-v1/track-device May 12 10:17:14 volumio volumio[2441]: % Total % Received % Xferd Average Speed Time Time Time Current May 12 10:17:14 volumio volumio[2441]: Dload Upload Total Spent Left Speed May 12 10:17:14 volumio volumio[2441]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused May 12 10:17:14 volumio volumio[2441]: retrying in 5 seconds, trial 1 May 12 10:17:14 volumio volumio[2441]: Volumio Calling Home May 12 10:17:17 volumio sudo[2744]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //undefined/\\WIN-L3PLNSOHSGQ\Music /mnt/NAS/music May 12 10:17:17 volumio sudo[2744]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 10:17:17 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 12 10:17:17 volumio volumio[2441]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 10:17:18 volumio sudo[2744]: pam_unix(sudo:session): session closed for user root May 12 10:17:18 volumio volumio[2441]: info: Cannot mount NAS at system boot, trial number 4 ,stopping May 12 10:17:20 volumio wpa_supplicant[967]: wlan0: Failed to initiate sched scan May 12 10:17:24 volumio volumio[2441]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.834&uuid=fca3d8b8433ae92262c46b4e498d216b" http://updates.volumio.org:7070/downloader-v1/track-device May 12 10:17:24 volumio volumio[2441]: % Total % Received % Xferd Average Speed Time Time Time Current May 12 10:17:24 volumio volumio[2441]: Dload Upload Total Spent Left Speed May 12 10:17:24 volumio volumio[2441]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused May 12 10:17:24 volumio volumio[2441]: retrying in 5 seconds, trial 2 May 12 10:17:24 volumio volumio[2441]: Volumio Calling Home May 12 10:17:27 volumio wpa_supplicant[967]: wlan0: Failed to initiate sched scan May 12 10:17:28 volumio volumio[2441]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 12 10:17:28 volumio volumio[2441]: { Error: connect ETIMEDOUT 205.186.152.122:443 May 12 10:17:28 volumio volumio[2441]: at Object._errnoException (util.js:1022:11) May 12 10:17:28 volumio volumio[2441]: at _exceptionWithHostPort (util.js:1044:20) May 12 10:17:28 volumio volumio[2441]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) May 12 10:17:28 volumio volumio[2441]: code: 'ETIMEDOUT', May 12 10:17:28 volumio volumio[2441]: errno: 'ETIMEDOUT', May 12 10:17:28 volumio volumio[2441]: syscall: 'connect', May 12 10:17:28 volumio volumio[2441]: address: '205.186.152.122', May 12 10:17:28 volumio volumio[2441]: port: 443 } May 12 10:17:28 volumio volumio[2441]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 12 10:17:29 volumio sudo[2804]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-12 10:16 May 12 10:17:29 volumio sudo[2804]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="74e4cc9de715c64d553d35948d017f973a622b6d" VOLUMIO_FE_VERSION="2be6c28eb9de74ec1f9662ca333f7bd51a232c33" VOLUMIO_BE_VERSION="259a7f2894e1376413ffac331be84e0e9a6173dd" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Sep 24 22:42:43 CEST 2020" VOLUMIO_VERSION="2.834" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="e41ef0f29aa50c1af109d3064a380c69"