-- Logs begin at Thu 2024-09-05 21:01:34 CST, end at Thu 2024-09-05 21:06:27 CST. -- Sep 05 21:05:07 volumio3 volumio[1438]: info: CoreCommandRouter::volumioGetState Sep 05 21:05:07 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:05:09 volumio3 volumio[1438]: info: CoreCommandRouter::volumioNext Sep 05 21:05:09 volumio3 volumio[1438]: info: CoreStateMachine::next Sep 05 21:05:09 volumio3 volumio[1438]: info: CoreStateMachine::stop Sep 05 21:05:09 volumio3 volumio[1438]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 21:05:09 volumio3 volumio[1438]: info: CoreStateMachine::stPlaybackTimer Sep 05 21:05:09 volumio3 volumio[1438]: info: CoreStateMachine::updateTrackBlock Sep 05 21:05:09 volumio3 volumio[1438]: info: CorePlayQueue::getTrackBlock Sep 05 21:05:09 volumio3 volumio[1438]: info: CoreStateMachine::pushState Sep 05 21:05:09 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:05:09 volumio3 volumio[1438]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 21:05:09 volumio3 volumio[1438]: info: CoreCommandRouter::volumioPushState Sep 05 21:05:09 volumio3 volumio[1438]: info: CoreStateMachine::serviceStop Sep 05 21:05:09 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:05:09 volumio3 volumio[1438]: info: CoreCommandRouter::serviceStop Sep 05 21:05:09 volumio3 volumio[1438]: info: ControllerMpd::stop Sep 05 21:05:09 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand stop Sep 05 21:05:09 volumio3 volumio[1438]: info: sendMpdCommand stop took 25 milliseconds Sep 05 21:05:09 volumio3 volumio[1438]: info: CoreStateMachine::play index undefined Sep 05 21:05:09 volumio3 volumio[1438]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 21:05:09 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 1 Sep 05 21:05:09 volumio3 volumio[1438]: info: CoreStateMachine::startPlaybackTimer Sep 05 21:05:09 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 1 Sep 05 21:05:09 volumio3 volumio[1438]: verbose: ControllerMpd::clearAddPlayTracks NAS/My_Music/00CD/《音乐之声电影原声带》35周年至尊完整版/The Sound of Music(disc 1)/02. Overture and Preludium (Dixit Dominus) .ape Sep 05 21:05:09 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand stop Sep 05 21:05:09 volumio3 volumio[1438]: info: CoreStateMachine::updateTrackBlock Sep 05 21:05:09 volumio3 volumio[1438]: info: CorePlayQueue::getTrackBlock Sep 05 21:05:09 volumio3 volumio[1438]: info: Sep 05 21:05:09 volumio3 volumio[1438]: ---------------------------- MPD announces state update: player Sep 05 21:05:09 volumio3 volumio[1438]: info: ControllerMpd::getState Sep 05 21:05:09 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand status Sep 05 21:05:09 volumio3 volumio[1438]: info: sendMpdCommand stop took 1 milliseconds Sep 05 21:05:09 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand clear Sep 05 21:05:09 volumio3 volumio[1438]: info: Sep 05 21:05:09 volumio3 volumio[1438]: ---------------------------- MPD announces system playlist update Sep 05 21:05:09 volumio3 volumio[1438]: info: Ignoring MPD Status Update Sep 05 21:05:09 volumio3 volumio[1438]: info: sendMpdCommand status took 1 milliseconds Sep 05 21:05:09 volumio3 volumio[1438]: info: sendMpdCommand clear took 1 milliseconds Sep 05 21:05:09 volumio3 volumio[1438]: verbose: ControllerMpd::parseState Sep 05 21:05:09 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 21:05:09 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand add "NAS/My_Music/00CD/《音乐之声电影原声带》35周年至尊完整版/The Sound of Music(disc 1)/02. Overture and Preludium (Dixit Dominus) .ape" Sep 05 21:05:09 volumio3 volumio[1438]: error: updateQueue error: null Sep 05 21:05:09 volumio3 volumio[1438]: info: Sep 05 21:05:09 volumio3 volumio[1438]: ---------------------------- MPD announces system playlist update Sep 05 21:05:09 volumio3 volumio[1438]: info: Ignoring MPD Status Update Sep 05 21:05:09 volumio3 volumio[1438]: info: ------------------------------ 2ms Sep 05 21:05:09 volumio3 volumio[1438]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 05 21:05:09 volumio3 volumio[1438]: info: sendMpdCommand add "NAS/My_Music/00CD/《音乐之声电影原声带》35周年至尊完整版/The Sound of Music(disc 1)/02. Overture and Preludium (Dixit Dominus) .ape" took 2 milliseconds Sep 05 21:05:09 volumio3 volumio[1438]: verbose: ControllerMpd::parseTrackInfo Sep 05 21:05:09 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand play Sep 05 21:05:09 volumio3 volumio[1438]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 05 21:05:09 volumio3 volumio[1438]: info: ------------------------------ 4ms Sep 05 21:05:09 volumio3 volumio[1438]: info: ------------------------------ 2ms Sep 05 21:05:09 volumio3 volumio[1438]: info: sendMpdCommand play took 1 milliseconds Sep 05 21:05:09 volumio3 volumio[1438]: info: Sep 05 21:05:09 volumio3 volumio[1438]: ---------------------------- MPD announces state update: player Sep 05 21:05:09 volumio3 volumio[1438]: info: ControllerMpd::getState Sep 05 21:05:09 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand status Sep 05 21:05:09 volumio3 volumio[1438]: info: Sep 05 21:05:09 volumio3 volumio[1438]: ---------------------------- MPD announces state update: player Sep 05 21:05:09 volumio3 volumio[1438]: info: sendMpdCommand status took 4 milliseconds Sep 05 21:05:09 volumio3 volumio[1438]: info: ControllerMpd::getState Sep 05 21:05:09 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand status Sep 05 21:05:09 volumio3 volumio[1438]: verbose: ControllerMpd::parseState Sep 05 21:05:09 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 21:05:09 volumio3 volumio[1438]: info: sendMpdCommand status took 1 milliseconds Sep 05 21:05:09 volumio3 volumio[1438]: info: sendMpdCommand playlistinfo took 0 milliseconds Sep 05 21:05:09 volumio3 volumio[1438]: verbose: ControllerMpd::parseState Sep 05 21:05:09 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 21:05:09 volumio3 volumio[1438]: verbose: ControllerMpd::parseTrackInfo Sep 05 21:05:09 volumio3 volumio[1438]: info: ControllerMpd::pushState Sep 05 21:05:09 volumio3 volumio[1438]: info: CoreCommandRouter::servicePushState Sep 05 21:05:09 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 1 Sep 05 21:05:09 volumio3 volumio[1438]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":196,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Overture and Preludium (Dixit Dominus) ","artist":"Various Artists","album":"The Sound of Music","uri":"NAS/My_Music/00CD/《音乐之声电影原声带》35周年至尊完整版/The Sound of Music(disc 1)/02. Overture and Preludium (Dixit Dominus) .ape","trackType":"ape"} Sep 05 21:05:09 volumio3 volumio[1438]: verbose: CURRENT POSITION 1 Sep 05 21:05:09 volumio3 volumio[1438]: info: CoreStateMachine::syncState stateService play Sep 05 21:05:09 volumio3 volumio[1438]: info: CoreStateMachine::syncState currentStatus stop Sep 05 21:05:09 volumio3 volumio[1438]: info: ------------------------------ 8ms Sep 05 21:05:09 volumio3 volumio[1438]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 05 21:05:09 volumio3 volumio[1438]: verbose: ControllerMpd::parseTrackInfo Sep 05 21:05:09 volumio3 volumio[1438]: info: ControllerMpd::pushState Sep 05 21:05:09 volumio3 volumio[1438]: info: CoreCommandRouter::servicePushState Sep 05 21:05:09 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 1 Sep 05 21:05:09 volumio3 volumio[1438]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":196,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Overture and Preludium (Dixit Dominus) ","artist":"Various Artists","album":"The Sound of Music","uri":"NAS/My_Music/00CD/《音乐之声电影原声带》35周年至尊完整版/The Sound of Music(disc 1)/02. Overture and Preludium (Dixit Dominus) .ape","trackType":"ape"} Sep 05 21:05:09 volumio3 volumio[1438]: verbose: CURRENT POSITION 1 Sep 05 21:05:09 volumio3 volumio[1438]: info: CoreStateMachine::syncState stateService play Sep 05 21:05:09 volumio3 volumio[1438]: info: CoreStateMachine::syncState currentStatus play Sep 05 21:05:09 volumio3 volumio[1438]: info: Received an update from plugin. extracting info from payload Sep 05 21:05:09 volumio3 volumio[1438]: info: CoreStateMachine::pushState Sep 05 21:05:09 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 1 Sep 05 21:05:09 volumio3 volumio[1438]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 21:05:09 volumio3 volumio[1438]: info: CoreCommandRouter::volumioPushState Sep 05 21:05:09 volumio3 volumio[1438]: info: CoreStateMachine::pushState Sep 05 21:05:09 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 1 Sep 05 21:05:09 volumio3 volumio[1438]: info: CoreCommandRouter::volumioPushState Sep 05 21:05:09 volumio3 volumio[1438]: info: ------------------------------ 15ms Sep 05 21:05:11 volumio3 volumio[1438]: 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: 7 Sep 05 21:05:11 volumio3 volumio[1438]: info: CoreCommandRouter::volumioGetState Sep 05 21:05:11 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 1 Sep 05 21:05:11 volumio3 volumio[1438]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Various%20Artists/The%20Sound%20of%20Music/a740544a-4da9-4fd6-964a-48c42bb1891b.png' Sep 05 21:05:18 volumio3 volumio[1438]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Sep 05 21:05:18 volumio3 volumio[1438]: info: Retrying Login Due to Network Error Sep 05 21:05:22 volumio3 volumio[1438]: info: CoreCommandRouter::volumioGetState Sep 05 21:05:22 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 1 Sep 05 21:05:24 volumio3 volumio[1438]: info: Preload queue cleared Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreStateMachine::ClearQueue Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreStateMachine::stop Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreStateMachine::stPlaybackTimer Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreStateMachine::updateTrackBlock Sep 05 21:05:24 volumio3 volumio[1438]: info: CorePlayQueue::getTrackBlock Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreStateMachine::pushState Sep 05 21:05:24 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 1 Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreCommandRouter::volumioPushState Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreStateMachine::serviceStop Sep 05 21:05:24 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 1 Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreCommandRouter::serviceStop Sep 05 21:05:24 volumio3 volumio[1438]: info: ControllerMpd::stop Sep 05 21:05:24 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand stop Sep 05 21:05:24 volumio3 volumio[1438]: info: CorePlayQueue::clearPlayQueue Sep 05 21:05:24 volumio3 volumio[1438]: info: CorePlayQueue::saveQueue Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreCommandRouter::volumioPushQueue Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreStateMachine::addQueueItems Sep 05 21:05:24 volumio3 volumio[1438]: info: CorePlayQueue::addQueueItems Sep 05 21:05:24 volumio3 volumio[1438]: info: Preload queue cleared Sep 05 21:05:24 volumio3 volumio[1438]: info: Adding Item to queue: music-library/NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》 Sep 05 21:05:24 volumio3 volumio[1438]: info: Exploding uri music-library/NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》 in service mpd Sep 05 21:05:24 volumio3 volumio[1438]: info: sendMpdCommand stop took 26 milliseconds Sep 05 21:05:24 volumio3 volumio[1438]: info: Sep 05 21:05:24 volumio3 volumio[1438]: ---------------------------- MPD announces state update: player Sep 05 21:05:24 volumio3 volumio[1438]: info: ALBUMART /albumart?cacheid=300&web=//large&path=%2Fmnt%2FNAS%2FMy_Music%2F00CD%2FDTS-ES6.1%20%E8%BE%BE%E5%B0%BC%E6%B5%8B%E8%AF%95%E7%A2%9F%E3%80%8AThe%20Dali-3%E3%80%8B%2F01%20Pat%20Metheny.wav&metadata=false Sep 05 21:05:24 volumio3 volumio[1438]: info: URI /mnt/NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》/01 Pat Metheny.wav Sep 05 21:05:24 volumio3 volumio[1438]: info: ALBUMART /albumart?cacheid=300&web=//large&path=%2Fmnt%2FNAS%2FMy_Music%2F00CD%2FDTS-ES6.1%20%E8%BE%BE%E5%B0%BC%E6%B5%8B%E8%AF%95%E7%A2%9F%E3%80%8AThe%20Dali-3%E3%80%8B%2F02%20Sophie%20Zelmani.wav&metadata=false Sep 05 21:05:24 volumio3 volumio[1438]: info: URI /mnt/NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》/02 Sophie Zelmani.wav Sep 05 21:05:24 volumio3 volumio[1438]: info: ALBUMART /albumart?cacheid=300&web=//large&path=%2Fmnt%2FNAS%2FMy_Music%2F00CD%2FDTS-ES6.1%20%E8%BE%BE%E5%B0%BC%E6%B5%8B%E8%AF%95%E7%A2%9F%E3%80%8AThe%20Dali-3%E3%80%8B%2F03%20Teitur.wav&metadata=false Sep 05 21:05:24 volumio3 volumio[1438]: info: URI /mnt/NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》/03 Teitur.wav Sep 05 21:05:24 volumio3 volumio[1438]: info: ALBUMART /albumart?cacheid=300&web=//large&path=%2Fmnt%2FNAS%2FMy_Music%2F00CD%2FDTS-ES6.1%20%E8%BE%BE%E5%B0%BC%E6%B5%8B%E8%AF%95%E7%A2%9F%E3%80%8AThe%20Dali-3%E3%80%8B%2F04%20Zhao%20Cong.wav&metadata=false Sep 05 21:05:24 volumio3 volumio[1438]: info: URI /mnt/NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》/04 Zhao Cong.wav Sep 05 21:05:24 volumio3 volumio[1438]: info: ALBUMART /albumart?cacheid=300&web=//large&path=%2Fmnt%2FNAS%2FMy_Music%2F00CD%2FDTS-ES6.1%20%E8%BE%BE%E5%B0%BC%E6%B5%8B%E8%AF%95%E7%A2%9F%E3%80%8AThe%20Dali-3%E3%80%8B%2F05%20Ane%20Brun.wav&metadata=false Sep 05 21:05:24 volumio3 volumio[1438]: info: URI /mnt/NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》/05 Ane Brun.wav Sep 05 21:05:24 volumio3 volumio[1438]: info: ALBUMART /albumart?cacheid=300&web=//large&path=%2Fmnt%2FNAS%2FMy_Music%2F00CD%2FDTS-ES6.1%20%E8%BE%BE%E5%B0%BC%E6%B5%8B%E8%AF%95%E7%A2%9F%E3%80%8AThe%20Dali-3%E3%80%8B%2F06%20SkoTorp.wav&metadata=false Sep 05 21:05:24 volumio3 volumio[1438]: info: URI /mnt/NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》/06 SkoTorp.wav Sep 05 21:05:24 volumio3 volumio[1438]: info: ALBUMART /albumart?cacheid=300&web=//large&path=%2Fmnt%2FNAS%2FMy_Music%2F00CD%2FDTS-ES6.1%20%E8%BE%BE%E5%B0%BC%E6%B5%8B%E8%AF%95%E7%A2%9F%E3%80%8AThe%20Dali-3%E3%80%8B%2F07%20Sinne%20Eeg.wav&metadata=false Sep 05 21:05:24 volumio3 volumio[1438]: info: URI /mnt/NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》/07 Sinne Eeg.wav Sep 05 21:05:24 volumio3 volumio[1438]: info: ALBUMART /albumart?cacheid=300&web=//large&path=%2Fmnt%2FNAS%2FMy_Music%2F00CD%2FDTS-ES6.1%20%E8%BE%BE%E5%B0%BC%E6%B5%8B%E8%AF%95%E7%A2%9F%E3%80%8AThe%20Dali-3%E3%80%8B%2F08%20OP8%20-%20Leather.wav&metadata=false Sep 05 21:05:24 volumio3 volumio[1438]: info: URI /mnt/NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》/08 OP8 - Leather.wav Sep 05 21:05:24 volumio3 volumio[1438]: info: ALBUMART /albumart?cacheid=300&web=//large&path=%2Fmnt%2FNAS%2FMy_Music%2F00CD%2FDTS-ES6.1%20%E8%BE%BE%E5%B0%BC%E6%B5%8B%E8%AF%95%E7%A2%9F%E3%80%8AThe%20Dali-3%E3%80%8B%2F09%20The%20Brandt%20Brauer%20Frick%20Ensemble.wav&metadata=false Sep 05 21:05:24 volumio3 volumio[1438]: info: URI /mnt/NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》/09 The Brandt Brauer Frick Ensemble.wav Sep 05 21:05:24 volumio3 volumio[1438]: info: ALBUMART /albumart?cacheid=300&web=//large&path=%2Fmnt%2FNAS%2FMy_Music%2F00CD%2FDTS-ES6.1%20%E8%BE%BE%E5%B0%BC%E6%B5%8B%E8%AF%95%E7%A2%9F%E3%80%8AThe%20Dali-3%E3%80%8B%2F10%20Jan%20Harbeck%20Quartet.wav&metadata=false Sep 05 21:05:24 volumio3 volumio[1438]: info: URI /mnt/NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》/10 Jan Harbeck Quartet.wav Sep 05 21:05:24 volumio3 volumio[1438]: info: ALBUMART /albumart?cacheid=300&web=//large&path=%2Fmnt%2FNAS%2FMy_Music%2F00CD%2FDTS-ES6.1%20%E8%BE%BE%E5%B0%BC%E6%B5%8B%E8%AF%95%E7%A2%9F%E3%80%8AThe%20Dali-3%E3%80%8B%2F11%20Haydn.wav&metadata=false Sep 05 21:05:24 volumio3 volumio[1438]: info: URI /mnt/NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》/11 Haydn.wav Sep 05 21:05:24 volumio3 volumio[1438]: info: ALBUMART /albumart?cacheid=300&web=//large&path=%2Fmnt%2FNAS%2FMy_Music%2F00CD%2FDTS-ES6.1%20%E8%BE%BE%E5%B0%BC%E6%B5%8B%E8%AF%95%E7%A2%9F%E3%80%8AThe%20Dali-3%E3%80%8B%2F12%20Grieg.wav&metadata=false Sep 05 21:05:24 volumio3 volumio[1438]: info: URI /mnt/NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》/12 Grieg.wav Sep 05 21:05:24 volumio3 volumio[1438]: info: ALBUMART /albumart?cacheid=300&web=//large&path=%2Fmnt%2FNAS%2FMy_Music%2F00CD%2FDTS-ES6.1%20%E8%BE%BE%E5%B0%BC%E6%B5%8B%E8%AF%95%E7%A2%9F%E3%80%8AThe%20Dali-3%E3%80%8B%2F13%20Tim%20Christensen.wav&metadata=false Sep 05 21:05:24 volumio3 volumio[1438]: info: URI /mnt/NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》/13 Tim Christensen.wav Sep 05 21:05:24 volumio3 volumio[1438]: info: ALBUMART /albumart?cacheid=300&web=//large&path=%2Fmnt%2FNAS%2FMy_Music%2F00CD%2FDTS-ES6.1%20%E8%BE%BE%E5%B0%BC%E6%B5%8B%E8%AF%95%E7%A2%9F%E3%80%8AThe%20Dali-3%E3%80%8B%2F14%20Fallulah.wav&metadata=false Sep 05 21:05:24 volumio3 volumio[1438]: info: URI /mnt/NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》/14 Fallulah.wav Sep 05 21:05:24 volumio3 volumio[1438]: info: ALBUMART /albumart?cacheid=300&web=//large&path=%2Fmnt%2FNAS%2FMy_Music%2F00CD%2FDTS-ES6.1%20%E8%BE%BE%E5%B0%BC%E6%B5%8B%E8%AF%95%E7%A2%9F%E3%80%8AThe%20Dali-3%E3%80%8B%2F15%20Mike%20Sheridan.wav&metadata=false Sep 05 21:05:24 volumio3 volumio[1438]: info: URI /mnt/NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》/15 Mike Sheridan.wav Sep 05 21:05:24 volumio3 volumio[1438]: info: ALBUMART /albumart?cacheid=300&web=//large&path=%2Fmnt%2FNAS%2FMy_Music%2F00CD%2FDTS-ES6.1%20%E8%BE%BE%E5%B0%BC%E6%B5%8B%E8%AF%95%E7%A2%9F%E3%80%8AThe%20Dali-3%E3%80%8B%2F16%20Deadmau5.wav&metadata=false Sep 05 21:05:24 volumio3 volumio[1438]: info: URI /mnt/NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》/16 Deadmau5.wav Sep 05 21:05:24 volumio3 volumio[1438]: info: ControllerMpd::getState Sep 05 21:05:24 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand status Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreCommandRouter::volumioPushQueue Sep 05 21:05:24 volumio3 volumio[1438]: info: CorePlayQueue::saveQueue Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreStateMachine::updateTrackBlock Sep 05 21:05:24 volumio3 volumio[1438]: info: CorePlayQueue::getTrackBlock Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreCommandRouter::volumioPlay Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreStateMachine::play index 0 Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreStateMachine::stop Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreStateMachine::play index undefined Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 21:05:24 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreStateMachine::startPlaybackTimer Sep 05 21:05:24 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:05:24 volumio3 volumio[1438]: verbose: ControllerMpd::clearAddPlayTracks NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》/01 Pat Metheny.wav Sep 05 21:05:24 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand stop Sep 05 21:05:24 volumio3 volumio[1438]: info: sendMpdCommand status took 7 milliseconds Sep 05 21:05:24 volumio3 volumio[1438]: info: sendMpdCommand stop took 1 milliseconds Sep 05 21:05:24 volumio3 volumio[1438]: verbose: ControllerMpd::parseState Sep 05 21:05:24 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 21:05:24 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand clear Sep 05 21:05:24 volumio3 volumio[1438]: info: Sep 05 21:05:24 volumio3 volumio[1438]: ---------------------------- MPD announces system playlist update Sep 05 21:05:24 volumio3 volumio[1438]: info: Ignoring MPD Status Update Sep 05 21:05:24 volumio3 volumio[1438]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 05 21:05:24 volumio3 volumio[1438]: info: sendMpdCommand clear took 2 milliseconds Sep 05 21:05:24 volumio3 volumio[1438]: verbose: ControllerMpd::parseTrackInfo Sep 05 21:05:24 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand add "NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》/01 Pat Metheny.wav" Sep 05 21:05:24 volumio3 volumio[1438]: info: ControllerMpd::pushState Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreCommandRouter::servicePushState Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreStateMachine::pushState Sep 05 21:05:24 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreCommandRouter::volumioPushState Sep 05 21:05:24 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:05:24 volumio3 volumio[1438]: 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":"Overture and Preludium (Dixit Dominus) ","artist":"Various Artists","album":"The Sound of Music","uri":"NAS/My_Music/00CD/《音乐之声电影原声带》35周年至尊完整版/The Sound of Music(disc 1)/02. Overture and Preludium (Dixit Dominus) .ape","trackType":"ape"} Sep 05 21:05:24 volumio3 volumio[1438]: verbose: CURRENT POSITION 0 Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreStateMachine::syncState stateService stop Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreStateMachine::syncState currentStatus stop Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreStateMachine::pushState Sep 05 21:05:24 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreCommandRouter::volumioPushState Sep 05 21:05:24 volumio3 volumio[1438]: info: No code Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreStateMachine::pushState Sep 05 21:05:24 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:05:24 volumio3 volumio[1438]: info: CoreCommandRouter::volumioPushState Sep 05 21:05:24 volumio3 volumio[1438]: info: ------------------------------ 31ms Sep 05 21:05:24 volumio3 volumio[1438]: error: updateQueue error: null Sep 05 21:05:24 volumio3 volumio[1438]: info: Sep 05 21:05:24 volumio3 volumio[1438]: ---------------------------- MPD announces system playlist update Sep 05 21:05:24 volumio3 volumio[1438]: info: Ignoring MPD Status Update Sep 05 21:05:24 volumio3 volumio[1438]: info: ------------------------------ 19ms Sep 05 21:05:24 volumio3 volumio[1438]: info: sendMpdCommand add "NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》/01 Pat Metheny.wav" took 19 milliseconds Sep 05 21:05:24 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand play Sep 05 21:05:24 volumio3 volumio[1438]: info: ------------------------------ 3ms Sep 05 21:05:24 volumio3 volumio[1438]: info: sendMpdCommand play took 3 milliseconds Sep 05 21:05:26 volumio3 volumio[1438]: info: Sep 05 21:05:26 volumio3 volumio[1438]: ---------------------------- MPD announces state update: player Sep 05 21:05:26 volumio3 volumio[1438]: info: ControllerMpd::getState Sep 05 21:05:26 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand status Sep 05 21:05:26 volumio3 volumio[1438]: info: Preload queue cleared Sep 05 21:05:26 volumio3 volumio[1438]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 05 21:05:26 volumio3 volumio[1438]: info: CoreStateMachine::ClearQueue Sep 05 21:05:26 volumio3 volumio[1438]: info: CoreStateMachine::stop Sep 05 21:05:26 volumio3 volumio[1438]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 21:05:26 volumio3 volumio[1438]: info: CorePlayQueue::clearPlayQueue Sep 05 21:05:26 volumio3 volumio[1438]: info: CorePlayQueue::saveQueue Sep 05 21:05:26 volumio3 volumio[1438]: info: CoreCommandRouter::volumioPushQueue Sep 05 21:05:26 volumio3 volumio[1438]: info: CoreStateMachine::addQueueItems Sep 05 21:05:26 volumio3 volumio[1438]: info: CorePlayQueue::addQueueItems Sep 05 21:05:26 volumio3 volumio[1438]: info: Preload queue cleared Sep 05 21:05:26 volumio3 volumio[1438]: info: Adding Item to queue: music-library/NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》 Sep 05 21:05:26 volumio3 volumio[1438]: info: Using cached record of: music-library/NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》 Sep 05 21:05:26 volumio3 volumio[1438]: info: CoreCommandRouter::volumioPushQueue Sep 05 21:05:26 volumio3 volumio[1438]: info: CorePlayQueue::saveQueue Sep 05 21:05:26 volumio3 volumio[1438]: info: CoreStateMachine::updateTrackBlock Sep 05 21:05:26 volumio3 volumio[1438]: info: CorePlayQueue::getTrackBlock Sep 05 21:05:26 volumio3 volumio[1438]: info: CoreCommandRouter::volumioPlay Sep 05 21:05:26 volumio3 volumio[1438]: info: CoreStateMachine::play index 0 Sep 05 21:05:26 volumio3 volumio[1438]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 21:05:26 volumio3 volumio[1438]: info: CoreStateMachine::stop Sep 05 21:05:26 volumio3 volumio[1438]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 21:05:26 volumio3 volumio[1438]: info: CoreStateMachine::play index undefined Sep 05 21:05:26 volumio3 volumio[1438]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 21:05:26 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:05:26 volumio3 volumio[1438]: info: CoreStateMachine::startPlaybackTimer Sep 05 21:05:26 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:05:26 volumio3 volumio[1438]: verbose: ControllerMpd::clearAddPlayTracks NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》/01 Pat Metheny.wav Sep 05 21:05:26 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand stop Sep 05 21:05:26 volumio3 volumio[1438]: info: Sep 05 21:05:26 volumio3 volumio[1438]: ---------------------------- MPD announces state update: player Sep 05 21:05:26 volumio3 volumio[1438]: info: ControllerMpd::getState Sep 05 21:05:26 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand status Sep 05 21:05:26 volumio3 volumio[1438]: info: sendMpdCommand status took 12 milliseconds Sep 05 21:05:26 volumio3 volumio[1438]: verbose: ControllerMpd::parseState Sep 05 21:05:26 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 21:05:26 volumio3 volumio[1438]: info: Sep 05 21:05:26 volumio3 volumio[1438]: ---------------------------- MPD announces state update: player Sep 05 21:05:26 volumio3 volumio[1438]: info: sendMpdCommand stop took 52 milliseconds Sep 05 21:05:26 volumio3 volumio[1438]: info: ControllerMpd::getState Sep 05 21:05:26 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand status Sep 05 21:05:26 volumio3 volumio[1438]: info: sendMpdCommand status took 50 milliseconds Sep 05 21:05:26 volumio3 volumio[1438]: info: sendMpdCommand playlistinfo took 49 milliseconds Sep 05 21:05:26 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand clear Sep 05 21:05:26 volumio3 volumio[1438]: verbose: ControllerMpd::parseState Sep 05 21:05:26 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 21:05:26 volumio3 volumio[1438]: verbose: ControllerMpd::parseTrackInfo Sep 05 21:05:26 volumio3 volumio[1438]: info: ControllerMpd::pushState Sep 05 21:05:26 volumio3 volumio[1438]: info: CoreCommandRouter::servicePushState Sep 05 21:05:26 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:05:26 volumio3 volumio[1438]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3210,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 Pat Metheny.wav","artist":null,"album":null,"uri":"NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》/01 Pat Metheny.wav","trackType":"wav"} Sep 05 21:05:26 volumio3 volumio[1438]: verbose: CURRENT POSITION 0 Sep 05 21:05:26 volumio3 volumio[1438]: info: CoreStateMachine::syncState stateService play Sep 05 21:05:26 volumio3 volumio[1438]: info: CoreStateMachine::syncState currentStatus stop Sep 05 21:05:26 volumio3 volumio[1438]: info: ------------------------------ 64ms Sep 05 21:05:26 volumio3 volumio[1438]: info: Sep 05 21:05:26 volumio3 volumio[1438]: ---------------------------- MPD announces system playlist update Sep 05 21:05:26 volumio3 volumio[1438]: info: Ignoring MPD Status Update Sep 05 21:05:26 volumio3 volumio[1438]: info: sendMpdCommand status took 4 milliseconds Sep 05 21:05:26 volumio3 volumio[1438]: info: sendMpdCommand clear took 4 milliseconds Sep 05 21:05:26 volumio3 volumio[1438]: info: sendMpdCommand playlistinfo took 4 milliseconds Sep 05 21:05:26 volumio3 volumio[1438]: verbose: ControllerMpd::parseState Sep 05 21:05:26 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 21:05:26 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand add "NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》/01 Pat Metheny.wav" Sep 05 21:05:26 volumio3 volumio[1438]: verbose: ControllerMpd::parseTrackInfo Sep 05 21:05:26 volumio3 volumio[1438]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 05 21:05:26 volumio3 volumio[1438]: info: ------------------------------ 56ms Sep 05 21:05:26 volumio3 volumio[1438]: error: updateQueue error: null Sep 05 21:05:26 volumio3 volumio[1438]: info: Sep 05 21:05:26 volumio3 volumio[1438]: ---------------------------- MPD announces system playlist update Sep 05 21:05:26 volumio3 volumio[1438]: info: Ignoring MPD Status Update Sep 05 21:05:26 volumio3 volumio[1438]: info: ------------------------------ 4ms Sep 05 21:05:26 volumio3 volumio[1438]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 05 21:05:26 volumio3 volumio[1438]: info: sendMpdCommand add "NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》/01 Pat Metheny.wav" took 4 milliseconds Sep 05 21:05:26 volumio3 volumio[1438]: verbose: ControllerMpd::parseTrackInfo Sep 05 21:05:26 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand play Sep 05 21:05:26 volumio3 volumio[1438]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 05 21:05:26 volumio3 volumio[1438]: info: ------------------------------ 11ms Sep 05 21:05:26 volumio3 volumio[1438]: info: ------------------------------ 3ms Sep 05 21:05:26 volumio3 volumio[1438]: info: sendMpdCommand play took 3 milliseconds Sep 05 21:05:26 volumio3 volumio[1438]: info: Sep 05 21:05:26 volumio3 volumio[1438]: ---------------------------- MPD announces state update: player Sep 05 21:05:26 volumio3 volumio[1438]: info: ControllerMpd::getState Sep 05 21:05:26 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand status Sep 05 21:05:26 volumio3 volumio[1438]: info: Sep 05 21:05:26 volumio3 volumio[1438]: ---------------------------- MPD announces state update: player Sep 05 21:05:26 volumio3 volumio[1438]: info: sendMpdCommand status took 4 milliseconds Sep 05 21:05:26 volumio3 volumio[1438]: info: ControllerMpd::getState Sep 05 21:05:26 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand status Sep 05 21:05:26 volumio3 volumio[1438]: verbose: ControllerMpd::parseState Sep 05 21:05:26 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 21:05:26 volumio3 volumio[1438]: info: sendMpdCommand status took 1 milliseconds Sep 05 21:05:26 volumio3 volumio[1438]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 05 21:05:26 volumio3 volumio[1438]: verbose: ControllerMpd::parseState Sep 05 21:05:26 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 21:05:26 volumio3 volumio[1438]: verbose: ControllerMpd::parseTrackInfo Sep 05 21:05:26 volumio3 volumio[1438]: info: ControllerMpd::pushState Sep 05 21:05:26 volumio3 volumio[1438]: info: CoreCommandRouter::servicePushState Sep 05 21:05:26 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:05:26 volumio3 volumio[1438]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 Pat Metheny.wav","artist":null,"album":null,"uri":"NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》/01 Pat Metheny.wav","trackType":"wav"} Sep 05 21:05:26 volumio3 volumio[1438]: verbose: CURRENT POSITION 0 Sep 05 21:05:26 volumio3 volumio[1438]: info: CoreStateMachine::syncState stateService play Sep 05 21:05:26 volumio3 volumio[1438]: info: CoreStateMachine::syncState currentStatus play Sep 05 21:05:26 volumio3 volumio[1438]: info: Received an update from plugin. extracting info from payload Sep 05 21:05:26 volumio3 volumio[1438]: info: CoreStateMachine::pushState Sep 05 21:05:26 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:05:26 volumio3 volumio[1438]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 21:05:26 volumio3 volumio[1438]: info: CoreCommandRouter::volumioPushState Sep 05 21:05:26 volumio3 volumio[1438]: info: CoreStateMachine::pushState Sep 05 21:05:26 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:05:26 volumio3 volumio[1438]: info: CoreCommandRouter::volumioPushState Sep 05 21:05:26 volumio3 volumio[1438]: info: ------------------------------ 19ms Sep 05 21:05:27 volumio3 volumio[1438]: info: sendMpdCommand playlistinfo took 13 milliseconds Sep 05 21:05:27 volumio3 volumio[1438]: verbose: ControllerMpd::parseTrackInfo Sep 05 21:05:27 volumio3 volumio[1438]: info: ControllerMpd::pushState Sep 05 21:05:27 volumio3 volumio[1438]: info: CoreCommandRouter::servicePushState Sep 05 21:05:27 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:05:27 volumio3 volumio[1438]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 Pat Metheny.wav","artist":null,"album":null,"uri":"NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》/01 Pat Metheny.wav","trackType":"wav"} Sep 05 21:05:27 volumio3 volumio[1438]: verbose: CURRENT POSITION 0 Sep 05 21:05:27 volumio3 volumio[1438]: info: CoreStateMachine::syncState stateService play Sep 05 21:05:27 volumio3 volumio[1438]: info: CoreStateMachine::syncState currentStatus play Sep 05 21:05:27 volumio3 volumio[1438]: info: Received an update from plugin. extracting info from payload Sep 05 21:05:27 volumio3 volumio[1438]: info: CoreStateMachine::pushState Sep 05 21:05:27 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:05:27 volumio3 volumio[1438]: info: CoreCommandRouter::volumioPushState Sep 05 21:05:27 volumio3 volumio[1438]: info: CoreStateMachine::pushState Sep 05 21:05:27 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:05:27 volumio3 volumio[1438]: info: CoreCommandRouter::volumioPushState Sep 05 21:05:27 volumio3 volumio[1438]: info: ------------------------------ 35ms Sep 05 21:05:28 volumio3 volumio[1438]: info: MyVolumio login type: Token Sep 05 21:05:29 volumio3 volumio[1438]: 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: 7 Sep 05 21:05:29 volumio3 volumio[1438]: info: CoreCommandRouter::volumioGetState Sep 05 21:05:29 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:05:29 volumio3 volumio[1438]: info: CoreCommandRouter::volumioPause Sep 05 21:05:29 volumio3 volumio[1438]: info: CoreStateMachine::pause Sep 05 21:05:29 volumio3 volumio[1438]: info: CoreStateMachine::stPlaybackTimer Sep 05 21:05:29 volumio3 volumio[1438]: info: CoreStateMachine::servicePause Sep 05 21:05:29 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:05:29 volumio3 volumio[1438]: info: CoreCommandRouter::servicePause Sep 05 21:05:29 volumio3 volumio[1438]: info: ControllerMpd::pause Sep 05 21:05:29 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand pause Sep 05 21:05:29 volumio3 volumio[1438]: info: sendMpdCommand pause took 1 milliseconds Sep 05 21:05:29 volumio3 volumio[1438]: info: Sep 05 21:05:29 volumio3 volumio[1438]: ---------------------------- MPD announces state update: player Sep 05 21:05:29 volumio3 volumio[1438]: info: ControllerMpd::getState Sep 05 21:05:29 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand status Sep 05 21:05:29 volumio3 volumio[1438]: info: sendMpdCommand status took 0 milliseconds Sep 05 21:05:29 volumio3 volumio[1438]: verbose: ControllerMpd::parseState Sep 05 21:05:29 volumio3 volumio[1438]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 21:05:29 volumio3 volumio[1438]: info: sendMpdCommand playlistinfo took 0 milliseconds Sep 05 21:05:29 volumio3 volumio[1438]: verbose: ControllerMpd::parseTrackInfo Sep 05 21:05:29 volumio3 volumio[1438]: info: ControllerMpd::pushState Sep 05 21:05:29 volumio3 volumio[1438]: info: CoreCommandRouter::servicePushState Sep 05 21:05:29 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:05:29 volumio3 volumio[1438]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":3210,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01 Pat Metheny.wav","artist":null,"album":null,"uri":"NAS/My_Music/00CD/DTS-ES6.1 达尼测试碟《The Dali-3》/01 Pat Metheny.wav","trackType":"wav"} Sep 05 21:05:29 volumio3 volumio[1438]: verbose: CURRENT POSITION 0 Sep 05 21:05:29 volumio3 volumio[1438]: info: CoreStateMachine::syncState stateService pause Sep 05 21:05:29 volumio3 volumio[1438]: info: CoreStateMachine::syncState currentStatus pause Sep 05 21:05:29 volumio3 volumio[1438]: info: CoreStateMachine::pushState Sep 05 21:05:29 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:05:29 volumio3 volumio[1438]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 21:05:29 volumio3 volumio[1438]: info: CoreCommandRouter::volumioPushState Sep 05 21:05:29 volumio3 volumio[1438]: info: CoreStateMachine::stPlaybackTimer Sep 05 21:05:29 volumio3 volumio[1438]: info: ------------------------------ 7ms Sep 05 21:05:37 volumio3 volumio[1438]: info: CoreCommandRouter::volumioGetState Sep 05 21:05:37 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:05:37 volumio3 clearscr.sh[664]: 2496 Sep 05 21:05:37 volumio3 sudo[2858]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/bin/systemctl stop screensaver.service Sep 05 21:05:37 volumio3 sudo[2858]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 21:05:37 volumio3 systemd[1]: Stopping My Shell Script... Sep 05 21:05:37 volumio3 systemd[1]: screensaver.service: Main process exited, code=killed, status=15/TERM Sep 05 21:05:38 volumio3 systemd[1]: screensaver.service: Succeeded. Sep 05 21:05:38 volumio3 systemd[1]: Stopped My Shell Script. Sep 05 21:05:38 volumio3 sudo[2858]: pam_unix(sudo:session): session closed for user root Sep 05 21:05:38 volumio3 sudo[2860]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/bin/systemctl start screensaver.service Sep 05 21:05:38 volumio3 sudo[2860]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 21:05:38 volumio3 systemd[1]: Started My Shell Script. Sep 05 21:05:38 volumio3 sudo[2860]: pam_unix(sudo:session): session closed for user root Sep 05 21:05:48 volumio3 volumio[1438]: info: CoreCommandRouter::volumioGetState Sep 05 21:05:48 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:05:50 volumio3 wpa_supplicant[1333]: wlan0: CTRL-EVENT-BEACON-LOSS Sep 05 21:05:53 volumio3 volumio[1438]: info: CoreCommandRouter::volumioGetState Sep 05 21:05:53 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:05:58 volumio3 volumio[1438]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Sep 05 21:05:58 volumio3 volumio[1438]: info: Retrying Login Due to Network Error Sep 05 21:06:00 volumio3 volumio[1438]: info: CoreCommandRouter::volumioGetState Sep 05 21:06:00 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:06:08 volumio3 volumio[1438]: info: CoreCommandRouter::volumioGetState Sep 05 21:06:08 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:06:08 volumio3 volumio[1438]: info: MyVolumio login type: Token Sep 05 21:06:12 volumio3 volumio[1438]: info: CoreCommandRouter::volumioGetState Sep 05 21:06:12 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:06:23 volumio3 volumio[1438]: info: CoreCommandRouter::volumioGetState Sep 05 21:06:23 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:06:24 volumio3 volumio[1438]: info: CoreCommandRouter::volumioGetState Sep 05 21:06:24 volumio3 volumio[1438]: info: CorePlayQueue::getTrack 0 Sep 05 21:06:27 volumio3 volumio[1438]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 05 21:06:27 volumio3 volumio[1438]: Error: connect ETIMEDOUT 168.143.162.58:443 Sep 05 21:06:27 volumio3 volumio[1438]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Sep 05 21:06:27 volumio3 volumio[1438]: errno: -110, Sep 05 21:06:27 volumio3 volumio[1438]: code: 'ETIMEDOUT', Sep 05 21:06:27 volumio3 volumio[1438]: syscall: 'connect', Sep 05 21:06:27 volumio3 volumio[1438]: address: '168.143.162.58', Sep 05 21:06:27 volumio3 volumio[1438]: port: 443 Sep 05 21:06:27 volumio3 volumio[1438]: } Sep 05 21:06:27 volumio3 volumio[1438]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 05 21:06:27 volumio3 sudo[2927]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-05 21:05 Sep 05 21:06:27 volumio3 sudo[2927]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:48:50 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="1049be5fd382035818795b7f5c38e10d"