-- Logs begin at Sat 2026-01-10 09:50:32 CST, end at Sat 2026-01-10 09:52:14 CST. -- Jan 10 09:51:01 volumio volumio[890]: info: Preload queue cleared Jan 10 09:51:01 volumio volumio[890]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 10 09:51:01 volumio volumio[890]: info: CoreStateMachine::ClearQueue Jan 10 09:51:01 volumio volumio[890]: info: CoreStateMachine::stop Jan 10 09:51:01 volumio volumio[890]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 10 09:51:01 volumio volumio[890]: info: CorePlayQueue::clearPlayQueue Jan 10 09:51:01 volumio volumio[890]: info: CorePlayQueue::saveQueue Jan 10 09:51:01 volumio volumio[890]: info: CoreCommandRouter::volumioPushQueue Jan 10 09:51:01 volumio volumio[890]: info: CoreStateMachine::addQueueItems Jan 10 09:51:01 volumio volumio[890]: info: CorePlayQueue::addQueueItems Jan 10 09:51:01 volumio volumio[890]: info: Preload queue cleared Jan 10 09:51:01 volumio volumio[890]: info: Adding Item to queue: music-library/NAS/CD1-210G/【FP抓】童丽 - 念情 Jan 10 09:51:01 volumio volumio[890]: info: Exploding uri music-library/NAS/CD1-210G/【FP抓】童丽 - 念情 in service mpd Jan 10 09:51:02 volumio volumio[890]: info: ALBUMART /albumart?cacheid=609&web=%CD%AF%3F%3F/%3F%3F%3F%3F/extralarge&path=%2Fmnt%2FNAS%2FCD1-210G%2F%E3%80%90FP%E6%8A%93%E3%80%91%E7%AB%A5%E4%B8%BD%20-%20%E5%BF%B5%E6%83%85%2F01.%E7%81%9E%E6%A1%A5%E6%9F%B3.wav&metadata=false Jan 10 09:51:02 volumio volumio[890]: info: URI /mnt/NAS/CD1-210G/【FP抓】童丽 - 念情/01.灞桥柳.wav Jan 10 09:51:02 volumio volumio[890]: info: ALBUMART /albumart?cacheid=609&web=%CD%AF%3F%3F/%3F%3F%3F%3F/extralarge&path=%2Fmnt%2FNAS%2FCD1-210G%2F%E3%80%90FP%E6%8A%93%E3%80%91%E7%AB%A5%E4%B8%BD%20-%20%E5%BF%B5%E6%83%85%2F02.%E8%8A%B1%E8%B0%A2%E8%8A%B1%E9%A3%9E%E9%A3%9E%E6%BB%A1%E5%A4%A9.wav&metadata=false Jan 10 09:51:02 volumio volumio[890]: info: URI /mnt/NAS/CD1-210G/【FP抓】童丽 - 念情/02.花谢花飞飞满天.wav Jan 10 09:51:02 volumio volumio[890]: info: ALBUMART /albumart?cacheid=609&web=%CD%AF%3F%3F/%3F%3F%3F%3F/extralarge&path=%2Fmnt%2FNAS%2FCD1-210G%2F%E3%80%90FP%E6%8A%93%E3%80%91%E7%AB%A5%E4%B8%BD%20-%20%E5%BF%B5%E6%83%85%2F03.%E6%A2%A6%E5%85%A5%E6%A1%83%E8%8A%B1%E6%BA%90.wav&metadata=false Jan 10 09:51:02 volumio volumio[890]: info: URI /mnt/NAS/CD1-210G/【FP抓】童丽 - 念情/03.梦入桃花源.wav Jan 10 09:51:02 volumio volumio[890]: info: ALBUMART /albumart?cacheid=609&web=%CD%AF%3F%3F/%3F%3F%3F%3F/extralarge&path=%2Fmnt%2FNAS%2FCD1-210G%2F%E3%80%90FP%E6%8A%93%E3%80%91%E7%AB%A5%E4%B8%BD%20-%20%E5%BF%B5%E6%83%85%2F04.%E6%9D%A8%E6%9F%B3%E9%9D%92.wav&metadata=false Jan 10 09:51:02 volumio volumio[890]: info: URI /mnt/NAS/CD1-210G/【FP抓】童丽 - 念情/04.杨柳青.wav Jan 10 09:51:02 volumio volumio[890]: info: ALBUMART /albumart?cacheid=609&web=%CD%AF%3F%3F/%3F%3F%3F%3F/extralarge&path=%2Fmnt%2FNAS%2FCD1-210G%2F%E3%80%90FP%E6%8A%93%E3%80%91%E7%AB%A5%E4%B8%BD%20-%20%E5%BF%B5%E6%83%85%2F05.%E5%BF%B5%E6%83%85.wav&metadata=false Jan 10 09:51:02 volumio volumio[890]: info: URI /mnt/NAS/CD1-210G/【FP抓】童丽 - 念情/05.念情.wav Jan 10 09:51:02 volumio volumio[890]: info: ALBUMART /albumart?cacheid=609&web=%CD%AF%3F%3F/%3F%3F%3F%3F/extralarge&path=%2Fmnt%2FNAS%2FCD1-210G%2F%E3%80%90FP%E6%8A%93%E3%80%91%E7%AB%A5%E4%B8%BD%20-%20%E5%BF%B5%E6%83%85%2F06.%E4%BA%8C%E6%B3%89%E6%98%A0%E6%9C%88.wav&metadata=false Jan 10 09:51:02 volumio volumio[890]: info: URI /mnt/NAS/CD1-210G/【FP抓】童丽 - 念情/06.二泉映月.wav Jan 10 09:51:02 volumio volumio[890]: info: ALBUMART /albumart?cacheid=609&web=%CD%AF%3F%3F/%3F%3F%3F%3F/extralarge&path=%2Fmnt%2FNAS%2FCD1-210G%2F%E3%80%90FP%E6%8A%93%E3%80%91%E7%AB%A5%E4%B8%BD%20-%20%E5%BF%B5%E6%83%85%2F07.%E5%B0%8F%E5%A6%B9%E7%94%9C%E7%94%9C%E7%94%9C.wav&metadata=false Jan 10 09:51:02 volumio volumio[890]: info: URI /mnt/NAS/CD1-210G/【FP抓】童丽 - 念情/07.小妹甜甜甜.wav Jan 10 09:51:02 volumio volumio[890]: info: ALBUMART /albumart?cacheid=609&web=%CD%AF%3F%3F/%3F%3F%3F%3F/extralarge&path=%2Fmnt%2FNAS%2FCD1-210G%2F%E3%80%90FP%E6%8A%93%E3%80%91%E7%AB%A5%E4%B8%BD%20-%20%E5%BF%B5%E6%83%85%2F08.%E4%B8%9C%E5%8C%97%E6%91%87%E7%AF%AE%E6%9B%B2.wav&metadata=false Jan 10 09:51:02 volumio volumio[890]: info: URI /mnt/NAS/CD1-210G/【FP抓】童丽 - 念情/08.东北摇篮曲.wav Jan 10 09:51:02 volumio volumio[890]: info: ALBUMART /albumart?cacheid=609&web=%CD%AF%3F%3F/%3F%3F%3F%3F/extralarge&path=%2Fmnt%2FNAS%2FCD1-210G%2F%E3%80%90FP%E6%8A%93%E3%80%91%E7%AB%A5%E4%B8%BD%20-%20%E5%BF%B5%E6%83%85%2F09.%E5%8D%83%E5%8F%A4%E4%B8%80%E7%88%B1.wav&metadata=false Jan 10 09:51:02 volumio volumio[890]: info: URI /mnt/NAS/CD1-210G/【FP抓】童丽 - 念情/09.千古一爱.wav Jan 10 09:51:02 volumio volumio[890]: info: ALBUMART /albumart?cacheid=609&web=%CD%AF%3F%3F/%3F%3F%3F%3F/extralarge&path=%2Fmnt%2FNAS%2FCD1-210G%2F%E3%80%90FP%E6%8A%93%E3%80%91%E7%AB%A5%E4%B8%BD%20-%20%E5%BF%B5%E6%83%85%2F10.%E5%8F%88%E5%94%B1%E6%B5%8F%E9%98%B3%E6%B2%B3.wav&metadata=false Jan 10 09:51:02 volumio volumio[890]: info: URI /mnt/NAS/CD1-210G/【FP抓】童丽 - 念情/10.又唱浏阳河.wav Jan 10 09:51:02 volumio volumio[890]: info: ALBUMART /albumart?cacheid=609&web=%CD%AF%3F%3F/%3F%3F%3F%3F/extralarge&path=%2Fmnt%2FNAS%2FCD1-210G%2F%E3%80%90FP%E6%8A%93%E3%80%91%E7%AB%A5%E4%B8%BD%20-%20%E5%BF%B5%E6%83%85%2F11.%E6%B0%B8%E6%81%92%E7%9A%84%E8%AF%B1%E6%83%91.wav&metadata=false Jan 10 09:51:02 volumio volumio[890]: info: URI /mnt/NAS/CD1-210G/【FP抓】童丽 - 念情/11.永恒的诱惑.wav Jan 10 09:51:02 volumio volumio[890]: info: ALBUMART /albumart?cacheid=609&web=%CD%AF%3F%3F/%3F%3F%3F%3F/extralarge&path=%2Fmnt%2FNAS%2FCD1-210G%2F%E3%80%90FP%E6%8A%93%E3%80%91%E7%AB%A5%E4%B8%BD%20-%20%E5%BF%B5%E6%83%85%2F12.%E4%BD%A0%E4%BD%A0%E6%88%91%E6%88%91.wav&metadata=false Jan 10 09:51:02 volumio volumio[890]: info: URI /mnt/NAS/CD1-210G/【FP抓】童丽 - 念情/12.你你我我.wav Jan 10 09:51:02 volumio volumio[890]: info: ALBUMART /albumart?cacheid=609&web=%CD%AF%3F%3F/%3F%3F%3F%3F/extralarge&path=%2Fmnt%2FNAS%2FCD1-210G%2F%E3%80%90FP%E6%8A%93%E3%80%91%E7%AB%A5%E4%B8%BD%20-%20%E5%BF%B5%E6%83%85%2F13.%E5%9B%9B%E5%AD%A3%E8%B0%83.wav&metadata=false Jan 10 09:51:02 volumio volumio[890]: info: URI /mnt/NAS/CD1-210G/【FP抓】童丽 - 念情/13.四季调.wav Jan 10 09:51:02 volumio volumio[890]: info: CoreCommandRouter::volumioPushQueue Jan 10 09:51:02 volumio volumio[890]: info: CorePlayQueue::saveQueue Jan 10 09:51:02 volumio volumio[890]: info: CoreStateMachine::updateTrackBlock Jan 10 09:51:02 volumio volumio[890]: info: CorePlayQueue::getTrackBlock Jan 10 09:51:02 volumio volumio[890]: info: CoreCommandRouter::volumioPlay Jan 10 09:51:02 volumio volumio[890]: info: CoreStateMachine::play index 0 Jan 10 09:51:02 volumio volumio[890]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 10 09:51:02 volumio volumio[890]: info: CoreStateMachine::stop Jan 10 09:51:02 volumio volumio[890]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 10 09:51:02 volumio volumio[890]: info: CoreStateMachine::play index undefined Jan 10 09:51:02 volumio volumio[890]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 10 09:51:02 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:02 volumio volumio[890]: info: CoreStateMachine::startPlaybackTimer Jan 10 09:51:02 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:02 volumio volumio[890]: verbose: ControllerMpd::clearAddPlayTracks NAS/CD1-210G/【FP抓】童丽 - 念情/01.灞桥柳.wav Jan 10 09:51:02 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand stop Jan 10 09:51:02 volumio volumio[890]: info: sendMpdCommand stop took 76 milliseconds Jan 10 09:51:02 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand clear Jan 10 09:51:02 volumio volumio[890]: info: Jan 10 09:51:02 volumio volumio[890]: ---------------------------- MPD announces system playlist update Jan 10 09:51:02 volumio volumio[890]: info: Ignoring MPD Status Update Jan 10 09:51:02 volumio volumio[890]: info: sendMpdCommand clear took 62 milliseconds Jan 10 09:51:02 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand add "NAS/CD1-210G/【FP抓】童丽 - 念情/01.灞桥柳.wav" Jan 10 09:51:02 volumio volumio[890]: info: Jan 10 09:51:02 volumio volumio[890]: ---------------------------- MPD announces system playlist update Jan 10 09:51:02 volumio volumio[890]: info: Ignoring MPD Status Update Jan 10 09:51:02 volumio volumio[890]: info: Jan 10 09:51:02 volumio volumio[890]: ---------------------------- MPD announces system playlist update Jan 10 09:51:02 volumio volumio[890]: info: Ignoring MPD Status Update Jan 10 09:51:02 volumio volumio[890]: info: Jan 10 09:51:02 volumio volumio[890]: ---------------------------- MPD announces system playlist update Jan 10 09:51:02 volumio volumio[890]: info: Ignoring MPD Status Update Jan 10 09:51:02 volumio volumio[890]: error: updateQueue error: null Jan 10 09:51:02 volumio volumio[890]: info: Jan 10 09:51:02 volumio volumio[890]: ---------------------------- MPD announces system playlist update Jan 10 09:51:02 volumio volumio[890]: info: Ignoring MPD Status Update Jan 10 09:51:02 volumio volumio[890]: info: ------------------------------ 68ms Jan 10 09:51:02 volumio volumio[890]: info: sendMpdCommand add "NAS/CD1-210G/【FP抓】童丽 - 念情/01.灞桥柳.wav" took 65 milliseconds Jan 10 09:51:02 volumio volumio[890]: info: ------------------------------ 63ms Jan 10 09:51:02 volumio volumio[890]: info: ------------------------------ 62ms Jan 10 09:51:02 volumio volumio[890]: info: ------------------------------ 62ms Jan 10 09:51:02 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand play Jan 10 09:51:02 volumio volumio[890]: info: Jan 10 09:51:02 volumio volumio[890]: ---------------------------- MPD announces system playlist update Jan 10 09:51:02 volumio volumio[890]: info: Ignoring MPD Status Update Jan 10 09:51:02 volumio volumio[890]: info: Jan 10 09:51:02 volumio volumio[890]: ---------------------------- MPD announces system playlist update Jan 10 09:51:02 volumio volumio[890]: info: Ignoring MPD Status Update Jan 10 09:51:02 volumio volumio[890]: info: Jan 10 09:51:02 volumio volumio[890]: ---------------------------- MPD announces system playlist update Jan 10 09:51:02 volumio volumio[890]: info: Ignoring MPD Status Update Jan 10 09:51:02 volumio volumio[890]: info: Jan 10 09:51:02 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:02 volumio volumio[890]: info: ------------------------------ 585ms Jan 10 09:51:02 volumio volumio[890]: info: sendMpdCommand play took 584 milliseconds Jan 10 09:51:02 volumio volumio[890]: info: ------------------------------ 583ms Jan 10 09:51:02 volumio volumio[890]: info: ------------------------------ 583ms Jan 10 09:51:02 volumio volumio[890]: info: ------------------------------ 582ms Jan 10 09:51:02 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:02 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:02 volumio volumio[890]: info: Jan 10 09:51:02 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:02 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:02 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:02 volumio volumio[890]: info: sendMpdCommand status took 58 milliseconds Jan 10 09:51:02 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:02 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:02 volumio volumio[890]: info: Jan 10 09:51:02 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:02 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:02 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:02 volumio volumio[890]: info: Jan 10 09:51:02 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:02 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:02 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:02 volumio volumio[890]: info: Jan 10 09:51:02 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:02 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:02 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:03 volumio volumio[890]: info: sendMpdCommand status took 68 milliseconds Jan 10 09:51:03 volumio volumio[890]: info: sendMpdCommand playlistinfo took 66 milliseconds Jan 10 09:51:03 volumio volumio[890]: info: sendMpdCommand status took 65 milliseconds Jan 10 09:51:03 volumio volumio[890]: info: sendMpdCommand status took 64 milliseconds Jan 10 09:51:03 volumio volumio[890]: info: sendMpdCommand status took 63 milliseconds Jan 10 09:51:03 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:03 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:03 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:03 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:03 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:03 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:03 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:03 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:03 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:03 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:51:03 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:51:03 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:03 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1183,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01.??????","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/01.灞桥柳.wav","trackType":"wav"} Jan 10 09:51:03 volumio volumio[890]: verbose: CURRENT POSITION 0 Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::syncState stateService play Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus stop Jan 10 09:51:03 volumio volumio[890]: info: ------------------------------ 135ms Jan 10 09:51:03 volumio volumio[890]: info: Jan 10 09:51:03 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:03 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:03 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:03 volumio volumio[890]: info: Jan 10 09:51:03 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:03 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:03 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:03 volumio volumio[890]: info: Jan 10 09:51:03 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:03 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:03 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:03 volumio volumio[890]: info: sendMpdCommand playlistinfo took 64 milliseconds Jan 10 09:51:03 volumio volumio[890]: info: sendMpdCommand playlistinfo took 62 milliseconds Jan 10 09:51:03 volumio volumio[890]: info: sendMpdCommand playlistinfo took 63 milliseconds Jan 10 09:51:03 volumio volumio[890]: info: sendMpdCommand status took 58 milliseconds Jan 10 09:51:03 volumio volumio[890]: info: sendMpdCommand status took 57 milliseconds Jan 10 09:51:03 volumio volumio[890]: info: sendMpdCommand status took 57 milliseconds Jan 10 09:51:03 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:03 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:03 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:03 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:03 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:03 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:03 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:03 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:03 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:03 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:03 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:51:03 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:51:03 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:03 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1274,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01.??????","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/01.灞桥柳.wav","trackType":"wav"} Jan 10 09:51:03 volumio volumio[890]: verbose: CURRENT POSITION 0 Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::syncState stateService play Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play Jan 10 09:51:03 volumio volumio[890]: info: Received an update from plugin. extracting info from payload Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:03 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:03 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 09:51:03 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:03 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:03 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:03 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:51:03 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:51:03 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:03 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1274,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01.??????","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/01.灞桥柳.wav","trackType":"wav"} Jan 10 09:51:03 volumio volumio[890]: verbose: CURRENT POSITION 0 Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::syncState stateService play Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play Jan 10 09:51:03 volumio volumio[890]: info: Received an update from plugin. extracting info from payload Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:03 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:03 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:03 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:03 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:03 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:51:03 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:51:03 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:03 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1274,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01.??????","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/01.灞桥柳.wav","trackType":"wav"} Jan 10 09:51:03 volumio volumio[890]: verbose: CURRENT POSITION 0 Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::syncState stateService play Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play Jan 10 09:51:03 volumio volumio[890]: info: Received an update from plugin. extracting info from payload Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:03 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:03 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:03 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:03 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:03 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:51:03 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:51:03 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:03 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1274,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01.??????","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/01.灞桥柳.wav","trackType":"wav"} Jan 10 09:51:03 volumio volumio[890]: verbose: CURRENT POSITION 0 Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::syncState stateService play Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play Jan 10 09:51:03 volumio volumio[890]: info: Received an update from plugin. extracting info from payload Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:03 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:03 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:03 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:03 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:03 volumio volumio[890]: info: ------------------------------ 185ms Jan 10 09:51:03 volumio volumio[890]: info: ------------------------------ 182ms Jan 10 09:51:03 volumio volumio[890]: info: ------------------------------ 181ms Jan 10 09:51:03 volumio volumio[890]: info: ------------------------------ 181ms Jan 10 09:51:03 volumio volumio[890]: info: sendMpdCommand playlistinfo took 102 milliseconds Jan 10 09:51:03 volumio volumio[890]: info: sendMpdCommand playlistinfo took 103 milliseconds Jan 10 09:51:03 volumio volumio[890]: info: sendMpdCommand playlistinfo took 102 milliseconds Jan 10 09:51:03 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:03 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:03 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:03 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:51:03 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:51:03 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:03 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1365,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01.??????","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/01.灞桥柳.wav","trackType":"wav"} Jan 10 09:51:03 volumio volumio[890]: verbose: CURRENT POSITION 0 Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::syncState stateService play Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play Jan 10 09:51:03 volumio volumio[890]: info: Received an update from plugin. extracting info from payload Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:03 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:03 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 09:51:03 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:03 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:03 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:03 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:51:03 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:51:03 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:03 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1365,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01.??????","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/01.灞桥柳.wav","trackType":"wav"} Jan 10 09:51:03 volumio volumio[890]: verbose: CURRENT POSITION 0 Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::syncState stateService play Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play Jan 10 09:51:03 volumio volumio[890]: info: Received an update from plugin. extracting info from payload Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:03 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:03 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:03 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:03 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:03 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:51:03 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:51:03 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:03 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1365,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01.??????","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/01.灞桥柳.wav","trackType":"wav"} Jan 10 09:51:03 volumio volumio[890]: verbose: CURRENT POSITION 0 Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::syncState stateService play Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play Jan 10 09:51:03 volumio volumio[890]: info: Received an update from plugin. extracting info from payload Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:03 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:03 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:03 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:03 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:03 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:03 volumio volumio[890]: info: ------------------------------ 205ms Jan 10 09:51:03 volumio volumio[890]: info: ------------------------------ 204ms Jan 10 09:51:03 volumio volumio[890]: info: ------------------------------ 204ms Jan 10 09:51:03 volumio systemd[1]: systemd-fsckd.service: Succeeded. Jan 10 09:51:07 volumio volumio[890]: info: CoreCommandRouter::volumioGetState Jan 10 09:51:07 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:07 volumio sudo[1822]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py Jan 10 09:51:07 volumio sudo[1822]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 09:51:09 volumio volumio[890]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 10 Jan 10 09:51:09 volumio volumio[890]: info: CoreCommandRouter::volumioGetState Jan 10 09:51:09 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:09 volumio screensaver.sh[654]: libpng warning: iCCP: known incorrect sRGB profile Jan 10 09:51:09 volumio screensaver.sh[654]: libpng warning: iCCP: known incorrect sRGB profile Jan 10 09:51:09 volumio screensaver.sh[654]: libpng warning: iCCP: known incorrect sRGB profile Jan 10 09:51:09 volumio volumio[890]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 11 Jan 10 09:51:09 volumio volumio[890]: info: CoreCommandRouter::volumioGetState Jan 10 09:51:09 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:10 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 10 09:51:10 volumio volumio[890]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Jan 10 09:51:10 volumio volumio[890]: info: CoreCommandRouter::volumioGetState Jan 10 09:51:10 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:11 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Jan 10 09:51:13 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 10 09:51:13 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 09:51:13 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 10 09:51:13 volumio volumio-remote-updater[662]: No test mode Jan 10 09:51:13 volumio volumio-remote-updater[662]: No alpha test mode Jan 10 09:51:13 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jan 10 09:51:14 volumio volumio[890]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES



 

 

 



