-- Logs begin at Sat 2024-07-13 16:07:39 UTC, end at Sat 2024-07-13 16:12:59 UTC. -- Jul 13 16:11:18 volumio volumio[837]: Searching plugin music_service/mpd Jul 13 16:11:18 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jul 13 16:11:18 volumio volumio[837]: info: All search sources collected, pushing search results Jul 13 16:11:28 volumio volumio[837]: info: Preload queue cleared Jul 13 16:11:28 volumio volumio[837]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::ClearQueue Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::stop Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 13 16:11:28 volumio volumio[837]: info: CorePlayQueue::clearPlayQueue Jul 13 16:11:28 volumio volumio[837]: info: CorePlayQueue::saveQueue Jul 13 16:11:28 volumio volumio[837]: info: CoreCommandRouter::volumioPushQueue Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::addQueueItems Jul 13 16:11:28 volumio volumio[837]: info: CorePlayQueue::addQueueItems Jul 13 16:11:28 volumio volumio[837]: info: Preload queue cleared Jul 13 16:11:28 volumio volumio[837]: info: Adding Item to queue: music-library/NAS/NAS123/susan说发烧/群星 - 01.SUSAN说.flac Jul 13 16:11:28 volumio volumio[837]: info: Exploding uri music-library/NAS/NAS123/susan说发烧/群星 - 01.SUSAN说.flac in service mpd Jul 13 16:11:28 volumio volumio[837]: info: Adding Item to queue: music-library/NAS/NAS123/susan说发烧/群星 - 02.Some OneLike You.flac Jul 13 16:11:28 volumio volumio[837]: info: Exploding uri music-library/NAS/NAS123/susan说发烧/群星 - 02.Some OneLike You.flac in service mpd Jul 13 16:11:28 volumio volumio[837]: info: Adding Item to queue: music-library/NAS/NAS123/susan说发烧/群星 - 03.兰花花.flac Jul 13 16:11:28 volumio volumio[837]: info: Exploding uri music-library/NAS/NAS123/susan说发烧/群星 - 03.兰花花.flac in service mpd Jul 13 16:11:28 volumio volumio[837]: info: Adding Item to queue: music-library/NAS/NAS123/susan说发烧/群星 - 04.空中漫步.flac Jul 13 16:11:28 volumio volumio[837]: info: Exploding uri music-library/NAS/NAS123/susan说发烧/群星 - 04.空中漫步.flac in service mpd Jul 13 16:11:28 volumio volumio[837]: info: Adding Item to queue: music-library/NAS/NAS123/susan说发烧/群星 - 05.有谁知我此时情.flac Jul 13 16:11:28 volumio volumio[837]: info: Exploding uri music-library/NAS/NAS123/susan说发烧/群星 - 05.有谁知我此时情.flac in service mpd Jul 13 16:11:28 volumio volumio[837]: info: Adding Item to queue: music-library/NAS/NAS123/susan说发烧/群星 - 07.望春风.flac Jul 13 16:11:28 volumio volumio[837]: info: Exploding uri music-library/NAS/NAS123/susan说发烧/群星 - 07.望春风.flac in service mpd Jul 13 16:11:28 volumio volumio[837]: info: Adding Item to queue: music-library/NAS/NAS123/susan说发烧/群星 - 08.归航.flac Jul 13 16:11:28 volumio volumio[837]: info: Exploding uri music-library/NAS/NAS123/susan说发烧/群星 - 08.归航.flac in service mpd Jul 13 16:11:28 volumio volumio[837]: info: Adding Item to queue: music-library/NAS/NAS123/susan说发烧/群星 - 09.情海.flac Jul 13 16:11:28 volumio volumio[837]: info: Exploding uri music-library/NAS/NAS123/susan说发烧/群星 - 09.情海.flac in service mpd Jul 13 16:11:28 volumio volumio[837]: info: Adding Item to queue: music-library/NAS/NAS123/susan说发烧/群星 - 10.月满西楼.flac Jul 13 16:11:28 volumio volumio[837]: info: Exploding uri music-library/NAS/NAS123/susan说发烧/群星 - 10.月满西楼.flac in service mpd Jul 13 16:11:28 volumio volumio[837]: info: Adding Item to queue: music-library/NAS/NAS123/susan说发烧/群星 - 11.痴痴地等.flac Jul 13 16:11:28 volumio volumio[837]: info: Exploding uri music-library/NAS/NAS123/susan说发烧/群星 - 11.痴痴地等.flac in service mpd Jul 13 16:11:28 volumio volumio[837]: info: Adding Item to queue: music-library/NAS/NAS123/susan说发烧/群星 - 12.Donna Donna.flac Jul 13 16:11:28 volumio volumio[837]: info: Exploding uri music-library/NAS/NAS123/susan说发烧/群星 - 12.Donna Donna.flac in service mpd Jul 13 16:11:28 volumio volumio[837]: info: Adding Item to queue: music-library/NAS/NAS123/susan说发烧/群星 - 13.黄莺树上声声唱.flac Jul 13 16:11:28 volumio volumio[837]: info: Exploding uri music-library/NAS/NAS123/susan说发烧/群星 - 13.黄莺树上声声唱.flac in service mpd Jul 13 16:11:28 volumio volumio[837]: info: Adding Item to queue: music-library/NAS/NAS123/susan说发烧/群星 - 14.思乡愁.flac Jul 13 16:11:28 volumio volumio[837]: info: Exploding uri music-library/NAS/NAS123/susan说发烧/群星 - 14.思乡愁.flac in service mpd Jul 13 16:11:28 volumio volumio[837]: info: ALBUMART /albumart?cacheid=539&web=%E7%BE%A4%E6%98%9F/%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A715/extralarge&path=%2Fmnt%2FNAS%2FNAS123%2Fsusan%E8%AF%B4%E5%8F%91%E7%83%A7%2F%E7%BE%A4%E6%98%9F%20-%2001.SUSAN%E8%AF%B4.flac&metadata=false Jul 13 16:11:28 volumio volumio[837]: info: URI /mnt/NAS/NAS123/susan说发烧/群星 - 01.SUSAN说.flac Jul 13 16:11:28 volumio volumio[837]: info: ALBUMART /albumart?cacheid=539&web=%E7%BE%A4%E6%98%9F/%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A715/extralarge&path=%2Fmnt%2FNAS%2FNAS123%2Fsusan%E8%AF%B4%E5%8F%91%E7%83%A7%2F%E7%BE%A4%E6%98%9F%20-%2002.Some%20OneLike%20You.flac&metadata=false Jul 13 16:11:28 volumio volumio[837]: info: URI /mnt/NAS/NAS123/susan说发烧/群星 - 02.Some OneLike You.flac Jul 13 16:11:28 volumio volumio[837]: info: ALBUMART /albumart?cacheid=539&web=%E7%BE%A4%E6%98%9F/%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A715/extralarge&path=%2Fmnt%2FNAS%2FNAS123%2Fsusan%E8%AF%B4%E5%8F%91%E7%83%A7%2F%E7%BE%A4%E6%98%9F%20-%2003.%E5%85%B0%E8%8A%B1%E8%8A%B1.flac&metadata=false Jul 13 16:11:28 volumio volumio[837]: info: URI /mnt/NAS/NAS123/susan说发烧/群星 - 03.兰花花.flac Jul 13 16:11:28 volumio volumio[837]: info: ALBUMART /albumart?cacheid=539&web=%E7%BE%A4%E6%98%9F/%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A715/extralarge&path=%2Fmnt%2FNAS%2FNAS123%2Fsusan%E8%AF%B4%E5%8F%91%E7%83%A7%2F%E7%BE%A4%E6%98%9F%20-%2004.%E7%A9%BA%E4%B8%AD%E6%BC%AB%E6%AD%A5.flac&metadata=false Jul 13 16:11:28 volumio volumio[837]: info: URI /mnt/NAS/NAS123/susan说发烧/群星 - 04.空中漫步.flac Jul 13 16:11:28 volumio volumio[837]: info: ALBUMART /albumart?cacheid=539&web=%E7%BE%A4%E6%98%9F/%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A715/extralarge&path=%2Fmnt%2FNAS%2FNAS123%2Fsusan%E8%AF%B4%E5%8F%91%E7%83%A7%2F%E7%BE%A4%E6%98%9F%20-%2005.%E6%9C%89%E8%B0%81%E7%9F%A5%E6%88%91%E6%AD%A4%E6%97%B6%E6%83%85.flac&metadata=false Jul 13 16:11:28 volumio volumio[837]: info: URI /mnt/NAS/NAS123/susan说发烧/群星 - 05.有谁知我此时情.flac Jul 13 16:11:28 volumio volumio[837]: info: ALBUMART /albumart?cacheid=539&web=%E7%BE%A4%E6%98%9F/%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A715/extralarge&path=%2Fmnt%2FNAS%2FNAS123%2Fsusan%E8%AF%B4%E5%8F%91%E7%83%A7%2F%E7%BE%A4%E6%98%9F%20-%2007.%E6%9C%9B%E6%98%A5%E9%A3%8E.flac&metadata=false Jul 13 16:11:28 volumio volumio[837]: info: URI /mnt/NAS/NAS123/susan说发烧/群星 - 07.望春风.flac Jul 13 16:11:28 volumio volumio[837]: info: ALBUMART /albumart?cacheid=539&web=%E7%BE%A4%E6%98%9F/%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A715/extralarge&path=%2Fmnt%2FNAS%2FNAS123%2Fsusan%E8%AF%B4%E5%8F%91%E7%83%A7%2F%E7%BE%A4%E6%98%9F%20-%2008.%E5%BD%92%E8%88%AA.flac&metadata=false Jul 13 16:11:28 volumio volumio[837]: info: URI /mnt/NAS/NAS123/susan说发烧/群星 - 08.归航.flac Jul 13 16:11:28 volumio volumio[837]: info: ALBUMART /albumart?cacheid=539&web=%E7%BE%A4%E6%98%9F/%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A715/extralarge&path=%2Fmnt%2FNAS%2FNAS123%2Fsusan%E8%AF%B4%E5%8F%91%E7%83%A7%2F%E7%BE%A4%E6%98%9F%20-%2009.%E6%83%85%E6%B5%B7.flac&metadata=false Jul 13 16:11:28 volumio volumio[837]: info: URI /mnt/NAS/NAS123/susan说发烧/群星 - 09.情海.flac Jul 13 16:11:28 volumio volumio[837]: info: ALBUMART /albumart?cacheid=539&web=%E7%BE%A4%E6%98%9F/%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A715/extralarge&path=%2Fmnt%2FNAS%2FNAS123%2Fsusan%E8%AF%B4%E5%8F%91%E7%83%A7%2F%E7%BE%A4%E6%98%9F%20-%2010.%E6%9C%88%E6%BB%A1%E8%A5%BF%E6%A5%BC.flac&metadata=false Jul 13 16:11:28 volumio volumio[837]: info: URI /mnt/NAS/NAS123/susan说发烧/群星 - 10.月满西楼.flac Jul 13 16:11:28 volumio volumio[837]: info: ALBUMART /albumart?cacheid=539&web=%E7%BE%A4%E6%98%9F/%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A715/extralarge&path=%2Fmnt%2FNAS%2FNAS123%2Fsusan%E8%AF%B4%E5%8F%91%E7%83%A7%2F%E7%BE%A4%E6%98%9F%20-%2011.%E7%97%B4%E7%97%B4%E5%9C%B0%E7%AD%89.flac&metadata=false Jul 13 16:11:28 volumio volumio[837]: info: URI /mnt/NAS/NAS123/susan说发烧/群星 - 11.痴痴地等.flac Jul 13 16:11:28 volumio volumio[837]: info: ALBUMART /albumart?cacheid=539&web=%E7%BE%A4%E6%98%9F/%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A715/extralarge&path=%2Fmnt%2FNAS%2FNAS123%2Fsusan%E8%AF%B4%E5%8F%91%E7%83%A7%2F%E7%BE%A4%E6%98%9F%20-%2012.Donna%20Donna.flac&metadata=false Jul 13 16:11:28 volumio volumio[837]: info: URI /mnt/NAS/NAS123/susan说发烧/群星 - 12.Donna Donna.flac Jul 13 16:11:28 volumio volumio[837]: info: ALBUMART /albumart?cacheid=539&web=%E7%BE%A4%E6%98%9F/%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A715/extralarge&path=%2Fmnt%2FNAS%2FNAS123%2Fsusan%E8%AF%B4%E5%8F%91%E7%83%A7%2F%E7%BE%A4%E6%98%9F%20-%2013.%E9%BB%84%E8%8E%BA%E6%A0%91%E4%B8%8A%E5%A3%B0%E5%A3%B0%E5%94%B1.flac&metadata=false Jul 13 16:11:28 volumio volumio[837]: info: URI /mnt/NAS/NAS123/susan说发烧/群星 - 13.黄莺树上声声唱.flac Jul 13 16:11:28 volumio volumio[837]: info: ALBUMART /albumart?cacheid=539&web=%E7%BE%A4%E6%98%9F/%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A715/extralarge&path=%2Fmnt%2FNAS%2FNAS123%2Fsusan%E8%AF%B4%E5%8F%91%E7%83%A7%2F%E7%BE%A4%E6%98%9F%20-%2014.%E6%80%9D%E4%B9%A1%E6%84%81.flac&metadata=false Jul 13 16:11:28 volumio volumio[837]: info: URI /mnt/NAS/NAS123/susan说发烧/群星 - 14.思乡愁.flac Jul 13 16:11:28 volumio volumio[837]: info: CoreCommandRouter::volumioPushQueue Jul 13 16:11:28 volumio volumio[837]: info: CorePlayQueue::saveQueue Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::updateTrackBlock Jul 13 16:11:28 volumio volumio[837]: info: CorePlayQueue::getTrackBlock Jul 13 16:11:28 volumio volumio[837]: info: CoreCommandRouter::volumioPlay Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::play index 12 Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::stop Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::play index undefined Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 13 16:11:28 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::startPlaybackTimer Jul 13 16:11:28 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS123/susan说发烧/群星 - 14.思乡愁.flac Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand stop Jul 13 16:11:28 volumio volumio[837]: info: sendMpdCommand stop took 3 milliseconds Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand clear Jul 13 16:11:28 volumio volumio[837]: info: Jul 13 16:11:28 volumio volumio[837]: ---------------------------- MPD announces system playlist update Jul 13 16:11:28 volumio volumio[837]: info: Ignoring MPD Status Update Jul 13 16:11:28 volumio volumio[837]: info: sendMpdCommand clear took 6 milliseconds Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS123/susan说发烧/群星 - 14.思乡愁.flac" Jul 13 16:11:28 volumio volumio[837]: info: Jul 13 16:11:28 volumio volumio[837]: ---------------------------- MPD announces system playlist update Jul 13 16:11:28 volumio volumio[837]: info: Ignoring MPD Status Update Jul 13 16:11:28 volumio volumio[837]: info: Jul 13 16:11:28 volumio volumio[837]: ---------------------------- MPD announces system playlist update Jul 13 16:11:28 volumio volumio[837]: info: Ignoring MPD Status Update Jul 13 16:11:28 volumio volumio[837]: error: updateQueue error: null Jul 13 16:11:28 volumio volumio[837]: info: Jul 13 16:11:28 volumio volumio[837]: ---------------------------- MPD announces system playlist update Jul 13 16:11:28 volumio volumio[837]: info: Ignoring MPD Status Update Jul 13 16:11:28 volumio volumio[837]: info: ------------------------------ 22ms Jul 13 16:11:28 volumio volumio[837]: info: sendMpdCommand add "NAS/NAS123/susan说发烧/群星 - 14.思乡愁.flac" took 19 milliseconds Jul 13 16:11:28 volumio volumio[837]: info: ------------------------------ 13ms Jul 13 16:11:28 volumio volumio[837]: info: ------------------------------ 10ms Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand play Jul 13 16:11:28 volumio volumio[837]: info: Jul 13 16:11:28 volumio volumio[837]: ---------------------------- MPD announces system playlist update Jul 13 16:11:28 volumio volumio[837]: info: Ignoring MPD Status Update Jul 13 16:11:28 volumio volumio[837]: info: Jul 13 16:11:28 volumio volumio[837]: ---------------------------- MPD announces system playlist update Jul 13 16:11:28 volumio volumio[837]: info: Ignoring MPD Status Update Jul 13 16:11:28 volumio volumio[837]: error: Upnp client error: Error: This socket has been ended by the other party Jul 13 16:11:28 volumio volumio[837]: info: ------------------------------ 23ms Jul 13 16:11:28 volumio volumio[837]: info: sendMpdCommand play took 19 milliseconds Jul 13 16:11:28 volumio volumio[837]: info: ------------------------------ 18ms Jul 13 16:11:28 volumio volumio[837]: info: ------------------------------ 16ms Jul 13 16:11:28 volumio volumio[837]: info: Jul 13 16:11:28 volumio volumio[837]: ---------------------------- MPD announces state update: player Jul 13 16:11:28 volumio volumio[837]: info: ControllerMpd::getState Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Jul 13 16:11:28 volumio volumio[837]: info: Jul 13 16:11:28 volumio volumio[837]: ---------------------------- MPD announces state update: player Jul 13 16:11:28 volumio volumio[837]: info: ControllerMpd::getState Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Jul 13 16:11:28 volumio volumio[837]: info: Jul 13 16:11:28 volumio volumio[837]: ---------------------------- MPD announces state update: player Jul 13 16:11:28 volumio volumio[837]: info: ControllerMpd::getState Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Jul 13 16:11:28 volumio volumio[837]: info: Jul 13 16:11:28 volumio volumio[837]: ---------------------------- MPD announces state update: player Jul 13 16:11:28 volumio volumio[837]: info: ControllerMpd::getState Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 13 16:11:28 volumio volumio[837]: info: sendMpdCommand status took 26 milliseconds Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 13 16:11:28 volumio volumio[837]: info: sendMpdCommand status took 24 milliseconds Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 13 16:11:28 volumio volumio[837]: info: sendMpdCommand status took 24 milliseconds Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::parseState Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::parseState Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::parseState Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 13 16:11:28 volumio volumio[837]: info: Jul 13 16:11:28 volumio volumio[837]: ---------------------------- MPD announces state update: player Jul 13 16:11:28 volumio volumio[837]: info: ControllerMpd::getState Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Jul 13 16:11:28 volumio volumio[837]: info: Jul 13 16:11:28 volumio volumio[837]: ---------------------------- MPD announces state update: player Jul 13 16:11:28 volumio volumio[837]: info: ControllerMpd::getState Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand clearerror Jul 13 16:11:28 volumio volumio[837]: info: sendMpdCommand status took 75 milliseconds Jul 13 16:11:28 volumio volumio[837]: info: sendMpdCommand clearerror took 63 milliseconds Jul 13 16:11:28 volumio volumio[837]: info: sendMpdCommand clearerror took 60 milliseconds Jul 13 16:11:28 volumio volumio[837]: info: sendMpdCommand clearerror took 58 milliseconds Jul 13 16:11:28 volumio volumio[837]: info: sendMpdCommand playlistinfo took 38 milliseconds Jul 13 16:11:28 volumio volumio[837]: info: sendMpdCommand playlistinfo took 37 milliseconds Jul 13 16:11:28 volumio volumio[837]: info: sendMpdCommand playlistinfo took 35 milliseconds Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::parseState Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Jul 13 16:11:28 volumio volumio[837]: info: ControllerMpd::pushState Jul 13 16:11:28 volumio volumio[837]: info: CoreCommandRouter::servicePushState Jul 13 16:11:28 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:28 volumio volumio[837]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"思乡愁","artist":"群星","album":"绝对发烧15","uri":"NAS/NAS123/susan说发烧/群星 - 14.思乡愁.flac","trackType":"flac"} Jul 13 16:11:28 volumio volumio[837]: verbose: CURRENT POSITION 12 Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::syncState stateService pause Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus stop Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::pushState Jul 13 16:11:28 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:28 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 13 16:11:28 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Jul 13 16:11:28 volumio volumio[837]: info: ControllerMpd::pushState Jul 13 16:11:28 volumio volumio[837]: info: CoreCommandRouter::servicePushState Jul 13 16:11:28 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:28 volumio volumio[837]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"思乡愁","artist":"群星","album":"绝对发烧15","uri":"NAS/NAS123/susan说发烧/群星 - 14.思乡愁.flac","trackType":"flac"} Jul 13 16:11:28 volumio volumio[837]: verbose: CURRENT POSITION 12 Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::syncState stateService pause Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus stop Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::pushState Jul 13 16:11:28 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:28 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Jul 13 16:11:28 volumio volumio[837]: info: ControllerMpd::pushState Jul 13 16:11:28 volumio volumio[837]: info: CoreCommandRouter::servicePushState Jul 13 16:11:28 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:28 volumio volumio[837]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"思乡愁","artist":"群星","album":"绝对发烧15","uri":"NAS/NAS123/susan说发烧/群星 - 14.思乡愁.flac","trackType":"flac"} Jul 13 16:11:28 volumio volumio[837]: verbose: CURRENT POSITION 12 Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::syncState stateService pause Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus stop Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::pushState Jul 13 16:11:28 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:28 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Jul 13 16:11:28 volumio volumio[837]: info: ------------------------------ 263ms Jul 13 16:11:28 volumio volumio[837]: info: ------------------------------ 253ms Jul 13 16:11:28 volumio volumio[837]: info: ------------------------------ 250ms Jul 13 16:11:28 volumio volumio[837]: info: sendMpdCommand status took 220 milliseconds Jul 13 16:11:28 volumio volumio[837]: info: sendMpdCommand status took 218 milliseconds Jul 13 16:11:28 volumio volumio[837]: info: sendMpdCommand clearerror took 205 milliseconds Jul 13 16:11:28 volumio volumio[837]: info: sendMpdCommand playlistinfo took 192 milliseconds Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::parseState Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::parseState Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Jul 13 16:11:28 volumio volumio[837]: info: ControllerMpd::pushState Jul 13 16:11:28 volumio volumio[837]: info: CoreCommandRouter::servicePushState Jul 13 16:11:28 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:28 volumio volumio[837]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"思乡愁","artist":"群星","album":"绝对发烧15","uri":"NAS/NAS123/susan说发烧/群星 - 14.思乡愁.flac","trackType":"flac"} Jul 13 16:11:28 volumio volumio[837]: verbose: CURRENT POSITION 12 Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::syncState stateService pause Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus stop Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::pushState Jul 13 16:11:28 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:28 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 13 16:11:28 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Jul 13 16:11:28 volumio volumio[837]: info: ------------------------------ 317ms Jul 13 16:11:28 volumio volumio[837]: info: sendMpdCommand playlistinfo took 34 milliseconds Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Jul 13 16:11:28 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Jul 13 16:11:28 volumio volumio[837]: info: ControllerMpd::pushState Jul 13 16:11:28 volumio volumio[837]: info: CoreCommandRouter::servicePushState Jul 13 16:11:28 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:28 volumio volumio[837]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"思乡愁","artist":"群星","album":"绝对发烧15","uri":"NAS/NAS123/susan说发烧/群星 - 14.思乡愁.flac","trackType":"flac"} Jul 13 16:11:28 volumio volumio[837]: verbose: CURRENT POSITION 12 Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::syncState stateService pause Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus stop Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::pushState Jul 13 16:11:28 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:28 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Jul 13 16:11:28 volumio volumio[837]: info: ControllerMpd::pushState Jul 13 16:11:28 volumio volumio[837]: info: CoreCommandRouter::servicePushState Jul 13 16:11:28 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:28 volumio volumio[837]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"思乡愁","artist":"群星","album":"绝对发烧15","uri":"NAS/NAS123/susan说发烧/群星 - 14.思乡愁.flac","trackType":"flac"} Jul 13 16:11:28 volumio volumio[837]: verbose: CURRENT POSITION 12 Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::syncState stateService pause Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus stop Jul 13 16:11:28 volumio volumio[837]: info: CoreStateMachine::pushState Jul 13 16:11:28 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:28 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Jul 13 16:11:28 volumio volumio[837]: info: ------------------------------ 316ms Jul 13 16:11:28 volumio volumio[837]: info: ------------------------------ 312ms Jul 13 16:11:40 volumio kernel: usb 1-1.3: new high-speed USB device number 4 using ehci-pci Jul 13 16:11:40 volumio kernel: usb 1-1.3: New USB device found, idVendor=152a, idProduct=85dd, bcdDevice= 2.06 Jul 13 16:11:40 volumio kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Jul 13 16:11:40 volumio kernel: usb 1-1.3: Product: SMSL USB AUDIO Jul 13 16:11:40 volumio kernel: usb 1-1.3: Manufacturer: SMSL Jul 13 16:11:40 volumio kernel: hid-generic 0003:152A:85DD.0006: hiddev1,hidraw3: USB HID v1.10 Device [SMSL SMSL USB AUDIO] on usb-0000:00:12.0-1.3/input3 Jul 13 16:11:40 volumio kernel: mc: Linux media interface: v0.10 Jul 13 16:11:40 volumio kernel: usb 1-1.3: 1:3 : unsupported format bits 0x100000000 Jul 13 16:11:40 volumio kernel: usbcore: registered new interface driver snd-usb-audio Jul 13 16:11:40 volumio volumio[837]: info: Jul 13 16:11:40 volumio volumio[837]: ---------------------------- USB Audio Device Attached Jul 13 16:11:40 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jul 13 16:11:40 volumio volumio[837]: info: CoreCommandRouter::Close All Modals sent Jul 13 16:11:40 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 13 16:11:41 volumio volumio[837]: info: Device 5 does not have any Mixer Control Available Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 13 16:11:41 volumio volumio[837]: info: Updating Volume Controller Parameters: Device: 5 Name: SMSL USB AUDIO Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jul 13 16:11:41 volumio volumio[837]: info: Disabling external Volume Control Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 13 16:11:41 volumio volumio[837]: info: CoreStateMachine::pushState Jul 13 16:11:41 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Jul 13 16:11:41 volumio volumio[837]: info: Preparing to generate the ALSA configuration file Jul 13 16:11:41 volumio volumio[837]: info: Asound.conf file unchanged, so no further update is needed Jul 13 16:11:41 volumio volumio[837]: info: Output device has changed, restarting MPD Jul 13 16:11:41 volumio sudo[1740]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 13 16:11:41 volumio sudo[1740]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 16:11:41 volumio volumio[837]: info: Output device has changed, restarting Shairport Sync Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 13 16:11:41 volumio sudo[1740]: pam_unix(sudo:session): session closed for user root Jul 13 16:11:41 volumio sudo[1742]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 13 16:11:41 volumio sudo[1742]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 16:11:41 volumio systemd[1]: Stopping Music Player Daemon... Jul 13 16:11:41 volumio volumio[837]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 13 16:11:41 volumio systemd[1]: mpd.service: Succeeded. Jul 13 16:11:41 volumio systemd[1]: Stopped Music Player Daemon. Jul 13 16:11:41 volumio systemd[1]: Starting Music Player Daemon... Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 13 16:11:41 volumio volumio[837]: info: MPD Permissions set Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 13 16:11:41 volumio volumio[837]: info: CoreCommandRouter::volumioPlay Jul 13 16:11:41 volumio volumio[837]: info: CoreStateMachine::play index undefined Jul 13 16:11:41 volumio volumio[837]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 13 16:11:41 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:41 volumio volumio[837]: info: CoreStateMachine::startPlaybackTimer Jul 13 16:11:41 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:41 volumio volumio[837]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS123/susan说发烧/群星 - 14.思乡愁.flac Jul 13 16:11:41 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand stop Jul 13 16:11:41 volumio volumio[837]: error: MPD error: Error: This socket has been ended by the other party Jul 13 16:11:41 volumio volumio[837]: error: This socket has been ended by the other party {"code":"EPIPE"} Jul 13 16:11:41 volumio volumio[837]: error: MPD error: Error: This socket has been ended by the other party Jul 13 16:11:41 volumio volumio[837]: error: This socket has been ended by the other party {"code":"EPIPE"} Jul 13 16:11:41 volumio volumio[837]: error: MPD error: Error: This socket has been ended by the other party Jul 13 16:11:41 volumio volumio[837]: error: This socket has been ended by the other party {"code":"EPIPE"} Jul 13 16:11:41 volumio volumio[837]: info: Starting Shairport Sync Jul 13 16:11:42 volumio sudo[1760]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 13 16:11:42 volumio sudo[1760]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 13 16:11:42 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 13 16:11:42 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 13 16:11:42 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 13 16:11:42 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 13 16:11:42 volumio sudo[1760]: pam_unix(sudo:session): session closed for user root Jul 13 16:11:42 volumio volumio[837]: info: Shairport-Sync Started Jul 13 16:11:43 volumio mpd[1749]: Jul 13 16:11 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 13 16:11:43 volumio systemd[1]: Started Music Player Daemon. Jul 13 16:11:43 volumio sudo[1742]: pam_unix(sudo:session): session closed for user root Jul 13 16:11:43 volumio volumio[837]: error: updateQueue error: null Jul 13 16:11:45 volumio volumio[837]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jul 13 16:11:45 volumio volumio[837]: info: CoreStateMachine::getcurrentVolume Jul 13 16:11:45 volumio volumio[837]: info: CoreCommandRouter::volumioRetrievevolume Jul 13 16:11:45 volumio volumio[837]: info: CoreStateMachine::pushState Jul 13 16:11:45 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:45 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 13 16:11:45 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Jul 13 16:11:47 volumio volumio[837]: info: CoreCommandRouter::volumioSeek Jul 13 16:11:47 volumio volumio[837]: info: CoreStateMachine::seek Jul 13 16:11:47 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:47 volumio volumio[837]: info: TRACKBLOCK {"uri":"mnt/NAS/NAS123/susan说发烧/群星 - 14.思乡愁.flac","service":"mpd","name":"思乡愁","artist":"群星","album":"绝对发烧15","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=539&web=%E7%BE%A4%E6%98%9F/%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A715/extralarge&path=%2FNAS%2FNAS123%2Fsusan%E8%AF%B4%E5%8F%91%E7%83%A7&metadata=false","duration":298,"trackType":"flac"} Jul 13 16:11:47 volumio volumio[837]: info: CoreStateMachine::startPlaybackTimer Jul 13 16:11:47 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:47 volumio volumio[837]: info: ControllerMpd::seek Jul 13 16:11:47 volumio volumio[837]: info: CoreStateMachine::pushState Jul 13 16:11:47 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:47 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 13 16:11:47 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Jul 13 16:11:47 volumio volumio[837]: error: [2@0] {seek} Bad song index Jul 13 16:11:48 volumio volumio[837]: info: CoreCommandRouter::volumioPlay Jul 13 16:11:48 volumio volumio[837]: info: CoreStateMachine::play index undefined Jul 13 16:11:48 volumio volumio[837]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 13 16:11:48 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:48 volumio volumio[837]: info: CoreStateMachine::startPlaybackTimer Jul 13 16:11:48 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:48 volumio volumio[837]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS123/susan说发烧/群星 - 14.思乡愁.flac Jul 13 16:11:48 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand stop Jul 13 16:11:48 volumio volumio[837]: info: sendMpdCommand stop took 1 milliseconds Jul 13 16:11:48 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand clear Jul 13 16:11:48 volumio volumio[837]: info: Jul 13 16:11:48 volumio volumio[837]: ---------------------------- MPD announces system playlist update Jul 13 16:11:48 volumio volumio[837]: info: Ignoring MPD Status Update Jul 13 16:11:48 volumio volumio[837]: info: sendMpdCommand clear took 1 milliseconds Jul 13 16:11:48 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS123/susan说发烧/群星 - 14.思乡愁.flac" Jul 13 16:11:48 volumio volumio[837]: error: updateQueue error: null Jul 13 16:11:48 volumio volumio[837]: info: Jul 13 16:11:48 volumio volumio[837]: ---------------------------- MPD announces system playlist update Jul 13 16:11:48 volumio volumio[837]: info: Ignoring MPD Status Update Jul 13 16:11:48 volumio volumio[837]: info: ------------------------------ 3ms Jul 13 16:11:48 volumio volumio[837]: info: sendMpdCommand add "NAS/NAS123/susan说发烧/群星 - 14.思乡愁.flac" took 2 milliseconds Jul 13 16:11:48 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand play Jul 13 16:11:48 volumio volumio[837]: info: ------------------------------ 3ms Jul 13 16:11:48 volumio volumio[837]: info: sendMpdCommand play took 2 milliseconds Jul 13 16:11:48 volumio volumio[837]: info: Jul 13 16:11:48 volumio volumio[837]: ---------------------------- MPD announces state update: player Jul 13 16:11:48 volumio volumio[837]: info: ControllerMpd::getState Jul 13 16:11:48 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Jul 13 16:11:48 volumio volumio[837]: info: Jul 13 16:11:48 volumio volumio[837]: ---------------------------- MPD announces state update: player Jul 13 16:11:48 volumio volumio[837]: info: sendMpdCommand status took 45 milliseconds Jul 13 16:11:48 volumio volumio[837]: info: ControllerMpd::getState Jul 13 16:11:48 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Jul 13 16:11:48 volumio volumio[837]: verbose: ControllerMpd::parseState Jul 13 16:11:48 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 13 16:11:48 volumio volumio[837]: info: sendMpdCommand status took 3 milliseconds Jul 13 16:11:48 volumio volumio[837]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 13 16:11:48 volumio volumio[837]: verbose: ControllerMpd::parseState Jul 13 16:11:48 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 13 16:11:48 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Jul 13 16:11:48 volumio volumio[837]: info: ControllerMpd::pushState Jul 13 16:11:48 volumio volumio[837]: info: CoreCommandRouter::servicePushState Jul 13 16:11:48 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:48 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"623 Kbps","isStreaming":false,"title":"思乡愁","artist":"群星","album":"绝对发烧15","uri":"NAS/NAS123/susan说发烧/群星 - 14.思乡愁.flac","trackType":"flac"} Jul 13 16:11:48 volumio volumio[837]: verbose: CURRENT POSITION 12 Jul 13 16:11:48 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Jul 13 16:11:48 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus stop Jul 13 16:11:48 volumio volumio[837]: info: ------------------------------ 58ms Jul 13 16:11:48 volumio volumio[837]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 13 16:11:48 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Jul 13 16:11:48 volumio volumio[837]: info: ControllerMpd::pushState Jul 13 16:11:48 volumio volumio[837]: info: CoreCommandRouter::servicePushState Jul 13 16:11:48 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:48 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"627 Kbps","isStreaming":false,"title":"思乡愁","artist":"群星","album":"绝对发烧15","uri":"NAS/NAS123/susan说发烧/群星 - 14.思乡愁.flac","trackType":"flac"} Jul 13 16:11:48 volumio volumio[837]: verbose: CURRENT POSITION 12 Jul 13 16:11:48 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Jul 13 16:11:48 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Jul 13 16:11:48 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Jul 13 16:11:48 volumio volumio[837]: info: CoreStateMachine::pushState Jul 13 16:11:48 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:48 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 13 16:11:48 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Jul 13 16:11:48 volumio volumio[837]: info: CoreStateMachine::pushState Jul 13 16:11:48 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:48 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Jul 13 16:11:48 volumio volumio[837]: info: ------------------------------ 61ms Jul 13 16:11:51 volumio volumio[837]: info: CoreCommandRouter::volumioPause Jul 13 16:11:51 volumio volumio[837]: info: CoreStateMachine::pause Jul 13 16:11:51 volumio volumio[837]: info: CoreStateMachine::stPlaybackTimer Jul 13 16:11:51 volumio volumio[837]: info: CoreStateMachine::servicePause Jul 13 16:11:51 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:51 volumio volumio[837]: info: CoreCommandRouter::servicePause Jul 13 16:11:51 volumio volumio[837]: info: ControllerMpd::pause Jul 13 16:11:51 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand pause Jul 13 16:11:51 volumio volumio[837]: info: Jul 13 16:11:51 volumio volumio[837]: ---------------------------- MPD announces state update: player Jul 13 16:11:51 volumio volumio[837]: info: sendMpdCommand pause took 3 milliseconds Jul 13 16:11:51 volumio volumio[837]: info: ControllerMpd::getState Jul 13 16:11:51 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Jul 13 16:11:51 volumio volumio[837]: info: sendMpdCommand status took 2 milliseconds Jul 13 16:11:51 volumio volumio[837]: verbose: ControllerMpd::parseState Jul 13 16:11:51 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 13 16:11:51 volumio volumio[837]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 13 16:11:51 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Jul 13 16:11:51 volumio volumio[837]: info: ControllerMpd::pushState Jul 13 16:11:51 volumio volumio[837]: info: CoreCommandRouter::servicePushState Jul 13 16:11:51 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:51 volumio volumio[837]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":3346,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"717 Kbps","isStreaming":false,"title":"思乡愁","artist":"群星","album":"绝对发烧15","uri":"NAS/NAS123/susan说发烧/群星 - 14.思乡愁.flac","trackType":"flac"} Jul 13 16:11:51 volumio volumio[837]: verbose: CURRENT POSITION 12 Jul 13 16:11:51 volumio volumio[837]: info: CoreStateMachine::syncState stateService pause Jul 13 16:11:51 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus pause Jul 13 16:11:51 volumio volumio[837]: info: CoreStateMachine::pushState Jul 13 16:11:51 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:51 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 13 16:11:51 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Jul 13 16:11:51 volumio volumio[837]: info: CoreStateMachine::stPlaybackTimer Jul 13 16:11:51 volumio volumio[837]: info: ------------------------------ 32ms Jul 13 16:11:58 volumio volumio[837]: info: CoreCommandRouter::volumioPlay Jul 13 16:11:58 volumio volumio[837]: info: CoreStateMachine::play index undefined Jul 13 16:11:58 volumio volumio[837]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 13 16:11:58 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:58 volumio volumio[837]: info: CoreStateMachine::startPlaybackTimer Jul 13 16:11:58 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:58 volumio volumio[837]: info: ControllerMpd::resume Jul 13 16:11:58 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand play Jul 13 16:11:58 volumio volumio[837]: info: Jul 13 16:11:58 volumio volumio[837]: ---------------------------- MPD announces state update: player Jul 13 16:11:58 volumio volumio[837]: info: sendMpdCommand play took 5 milliseconds Jul 13 16:11:58 volumio volumio[837]: info: ControllerMpd::getState Jul 13 16:11:58 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Jul 13 16:11:58 volumio volumio[837]: info: sendMpdCommand status took 1 milliseconds Jul 13 16:11:58 volumio volumio[837]: verbose: ControllerMpd::parseState Jul 13 16:11:58 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 13 16:11:58 volumio volumio[837]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 13 16:11:58 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Jul 13 16:11:58 volumio volumio[837]: info: ControllerMpd::pushState Jul 13 16:11:58 volumio volumio[837]: info: CoreCommandRouter::servicePushState Jul 13 16:11:58 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:58 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4211,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"744 Kbps","isStreaming":false,"title":"思乡愁","artist":"群星","album":"绝对发烧15","uri":"NAS/NAS123/susan说发烧/群星 - 14.思乡愁.flac","trackType":"flac"} Jul 13 16:11:58 volumio volumio[837]: verbose: CURRENT POSITION 12 Jul 13 16:11:58 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Jul 13 16:11:58 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus pause Jul 13 16:11:58 volumio volumio[837]: info: CoreStateMachine::pushState Jul 13 16:11:58 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:11:58 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 13 16:11:58 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Jul 13 16:11:58 volumio volumio[837]: info: ------------------------------ 22ms Jul 13 16:12:10 volumio volumio[837]: info: CoreCommandRouter::volumioSeek Jul 13 16:12:10 volumio volumio[837]: info: CoreStateMachine::seek Jul 13 16:12:10 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:12:10 volumio volumio[837]: info: TRACKBLOCK {"uri":"mnt/NAS/NAS123/susan说发烧/群星 - 14.思乡愁.flac","service":"mpd","name":"思乡愁","artist":"群星","album":"绝对发烧15","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=539&web=%E7%BE%A4%E6%98%9F/%E7%BB%9D%E5%AF%B9%E5%8F%91%E7%83%A715/extralarge&path=%2FNAS%2FNAS123%2Fsusan%E8%AF%B4%E5%8F%91%E7%83%A7&metadata=false","duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","trackType":"flac","channels":2} Jul 13 16:12:10 volumio volumio[837]: info: CoreStateMachine::startPlaybackTimer Jul 13 16:12:10 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:12:10 volumio volumio[837]: info: ControllerMpd::seek Jul 13 16:12:10 volumio volumio[837]: info: CoreStateMachine::pushState Jul 13 16:12:10 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:12:10 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 13 16:12:10 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Jul 13 16:12:10 volumio volumio[837]: error: null Jul 13 16:12:10 volumio volumio[837]: info: Jul 13 16:12:10 volumio volumio[837]: ---------------------------- MPD announces state update: player Jul 13 16:12:10 volumio volumio[837]: info: ControllerMpd::getState Jul 13 16:12:10 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand status Jul 13 16:12:10 volumio volumio[837]: info: sendMpdCommand status took 9 milliseconds Jul 13 16:12:10 volumio volumio[837]: verbose: ControllerMpd::parseState Jul 13 16:12:10 volumio volumio[837]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 13 16:12:10 volumio volumio[837]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 13 16:12:10 volumio volumio[837]: verbose: ControllerMpd::parseTrackInfo Jul 13 16:12:10 volumio volumio[837]: info: ControllerMpd::pushState Jul 13 16:12:10 volumio volumio[837]: info: CoreCommandRouter::servicePushState Jul 13 16:12:10 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:12:10 volumio volumio[837]: verbose: STATE SERVICE {"status":"play","position":0,"seek":54842,"duration":298,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"852 Kbps","isStreaming":false,"title":"思乡愁","artist":"群星","album":"绝对发烧15","uri":"NAS/NAS123/susan说发烧/群星 - 14.思乡愁.flac","trackType":"flac"} Jul 13 16:12:10 volumio volumio[837]: verbose: CURRENT POSITION 12 Jul 13 16:12:10 volumio volumio[837]: info: CoreStateMachine::syncState stateService play Jul 13 16:12:10 volumio volumio[837]: info: CoreStateMachine::syncState currentStatus play Jul 13 16:12:10 volumio volumio[837]: info: Received an update from plugin. extracting info from payload Jul 13 16:12:10 volumio volumio[837]: info: CoreStateMachine::pushState Jul 13 16:12:10 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:12:10 volumio volumio[837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 13 16:12:10 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Jul 13 16:12:10 volumio volumio[837]: info: CoreStateMachine::pushState Jul 13 16:12:10 volumio volumio[837]: info: CorePlayQueue::getTrack 12 Jul 13 16:12:10 volumio volumio[837]: info: CoreCommandRouter::volumioPushState Jul 13 16:12:10 volumio volumio[837]: info: ------------------------------ 65ms Jul 13 16:12:58 volumio volumio[837]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 13 16:12:58 volumio volumio[837]: Error: connect ETIMEDOUT 159.65.107.38:443 Jul 13 16:12:58 volumio volumio[837]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jul 13 16:12:58 volumio volumio[837]: errno: -110, Jul 13 16:12:58 volumio volumio[837]: code: 'ETIMEDOUT', Jul 13 16:12:58 volumio volumio[837]: syscall: 'connect', Jul 13 16:12:58 volumio volumio[837]: address: '159.65.107.38', Jul 13 16:12:58 volumio volumio[837]: port: 443 Jul 13 16:12:58 volumio volumio[837]: } Jul 13 16:12:58 volumio volumio[837]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 13 16:12:59 volumio sudo[1885]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-13 16:11 Jul 13 16:12:59 volumio sudo[1885]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="e831866afe2db61aee9333a8f5ba9d9fd36609c7" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 18 Feb 2024 11:28:21 AM CET" VOLUMIO_VERSION="3.629" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="00272c702f983c8787b8de2b7502dec4"