-- Logs begin at Sun 2024-09-08 21:51:40 CST, end at Mon 2024-09-09 02:33:02 CST. -- Sep 09 02:32:00 volumio volumio[20131]: info: CoreCommandRouter::volumioPlay Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::play index 354 Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::stop Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::play index undefined Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 09 02:32:00 volumio volumio[20131]: info: CorePlayQueue::getTrack 354 Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::startPlaybackTimer Sep 09 02:32:00 volumio volumio[20131]: info: CorePlayQueue::getTrack 354 Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::clearAddPlayTracks NAS/Z4Pro/flac/陈奕迅 - 十年.flac Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::sendMpdCommand stop Sep 09 02:32:00 volumio volumio[20131]: info: sendMpdCommand stop took 1 milliseconds Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::sendMpdCommand clear Sep 09 02:32:00 volumio volumio[20131]: info: sendMpdCommand clear took 0 milliseconds Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::sendMpdCommand add "NAS/Z4Pro/flac/陈奕迅 - 十年.flac" Sep 09 02:32:00 volumio volumio[20131]: info: Sep 09 02:32:00 volumio volumio[20131]: ---------------------------- MPD announces system playlist update Sep 09 02:32:00 volumio volumio[20131]: info: Ignoring MPD Status Update Sep 09 02:32:00 volumio volumio[20131]: info: Sep 09 02:32:00 volumio volumio[20131]: ---------------------------- MPD announces system playlist update Sep 09 02:32:00 volumio volumio[20131]: info: Ignoring MPD Status Update Sep 09 02:32:00 volumio volumio[20131]: info: sendMpdCommand add "NAS/Z4Pro/flac/陈奕迅 - 十年.flac" took 2 milliseconds Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::sendMpdCommand play Sep 09 02:32:00 volumio volumio[20131]: info: Sep 09 02:32:00 volumio volumio[20131]: ---------------------------- MPD announces system playlist update Sep 09 02:32:00 volumio volumio[20131]: info: Ignoring MPD Status Update Sep 09 02:32:00 volumio volumio[20131]: info: Sep 09 02:32:00 volumio volumio[20131]: ---------------------------- MPD announces system playlist update Sep 09 02:32:00 volumio volumio[20131]: info: Ignoring MPD Status Update Sep 09 02:32:00 volumio volumio[20131]: info: ------------------------------ 6ms Sep 09 02:32:00 volumio volumio[20131]: info: ------------------------------ 5ms Sep 09 02:32:00 volumio volumio[20131]: info: sendMpdCommand play took 4 milliseconds Sep 09 02:32:00 volumio volumio[20131]: info: ------------------------------ 3ms Sep 09 02:32:00 volumio volumio[20131]: info: ------------------------------ 3ms Sep 09 02:32:00 volumio volumio[20131]: info: Sep 09 02:32:00 volumio volumio[20131]: ---------------------------- MPD announces system playlist update Sep 09 02:32:00 volumio volumio[20131]: info: Ignoring MPD Status Update Sep 09 02:32:00 volumio volumio[20131]: info: Sep 09 02:32:00 volumio volumio[20131]: ---------------------------- MPD announces system playlist update Sep 09 02:32:00 volumio volumio[20131]: info: Ignoring MPD Status Update Sep 09 02:32:00 volumio volumio[20131]: info: ------------------------------ 2ms Sep 09 02:32:00 volumio volumio[20131]: info: ------------------------------ 1ms Sep 09 02:32:00 volumio volumio[20131]: info: Sep 09 02:32:00 volumio volumio[20131]: ---------------------------- MPD announces state update: player Sep 09 02:32:00 volumio volumio[20131]: info: ControllerMpd::getState Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::sendMpdCommand status Sep 09 02:32:00 volumio volumio[20131]: info: Sep 09 02:32:00 volumio volumio[20131]: ---------------------------- MPD announces state update: player Sep 09 02:32:00 volumio volumio[20131]: info: ControllerMpd::getState Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::sendMpdCommand status Sep 09 02:32:00 volumio volumio[20131]: info: Sep 09 02:32:00 volumio volumio[20131]: ---------------------------- MPD announces state update: player Sep 09 02:32:00 volumio volumio[20131]: info: ControllerMpd::getState Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::sendMpdCommand status Sep 09 02:32:00 volumio volumio[20131]: info: Sep 09 02:32:00 volumio volumio[20131]: ---------------------------- MPD announces state update: player Sep 09 02:32:00 volumio volumio[20131]: info: sendMpdCommand status took 108 milliseconds Sep 09 02:32:00 volumio volumio[20131]: info: ControllerMpd::getState Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::sendMpdCommand status Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::parseState Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 02:32:00 volumio volumio[20131]: info: Sep 09 02:32:00 volumio volumio[20131]: ---------------------------- MPD announces state update: player Sep 09 02:32:00 volumio volumio[20131]: info: ControllerMpd::getState Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::sendMpdCommand status Sep 09 02:32:00 volumio volumio[20131]: info: sendMpdCommand status took 110 milliseconds Sep 09 02:32:00 volumio volumio[20131]: info: sendMpdCommand status took 109 milliseconds Sep 09 02:32:00 volumio volumio[20131]: info: sendMpdCommand status took 5 milliseconds Sep 09 02:32:00 volumio volumio[20131]: info: sendMpdCommand playlistinfo took 4 milliseconds Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::parseState Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::parseState Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::parseState Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::parseTrackInfo Sep 09 02:32:00 volumio volumio[20131]: info: ControllerMpd::pushState Sep 09 02:32:00 volumio volumio[20131]: info: CoreCommandRouter::servicePushState Sep 09 02:32:00 volumio volumio[20131]: info: CorePlayQueue::getTrack 354 Sep 09 02:32:00 volumio volumio[20131]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":205,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"504 Kbps","isStreaming":false,"title":"十年","artist":"陈奕迅","album":"七","uri":"NAS/Z4Pro/flac/陈奕迅 - 十年.flac","trackType":"flac"} Sep 09 02:32:00 volumio volumio[20131]: verbose: CURRENT POSITION 354 Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::syncState stateService play Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::syncState currentStatus stop Sep 09 02:32:00 volumio volumio[20131]: info: ------------------------------ 124ms Sep 09 02:32:00 volumio volumio[20131]: info: Sep 09 02:32:00 volumio volumio[20131]: ---------------------------- MPD announces state update: player Sep 09 02:32:00 volumio volumio[20131]: info: ControllerMpd::getState Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::sendMpdCommand status Sep 09 02:32:00 volumio volumio[20131]: info: sendMpdCommand status took 11 milliseconds Sep 09 02:32:00 volumio volumio[20131]: info: sendMpdCommand playlistinfo took 8 milliseconds Sep 09 02:32:00 volumio volumio[20131]: info: sendMpdCommand playlistinfo took 8 milliseconds Sep 09 02:32:00 volumio volumio[20131]: info: sendMpdCommand playlistinfo took 7 milliseconds Sep 09 02:32:00 volumio volumio[20131]: info: sendMpdCommand status took 2 milliseconds Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::parseState Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::parseTrackInfo Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::parseTrackInfo Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::parseTrackInfo Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::parseState Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 09 02:32:00 volumio volumio[20131]: info: ControllerMpd::pushState Sep 09 02:32:00 volumio volumio[20131]: info: CoreCommandRouter::servicePushState Sep 09 02:32:00 volumio volumio[20131]: info: CorePlayQueue::getTrack 354 Sep 09 02:32:00 volumio volumio[20131]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":205,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"515 Kbps","isStreaming":false,"title":"十年","artist":"陈奕迅","album":"七","uri":"NAS/Z4Pro/flac/陈奕迅 - 十年.flac","trackType":"flac"} Sep 09 02:32:00 volumio volumio[20131]: verbose: CURRENT POSITION 354 Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::syncState stateService play Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::syncState currentStatus play Sep 09 02:32:00 volumio volumio[20131]: info: Received an update from plugin. extracting info from payload Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::pushState Sep 09 02:32:00 volumio volumio[20131]: info: CorePlayQueue::getTrack 354 Sep 09 02:32:00 volumio volumio[20131]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 09 02:32:00 volumio volumio[20131]: info: CoreCommandRouter::volumioPushState Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::pushState Sep 09 02:32:00 volumio volumio[20131]: info: CorePlayQueue::getTrack 354 Sep 09 02:32:00 volumio volumio[20131]: info: CoreCommandRouter::volumioPushState Sep 09 02:32:00 volumio volumio[20131]: info: ControllerMpd::pushState Sep 09 02:32:00 volumio volumio[20131]: info: CoreCommandRouter::servicePushState Sep 09 02:32:00 volumio volumio[20131]: info: CorePlayQueue::getTrack 354 Sep 09 02:32:00 volumio volumio[20131]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":205,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"515 Kbps","isStreaming":false,"title":"十年","artist":"陈奕迅","album":"七","uri":"NAS/Z4Pro/flac/陈奕迅 - 十年.flac","trackType":"flac"} Sep 09 02:32:00 volumio volumio[20131]: verbose: CURRENT POSITION 354 Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::syncState stateService play Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::syncState currentStatus play Sep 09 02:32:00 volumio volumio[20131]: info: Received an update from plugin. extracting info from payload Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::pushState Sep 09 02:32:00 volumio volumio[20131]: info: CorePlayQueue::getTrack 354 Sep 09 02:32:00 volumio volumio[20131]: info: CoreCommandRouter::volumioPushState Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::pushState Sep 09 02:32:00 volumio volumio[20131]: info: CorePlayQueue::getTrack 354 Sep 09 02:32:00 volumio volumio[20131]: info: CoreCommandRouter::volumioPushState Sep 09 02:32:00 volumio volumio[20131]: info: ControllerMpd::pushState Sep 09 02:32:00 volumio volumio[20131]: info: CoreCommandRouter::servicePushState Sep 09 02:32:00 volumio volumio[20131]: info: CorePlayQueue::getTrack 354 Sep 09 02:32:00 volumio volumio[20131]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":205,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"515 Kbps","isStreaming":false,"title":"十年","artist":"陈奕迅","album":"七","uri":"NAS/Z4Pro/flac/陈奕迅 - 十年.flac","trackType":"flac"} Sep 09 02:32:00 volumio volumio[20131]: verbose: CURRENT POSITION 354 Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::syncState stateService play Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::syncState currentStatus play Sep 09 02:32:00 volumio volumio[20131]: info: Received an update from plugin. extracting info from payload Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::pushState Sep 09 02:32:00 volumio volumio[20131]: info: CorePlayQueue::getTrack 354 Sep 09 02:32:00 volumio volumio[20131]: info: CoreCommandRouter::volumioPushState Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::pushState Sep 09 02:32:00 volumio volumio[20131]: info: CorePlayQueue::getTrack 354 Sep 09 02:32:00 volumio volumio[20131]: info: CoreCommandRouter::volumioPushState Sep 09 02:32:00 volumio volumio[20131]: info: ------------------------------ 170ms Sep 09 02:32:00 volumio volumio[20131]: info: ------------------------------ 169ms Sep 09 02:32:00 volumio volumio[20131]: info: ------------------------------ 65ms Sep 09 02:32:00 volumio volumio[20131]: info: sendMpdCommand playlistinfo took 50 milliseconds Sep 09 02:32:00 volumio volumio[20131]: info: sendMpdCommand playlistinfo took 50 milliseconds Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::parseTrackInfo Sep 09 02:32:00 volumio volumio[20131]: verbose: ControllerMpd::parseTrackInfo Sep 09 02:32:00 volumio volumio[20131]: info: ControllerMpd::pushState Sep 09 02:32:00 volumio volumio[20131]: info: CoreCommandRouter::servicePushState Sep 09 02:32:00 volumio volumio[20131]: info: CorePlayQueue::getTrack 354 Sep 09 02:32:00 volumio volumio[20131]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":205,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"515 Kbps","isStreaming":false,"title":"十年","artist":"陈奕迅","album":"七","uri":"NAS/Z4Pro/flac/陈奕迅 - 十年.flac","trackType":"flac"} Sep 09 02:32:00 volumio volumio[20131]: verbose: CURRENT POSITION 354 Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::syncState stateService play Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::syncState currentStatus play Sep 09 02:32:00 volumio volumio[20131]: info: Received an update from plugin. extracting info from payload Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::pushState Sep 09 02:32:00 volumio volumio[20131]: info: CorePlayQueue::getTrack 354 Sep 09 02:32:00 volumio volumio[20131]: info: CoreCommandRouter::volumioPushState Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::pushState Sep 09 02:32:00 volumio volumio[20131]: info: CorePlayQueue::getTrack 354 Sep 09 02:32:00 volumio volumio[20131]: info: CoreCommandRouter::volumioPushState Sep 09 02:32:00 volumio volumio[20131]: info: ControllerMpd::pushState Sep 09 02:32:00 volumio volumio[20131]: info: CoreCommandRouter::servicePushState Sep 09 02:32:00 volumio volumio[20131]: info: CorePlayQueue::getTrack 354 Sep 09 02:32:00 volumio volumio[20131]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":205,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"515 Kbps","isStreaming":false,"title":"十年","artist":"陈奕迅","album":"七","uri":"NAS/Z4Pro/flac/陈奕迅 - 十年.flac","trackType":"flac"} Sep 09 02:32:00 volumio volumio[20131]: verbose: CURRENT POSITION 354 Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::syncState stateService play Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::syncState currentStatus play Sep 09 02:32:00 volumio volumio[20131]: info: Received an update from plugin. extracting info from payload Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::pushState Sep 09 02:32:00 volumio volumio[20131]: info: CorePlayQueue::getTrack 354 Sep 09 02:32:00 volumio volumio[20131]: info: CoreCommandRouter::volumioPushState Sep 09 02:32:00 volumio volumio[20131]: info: CoreStateMachine::pushState Sep 09 02:32:00 volumio volumio[20131]: info: CorePlayQueue::getTrack 354 Sep 09 02:32:00 volumio volumio[20131]: info: CoreCommandRouter::volumioPushState Sep 09 02:32:00 volumio volumio[20131]: info: ------------------------------ 96ms Sep 09 02:32:00 volumio volumio[20131]: info: ------------------------------ 86ms Sep 09 02:33:01 volumio volumio[20131]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 09 02:33:01 volumio volumio[20131]: Error: connect ETIMEDOUT 208.77.47.172:443 Sep 09 02:33:01 volumio volumio[20131]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Sep 09 02:33:01 volumio volumio[20131]: errno: -110, Sep 09 02:33:01 volumio volumio[20131]: code: 'ETIMEDOUT', Sep 09 02:33:01 volumio volumio[20131]: syscall: 'connect', Sep 09 02:33:01 volumio volumio[20131]: address: '208.77.47.172', Sep 09 02:33:01 volumio volumio[20131]: port: 443 Sep 09 02:33:01 volumio volumio[20131]: } Sep 09 02:33:01 volumio volumio[20131]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 09 02:33:02 volumio sudo[20434]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-09 02:32 Sep 09 02:33:02 volumio sudo[20434]: 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"