-- Logs begin at Sun 2024-09-01 07:11:01 UTC, end at Sun 2024-09-01 07:26:32 UTC. -- Sep 01 07:25:06 volumio dhcpcd[1016]: eth0: adding route to 192.168.3.0/24 Sep 01 07:25:06 volumio dhcpcd[1016]: eth0: adding default route via 192.168.3.101 Sep 01 07:25:06 volumio dhcpcd[1016]: eth0: ipv4_addroute: File exists Sep 01 07:25:06 volumio dhcpcd[1016]: eth0: removing route to 192.168.3.0/24 Sep 01 07:25:29 volumio volumio[2065]: info: Sep 01 07:25:29 volumio volumio[2065]: ---------------------------- MPD announces state update: player Sep 01 07:25:29 volumio volumio[2065]: info: ControllerMpd::getState Sep 01 07:25:29 volumio volumio[2065]: verbose: ControllerMpd::sendMpdCommand status Sep 01 07:25:29 volumio volumio[2065]: verbose: ControllerMpd::parseState Sep 01 07:25:29 volumio volumio[2065]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 01 07:25:29 volumio volumio[2065]: verbose: ControllerMpd::parseTrackInfo Sep 01 07:25:29 volumio volumio[2065]: info: ControllerMpd::pushState Sep 01 07:25:29 volumio volumio[2065]: info: CoreCommandRouter::servicePushState Sep 01 07:25:29 volumio volumio[2065]: info: CoreStateMachine::pushState Sep 01 07:25:29 volumio volumio[2065]: info: CoreCommandRouter::volumioPushState Sep 01 07:25:29 volumio volumio[2065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 07:25:29 volumio volumio[2065]: info: CorePlayQueue::getTrack 0 Sep 01 07:25:29 volumio volumio[2065]: 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":"洋澜一","album":"追梦人","uri":"http://aqqmusic.tc.qq.com/F0000020UB9a0CN5Vm.flac?guid=0000000004cb49d2000001871e73f5cf&vkey=E75AF390F75925BF0287C2E265F6BA08C0D258F076A45F18907CA0F67FC66F73ED5D18105908DAF5F309BB0B72F51286E1318EF78D81DE28&uin=1259438298&redirect=1&fromtag=111114","trackType":""} Sep 01 07:25:29 volumio volumio[2065]: verbose: CURRENT POSITION 0 Sep 01 07:25:29 volumio volumio[2065]: info: CoreStateMachine::syncState stateService stop Sep 01 07:25:29 volumio volumio[2065]: info: CoreStateMachine::syncState currentStatus play Sep 01 07:25:29 volumio volumio[2065]: info: CoreCommandRouter::volumioPushState Sep 01 07:25:29 volumio volumio[2065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 07:25:29 volumio volumio[2065]: info: CoreStateMachine::stPlaybackTimer Sep 01 07:25:29 volumio volumio[2065]: info: ------------------------------ 26ms Sep 01 07:25:29 volumio volumio[2065]: info: CoreCommandRouter::volumioGetQueue Sep 01 07:25:29 volumio volumio[2065]: info: CoreStateMachine::getQueue Sep 01 07:25:29 volumio volumio[2065]: info: CorePlayQueue::getQueue Sep 01 07:25:31 volumio volumio[2065]: info: Clearing queue after UPNP request Sep 01 07:25:31 volumio volumio[2065]: info: CoreStateMachine::ClearQueue Sep 01 07:25:31 volumio volumio[2065]: info: CoreStateMachine::stop Sep 01 07:25:31 volumio volumio[2065]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 01 07:25:31 volumio volumio[2065]: UNSET VOLATILE Sep 01 07:25:31 volumio volumio[2065]: info: CorePlayQueue::clearPlayQueue Sep 01 07:25:31 volumio volumio[2065]: info: CorePlayQueue::saveQueue Sep 01 07:25:31 volumio volumio[2065]: info: CoreCommandRouter::volumioPushState Sep 01 07:25:31 volumio volumio[2065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 07:25:31 volumio volumio[2065]: info: CoreCommandRouter::volumioPushQueue Sep 01 07:25:31 volumio volumio[2065]: info: Sep 01 07:25:31 volumio volumio[2065]: ---------------------------- MPD announces system playlist update Sep 01 07:25:31 volumio volumio[2065]: info: Ignoring MPD Status Update Sep 01 07:25:31 volumio volumio[2065]: info: Starting UPNP Playback Sep 01 07:25:31 volumio volumio[2065]: info: Preparing playback through UPNP Sep 01 07:25:31 volumio volumio[2065]: info: CoreCommandRouter::volumioGetState Sep 01 07:25:31 volumio volumio[2065]: info: CorePlayQueue::getTrack 0 Sep 01 07:25:31 volumio volumio[2065]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 01 07:25:31 volumio volumio[2065]: error: updateQueue error: null Sep 01 07:25:31 volumio volumio[2065]: info: ------------------------------ 11ms Sep 01 07:25:32 volumio volumio[2065]: info: Sep 01 07:25:32 volumio volumio[2065]: ---------------------------- MPD announces system playlist update Sep 01 07:25:32 volumio volumio[2065]: info: Ignoring MPD Status Update Sep 01 07:25:32 volumio volumio[2065]: info: Sep 01 07:25:32 volumio volumio[2065]: ---------------------------- MPD announces system playlist update Sep 01 07:25:32 volumio volumio[2065]: info: Ignoring MPD Status Update Sep 01 07:25:32 volumio volumio[2065]: info: ------------------------------ 2ms Sep 01 07:25:32 volumio volumio[2065]: info: ------------------------------ 1ms Sep 01 07:25:32 volumio volumio[2065]: info: Sep 01 07:25:32 volumio volumio[2065]: ---------------------------- MPD announces system playlist update Sep 01 07:25:32 volumio volumio[2065]: info: Ignoring MPD Status Update Sep 01 07:25:32 volumio volumio[2065]: info: ------------------------------ 1ms Sep 01 07:25:32 volumio volumio[2065]: info: Sep 01 07:25:32 volumio volumio[2065]: ---------------------------- MPD announces system playlist update Sep 01 07:25:32 volumio volumio[2065]: info: Ignoring MPD Status Update Sep 01 07:25:32 volumio volumio[2065]: info: ------------------------------ 1ms Sep 01 07:25:32 volumio volumio[2065]: info: Sep 01 07:25:32 volumio volumio[2065]: ---------------------------- MPD announces system playlist update Sep 01 07:25:32 volumio volumio[2065]: info: Ignoring MPD Status Update Sep 01 07:25:32 volumio volumio[2065]: info: ------------------------------ 1ms Sep 01 07:25:32 volumio volumio[2065]: info: Sep 01 07:25:32 volumio volumio[2065]: ---------------------------- MPD announces system playlist update Sep 01 07:25:32 volumio volumio[2065]: info: Ignoring MPD Status Update Sep 01 07:25:32 volumio volumio[2065]: info: ------------------------------ 1ms Sep 01 07:25:36 volumio dhcpcd[1016]: eth0: adding route to 192.168.3.0/24 Sep 01 07:25:36 volumio dhcpcd[1016]: eth0: adding default route via 192.168.3.101 Sep 01 07:25:36 volumio dhcpcd[1016]: eth0: ipv4_addroute: File exists Sep 01 07:25:36 volumio dhcpcd[1016]: eth0: removing route to 192.168.3.0/24 Sep 01 07:25:40 volumio volumio[2065]: info: Sep 01 07:25:40 volumio volumio[2065]: ---------------------------- MPD announces state update: player Sep 01 07:25:40 volumio volumio[2065]: info: ControllerMpd::getState Sep 01 07:25:40 volumio volumio[2065]: verbose: ControllerMpd::sendMpdCommand status Sep 01 07:25:40 volumio volumio[2065]: info: Sep 01 07:25:40 volumio volumio[2065]: ---------------------------- MPD announces state update: player Sep 01 07:25:40 volumio volumio[2065]: info: ControllerMpd::getState Sep 01 07:25:40 volumio volumio[2065]: verbose: ControllerMpd::sendMpdCommand status Sep 01 07:25:40 volumio volumio[2065]: verbose: ControllerMpd::parseState Sep 01 07:25:40 volumio volumio[2065]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 01 07:25:40 volumio volumio[2065]: info: Sep 01 07:25:40 volumio volumio[2065]: ---------------------------- MPD announces system playlist update Sep 01 07:25:40 volumio volumio[2065]: info: Ignoring MPD Status Update Sep 01 07:25:40 volumio volumio[2065]: verbose: ControllerMpd::parseState Sep 01 07:25:40 volumio volumio[2065]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 01 07:25:40 volumio volumio[2065]: verbose: ControllerMpd::parseTrackInfo Sep 01 07:25:40 volumio volumio[2065]: info: ControllerMpd::pushState Sep 01 07:25:40 volumio volumio[2065]: info: CoreCommandRouter::servicePushState Sep 01 07:25:40 volumio volumio[2065]: In UPNP mode Sep 01 07:25:40 volumio volumio[2065]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"549 Kbps","isStreaming":false,"title":"一个人生活","artist":"林凡","album":"Freya 同名专辑","uri":"http://aqqmusic.tc.qq.com/F000002sWYtG1asmes.flac?guid=0000000004cb49d2000001871e73f5cf&vkey=2AE15258AFA57D82EDE17138B0F5EDB6D6769756C30694DCC69B513CC9C751D39FA61F357996A32E051D38A39A44068E68A07D0EF5AD6180&uin=1259438298&redirect=1&fromtag=111114","trackType":""} Sep 01 07:25:40 volumio volumio[2065]: verbose: CURRENT POSITION 0 Sep 01 07:25:40 volumio volumio[2065]: info: CoreStateMachine::syncState stateService play Sep 01 07:25:40 volumio volumio[2065]: info: CoreStateMachine::syncState currentStatus stop Sep 01 07:25:40 volumio volumio[2065]: info: CoreStateMachine::pushState Sep 01 07:25:40 volumio volumio[2065]: info: CoreCommandRouter::volumioPushState Sep 01 07:25:40 volumio volumio[2065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 07:25:40 volumio volumio[2065]: info: ------------------------------ 41ms Sep 01 07:25:40 volumio volumio[2065]: info: ------------------------------ 12ms Sep 01 07:25:40 volumio volumio[2065]: verbose: ControllerMpd::parseTrackInfo Sep 01 07:25:40 volumio volumio[2065]: info: ControllerMpd::pushState Sep 01 07:25:40 volumio volumio[2065]: info: CoreCommandRouter::servicePushState Sep 01 07:25:40 volumio volumio[2065]: In UPNP mode Sep 01 07:25:40 volumio volumio[2065]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"490 Kbps","isStreaming":false,"title":"一个人生活","artist":"林凡","album":"Freya 同名专辑","uri":"http://aqqmusic.tc.qq.com/F000002sWYtG1asmes.flac?guid=0000000004cb49d2000001871e73f5cf&vkey=2AE15258AFA57D82EDE17138B0F5EDB6D6769756C30694DCC69B513CC9C751D39FA61F357996A32E051D38A39A44068E68A07D0EF5AD6180&uin=1259438298&redirect=1&fromtag=111114","trackType":""} Sep 01 07:25:40 volumio volumio[2065]: verbose: CURRENT POSITION 0 Sep 01 07:25:40 volumio volumio[2065]: info: CoreStateMachine::syncState stateService play Sep 01 07:25:40 volumio volumio[2065]: info: CoreStateMachine::syncState currentStatus play Sep 01 07:25:40 volumio volumio[2065]: info: Received an update from plugin. extracting info from payload Sep 01 07:25:40 volumio volumio[2065]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 01 07:25:40 volumio volumio[2065]: info: CoreStateMachine::pushState Sep 01 07:25:40 volumio volumio[2065]: info: CoreCommandRouter::volumioPushState Sep 01 07:25:40 volumio volumio[2065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 07:25:40 volumio volumio[2065]: info: CoreStateMachine::pushState Sep 01 07:25:40 volumio volumio[2065]: info: CoreCommandRouter::volumioPushState Sep 01 07:25:40 volumio volumio[2065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 07:25:40 volumio volumio[2065]: info: ------------------------------ 37ms Sep 01 07:25:40 volumio volumio[2065]: info: CoreCommandRouter::volumioGetQueue Sep 01 07:25:40 volumio volumio[2065]: info: CoreStateMachine::getQueue Sep 01 07:25:40 volumio volumio[2065]: info: CorePlayQueue::getQueue Sep 01 07:25:40 volumio volumio[2065]: info: CoreCommandRouter::volumioGetQueue Sep 01 07:25:40 volumio volumio[2065]: info: CoreStateMachine::getQueue Sep 01 07:25:40 volumio volumio[2065]: info: CorePlayQueue::getQueue Sep 01 07:25:42 volumio systemd[1]: Starting Cleanup of Temporary Directories... Sep 01 07:25:42 volumio systemd[1]: Started Cleanup of Temporary Directories. Sep 01 07:26:06 volumio dhcpcd[1016]: eth0: adding route to 192.168.3.0/24 Sep 01 07:26:06 volumio dhcpcd[1016]: eth0: adding default route via 192.168.3.101 Sep 01 07:26:06 volumio dhcpcd[1016]: eth0: ipv4_addroute: File exists Sep 01 07:26:06 volumio dhcpcd[1016]: eth0: removing route to 192.168.3.0/24 Sep 01 07:26:31 volumio volumio[2065]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 01 07:26:31 volumio volumio[2065]: { Error: connect ETIMEDOUT 108.160.166.42:443 Sep 01 07:26:31 volumio volumio[2065]: at Object._errnoException (util.js:1022:11) Sep 01 07:26:31 volumio volumio[2065]: at _exceptionWithHostPort (util.js:1044:20) Sep 01 07:26:31 volumio volumio[2065]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Sep 01 07:26:31 volumio volumio[2065]: code: 'ETIMEDOUT', Sep 01 07:26:31 volumio volumio[2065]: errno: 'ETIMEDOUT', Sep 01 07:26:31 volumio volumio[2065]: syscall: 'connect', Sep 01 07:26:31 volumio volumio[2065]: address: '108.160.166.42', Sep 01 07:26:31 volumio volumio[2065]: port: 443 } Sep 01 07:26:31 volumio volumio[2065]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 01 07:26:32 volumio sudo[4624]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-01 07:25 Sep 01 07:26:32 volumio sudo[4624]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="168ba7444df98cd868db72f24faec0b6346489cc" VOLUMIO_FE_VERSION="847a48ecf32d35cc502a0053d585d1a69236e391" VOLUMIO_BE_VERSION="03f7bbd984817e093cac62b7ff876f3c2cfabc1d" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Dec 22 15:00:46 CET 2020" VOLUMIO_VERSION="2.861" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="b3401e25b8d19b16b1038c2843d2deaf"