-- Logs begin at Sat 2024-05-04 05:43:06 HKT, end at Thu 2024-05-09 14:25:27 HKT. -- May 09 14:24:04 volumio volumio[12010]: info: CoreCommandRouter::volumioRemoveQueueItem May 09 14:24:04 volumio volumio[12010]: info: CoreStateMachine::removeQueueItem May 09 14:24:04 volumio volumio[12010]: info: CorePlayQueue::removeQueueItem 0 May 09 14:24:04 volumio volumio[12010]: info: CorePlayQueue::saveQueue May 09 14:24:04 volumio volumio[12010]: info: CoreCommandRouter::volumioPushQueue May 09 14:24:08 volumio volumio[12010]: info: CoreCommandRouter::volumioPlay May 09 14:24:08 volumio volumio[12010]: info: CoreStateMachine::play index 2 May 09 14:24:08 volumio volumio[12010]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 14:24:08 volumio volumio[12010]: info: CoreStateMachine::stop May 09 14:24:08 volumio volumio[12010]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 14:24:08 volumio volumio[12010]: info: CoreStateMachine::stPlaybackTimer May 09 14:24:08 volumio volumio[12010]: info: CoreStateMachine::updateTrackBlock May 09 14:24:08 volumio volumio[12010]: info: CorePlayQueue::getTrackBlock May 09 14:24:08 volumio volumio[12010]: info: CoreStateMachine::pushState May 09 14:24:08 volumio volumio[12010]: info: CorePlayQueue::getTrack 6 May 09 14:24:08 volumio volumio[12010]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 14:24:08 volumio volumio[12010]: info: CoreCommandRouter::volumioPushState May 09 14:24:08 volumio volumio[12010]: info: CoreStateMachine::serviceStop May 09 14:24:08 volumio volumio[12010]: info: CorePlayQueue::getTrack 6 May 09 14:24:08 volumio volumio[12010]: info: CoreCommandRouter::serviceStop May 09 14:24:08 volumio volumio[12010]: info: ControllerMpd::stop May 09 14:24:08 volumio volumio[12010]: verbose: ControllerMpd::sendMpdCommand stop May 09 14:24:08 volumio volumio[12010]: info: May 09 14:24:08 volumio volumio[12010]: ---------------------------- MPD announces state update: player May 09 14:24:08 volumio volumio[12010]: info: sendMpdCommand stop took 76 milliseconds May 09 14:24:08 volumio volumio[12010]: info: ControllerMpd::getState May 09 14:24:08 volumio volumio[12010]: verbose: ControllerMpd::sendMpdCommand status May 09 14:24:08 volumio volumio[12010]: info: CoreStateMachine::play index undefined May 09 14:24:08 volumio volumio[12010]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 14:24:08 volumio volumio[12010]: info: CorePlayQueue::getTrack 2 May 09 14:24:08 volumio volumio[12010]: info: CoreStateMachine::startPlaybackTimer May 09 14:24:08 volumio volumio[12010]: info: CorePlayQueue::getTrack 2 May 09 14:24:08 volumio volumio[12010]: verbose: ControllerMpd::clearAddPlayTracks NAS/music/FLAC/0603/侃侃2012-时光倒流/04 我最亲爱的.flac May 09 14:24:08 volumio volumio[12010]: verbose: ControllerMpd::sendMpdCommand stop May 09 14:24:08 volumio volumio[12010]: info: sendMpdCommand status took 2 milliseconds May 09 14:24:08 volumio volumio[12010]: info: sendMpdCommand stop took 1 milliseconds May 09 14:24:08 volumio volumio[12010]: verbose: ControllerMpd::parseState May 09 14:24:08 volumio volumio[12010]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 14:24:08 volumio volumio[12010]: verbose: ControllerMpd::sendMpdCommand clear May 09 14:24:08 volumio volumio[12010]: info: May 09 14:24:08 volumio volumio[12010]: ---------------------------- MPD announces system playlist update May 09 14:24:08 volumio volumio[12010]: info: Ignoring MPD Status Update May 09 14:24:08 volumio volumio[12010]: info: sendMpdCommand playlistinfo took 3 milliseconds May 09 14:24:08 volumio volumio[12010]: info: sendMpdCommand clear took 2 milliseconds May 09 14:24:08 volumio volumio[12010]: verbose: ControllerMpd::parseTrackInfo May 09 14:24:08 volumio volumio[12010]: verbose: ControllerMpd::sendMpdCommand add "NAS/music/FLAC/0603/侃侃2012-时光倒流/04 我最亲爱的.flac" May 09 14:24:08 volumio volumio[12010]: info: ControllerMpd::pushState May 09 14:24:08 volumio volumio[12010]: info: CoreCommandRouter::servicePushState May 09 14:24:08 volumio volumio[12010]: info: CoreStateMachine::pushState May 09 14:24:08 volumio volumio[12010]: info: CorePlayQueue::getTrack 2 May 09 14:24:08 volumio volumio[12010]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 14:24:08 volumio volumio[12010]: info: CoreCommandRouter::volumioPushState May 09 14:24:08 volumio volumio[12010]: info: CorePlayQueue::getTrack 2 May 09 14:24:08 volumio volumio[12010]: 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":"红蔷薇","artist":"侃侃2012","album":"时光倒流","uri":"NAS/music/FLAC/0603/侃侃2012-时光倒流/08 红蔷薇.flac","trackType":"flac"} May 09 14:24:08 volumio volumio[12010]: verbose: CURRENT POSITION 2 May 09 14:24:08 volumio volumio[12010]: info: CoreStateMachine::syncState stateService stop May 09 14:24:08 volumio volumio[12010]: info: CoreStateMachine::syncState currentStatus stop May 09 14:24:08 volumio volumio[12010]: info: CoreStateMachine::pushState May 09 14:24:08 volumio volumio[12010]: info: CorePlayQueue::getTrack 2 May 09 14:24:08 volumio volumio[12010]: info: CoreCommandRouter::volumioPushState May 09 14:24:08 volumio volumio[12010]: info: No code May 09 14:24:08 volumio volumio[12010]: info: CoreStateMachine::pushState May 09 14:24:08 volumio volumio[12010]: info: CorePlayQueue::getTrack 2 May 09 14:24:08 volumio volumio[12010]: info: CoreCommandRouter::volumioPushState May 09 14:24:08 volumio volumio[12010]: info: ------------------------------ 20ms May 09 14:24:08 volumio volumio[12010]: error: updateQueue error: null May 09 14:24:08 volumio volumio[12010]: info: May 09 14:24:08 volumio volumio[12010]: ---------------------------- MPD announces system playlist update May 09 14:24:08 volumio volumio[12010]: info: Ignoring MPD Status Update May 09 14:24:08 volumio volumio[12010]: info: ------------------------------ 17ms May 09 14:24:08 volumio volumio[12010]: info: sendMpdCommand add "NAS/music/FLAC/0603/侃侃2012-时光倒流/04 我最亲爱的.flac" took 15 milliseconds May 09 14:24:08 volumio volumio[12010]: verbose: ControllerMpd::sendMpdCommand play May 09 14:24:08 volumio volumio[12010]: info: ------------------------------ 5ms May 09 14:24:08 volumio volumio[12010]: info: sendMpdCommand play took 3 milliseconds May 09 14:24:08 volumio volumio[12010]: info: May 09 14:24:08 volumio volumio[12010]: ---------------------------- MPD announces state update: player May 09 14:24:08 volumio volumio[12010]: info: ControllerMpd::getState May 09 14:24:08 volumio volumio[12010]: verbose: ControllerMpd::sendMpdCommand status May 09 14:24:08 volumio volumio[12010]: info: May 09 14:24:08 volumio volumio[12010]: ---------------------------- MPD announces state update: player May 09 14:24:08 volumio volumio[12010]: info: sendMpdCommand status took 7 milliseconds May 09 14:24:08 volumio volumio[12010]: info: ControllerMpd::getState May 09 14:24:08 volumio volumio[12010]: verbose: ControllerMpd::sendMpdCommand status May 09 14:24:08 volumio volumio[12010]: verbose: ControllerMpd::parseState May 09 14:24:08 volumio volumio[12010]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 14:24:08 volumio volumio[12010]: info: sendMpdCommand status took 2 milliseconds May 09 14:24:08 volumio volumio[12010]: info: sendMpdCommand playlistinfo took 2 milliseconds May 09 14:24:08 volumio volumio[12010]: verbose: ControllerMpd::parseState May 09 14:24:08 volumio volumio[12010]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 14:24:08 volumio volumio[12010]: verbose: ControllerMpd::parseTrackInfo May 09 14:24:08 volumio volumio[12010]: info: ControllerMpd::pushState May 09 14:24:08 volumio volumio[12010]: info: CoreCommandRouter::servicePushState May 09 14:24:08 volumio volumio[12010]: info: CorePlayQueue::getTrack 2 May 09 14:24:08 volumio volumio[12010]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":290,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"我最亲爱的","artist":"侃侃2012","album":"时光倒流","uri":"NAS/music/FLAC/0603/侃侃2012-时光倒流/04 我最亲爱的.flac","trackType":"flac"} May 09 14:24:08 volumio volumio[12010]: verbose: CURRENT POSITION 2 May 09 14:24:08 volumio volumio[12010]: info: CoreStateMachine::syncState stateService play May 09 14:24:08 volumio volumio[12010]: info: CoreStateMachine::syncState currentStatus stop May 09 14:24:08 volumio volumio[12010]: info: ------------------------------ 22ms May 09 14:24:08 volumio volumio[12010]: info: sendMpdCommand playlistinfo took 9 milliseconds May 09 14:24:08 volumio volumio[12010]: verbose: ControllerMpd::parseTrackInfo May 09 14:24:08 volumio volumio[12010]: info: ControllerMpd::pushState May 09 14:24:08 volumio volumio[12010]: info: CoreCommandRouter::servicePushState May 09 14:24:08 volumio volumio[12010]: info: CorePlayQueue::getTrack 2 May 09 14:24:08 volumio volumio[12010]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":290,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"我最亲爱的","artist":"侃侃2012","album":"时光倒流","uri":"NAS/music/FLAC/0603/侃侃2012-时光倒流/04 我最亲爱的.flac","trackType":"flac"} May 09 14:24:08 volumio volumio[12010]: verbose: CURRENT POSITION 2 May 09 14:24:08 volumio volumio[12010]: info: CoreStateMachine::syncState stateService play May 09 14:24:08 volumio volumio[12010]: info: CoreStateMachine::syncState currentStatus play May 09 14:24:08 volumio volumio[12010]: info: Received an update from plugin. extracting info from payload May 09 14:24:08 volumio volumio[12010]: info: CoreStateMachine::pushState May 09 14:24:08 volumio volumio[12010]: info: CorePlayQueue::getTrack 2 May 09 14:24:08 volumio volumio[12010]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 14:24:08 volumio volumio[12010]: info: CoreCommandRouter::volumioPushState May 09 14:24:08 volumio volumio[12010]: info: CoreStateMachine::pushState May 09 14:24:08 volumio volumio[12010]: info: CorePlayQueue::getTrack 2 May 09 14:24:08 volumio volumio[12010]: info: CoreCommandRouter::volumioPushState May 09 14:24:08 volumio volumio[12010]: info: ------------------------------ 27ms May 09 14:24:29 volumio volumio[12010]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. May 09 14:24:29 volumio volumio[12010]: info: Retrying Login Due to Network Error May 09 14:24:39 volumio volumio[12010]: info: MyVolumio login type: Token May 09 14:25:09 volumio volumio[12010]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. May 09 14:25:09 volumio volumio[12010]: info: Retrying Login Due to Network Error May 09 14:25:19 volumio volumio[12010]: info: MyVolumio login type: Token May 09 14:25:27 volumio volumio[12010]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 09 14:25:27 volumio volumio[12010]: Error: connect ETIMEDOUT 103.252.114.101:80 May 09 14:25:27 volumio volumio[12010]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { May 09 14:25:27 volumio volumio[12010]: errno: -110, May 09 14:25:27 volumio volumio[12010]: code: 'ETIMEDOUT', May 09 14:25:27 volumio volumio[12010]: syscall: 'connect', May 09 14:25:27 volumio volumio[12010]: address: '103.252.114.101', May 09 14:25:27 volumio volumio[12010]: port: 80 May 09 14:25:27 volumio volumio[12010]: } May 09 14:25:27 volumio volumio[12010]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 09 14:25:27 volumio sudo[21190]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-09 14:24 May 09 14:25:27 volumio sudo[21190]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="b1c3cf61c2a0027c66bab1eb0a3795f80c1f2e95" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="e3eb3ee5b16063502f3a1735e11a28cfe54a0f46" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 25 Jun 2023 07:20:58 PM CEST" VOLUMIO_VERSION="3.512" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="946a42b62509f37b5e7e2d86a2932a62"