Dec 30 12:39:00 volumio volumio[1244]: info: CoreCommandRouter::volumioPause Dec 30 12:39:00 volumio volumio[1244]: info: CoreStateMachine::pause Dec 30 12:39:00 volumio volumio[1244]: info: CoreStateMachine::stPlaybackTimer Dec 30 12:39:00 volumio volumio[1244]: info: CoreStateMachine::servicePause Dec 30 12:39:00 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:00 volumio volumio[1244]: info: CoreCommandRouter::servicePause Dec 30 12:39:00 volumio volumio[1244]: info: ControllerMpd::pause Dec 30 12:39:00 volumio volumio[1244]: verbose: ControllerMpd::sendMpdCommand pause Dec 30 12:39:00 volumio volumio[1244]: info: Dec 30 12:39:00 volumio volumio[1244]: ---------------------------- MPD announces state update: player Dec 30 12:39:00 volumio volumio[1244]: info: sendMpdCommand pause took 2 milliseconds Dec 30 12:39:00 volumio volumio[1244]: info: ControllerMpd::getState Dec 30 12:39:00 volumio volumio[1244]: verbose: ControllerMpd::sendMpdCommand status Dec 30 12:39:00 volumio volumio[1244]: info: Dec 30 12:39:00 volumio volumio[1244]: ---------------------------- MPD announces state update: player Dec 30 12:39:00 volumio volumio[1244]: info: ControllerMpd::getState Dec 30 12:39:00 volumio volumio[1244]: verbose: ControllerMpd::sendMpdCommand status Dec 30 12:39:00 volumio volumio[1244]: info: Dec 30 12:39:00 volumio volumio[1244]: ---------------------------- MPD announces state update: player Dec 30 12:39:00 volumio volumio[1244]: info: ControllerMpd::getState Dec 30 12:39:00 volumio volumio[1244]: verbose: ControllerMpd::sendMpdCommand status Dec 30 12:39:00 volumio volumio[1244]: info: sendMpdCommand status took 2 milliseconds Dec 30 12:39:00 volumio volumio[1244]: verbose: ControllerMpd::parseState Dec 30 12:39:00 volumio volumio[1244]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 12:39:00 volumio volumio[1244]: info: sendMpdCommand status took 2 milliseconds Dec 30 12:39:00 volumio volumio[1244]: info: sendMpdCommand status took 2 milliseconds Dec 30 12:39:00 volumio volumio[1244]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 30 12:39:00 volumio volumio[1244]: verbose: ControllerMpd::parseState Dec 30 12:39:00 volumio volumio[1244]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 12:39:00 volumio volumio[1244]: verbose: ControllerMpd::parseState Dec 30 12:39:00 volumio volumio[1244]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 12:39:00 volumio volumio[1244]: verbose: ControllerMpd::parseTrackInfo Dec 30 12:39:00 volumio volumio[1244]: info: ControllerMpd::pushState Dec 30 12:39:00 volumio volumio[1244]: info: CoreCommandRouter::servicePushState Dec 30 12:39:00 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:00 volumio volumio[1244]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":7725,"duration":282,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"灞桥柳","artist":"[吻雪收藏]","album":"2011年度至尊发烧金曲Ⅳ","uri":"USB/SSD/hifi/2011年度至尊发烧金曲Ⅳ/08. 灞桥柳.mp3","trackType":"mp3"} Dec 30 12:39:00 volumio volumio[1244]: verbose: CURRENT POSITION 7 Dec 30 12:39:00 volumio volumio[1244]: info: CoreStateMachine::syncState stateService pause Dec 30 12:39:00 volumio volumio[1244]: info: CoreStateMachine::syncState currentStatus pause Dec 30 12:39:00 volumio volumio[1244]: info: CoreStateMachine::pushState Dec 30 12:39:00 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:00 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 12:39:00 volumio volumio[1244]: info: CoreCommandRouter::volumioPushState Dec 30 12:39:00 volumio volumio[1244]: info: CoreStateMachine::stPlaybackTimer Dec 30 12:39:00 volumio volumio[1244]: info: ------------------------------ 14ms Dec 30 12:39:00 volumio volumio[1244]: info: sendMpdCommand playlistinfo took 9 milliseconds Dec 30 12:39:00 volumio volumio[1244]: info: sendMpdCommand playlistinfo took 10 milliseconds Dec 30 12:39:00 volumio volumio[1244]: verbose: ControllerMpd::parseTrackInfo Dec 30 12:39:00 volumio volumio[1244]: verbose: ControllerMpd::parseTrackInfo Dec 30 12:39:00 volumio volumio[1244]: info: ControllerMpd::pushState Dec 30 12:39:00 volumio volumio[1244]: info: CoreCommandRouter::servicePushState Dec 30 12:39:00 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:00 volumio volumio[1244]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":7725,"duration":282,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"灞桥柳","artist":"[吻雪收藏]","album":"2011年度至尊发烧金曲Ⅳ","uri":"USB/SSD/hifi/2011年度至尊发烧金曲Ⅳ/08. 灞桥柳.mp3","trackType":"mp3"} Dec 30 12:39:00 volumio volumio[1244]: verbose: CURRENT POSITION 7 Dec 30 12:39:00 volumio volumio[1244]: info: CoreStateMachine::syncState stateService pause Dec 30 12:39:00 volumio volumio[1244]: info: CoreStateMachine::syncState currentStatus pause Dec 30 12:39:00 volumio volumio[1244]: info: CoreStateMachine::pushState Dec 30 12:39:00 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:00 volumio volumio[1244]: info: CoreCommandRouter::volumioPushState Dec 30 12:39:00 volumio volumio[1244]: info: CoreStateMachine::stPlaybackTimer Dec 30 12:39:00 volumio volumio[1244]: info: ControllerMpd::pushState Dec 30 12:39:00 volumio volumio[1244]: info: CoreCommandRouter::servicePushState Dec 30 12:39:00 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:00 volumio volumio[1244]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":7725,"duration":282,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"灞桥柳","artist":"[吻雪收藏]","album":"2011年度至尊发烧金曲Ⅳ","uri":"USB/SSD/hifi/2011年度至尊发烧金曲Ⅳ/08. 灞桥柳.mp3","trackType":"mp3"} Dec 30 12:39:00 volumio volumio[1244]: verbose: CURRENT POSITION 7 Dec 30 12:39:00 volumio volumio[1244]: info: CoreStateMachine::syncState stateService pause Dec 30 12:39:00 volumio volumio[1244]: info: CoreStateMachine::syncState currentStatus pause Dec 30 12:39:00 volumio volumio[1244]: info: CoreStateMachine::pushState Dec 30 12:39:00 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:00 volumio volumio[1244]: info: CoreCommandRouter::volumioPushState Dec 30 12:39:00 volumio volumio[1244]: info: CoreStateMachine::stPlaybackTimer Dec 30 12:39:00 volumio volumio[1244]: info: ------------------------------ 25ms Dec 30 12:39:00 volumio volumio[1244]: info: ------------------------------ 24ms Dec 30 12:39:02 volumio volumio[1244]: info: CoreCommandRouter::volumioPlay Dec 30 12:39:02 volumio volumio[1244]: info: CoreStateMachine::play index undefined Dec 30 12:39:02 volumio volumio[1244]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 12:39:02 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:02 volumio volumio[1244]: info: CoreStateMachine::startPlaybackTimer Dec 30 12:39:02 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:02 volumio volumio[1244]: info: ControllerMpd::resume Dec 30 12:39:02 volumio volumio[1244]: verbose: ControllerMpd::sendMpdCommand play Dec 30 12:39:02 volumio volumio[1244]: info: Dec 30 12:39:02 volumio volumio[1244]: ---------------------------- MPD announces state update: player Dec 30 12:39:02 volumio volumio[1244]: info: sendMpdCommand play took 4 milliseconds Dec 30 12:39:02 volumio volumio[1244]: info: ControllerMpd::getState Dec 30 12:39:02 volumio volumio[1244]: verbose: ControllerMpd::sendMpdCommand status Dec 30 12:39:02 volumio volumio[1244]: info: Dec 30 12:39:02 volumio volumio[1244]: ---------------------------- MPD announces state update: player Dec 30 12:39:02 volumio volumio[1244]: info: ControllerMpd::getState Dec 30 12:39:02 volumio volumio[1244]: verbose: ControllerMpd::sendMpdCommand status Dec 30 12:39:02 volumio volumio[1244]: info: Dec 30 12:39:02 volumio volumio[1244]: ---------------------------- MPD announces state update: player Dec 30 12:39:02 volumio volumio[1244]: info: ControllerMpd::getState Dec 30 12:39:02 volumio volumio[1244]: verbose: ControllerMpd::sendMpdCommand status Dec 30 12:39:02 volumio volumio[1244]: info: sendMpdCommand status took 2 milliseconds Dec 30 12:39:02 volumio volumio[1244]: info: sendMpdCommand status took 1 milliseconds Dec 30 12:39:02 volumio volumio[1244]: info: sendMpdCommand status took 1 milliseconds Dec 30 12:39:02 volumio volumio[1244]: verbose: ControllerMpd::parseState Dec 30 12:39:02 volumio volumio[1244]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 12:39:02 volumio volumio[1244]: verbose: ControllerMpd::parseState Dec 30 12:39:02 volumio volumio[1244]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 12:39:02 volumio volumio[1244]: verbose: ControllerMpd::parseState Dec 30 12:39:02 volumio volumio[1244]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 12:39:02 volumio volumio[1244]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 30 12:39:02 volumio volumio[1244]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 30 12:39:02 volumio volumio[1244]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 30 12:39:02 volumio volumio[1244]: verbose: ControllerMpd::parseTrackInfo Dec 30 12:39:02 volumio volumio[1244]: verbose: ControllerMpd::parseTrackInfo Dec 30 12:39:02 volumio volumio[1244]: verbose: ControllerMpd::parseTrackInfo Dec 30 12:39:02 volumio volumio[1244]: info: ControllerMpd::pushState Dec 30 12:39:02 volumio volumio[1244]: info: CoreCommandRouter::servicePushState Dec 30 12:39:02 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:02 volumio volumio[1244]: verbose: STATE SERVICE {"status":"play","position":0,"seek":8711,"duration":282,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"灞桥柳","artist":"[吻雪收藏]","album":"2011年度至尊发烧金曲Ⅳ","uri":"USB/SSD/hifi/2011年度至尊发烧金曲Ⅳ/08. 灞桥柳.mp3","trackType":"mp3"} Dec 30 12:39:02 volumio volumio[1244]: verbose: CURRENT POSITION 7 Dec 30 12:39:02 volumio volumio[1244]: info: CoreStateMachine::syncState stateService play Dec 30 12:39:02 volumio volumio[1244]: info: CoreStateMachine::syncState currentStatus pause Dec 30 12:39:02 volumio volumio[1244]: info: CoreStateMachine::pushState Dec 30 12:39:02 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:02 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 12:39:02 volumio volumio[1244]: info: CoreCommandRouter::volumioPushState Dec 30 12:39:02 volumio volumio[1244]: info: ControllerMpd::pushState Dec 30 12:39:02 volumio volumio[1244]: info: CoreCommandRouter::servicePushState Dec 30 12:39:02 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:02 volumio volumio[1244]: verbose: STATE SERVICE {"status":"play","position":0,"seek":8711,"duration":282,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"灞桥柳","artist":"[吻雪收藏]","album":"2011年度至尊发烧金曲Ⅳ","uri":"USB/SSD/hifi/2011年度至尊发烧金曲Ⅳ/08. 灞桥柳.mp3","trackType":"mp3"} Dec 30 12:39:02 volumio volumio[1244]: verbose: CURRENT POSITION 7 Dec 30 12:39:02 volumio volumio[1244]: info: CoreStateMachine::syncState stateService play Dec 30 12:39:02 volumio volumio[1244]: info: CoreStateMachine::syncState currentStatus play Dec 30 12:39:02 volumio volumio[1244]: info: Received an update from plugin. extracting info from payload Dec 30 12:39:02 volumio volumio[1244]: info: CoreStateMachine::pushState Dec 30 12:39:02 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:02 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 12:39:02 volumio volumio[1244]: info: CoreCommandRouter::volumioPushState Dec 30 12:39:02 volumio volumio[1244]: info: CoreStateMachine::pushState Dec 30 12:39:02 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:02 volumio volumio[1244]: info: CoreCommandRouter::volumioPushState Dec 30 12:39:02 volumio volumio[1244]: info: ControllerMpd::pushState Dec 30 12:39:02 volumio volumio[1244]: info: CoreCommandRouter::servicePushState Dec 30 12:39:02 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:02 volumio volumio[1244]: verbose: STATE SERVICE {"status":"play","position":0,"seek":8711,"duration":282,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"灞桥柳","artist":"[吻雪收藏]","album":"2011年度至尊发烧金曲Ⅳ","uri":"USB/SSD/hifi/2011年度至尊发烧金曲Ⅳ/08. 灞桥柳.mp3","trackType":"mp3"} Dec 30 12:39:02 volumio volumio[1244]: verbose: CURRENT POSITION 7 Dec 30 12:39:02 volumio volumio[1244]: info: CoreStateMachine::syncState stateService play Dec 30 12:39:02 volumio volumio[1244]: info: CoreStateMachine::syncState currentStatus play Dec 30 12:39:02 volumio volumio[1244]: info: Received an update from plugin. extracting info from payload Dec 30 12:39:02 volumio volumio[1244]: info: CoreStateMachine::pushState Dec 30 12:39:02 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:02 volumio volumio[1244]: info: CoreCommandRouter::volumioPushState Dec 30 12:39:02 volumio volumio[1244]: info: CoreStateMachine::pushState Dec 30 12:39:02 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:02 volumio volumio[1244]: info: CoreCommandRouter::volumioPushState Dec 30 12:39:02 volumio volumio[1244]: info: ------------------------------ 30ms Dec 30 12:39:02 volumio volumio[1244]: info: ------------------------------ 30ms Dec 30 12:39:02 volumio volumio[1244]: info: ------------------------------ 29ms Dec 30 12:39:06 volumio volumio[1244]: info: CoreCommandRouter::volumioSeek Dec 30 12:39:06 volumio volumio[1244]: info: CoreStateMachine::seek Dec 30 12:39:06 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:06 volumio volumio[1244]: info: TRACKBLOCK {"uri":"mnt/USB/SSD/hifi/2011年度至尊发烧金曲Ⅳ/08. 灞桥柳.mp3","service":"mpd","name":"灞桥柳","artist":"[吻雪收藏]","album":"2011年度至尊发烧金曲Ⅳ","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=914&web=%5B%E5%90%BB%E9%9B%AA%E6%94%B6%E8%97%8F%5D/2011%E5%B9%B4%E5%BA%A6%E8%87%B3%E5%B0%8A%E5%8F%91%E7%83%A7%E9%87%91%E6%9B%B2%E2%85%A3/extralarge&path=%2FUSB%2FSSD%2Fhifi%2F2011%E5%B9%B4%E5%BA%A6%E8%87%B3%E5%B0%8A%E5%8F%91%E7%83%A7%E9%87%91%E6%9B%B2%E2%85%A3&metadata=false","duration":282,"samplerate":"44.1 kHz","bitdepth":"16 bit","trackType":"mp3","channels":2} Dec 30 12:39:06 volumio volumio[1244]: info: CoreStateMachine::startPlaybackTimer Dec 30 12:39:06 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:06 volumio volumio[1244]: info: ControllerMpd::seek Dec 30 12:39:06 volumio volumio[1244]: info: CoreStateMachine::pushState Dec 30 12:39:06 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:06 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 12:39:06 volumio volumio[1244]: info: CoreCommandRouter::volumioPushState Dec 30 12:39:06 volumio volumio[1244]: error: null Dec 30 12:39:06 volumio volumio[1244]: info: Dec 30 12:39:06 volumio volumio[1244]: ---------------------------- MPD announces state update: player Dec 30 12:39:06 volumio volumio[1244]: info: ControllerMpd::getState Dec 30 12:39:06 volumio volumio[1244]: verbose: ControllerMpd::sendMpdCommand status Dec 30 12:39:06 volumio volumio[1244]: info: sendMpdCommand status took 0 milliseconds Dec 30 12:39:06 volumio volumio[1244]: verbose: ControllerMpd::parseState Dec 30 12:39:06 volumio volumio[1244]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 12:39:06 volumio volumio[1244]: info: Dec 30 12:39:06 volumio volumio[1244]: ---------------------------- MPD announces state update: player Dec 30 12:39:06 volumio volumio[1244]: info: ControllerMpd::getState Dec 30 12:39:06 volumio volumio[1244]: verbose: ControllerMpd::sendMpdCommand status Dec 30 12:39:06 volumio volumio[1244]: info: Dec 30 12:39:06 volumio volumio[1244]: ---------------------------- MPD announces state update: player Dec 30 12:39:06 volumio volumio[1244]: info: ControllerMpd::getState Dec 30 12:39:06 volumio volumio[1244]: verbose: ControllerMpd::sendMpdCommand status Dec 30 12:39:06 volumio volumio[1244]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 30 12:39:06 volumio volumio[1244]: info: sendMpdCommand status took 1 milliseconds Dec 30 12:39:06 volumio volumio[1244]: info: sendMpdCommand status took 1 milliseconds Dec 30 12:39:06 volumio volumio[1244]: verbose: ControllerMpd::parseTrackInfo Dec 30 12:39:06 volumio volumio[1244]: verbose: ControllerMpd::parseState Dec 30 12:39:06 volumio volumio[1244]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 12:39:06 volumio volumio[1244]: verbose: ControllerMpd::parseState Dec 30 12:39:06 volumio volumio[1244]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 12:39:06 volumio volumio[1244]: info: ControllerMpd::pushState Dec 30 12:39:06 volumio volumio[1244]: info: CoreCommandRouter::servicePushState Dec 30 12:39:06 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:06 volumio volumio[1244]: verbose: STATE SERVICE {"status":"play","position":0,"seek":73000,"duration":282,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"灞桥柳","artist":"[吻雪收藏]","album":"2011年度至尊发烧金曲Ⅳ","uri":"USB/SSD/hifi/2011年度至尊发烧金曲Ⅳ/08. 灞桥柳.mp3","trackType":"mp3"} Dec 30 12:39:06 volumio volumio[1244]: verbose: CURRENT POSITION 7 Dec 30 12:39:06 volumio volumio[1244]: info: CoreStateMachine::syncState stateService play Dec 30 12:39:06 volumio volumio[1244]: info: CoreStateMachine::syncState currentStatus play Dec 30 12:39:06 volumio volumio[1244]: info: Received an update from plugin. extracting info from payload Dec 30 12:39:06 volumio volumio[1244]: info: CoreStateMachine::pushState Dec 30 12:39:06 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:06 volumio volumio[1244]: info: CoreCommandRouter::volumioPushState Dec 30 12:39:06 volumio volumio[1244]: info: CoreStateMachine::pushState Dec 30 12:39:06 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:06 volumio volumio[1244]: info: CoreCommandRouter::volumioPushState Dec 30 12:39:06 volumio volumio[1244]: info: ------------------------------ 17ms Dec 30 12:39:06 volumio volumio[1244]: info: sendMpdCommand playlistinfo took 14 milliseconds Dec 30 12:39:06 volumio volumio[1244]: info: sendMpdCommand playlistinfo took 14 milliseconds Dec 30 12:39:06 volumio volumio[1244]: verbose: ControllerMpd::parseTrackInfo Dec 30 12:39:06 volumio volumio[1244]: verbose: ControllerMpd::parseTrackInfo Dec 30 12:39:06 volumio volumio[1244]: info: ControllerMpd::pushState Dec 30 12:39:06 volumio volumio[1244]: info: CoreCommandRouter::servicePushState Dec 30 12:39:06 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:06 volumio volumio[1244]: verbose: STATE SERVICE {"status":"play","position":0,"seek":73000,"duration":282,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"灞桥柳","artist":"[吻雪收藏]","album":"2011年度至尊发烧金曲Ⅳ","uri":"USB/SSD/hifi/2011年度至尊发烧金曲Ⅳ/08. 灞桥柳.mp3","trackType":"mp3"} Dec 30 12:39:06 volumio volumio[1244]: verbose: CURRENT POSITION 7 Dec 30 12:39:06 volumio volumio[1244]: info: CoreStateMachine::syncState stateService play Dec 30 12:39:06 volumio volumio[1244]: info: CoreStateMachine::syncState currentStatus play Dec 30 12:39:06 volumio volumio[1244]: info: Received an update from plugin. extracting info from payload Dec 30 12:39:06 volumio volumio[1244]: info: CoreStateMachine::pushState Dec 30 12:39:06 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:06 volumio volumio[1244]: info: CoreCommandRouter::volumioPushState Dec 30 12:39:06 volumio volumio[1244]: info: CoreStateMachine::pushState Dec 30 12:39:06 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:06 volumio volumio[1244]: info: CoreCommandRouter::volumioPushState Dec 30 12:39:06 volumio volumio[1244]: info: ControllerMpd::pushState Dec 30 12:39:06 volumio volumio[1244]: info: CoreCommandRouter::servicePushState Dec 30 12:39:06 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:06 volumio volumio[1244]: verbose: STATE SERVICE {"status":"play","position":0,"seek":73000,"duration":282,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"灞桥柳","artist":"[吻雪收藏]","album":"2011年度至尊发烧金曲Ⅳ","uri":"USB/SSD/hifi/2011年度至尊发烧金曲Ⅳ/08. 灞桥柳.mp3","trackType":"mp3"} Dec 30 12:39:06 volumio volumio[1244]: verbose: CURRENT POSITION 7 Dec 30 12:39:06 volumio volumio[1244]: info: CoreStateMachine::syncState stateService play Dec 30 12:39:06 volumio volumio[1244]: info: CoreStateMachine::syncState currentStatus play Dec 30 12:39:06 volumio volumio[1244]: info: Received an update from plugin. extracting info from payload Dec 30 12:39:06 volumio volumio[1244]: info: CoreStateMachine::pushState Dec 30 12:39:06 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:06 volumio volumio[1244]: info: CoreCommandRouter::volumioPushState Dec 30 12:39:06 volumio volumio[1244]: info: CoreStateMachine::pushState Dec 30 12:39:06 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:06 volumio volumio[1244]: info: CoreCommandRouter::volumioPushState Dec 30 12:39:06 volumio volumio[1244]: info: ------------------------------ 39ms Dec 30 12:39:06 volumio volumio[1244]: info: ------------------------------ 38ms Dec 30 12:39:29 volumio volumio[1244]: info: CoreCommandRouter::volumioPause Dec 30 12:39:29 volumio volumio[1244]: info: CoreStateMachine::pause Dec 30 12:39:29 volumio volumio[1244]: info: CoreStateMachine::stPlaybackTimer Dec 30 12:39:29 volumio volumio[1244]: info: CoreStateMachine::servicePause Dec 30 12:39:29 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:29 volumio volumio[1244]: info: CoreCommandRouter::servicePause Dec 30 12:39:29 volumio volumio[1244]: info: ControllerMpd::pause Dec 30 12:39:29 volumio volumio[1244]: verbose: ControllerMpd::sendMpdCommand pause Dec 30 12:39:29 volumio volumio[1244]: info: sendMpdCommand pause took 2 milliseconds Dec 30 12:39:29 volumio volumio[1244]: info: Dec 30 12:39:29 volumio volumio[1244]: ---------------------------- MPD announces state update: player Dec 30 12:39:29 volumio volumio[1244]: info: ControllerMpd::getState Dec 30 12:39:29 volumio volumio[1244]: verbose: ControllerMpd::sendMpdCommand status Dec 30 12:39:29 volumio volumio[1244]: info: Dec 30 12:39:29 volumio volumio[1244]: ---------------------------- MPD announces state update: player Dec 30 12:39:29 volumio volumio[1244]: info: ControllerMpd::getState Dec 30 12:39:29 volumio volumio[1244]: verbose: ControllerMpd::sendMpdCommand status Dec 30 12:39:29 volumio volumio[1244]: info: Dec 30 12:39:29 volumio volumio[1244]: ---------------------------- MPD announces state update: player Dec 30 12:39:29 volumio volumio[1244]: info: ControllerMpd::getState Dec 30 12:39:29 volumio volumio[1244]: verbose: ControllerMpd::sendMpdCommand status Dec 30 12:39:29 volumio volumio[1244]: info: sendMpdCommand status took 2 milliseconds Dec 30 12:39:29 volumio volumio[1244]: info: sendMpdCommand status took 2 milliseconds Dec 30 12:39:29 volumio volumio[1244]: info: sendMpdCommand status took 1 milliseconds Dec 30 12:39:29 volumio volumio[1244]: verbose: ControllerMpd::parseState Dec 30 12:39:29 volumio volumio[1244]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 12:39:29 volumio volumio[1244]: verbose: ControllerMpd::parseState Dec 30 12:39:29 volumio volumio[1244]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 12:39:29 volumio volumio[1244]: verbose: ControllerMpd::parseState Dec 30 12:39:29 volumio volumio[1244]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 12:39:29 volumio volumio[1244]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 30 12:39:29 volumio volumio[1244]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 30 12:39:29 volumio volumio[1244]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 30 12:39:29 volumio volumio[1244]: verbose: ControllerMpd::parseTrackInfo Dec 30 12:39:29 volumio volumio[1244]: verbose: ControllerMpd::parseTrackInfo Dec 30 12:39:29 volumio volumio[1244]: verbose: ControllerMpd::parseTrackInfo Dec 30 12:39:29 volumio volumio[1244]: info: ControllerMpd::pushState Dec 30 12:39:29 volumio volumio[1244]: info: CoreCommandRouter::servicePushState Dec 30 12:39:29 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:29 volumio volumio[1244]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":97094,"duration":282,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"灞桥柳","artist":"[吻雪收藏]","album":"2011年度至尊发烧金曲Ⅳ","uri":"USB/SSD/hifi/2011年度至尊发烧金曲Ⅳ/08. 灞桥柳.mp3","trackType":"mp3"} Dec 30 12:39:29 volumio volumio[1244]: verbose: CURRENT POSITION 7 Dec 30 12:39:29 volumio volumio[1244]: info: CoreStateMachine::syncState stateService pause Dec 30 12:39:29 volumio volumio[1244]: info: CoreStateMachine::syncState currentStatus pause Dec 30 12:39:29 volumio volumio[1244]: info: CoreStateMachine::pushState Dec 30 12:39:29 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:29 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 12:39:29 volumio volumio[1244]: info: CoreCommandRouter::volumioPushState Dec 30 12:39:29 volumio volumio[1244]: info: CoreStateMachine::stPlaybackTimer Dec 30 12:39:29 volumio volumio[1244]: info: ControllerMpd::pushState Dec 30 12:39:29 volumio volumio[1244]: info: CoreCommandRouter::servicePushState Dec 30 12:39:29 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:29 volumio volumio[1244]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":97094,"duration":282,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"灞桥柳","artist":"[吻雪收藏]","album":"2011年度至尊发烧金曲Ⅳ","uri":"USB/SSD/hifi/2011年度至尊发烧金曲Ⅳ/08. 灞桥柳.mp3","trackType":"mp3"} Dec 30 12:39:29 volumio volumio[1244]: verbose: CURRENT POSITION 7 Dec 30 12:39:29 volumio volumio[1244]: info: CoreStateMachine::syncState stateService pause Dec 30 12:39:29 volumio volumio[1244]: info: CoreStateMachine::syncState currentStatus pause Dec 30 12:39:29 volumio volumio[1244]: info: CoreStateMachine::pushState Dec 30 12:39:29 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:29 volumio volumio[1244]: info: CoreCommandRouter::volumioPushState Dec 30 12:39:29 volumio volumio[1244]: info: CoreStateMachine::stPlaybackTimer Dec 30 12:39:29 volumio volumio[1244]: info: ControllerMpd::pushState Dec 30 12:39:29 volumio volumio[1244]: info: CoreCommandRouter::servicePushState Dec 30 12:39:29 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:29 volumio volumio[1244]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":97094,"duration":282,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"灞桥柳","artist":"[吻雪收藏]","album":"2011年度至尊发烧金曲Ⅳ","uri":"USB/SSD/hifi/2011年度至尊发烧金曲Ⅳ/08. 灞桥柳.mp3","trackType":"mp3"} Dec 30 12:39:29 volumio volumio[1244]: verbose: CURRENT POSITION 7 Dec 30 12:39:29 volumio volumio[1244]: info: CoreStateMachine::syncState stateService pause Dec 30 12:39:29 volumio volumio[1244]: info: CoreStateMachine::syncState currentStatus pause Dec 30 12:39:29 volumio volumio[1244]: info: CoreStateMachine::pushState Dec 30 12:39:29 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:29 volumio volumio[1244]: info: CoreCommandRouter::volumioPushState Dec 30 12:39:29 volumio volumio[1244]: info: CoreStateMachine::stPlaybackTimer Dec 30 12:39:29 volumio volumio[1244]: info: ------------------------------ 21ms Dec 30 12:39:29 volumio volumio[1244]: info: ------------------------------ 20ms Dec 30 12:39:29 volumio volumio[1244]: info: ------------------------------ 20ms Dec 30 12:39:33 volumio volumio[1244]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 30 12:39:33 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 30 12:39:33 volumio volumio[1244]: Disk list : [] Dec 30 12:39:33 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 30 12:39:33 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 30 12:39:33 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Dec 30 12:39:33 volumio volumio[1244]: info: Received Get System Version Dec 30 12:39:33 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 30 12:39:38 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: wizard , openWizard Dec 30 12:39:38 volumio volumio[1244]: info: CoreCommandRouter::Reload Ui Dec 30 12:39:38 volumio sudo[2792]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 30 12:39:38 volumio sudo[2792]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 12:39:38 volumio sudo[2792]: pam_unix(sudo:session): session closed for user root Dec 30 12:39:38 volumio sudo[2794]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 30 12:39:38 volumio sudo[2794]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 12:39:38 volumio sudo[2794]: pam_unix(sudo:session): session closed for user root Dec 30 12:39:38 volumio sudo[2798]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 30 12:39:38 volumio sudo[2798]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 12:39:38 volumio sudo[2798]: pam_unix(sudo:session): session closed for user root Dec 30 12:39:38 volumio volumio[1244]: verbose: New Socket.io Connection to 10.223.99.225 from 10.223.99.48 UA: Mozilla/5.0 (Linux; Android 15; V2285A Build/AP3A.240905.015.A2) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.6478.71 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Dec 30 12:39:38 volumio sudo[2800]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 30 12:39:38 volumio sudo[2800]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 12:39:38 volumio sudo[2800]: pam_unix(sudo:session): session closed for user root Dec 30 12:39:38 volumio volumio[1244]: verbose: New Socket.io Connection to 10.223.99.225 from 10.223.99.48 UA: Mozilla/5.0 (Linux; Android 15; V2285A Build/AP3A.240905.015.A2) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.6478.71 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::volumioGetVisibleSources Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Dec 30 12:39:39 volumio volumio[1244]: info: Received Get System Info Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 30 12:39:39 volumio volumio[1244]: info: Discovery: Getting this device information Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::volumioGetState Dec 30 12:39:39 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 30 12:39:39 volumio volumio-remote-updater[759]: Test mode disabled Dec 30 12:39:39 volumio volumio-remote-updater[759]: Alpha mode disabled Dec 30 12:39:39 volumio volumio-remote-updater[759]: Alpha legacy test mode disabled Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 30 12:39:39 volumio volumio[1244]: info: Retrieving Cloud Streaming UI Dec 30 12:39:39 volumio volumio[1244]: info: Getting Tidal Cloud Configuration Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 30 12:39:39 volumio volumio[1244]: info: Getting Qobuz Cloud Configuration Dec 30 12:39:39 volumio volumio[1244]: info: Asking plugin for UI Config Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 30 12:39:39 volumio volumio[1244]: info: Getting Spotify Cloud Configuration Dec 30 12:39:39 volumio volumio[1244]: info: Asking plugin for UI Config Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 30 12:39:39 volumio volumio[1244]: info: Saving Spotify Acccount Dec 30 12:39:39 volumio volumio[1244]: info: Got Tidal Cloud Configuration Dec 30 12:39:39 volumio volumio[1244]: info: Got it Dec 30 12:39:39 volumio volumio[1244]: info: Got it Dec 30 12:39:39 volumio volumio[1244]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::volumioGetVisibleSources Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 30 12:39:39 volumio volumio[1244]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Dec 30 12:39:39 volumio volumio[1244]: info: Received Get System Info Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 30 12:39:39 volumio volumio[1244]: info: Discovery: Getting this device information Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::volumioGetState Dec 30 12:39:39 volumio volumio[1244]: info: CorePlayQueue::getTrack 7 Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 30 12:39:39 volumio volumio[1244]: info: Retrieving Cloud Streaming UI Dec 30 12:39:39 volumio volumio[1244]: info: Getting Tidal Cloud Configuration Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 30 12:39:39 volumio volumio[1244]: info: Getting Qobuz Cloud Configuration Dec 30 12:39:39 volumio volumio[1244]: info: Asking plugin for UI Config Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 30 12:39:39 volumio volumio[1244]: info: Getting Spotify Cloud Configuration Dec 30 12:39:39 volumio volumio[1244]: info: Asking plugin for UI Config Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 30 12:39:39 volumio volumio[1244]: info: Saving Spotify Acccount Dec 30 12:39:39 volumio volumio[1244]: info: Got Tidal Cloud Configuration Dec 30 12:39:39 volumio volumio[1244]: info: Got it Dec 30 12:39:39 volumio volumio[1244]: info: Got it Dec 30 12:39:39 volumio volumio[1244]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 30 12:39:39 volumio volumio[1244]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Dec 30 12:39:39 volumio volumio-remote-updater[759]: Test mode disabled Dec 30 12:39:39 volumio volumio-remote-updater[759]: Alpha mode disabled Dec 30 12:39:39 volumio volumio-remote-updater[759]: Alpha legacy test mode disabled Dec 30 12:39:39 volumio volumio[1244]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Dec 30 12:39:39 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Dec 30 12:39:40 volumio volumio[1244]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Dec 30 12:39:40 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Dec 30 12:39:40 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Dec 30 12:39:40 volumio volumio[1244]: info: Loading i18n strings for locale zh Dec 30 12:39:40 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Dec 30 12:39:40 volumio volumio[1244]: info: Setting timezone to Asia/Shanghai Dec 30 12:39:40 volumio sudo[2815]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Dec 30 12:39:40 volumio sudo[2815]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 12:39:40 volumio sudo[2815]: pam_unix(sudo:session): session closed for user root Dec 30 12:39:40 volumio sudo[2819]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Shanghai /etc/localtime Dec 30 12:39:40 volumio sudo[2819]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 12:39:40 volumio sudo[2819]: pam_unix(sudo:session): session closed for user root Dec 30 12:39:40 volumio sudo[2823]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Dec 30 12:39:40 volumio sudo[2823]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 12:39:40 volumio sudo[2823]: pam_unix(sudo:session): session closed for user root Dec 30 12:39:40 volumio sudo[2827]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Shanghai Dec 30 12:39:40 volumio sudo[2827]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 12:39:40 volumio dbus-daemon[737]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.19' (uid=0 pid=2828 comm="/usr/bin/timedatectl set-timezone Asia/Shanghai") Dec 30 12:39:40 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Dec 30 12:39:40 volumio dbus-daemon[737]: [system] Successfully activated service 'org.freedesktop.timedate1' Dec 30 12:39:40 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Dec 30 12:39:40 volumio sudo[2827]: pam_unix(sudo:session): session closed for user root Dec 30 12:39:40 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Dec 30 12:39:40 volumio volumio[1244]: info: Loading i18n strings for locale zh Dec 30 12:39:40 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Dec 30 12:39:40 volumio volumio[1244]: info: Setting timezone to Asia/Shanghai Dec 30 12:39:40 volumio sudo[2833]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Dec 30 12:39:40 volumio sudo[2833]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 12:39:40 volumio sudo[2833]: pam_unix(sudo:session): session closed for user root Dec 30 12:39:40 volumio sudo[2837]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Shanghai /etc/localtime Dec 30 12:39:40 volumio sudo[2837]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 12:39:40 volumio sudo[2837]: pam_unix(sudo:session): session closed for user root Dec 30 12:39:40 volumio sudo[2841]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Dec 30 12:39:40 volumio sudo[2841]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 12:39:40 volumio sudo[2841]: pam_unix(sudo:session): session closed for user root Dec 30 12:39:40 volumio sudo[2845]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Shanghai Dec 30 12:39:40 volumio sudo[2845]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 12:39:40 volumio sudo[2845]: pam_unix(sudo:session): session closed for user root Dec 30 12:39:40 volumio volumio[1244]: Updating browse sources language Dec 30 12:39:40 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 12:39:40 volumio volumio[1244]: info: Fetching Streaming Services browse cache Dec 30 12:39:40 volumio volumio[1244]: Updating browse sources language Dec 30 12:39:40 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 12:39:40 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 30 12:39:41 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Dec 30 12:39:41 volumio volumio[1244]: info: Loading i18n strings for locale zh Dec 30 12:39:41 volumio volumio[1244]: info: Fetching Streaming Services browse cache Dec 30 12:39:41 volumio volumio[1244]: Updating browse sources language Dec 30 12:39:41 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 12:39:41 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Dec 30 12:39:41 volumio volumio[1244]: info: Setting timezone to Asia/Shanghai Dec 30 12:39:41 volumio sudo[2849]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Dec 30 12:39:41 volumio sudo[2849]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 12:39:41 volumio sudo[2849]: pam_unix(sudo:session): session closed for user root Dec 30 12:39:41 volumio sudo[2853]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Shanghai /etc/localtime Dec 30 12:39:41 volumio sudo[2853]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 12:39:41 volumio sudo[2853]: pam_unix(sudo:session): session closed for user root Dec 30 12:39:41 volumio sudo[2857]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Dec 30 12:39:41 volumio sudo[2857]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 12:39:41 volumio sudo[2857]: pam_unix(sudo:session): session closed for user root Dec 30 12:39:41 volumio sudo[2863]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Shanghai Dec 30 12:39:41 volumio sudo[2863]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 12:39:41 volumio sudo[2863]: pam_unix(sudo:session): session closed for user root Dec 30 12:39:41 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 30 12:39:41 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 30 12:39:41 volumio sudo[2866]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 30 12:39:41 volumio sudo[2866]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 30 12:39:41 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 30 12:39:41 volumio volumio[1244]: info: Fetching Streaming Services browse cache Dec 30 12:39:42 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Dec 30 12:39:42 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 30 12:39:42 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 12:39:42 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 30 12:39:42 volumio sudo[2866]: pam_unix(sudo:session): session closed for user root Dec 30 12:40:10 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Dec 30 12:40:10 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 30 12:40:10 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Dec 30 12:40:10 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 30 12:40:10 volumio volumio-remote-updater[759]: Test mode disabled Dec 30 12:40:10 volumio volumio-remote-updater[759]: Alpha mode disabled Dec 30 12:40:10 volumio volumio-remote-updater[759]: Alpha legacy test mode disabled Dec 30 12:40:10 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Dec 30 12:40:10 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Dec 30 12:40:11 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Dec 30 12:40:11 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 30 12:40:11 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Dec 30 12:40:11 volumio volumio-remote-updater[759]: Test mode disabled Dec 30 12:40:11 volumio volumio-remote-updater[759]: Alpha mode disabled Dec 30 12:40:11 volumio volumio-remote-updater[759]: Alpha legacy test mode disabled Dec 30 12:40:11 volumio volumio[1244]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Dec 30 12:40:11 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Dec 30 12:40:11 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Dec 30 12:40:12 volumio volumio-remote-updater[759]: Test mode disabled Dec 30 12:40:12 volumio volumio-remote-updater[759]: Alpha mode disabled Dec 30 12:40:12 volumio volumio-remote-updater[759]: Alpha legacy test mode disabled Dec 30 12:40:12 volumio volumio[1244]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Dec 30 12:40:12 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Dec 30 12:40:12 volumio volumio[1244]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Dec 30 12:40:12 volumio volumio[1244]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Dec 30 12:40:15 volumio volumio[1244]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 30 12:40:15 volumio volumio[1244]: Error: connect ETIMEDOUT 66.220.147.11:443 Dec 30 12:40:15 volumio volumio[1244]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Dec 30 12:40:15 volumio volumio[1244]: errno: -110, Dec 30 12:40:15 volumio volumio[1244]: code: 'ETIMEDOUT', Dec 30 12:40:15 volumio volumio[1244]: syscall: 'connect', Dec 30 12:40:15 volumio volumio[1244]: address: '66.220.147.11', Dec 30 12:40:15 volumio volumio[1244]: port: 443 Dec 30 12:40:15 volumio volumio[1244]: } Dec 30 12:40:15 volumio volumio[1244]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 30 12:40:15 volumio sudo[2956]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-30 12:39' Dec 30 12:40:15 volumio sudo[2956]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"