-- 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"