NEW ADDITIONS



 

 

 

","title":"Update v3.886","updateavailable":true} Jan 10 09:51:14 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jan 10 09:51:15 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 09:51:15 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jan 10 09:51:15 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jan 10 09:51:15 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jan 10 09:51:15 volumio volumio[890]: info: CoreCommandRouter::volumioGetBrowseSources Jan 10 09:51:15 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 10 09:51:16 volumio volumio[890]: error: MyVolumio Plugin failed to authenticate in a timely fashion Jan 10 09:51:16 volumio volumio[890]: info: Completed starting MyVolumio Plugin Jan 10 09:51:16 volumio volumio[890]: info: BOOT COMPLETED Jan 10 09:51:16 volumio volumio[890]: [Metrics] CommandRouter: 38s 934.87ms Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::volumiosetStartupVolume Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::Close All Modals sent Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::Close All Modals sent Jan 10 09:51:16 volumio volumio[890]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Jan 10 09:51:16 volumio volumio[890]: aplay: main:828: audio open error: Device or resource busy Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::volumioNext Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::next Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::stop Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::stPlaybackTimer Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::updateTrackBlock Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrackBlock Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::serviceStop Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 0 Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::serviceStop Jan 10 09:51:16 volumio volumio[890]: info: ControllerMpd::stop Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand stop Jan 10 09:51:16 volumio volumio[890]: info: sendMpdCommand stop took 18 milliseconds Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::play index undefined Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::startPlaybackTimer Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::clearAddPlayTracks NAS/CD1-210G/【FP抓】童丽 - 念情/02.花谢花飞飞满天.wav Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand stop Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::updateTrackBlock Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrackBlock Jan 10 09:51:16 volumio volumio[890]: info: Jan 10 09:51:16 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:16 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:16 volumio volumio[890]: info: sendMpdCommand stop took 2 milliseconds Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand clear Jan 10 09:51:16 volumio volumio[890]: info: Jan 10 09:51:16 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:16 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:16 volumio volumio[890]: info: Jan 10 09:51:16 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:16 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:16 volumio volumio[890]: info: Jan 10 09:51:16 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:16 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:16 volumio volumio[890]: info: Jan 10 09:51:16 volumio volumio[890]: ---------------------------- MPD announces system playlist update Jan 10 09:51:16 volumio volumio[890]: info: Ignoring MPD Status Update Jan 10 09:51:16 volumio volumio[890]: info: sendMpdCommand status took 6 milliseconds Jan 10 09:51:16 volumio volumio[890]: info: sendMpdCommand clear took 5 milliseconds Jan 10 09:51:16 volumio volumio[890]: info: sendMpdCommand status took 5 milliseconds Jan 10 09:51:16 volumio volumio[890]: info: sendMpdCommand status took 4 milliseconds Jan 10 09:51:16 volumio volumio[890]: info: sendMpdCommand status took 3 milliseconds Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand add "NAS/CD1-210G/【FP抓】童丽 - 念情/02.花谢花飞飞满天.wav" Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:16 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 10 09:51:16 volumio volumio[890]: verbose: CURRENT POSITION 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::syncState stateService stop Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus stop Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:16 volumio volumio[890]: info: No code Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:16 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 10 09:51:16 volumio volumio[890]: verbose: CURRENT POSITION 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::syncState stateService stop Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus stop Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:16 volumio volumio[890]: info: No code Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:16 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 10 09:51:16 volumio volumio[890]: verbose: CURRENT POSITION 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::syncState stateService stop Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus stop Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:16 volumio volumio[890]: info: No code Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:16 volumio volumio[890]: info: ------------------------------ 85ms Jan 10 09:51:16 volumio volumio[890]: info: ------------------------------ 84ms Jan 10 09:51:16 volumio volumio[890]: info: ------------------------------ 84ms Jan 10 09:51:16 volumio volumio[890]: info: Jan 10 09:51:16 volumio volumio[890]: ---------------------------- MPD announces system playlist update Jan 10 09:51:16 volumio volumio[890]: info: Ignoring MPD Status Update Jan 10 09:51:16 volumio volumio[890]: info: Jan 10 09:51:16 volumio volumio[890]: ---------------------------- MPD announces system playlist update Jan 10 09:51:16 volumio volumio[890]: info: Ignoring MPD Status Update Jan 10 09:51:16 volumio volumio[890]: info: Jan 10 09:51:16 volumio volumio[890]: ---------------------------- MPD announces system playlist update Jan 10 09:51:16 volumio volumio[890]: info: Ignoring MPD Status Update Jan 10 09:51:16 volumio volumio[890]: error: updateQueue error: null Jan 10 09:51:16 volumio volumio[890]: info: Jan 10 09:51:16 volumio volumio[890]: ---------------------------- MPD announces system playlist update Jan 10 09:51:16 volumio volumio[890]: info: Ignoring MPD Status Update Jan 10 09:51:16 volumio volumio[890]: info: ------------------------------ 88ms Jan 10 09:51:16 volumio volumio[890]: info: sendMpdCommand playlistinfo took 86 milliseconds Jan 10 09:51:16 volumio volumio[890]: info: sendMpdCommand add "NAS/CD1-210G/【FP抓】童丽 - 念情/02.花谢花飞飞满天.wav" took 86 milliseconds Jan 10 09:51:16 volumio volumio[890]: info: ------------------------------ 5ms Jan 10 09:51:16 volumio volumio[890]: info: ------------------------------ 4ms Jan 10 09:51:16 volumio volumio[890]: info: ------------------------------ 3ms Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand play Jan 10 09:51:16 volumio volumio[890]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 10 09:51:16 volumio volumio[890]: info: ------------------------------ 97ms Jan 10 09:51:16 volumio volumio[890]: info: Jan 10 09:51:16 volumio volumio[890]: ---------------------------- MPD announces system playlist update Jan 10 09:51:16 volumio volumio[890]: info: Ignoring MPD Status Update Jan 10 09:51:16 volumio volumio[890]: info: Jan 10 09:51:16 volumio volumio[890]: ---------------------------- MPD announces system playlist update Jan 10 09:51:16 volumio volumio[890]: info: Ignoring MPD Status Update Jan 10 09:51:16 volumio volumio[890]: info: Jan 10 09:51:16 volumio volumio[890]: ---------------------------- MPD announces system playlist update Jan 10 09:51:16 volumio volumio[890]: info: Ignoring MPD Status Update Jan 10 09:51:16 volumio volumio[890]: info: ------------------------------ 23ms Jan 10 09:51:16 volumio volumio[890]: info: sendMpdCommand play took 21 milliseconds Jan 10 09:51:16 volumio volumio[890]: info: ------------------------------ 19ms Jan 10 09:51:16 volumio volumio[890]: info: ------------------------------ 18ms Jan 10 09:51:16 volumio volumio[890]: info: Jan 10 09:51:16 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:16 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:16 volumio volumio[890]: info: Jan 10 09:51:16 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:16 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:16 volumio volumio[890]: info: Jan 10 09:51:16 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:16 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:16 volumio volumio[890]: info: Jan 10 09:51:16 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:16 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:16 volumio volumio[890]: info: sendMpdCommand status took 8 milliseconds Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:16 volumio volumio[890]: info: Jan 10 09:51:16 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:16 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:16 volumio volumio[890]: info: sendMpdCommand status took 10 milliseconds Jan 10 09:51:16 volumio volumio[890]: info: sendMpdCommand status took 9 milliseconds Jan 10 09:51:16 volumio volumio[890]: info: sendMpdCommand status took 8 milliseconds Jan 10 09:51:16 volumio volumio[890]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:16 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02.??л???ɷ?????","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/02.花谢花飞飞满天.wav","trackType":"wav"} Jan 10 09:51:16 volumio volumio[890]: verbose: CURRENT POSITION 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::syncState stateService play Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus stop Jan 10 09:51:16 volumio volumio[890]: info: ------------------------------ 16ms Jan 10 09:51:16 volumio volumio[890]: info: Jan 10 09:51:16 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:16 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:16 volumio volumio[890]: info: Jan 10 09:51:16 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:16 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:16 volumio volumio[890]: info: Jan 10 09:51:16 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:16 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:16 volumio volumio[890]: info: sendMpdCommand status took 7 milliseconds Jan 10 09:51:16 volumio volumio[890]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 10 09:51:16 volumio volumio[890]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 10 09:51:16 volumio volumio[890]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 10 09:51:16 volumio volumio[890]: info: sendMpdCommand status took 4 milliseconds Jan 10 09:51:16 volumio volumio[890]: info: sendMpdCommand status took 3 milliseconds Jan 10 09:51:16 volumio volumio[890]: info: sendMpdCommand status took 2 milliseconds Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:16 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02.??л???ɷ?????","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/02.花谢花飞飞满天.wav","trackType":"wav"} Jan 10 09:51:16 volumio volumio[890]: verbose: CURRENT POSITION 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::syncState stateService play Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play Jan 10 09:51:16 volumio volumio[890]: info: Received an update from plugin. extracting info from payload Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:16 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02.??л???ɷ?????","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/02.花谢花飞飞满天.wav","trackType":"wav"} Jan 10 09:51:16 volumio volumio[890]: verbose: CURRENT POSITION 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::syncState stateService play Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play Jan 10 09:51:16 volumio volumio[890]: info: Received an update from plugin. extracting info from payload Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:16 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02.??л???ɷ?????","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/02.花谢花飞飞满天.wav","trackType":"wav"} Jan 10 09:51:16 volumio volumio[890]: verbose: CURRENT POSITION 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::syncState stateService play Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play Jan 10 09:51:16 volumio volumio[890]: info: Received an update from plugin. extracting info from payload Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:16 volumio volumio[890]: info: ------------------------------ 76ms Jan 10 09:51:16 volumio volumio[890]: info: ------------------------------ 75ms Jan 10 09:51:16 volumio volumio[890]: info: sendMpdCommand playlistinfo took 60 milliseconds Jan 10 09:51:16 volumio volumio[890]: info: sendMpdCommand playlistinfo took 59 milliseconds Jan 10 09:51:16 volumio volumio[890]: info: sendMpdCommand playlistinfo took 60 milliseconds Jan 10 09:51:16 volumio volumio[890]: info: sendMpdCommand playlistinfo took 59 milliseconds Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:16 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:16 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02.??л???ɷ?????","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/02.花谢花飞飞满天.wav","trackType":"wav"} Jan 10 09:51:16 volumio volumio[890]: verbose: CURRENT POSITION 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::syncState stateService play Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play Jan 10 09:51:16 volumio volumio[890]: info: Received an update from plugin. extracting info from payload Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:16 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02.??л???ɷ?????","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/02.花谢花飞飞满天.wav","trackType":"wav"} Jan 10 09:51:16 volumio volumio[890]: verbose: CURRENT POSITION 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::syncState stateService play Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play Jan 10 09:51:16 volumio volumio[890]: info: Received an update from plugin. extracting info from payload Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:16 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02.??л???ɷ?????","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/02.花谢花飞飞满天.wav","trackType":"wav"} Jan 10 09:51:16 volumio volumio[890]: verbose: CURRENT POSITION 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::syncState stateService play Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play Jan 10 09:51:16 volumio volumio[890]: info: Received an update from plugin. extracting info from payload Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:16 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02.??л???ɷ?????","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/02.花谢花飞飞满天.wav","trackType":"wav"} Jan 10 09:51:16 volumio volumio[890]: verbose: CURRENT POSITION 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::syncState stateService play Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play Jan 10 09:51:16 volumio volumio[890]: info: Received an update from plugin. extracting info from payload Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:16 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:16 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:16 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:16 volumio volumio[890]: info: ------------------------------ 145ms Jan 10 09:51:16 volumio volumio[890]: info: ------------------------------ 141ms Jan 10 09:51:16 volumio volumio[890]: info: ------------------------------ 140ms Jan 10 09:51:16 volumio volumio[890]: info: ------------------------------ 140ms Jan 10 09:51:16 volumio screensaver.sh[654]: libpng warning: iCCP: known incorrect sRGB profile Jan 10 09:51:16 volumio screensaver.sh[654]: libpng warning: iCCP: known incorrect sRGB profile Jan 10 09:51:16 volumio screensaver.sh[654]: libpng warning: iCCP: known incorrect sRGB profile Jan 10 09:51:17 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jan 10 09:51:17 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 10 09:51:17 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jan 10 09:51:18 volumio volumio[890]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8 Jan 10 09:51:18 volumio volumio[890]: info: CoreCommandRouter::volumioGetState Jan 10 09:51:18 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:22 volumio volumio[890]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 10 09:51:22 volumio volumio[890]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 10 09:51:22 volumio volumio[890]: info: Retrieving Cloud Streaming UI Jan 10 09:51:22 volumio volumio[890]: info: Getting Tidal Cloud Configuration Jan 10 09:51:22 volumio volumio[890]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 10 09:51:22 volumio volumio[890]: info: Getting Qobuz Cloud Configuration Jan 10 09:51:22 volumio volumio[890]: info: Asking plugin for UI Config Jan 10 09:51:22 volumio volumio[890]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 10 09:51:22 volumio volumio[890]: info: Getting Spotify Cloud Configuration Jan 10 09:51:22 volumio volumio[890]: info: Asking plugin for UI Config Jan 10 09:51:22 volumio volumio[890]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 10 09:51:22 volumio volumio[890]: info: Saving Spotify Acccount Jan 10 09:51:22 volumio volumio[890]: info: Got Tidal Cloud Configuration Jan 10 09:51:22 volumio volumio[890]: info: Got it Jan 10 09:51:22 volumio volumio[890]: info: Got it Jan 10 09:51:22 volumio volumio[890]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jan 10 09:51:22 volumio volumio[890]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 10 09:51:22 volumio volumio[890]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jan 10 09:51:22 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 10 09:51:22 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 10 09:51:22 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 10 09:51:22 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 09:51:22 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 09:51:22 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 09:51:22 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 09:51:22 volumio volumio[890]: info: CoreCommandRouter::volumioGetBrowseSources Jan 10 09:51:22 volumio volumio[890]: info: CoreCommandRouter::volumioGetBrowseSources Jan 10 09:51:22 volumio volumio[890]: info: CoreCommandRouter::volumioGetBrowseSources Jan 10 09:51:22 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 10 09:51:22 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jan 10 09:51:26 volumio volumio[890]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jan 10 09:51:26 volumio volumio[890]: info: Retrying Login Due to Network Error Jan 10 09:51:26 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 10 09:51:26 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 10 09:51:27 volumio volumio[890]: info: CoreCommandRouter::Close All Modals sent Jan 10 09:51:33 volumio volumio[890]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 10 09:51:33 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jan 10 09:51:33 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jan 10 09:51:33 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Jan 10 09:51:33 volumio volumio[890]: info: Received Get System Version Jan 10 09:51:33 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 10 09:51:33 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds Jan 10 09:51:36 volumio volumio[890]: info: MyVolumio login type: Token Jan 10 09:51:37 volumio volumio[890]: info: CALLMETHOD: system_controller system saveHDMISettings [object Object] Jan 10 09:51:37 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: system , saveHDMISettings Jan 10 09:51:37 volumio sudo[2091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-kiosk.service Jan 10 09:51:37 volumio sudo[2091]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 09:51:37 volumio systemd[1]: Stopping Start Volumio Kiosk... Jan 10 09:51:37 volumio startx[894]: xinit: connection to X server lost Jan 10 09:51:37 volumio startx[894]: [1B blob data] Jan 10 09:51:37 volumio screensaver.sh[654]: XIO: fatal IO error 0 (Success) on X server ":0" Jan 10 09:51:37 volumio screensaver.sh[654]: after 126 requests (126 known processed) with 5 events remaining. Jan 10 09:51:37 volumio sudo[1822]: pam_unix(sudo:session): session closed for user root Jan 10 09:51:37 volumio startx[894]: waiting for X server to shut down (II) Server terminated successfully (0). Closing log file. Jan 10 09:51:38 volumio startx[894]: xinit: unexpected signal 15 Jan 10 09:51:38 volumio systemd[1]: volumio-kiosk.service: Main process exited, code=exited, status=1/FAILURE Jan 10 09:51:38 volumio systemd[1]: volumio-kiosk.service: Failed with result 'exit-code'. Jan 10 09:51:38 volumio systemd[1]: Stopped Start Volumio Kiosk. Jan 10 09:51:38 volumio systemd[1]: Started Start Volumio Kiosk. Jan 10 09:51:38 volumio sudo[2091]: pam_unix(sudo:session): session closed for user root Jan 10 09:51:38 volumio sudo[2103]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable volumio-kiosk.service Jan 10 09:51:38 volumio sudo[2103]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 09:51:38 volumio systemd[1]: Reloading. Jan 10 09:51:38 volumio startx[2101]: X.Org X Server 1.20.4 Jan 10 09:51:38 volumio startx[2101]: X Protocol Version 11, Revision 0 Jan 10 09:51:38 volumio startx[2101]: Build Operating System: Linux 5.10.0-10-amd64 x86_64 Debian Jan 10 09:51:38 volumio startx[2101]: Current Operating System: Linux volumio 6.6.32-volumio #2 SMP PREEMPT_DYNAMIC Wed May 29 23:04:42 CEST 2024 x86_64 Jan 10 09:51:38 volumio startx[2101]: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=d0822069-d48a-490f-b8bc-9970c0b6e384 bootpart=UUID=1496-1547 datapart=UUID=a0bf3376-7b72-4c09-9fc2-d0970ff7651c hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor net.ifnames=0 use_kmsg=no Jan 10 09:51:38 volumio startx[2101]: Build Date: 18 December 2021 09:05:36AM Jan 10 09:51:38 volumio startx[2101]: xorg-server 2:1.20.4-1+deb10u4 (https://www.debian.org/support) Jan 10 09:51:38 volumio startx[2101]: Current version of pixman: 0.36.0 Jan 10 09:51:38 volumio startx[2101]: Before reporting problems, check http://wiki.x.org Jan 10 09:51:38 volumio startx[2101]: to make sure that you have the latest version. Jan 10 09:51:38 volumio startx[2101]: Markers: (--) probed, (**) from config file, (==) default setting, Jan 10 09:51:38 volumio startx[2101]: (++) from command line, (!!) notice, (II) informational, Jan 10 09:51:38 volumio startx[2101]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Jan 10 09:51:38 volumio startx[2101]: (==) Log file: "/var/log/Xorg.0.log", Time: Sat Jan 10 09:51:38 2026 Jan 10 09:51:38 volumio startx[2101]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Jan 10 09:51:38 volumio kernel: broken atomic modeset userspace detected, disabling atomic Jan 10 09:51:38 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Jan 10 09:51:38 volumio startx[2101]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc. Jan 10 09:51:39 volumio systemd[1]: /lib/systemd/system/rpc-statd.service:13: PIDFile= references path below legacy directory /var/run/, updating /var/run/rpc.statd.pid → /run/rpc.statd.pid; please update the unit file accordingly. Jan 10 09:51:39 volumio systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed. Jan 10 09:51:39 volumio sudo[2103]: pam_unix(sudo:session): session closed for user root Jan 10 09:51:39 volumio volumio[890]: info: enable volumio-kiosk service success Jan 10 09:51:42 volumio volumio[890]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Jan 10 09:51:42 volumio volumio[890]: info: CoreCommandRouter::volumioGetVisibleSources Jan 10 09:51:42 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 10 09:51:42 volumio volumio[890]: info: CoreCommandRouter::volumioGetState Jan 10 09:51:42 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:42 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 10 09:51:42 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 10 09:51:42 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 10 09:51:42 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 10 09:51:42 volumio volumio[890]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jan 10 09:51:43 volumio volumio[890]: info: CoreCommandRouter::volumioGetState Jan 10 09:51:43 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:43 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 10 09:51:43 volumio volumio[890]: info: Listing playlists Jan 10 09:51:43 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 10 09:51:43 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 10 09:51:43 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 10 09:51:43 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 10 09:51:44 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 10 09:51:44 volumio volumio[890]: info: Received Get System Info Jan 10 09:51:44 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 10 09:51:44 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 10 09:51:44 volumio volumio[890]: info: Discovery: Getting this device information Jan 10 09:51:44 volumio volumio[890]: info: CoreCommandRouter::volumioGetState Jan 10 09:51:44 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:44 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 10 09:51:48 volumio volumio[890]: info: CoreCommandRouter::volumioNext Jan 10 09:51:48 volumio volumio[890]: info: CoreStateMachine::next Jan 10 09:51:48 volumio volumio[890]: info: CoreStateMachine::stop Jan 10 09:51:48 volumio volumio[890]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 10 09:51:48 volumio volumio[890]: info: CoreStateMachine::stPlaybackTimer Jan 10 09:51:48 volumio volumio[890]: info: CoreStateMachine::updateTrackBlock Jan 10 09:51:48 volumio volumio[890]: info: CorePlayQueue::getTrackBlock Jan 10 09:51:48 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:48 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:48 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 09:51:48 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:48 volumio volumio[890]: info: CoreStateMachine::serviceStop Jan 10 09:51:48 volumio volumio[890]: info: CorePlayQueue::getTrack 1 Jan 10 09:51:48 volumio volumio[890]: info: CoreCommandRouter::serviceStop Jan 10 09:51:48 volumio volumio[890]: info: ControllerMpd::stop Jan 10 09:51:48 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand stop Jan 10 09:51:48 volumio volumio[890]: info: Jan 10 09:51:48 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:48 volumio volumio[890]: info: sendMpdCommand stop took 23 milliseconds Jan 10 09:51:48 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:48 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:48 volumio volumio[890]: info: CoreStateMachine::play index undefined Jan 10 09:51:48 volumio volumio[890]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 10 09:51:48 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:48 volumio volumio[890]: info: CoreStateMachine::startPlaybackTimer Jan 10 09:51:48 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:48 volumio volumio[890]: verbose: ControllerMpd::clearAddPlayTracks NAS/CD1-210G/【FP抓】童丽 - 念情/03.梦入桃花源.wav Jan 10 09:51:48 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand stop Jan 10 09:51:48 volumio volumio[890]: info: CoreStateMachine::updateTrackBlock Jan 10 09:51:48 volumio volumio[890]: info: CorePlayQueue::getTrackBlock Jan 10 09:51:48 volumio volumio[890]: info: Jan 10 09:51:48 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:48 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:48 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:48 volumio volumio[890]: info: Jan 10 09:51:48 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:48 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:48 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:48 volumio volumio[890]: info: Jan 10 09:51:48 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:48 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:48 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:48 volumio volumio[890]: info: sendMpdCommand status took 10 milliseconds Jan 10 09:51:48 volumio volumio[890]: info: sendMpdCommand stop took 8 milliseconds Jan 10 09:51:48 volumio volumio[890]: info: sendMpdCommand status took 5 milliseconds Jan 10 09:51:48 volumio volumio[890]: info: sendMpdCommand status took 4 milliseconds Jan 10 09:51:48 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:48 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:48 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand clear Jan 10 09:51:48 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:48 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:48 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:48 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:48 volumio volumio[890]: info: Jan 10 09:51:48 volumio volumio[890]: ---------------------------- MPD announces system playlist update Jan 10 09:51:48 volumio volumio[890]: info: Ignoring MPD Status Update Jan 10 09:51:48 volumio volumio[890]: info: Jan 10 09:51:48 volumio volumio[890]: ---------------------------- MPD announces system playlist update Jan 10 09:51:48 volumio volumio[890]: info: Ignoring MPD Status Update Jan 10 09:51:48 volumio volumio[890]: info: sendMpdCommand status took 8 milliseconds Jan 10 09:51:48 volumio volumio[890]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 10 09:51:48 volumio volumio[890]: info: sendMpdCommand clear took 6 milliseconds Jan 10 09:51:48 volumio volumio[890]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 10 09:51:48 volumio volumio[890]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 10 09:51:48 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:48 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:48 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:48 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand add "NAS/CD1-210G/【FP抓】童丽 - 念情/03.梦入桃花源.wav" Jan 10 09:51:48 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:48 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:48 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:51:48 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:51:48 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:48 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:48 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 09:51:48 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:48 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:48 volumio volumio[890]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02.??л???ɷ?????","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/02.花谢花飞飞满天.wav","trackType":"wav"} Jan 10 09:51:48 volumio volumio[890]: verbose: CURRENT POSITION 2 Jan 10 09:51:48 volumio volumio[890]: info: CoreStateMachine::syncState stateService stop Jan 10 09:51:48 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus stop Jan 10 09:51:48 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:48 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:48 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:48 volumio volumio[890]: info: No code Jan 10 09:51:48 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:48 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:48 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:48 volumio volumio[890]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 10 09:51:48 volumio volumio[890]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 10 09:51:48 volumio volumio[890]: info: ------------------------------ 53ms Jan 10 09:51:48 volumio volumio[890]: info: ------------------------------ 47ms Jan 10 09:51:48 volumio volumio[890]: info: ------------------------------ 47ms Jan 10 09:51:48 volumio volumio[890]: info: Jan 10 09:51:48 volumio volumio[890]: ---------------------------- MPD announces system playlist update Jan 10 09:51:48 volumio volumio[890]: info: Ignoring MPD Status Update Jan 10 09:51:48 volumio volumio[890]: info: Jan 10 09:51:48 volumio volumio[890]: ---------------------------- MPD announces system playlist update Jan 10 09:51:48 volumio volumio[890]: info: Ignoring MPD Status Update Jan 10 09:51:48 volumio volumio[890]: info: Jan 10 09:51:48 volumio volumio[890]: ---------------------------- MPD announces system playlist update Jan 10 09:51:48 volumio volumio[890]: info: Ignoring MPD Status Update Jan 10 09:51:48 volumio volumio[890]: error: updateQueue error: null Jan 10 09:51:48 volumio volumio[890]: error: updateQueue error: null Jan 10 09:51:48 volumio volumio[890]: info: Jan 10 09:51:48 volumio volumio[890]: ---------------------------- MPD announces system playlist update Jan 10 09:51:48 volumio volumio[890]: info: Ignoring MPD Status Update Jan 10 09:51:48 volumio volumio[890]: info: ------------------------------ 44ms Jan 10 09:51:48 volumio volumio[890]: info: ------------------------------ 43ms Jan 10 09:51:48 volumio volumio[890]: info: sendMpdCommand playlistinfo took 41 milliseconds Jan 10 09:51:48 volumio volumio[890]: info: sendMpdCommand add "NAS/CD1-210G/【FP抓】童丽 - 念情/03.梦入桃花源.wav" took 40 milliseconds Jan 10 09:51:48 volumio volumio[890]: info: ------------------------------ 7ms Jan 10 09:51:48 volumio volumio[890]: info: ------------------------------ 6ms Jan 10 09:51:48 volumio volumio[890]: info: ------------------------------ 5ms Jan 10 09:51:48 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:48 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand play Jan 10 09:51:48 volumio volumio[890]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 10 09:51:48 volumio volumio[890]: info: ------------------------------ 55ms Jan 10 09:51:48 volumio volumio[890]: info: Jan 10 09:51:48 volumio volumio[890]: ---------------------------- MPD announces system playlist update Jan 10 09:51:48 volumio volumio[890]: info: Ignoring MPD Status Update Jan 10 09:51:48 volumio volumio[890]: info: Jan 10 09:51:48 volumio volumio[890]: ---------------------------- MPD announces system playlist update Jan 10 09:51:48 volumio volumio[890]: info: Ignoring MPD Status Update Jan 10 09:51:48 volumio volumio[890]: info: ------------------------------ 17ms Jan 10 09:51:48 volumio volumio[890]: info: sendMpdCommand play took 13 milliseconds Jan 10 09:51:48 volumio volumio[890]: info: ------------------------------ 12ms Jan 10 09:51:48 volumio volumio[890]: info: ------------------------------ 10ms Jan 10 09:51:48 volumio volumio[890]: info: CoreCommandRouter::volumioGetState Jan 10 09:51:48 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:49 volumio volumio[890]: info: Jan 10 09:51:49 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:49 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:49 volumio volumio[890]: info: Jan 10 09:51:49 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:49 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:49 volumio volumio[890]: info: Jan 10 09:51:49 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:49 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:49 volumio volumio[890]: info: Jan 10 09:51:49 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:49 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:49 volumio volumio[890]: info: Jan 10 09:51:49 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:49 volumio volumio[890]: info: sendMpdCommand status took 8 milliseconds Jan 10 09:51:49 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:49 volumio volumio[890]: info: sendMpdCommand status took 7 milliseconds Jan 10 09:51:49 volumio volumio[890]: info: sendMpdCommand status took 6 milliseconds Jan 10 09:51:49 volumio volumio[890]: info: sendMpdCommand status took 5 milliseconds Jan 10 09:51:49 volumio volumio[890]: info: sendMpdCommand status took 3 milliseconds Jan 10 09:51:49 volumio volumio[890]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:49 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:51:49 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:51:49 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:49 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":350,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03.?????һ?Դ","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/03.梦入桃花源.wav","trackType":"wav"} Jan 10 09:51:49 volumio volumio[890]: verbose: CURRENT POSITION 2 Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::syncState stateService play Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus stop Jan 10 09:51:49 volumio volumio[890]: info: ------------------------------ 16ms Jan 10 09:51:49 volumio volumio[890]: info: Jan 10 09:51:49 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:49 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:49 volumio volumio[890]: info: Jan 10 09:51:49 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:49 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:49 volumio volumio[890]: info: Jan 10 09:51:49 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:51:49 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:51:49 volumio volumio[890]: info: sendMpdCommand playlistinfo took 11 milliseconds Jan 10 09:51:49 volumio volumio[890]: info: sendMpdCommand playlistinfo took 12 milliseconds Jan 10 09:51:49 volumio volumio[890]: info: sendMpdCommand playlistinfo took 12 milliseconds Jan 10 09:51:49 volumio volumio[890]: info: sendMpdCommand playlistinfo took 11 milliseconds Jan 10 09:51:49 volumio volumio[890]: info: sendMpdCommand status took 5 milliseconds Jan 10 09:51:49 volumio volumio[890]: info: sendMpdCommand status took 4 milliseconds Jan 10 09:51:49 volumio volumio[890]: info: sendMpdCommand status took 3 milliseconds Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:51:49 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:51:49 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:51:49 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:49 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":350,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03.?????һ?Դ","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/03.梦入桃花源.wav","trackType":"wav"} Jan 10 09:51:49 volumio volumio[890]: verbose: CURRENT POSITION 2 Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::syncState stateService play Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play Jan 10 09:51:49 volumio volumio[890]: info: Received an update from plugin. extracting info from payload Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:49 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:49 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 09:51:49 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:49 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:49 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:49 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:51:49 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:51:49 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:49 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":350,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03.?????һ?Դ","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/03.梦入桃花源.wav","trackType":"wav"} Jan 10 09:51:49 volumio volumio[890]: verbose: CURRENT POSITION 2 Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::syncState stateService play Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play Jan 10 09:51:49 volumio volumio[890]: info: Received an update from plugin. extracting info from payload Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:49 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:49 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:49 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:49 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:49 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:51:49 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:51:49 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:49 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":350,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03.?????һ?Դ","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/03.梦入桃花源.wav","trackType":"wav"} Jan 10 09:51:49 volumio volumio[890]: verbose: CURRENT POSITION 2 Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::syncState stateService play Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play Jan 10 09:51:49 volumio volumio[890]: info: Received an update from plugin. extracting info from payload Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:49 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:49 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:49 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:49 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:49 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:51:49 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:51:49 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:49 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":350,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03.?????һ?Դ","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/03.梦入桃花源.wav","trackType":"wav"} Jan 10 09:51:49 volumio volumio[890]: verbose: CURRENT POSITION 2 Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::syncState stateService play Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play Jan 10 09:51:49 volumio volumio[890]: info: Received an update from plugin. extracting info from payload Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:49 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:49 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:49 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:49 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:49 volumio volumio[890]: info: ------------------------------ 92ms Jan 10 09:51:49 volumio volumio[890]: info: ------------------------------ 91ms Jan 10 09:51:49 volumio volumio[890]: info: ------------------------------ 91ms Jan 10 09:51:49 volumio volumio[890]: info: ------------------------------ 88ms Jan 10 09:51:49 volumio volumio[890]: info: sendMpdCommand playlistinfo took 70 milliseconds Jan 10 09:51:49 volumio volumio[890]: info: sendMpdCommand playlistinfo took 70 milliseconds Jan 10 09:51:49 volumio volumio[890]: info: sendMpdCommand playlistinfo took 69 milliseconds Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:49 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:51:49 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:51:49 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:51:49 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:49 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":350,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03.?????һ?Դ","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/03.梦入桃花源.wav","trackType":"wav"} Jan 10 09:51:49 volumio volumio[890]: verbose: CURRENT POSITION 2 Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::syncState stateService play Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play Jan 10 09:51:49 volumio volumio[890]: info: Received an update from plugin. extracting info from payload Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:49 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:49 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:49 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:49 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:49 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:51:49 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:51:49 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:49 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":350,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03.?????һ?Դ","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/03.梦入桃花源.wav","trackType":"wav"} Jan 10 09:51:49 volumio volumio[890]: verbose: CURRENT POSITION 2 Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::syncState stateService play Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play Jan 10 09:51:49 volumio volumio[890]: info: Received an update from plugin. extracting info from payload Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:49 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:49 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:49 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:49 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:49 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:51:49 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:51:49 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:49 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":350,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03.?????һ?Դ","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/03.梦入桃花源.wav","trackType":"wav"} Jan 10 09:51:49 volumio volumio[890]: verbose: CURRENT POSITION 2 Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::syncState stateService play Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play Jan 10 09:51:49 volumio volumio[890]: info: Received an update from plugin. extracting info from payload Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:49 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:49 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:49 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:51:49 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:49 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:51:49 volumio volumio[890]: info: ------------------------------ 127ms Jan 10 09:51:49 volumio volumio[890]: info: ------------------------------ 123ms Jan 10 09:51:49 volumio volumio[890]: info: ------------------------------ 123ms Jan 10 09:51:59 volumio volumio[890]: info: CoreCommandRouter::volumioGetState Jan 10 09:51:59 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:51:59 volumio sudo[2516]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py Jan 10 09:51:59 volumio sudo[2516]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 09:52:01 volumio volumio[890]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8 Jan 10 09:52:01 volumio volumio[890]: info: CoreCommandRouter::volumioGetState Jan 10 09:52:01 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:52:01 volumio screensaver.sh[654]: libpng warning: iCCP: known incorrect sRGB profile Jan 10 09:52:01 volumio screensaver.sh[654]: libpng warning: iCCP: known incorrect sRGB profile Jan 10 09:52:01 volumio screensaver.sh[654]: libpng warning: iCCP: known incorrect sRGB profile Jan 10 09:52:01 volumio volumio[890]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Jan 10 09:52:01 volumio volumio[890]: info: CoreCommandRouter::volumioGetState Jan 10 09:52:01 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:52:06 volumio volumio[890]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jan 10 09:52:06 volumio volumio[890]: info: Retrying Login Due to Network Error Jan 10 09:52:14 volumio volumio[890]: info: CoreCommandRouter::volumioPause Jan 10 09:52:14 volumio volumio[890]: info: CoreStateMachine::pause Jan 10 09:52:14 volumio volumio[890]: info: CoreStateMachine::stPlaybackTimer Jan 10 09:52:14 volumio volumio[890]: info: CoreStateMachine::servicePause Jan 10 09:52:14 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:52:14 volumio volumio[890]: info: CoreCommandRouter::servicePause Jan 10 09:52:14 volumio volumio[890]: info: ControllerMpd::pause Jan 10 09:52:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand pause Jan 10 09:52:14 volumio volumio[890]: info: Jan 10 09:52:14 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:52:14 volumio volumio[890]: info: sendMpdCommand pause took 3 milliseconds Jan 10 09:52:14 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:52:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:52:14 volumio volumio[890]: info: Jan 10 09:52:14 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:52:14 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:52:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:52:14 volumio volumio[890]: info: Jan 10 09:52:14 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:52:14 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:52:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:52:14 volumio volumio[890]: info: Jan 10 09:52:14 volumio volumio[890]: ---------------------------- MPD announces state update: player Jan 10 09:52:14 volumio volumio[890]: info: ControllerMpd::getState Jan 10 09:52:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status Jan 10 09:52:14 volumio volumio[890]: info: sendMpdCommand status took 5 milliseconds Jan 10 09:52:14 volumio volumio[890]: info: sendMpdCommand status took 4 milliseconds Jan 10 09:52:14 volumio volumio[890]: info: sendMpdCommand status took 3 milliseconds Jan 10 09:52:14 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:52:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:52:14 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:52:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:52:14 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:52:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:52:14 volumio volumio[890]: info: sendMpdCommand status took 5 milliseconds Jan 10 09:52:14 volumio volumio[890]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 10 09:52:14 volumio volumio[890]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 10 09:52:14 volumio volumio[890]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 10 09:52:14 volumio volumio[890]: verbose: ControllerMpd::parseState Jan 10 09:52:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 09:52:14 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:52:14 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:52:14 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:52:14 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:52:14 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:52:14 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:52:14 volumio volumio[890]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":25498,"duration":350,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03.?????һ?Դ","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/03.梦入桃花源.wav","trackType":"wav"} Jan 10 09:52:14 volumio volumio[890]: verbose: CURRENT POSITION 2 Jan 10 09:52:14 volumio volumio[890]: info: CoreStateMachine::syncState stateService pause Jan 10 09:52:14 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus pause Jan 10 09:52:14 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:52:14 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:52:14 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 09:52:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:52:14 volumio volumio[890]: info: CoreStateMachine::stPlaybackTimer Jan 10 09:52:14 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:52:14 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:52:14 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:52:14 volumio volumio[890]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":25498,"duration":350,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03.?????һ?Դ","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/03.梦入桃花源.wav","trackType":"wav"} Jan 10 09:52:14 volumio volumio[890]: verbose: CURRENT POSITION 2 Jan 10 09:52:14 volumio volumio[890]: info: CoreStateMachine::syncState stateService pause Jan 10 09:52:14 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus pause Jan 10 09:52:14 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:52:14 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:52:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:52:14 volumio volumio[890]: info: CoreStateMachine::stPlaybackTimer Jan 10 09:52:14 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:52:14 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:52:14 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:52:14 volumio volumio[890]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":25498,"duration":350,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03.?????һ?Դ","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/03.梦入桃花源.wav","trackType":"wav"} Jan 10 09:52:14 volumio volumio[890]: verbose: CURRENT POSITION 2 Jan 10 09:52:14 volumio volumio[890]: info: CoreStateMachine::syncState stateService pause Jan 10 09:52:14 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus pause Jan 10 09:52:14 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:52:14 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:52:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:52:14 volumio volumio[890]: info: CoreStateMachine::stPlaybackTimer Jan 10 09:52:14 volumio volumio[890]: info: ------------------------------ 54ms Jan 10 09:52:14 volumio volumio[890]: info: ------------------------------ 52ms Jan 10 09:52:14 volumio volumio[890]: info: ------------------------------ 53ms Jan 10 09:52:14 volumio volumio[890]: info: sendMpdCommand playlistinfo took 46 milliseconds Jan 10 09:52:14 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo Jan 10 09:52:14 volumio volumio[890]: info: ControllerMpd::pushState Jan 10 09:52:14 volumio volumio[890]: info: CoreCommandRouter::servicePushState Jan 10 09:52:14 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:52:14 volumio volumio[890]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":25498,"duration":350,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03.?????һ?Դ","artist":"ͯ??","album":"????","uri":"NAS/CD1-210G/【FP抓】童丽 - 念情/03.梦入桃花源.wav","trackType":"wav"} Jan 10 09:52:14 volumio volumio[890]: verbose: CURRENT POSITION 2 Jan 10 09:52:14 volumio volumio[890]: info: CoreStateMachine::syncState stateService pause Jan 10 09:52:14 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus pause Jan 10 09:52:14 volumio volumio[890]: info: CoreStateMachine::pushState Jan 10 09:52:14 volumio volumio[890]: info: CorePlayQueue::getTrack 2 Jan 10 09:52:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState Jan 10 09:52:14 volumio volumio[890]: info: CoreStateMachine::stPlaybackTimer Jan 10 09:52:14 volumio volumio[890]: info: ------------------------------ 72ms Jan 10 09:52:14 volumio volumio[890]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 10 09:52:14 volumio volumio[890]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning' Jan 10 09:52:14 volumio volumio[890]: at Object.readdirSync (fs.js:1048:3) Jan 10 09:52:14 volumio volumio[890]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11) Jan 10 09:52:14 volumio volumio[890]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7) Jan 10 09:52:14 volumio volumio[890]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62) Jan 10 09:52:14 volumio volumio[890]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17) Jan 10 09:52:14 volumio volumio[890]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48) Jan 10 09:52:14 volumio volumio[890]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Jan 10 09:52:14 volumio volumio[890]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10) Jan 10 09:52:14 volumio volumio[890]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12) Jan 10 09:52:14 volumio volumio[890]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Jan 10 09:52:14 volumio volumio[890]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Jan 10 09:52:14 volumio volumio[890]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8) Jan 10 09:52:14 volumio volumio[890]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Jan 10 09:52:14 volumio volumio[890]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Jan 10 09:52:14 volumio volumio[890]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12) Jan 10 09:52:14 volumio volumio[890]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) { Jan 10 09:52:14 volumio volumio[890]: errno: -20, Jan 10 09:52:14 volumio volumio[890]: syscall: 'scandir', Jan 10 09:52:14 volumio volumio[890]: code: 'ENOTDIR', Jan 10 09:52:14 volumio volumio[890]: path: '/tmp/peppyrunning' Jan 10 09:52:14 volumio volumio[890]: } Jan 10 09:52:14 volumio volumio[890]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 10 09:52:14 volumio sudo[2606]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-10 09:51 Jan 10 09:52:14 volumio sudo[2606]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"