-- Logs begin at Sun 2024-09-01 07:11:01 UTC, end at Sun 2024-09-01 08:53:32 UTC. -- Sep 01 08:52:20 volumio dhcpcd[1016]: eth0: adding route to 192.168.3.0/24 Sep 01 08:52:20 volumio dhcpcd[1016]: eth0: adding default route via 192.168.3.101 Sep 01 08:52:20 volumio dhcpcd[1016]: eth0: ipv4_addroute: File exists Sep 01 08:52:20 volumio dhcpcd[1016]: eth0: removing route to 192.168.3.0/24 Sep 01 08:52:50 volumio dhcpcd[1016]: eth0: adding route to 192.168.3.0/24 Sep 01 08:52:50 volumio dhcpcd[1016]: eth0: adding default route via 192.168.3.101 Sep 01 08:52:50 volumio dhcpcd[1016]: eth0: ipv4_addroute: File exists Sep 01 08:52:50 volumio dhcpcd[1016]: eth0: removing route to 192.168.3.0/24 Sep 01 08:53:05 volumio volumio[21512]: info: Sep 01 08:53:05 volumio volumio[21512]: ---------------------------- MPD announces state update: player Sep 01 08:53:05 volumio volumio[21512]: info: ControllerMpd::getState Sep 01 08:53:05 volumio volumio[21512]: verbose: ControllerMpd::sendMpdCommand status Sep 01 08:53:05 volumio volumio[21512]: verbose: ControllerMpd::parseState Sep 01 08:53:05 volumio volumio[21512]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 01 08:53:05 volumio volumio[21512]: verbose: ControllerMpd::parseTrackInfo Sep 01 08:53:05 volumio volumio[21512]: info: ControllerMpd::pushState Sep 01 08:53:05 volumio volumio[21512]: info: CoreCommandRouter::servicePushState Sep 01 08:53:05 volumio volumio[21512]: info: CoreStateMachine::pushState Sep 01 08:53:05 volumio volumio[21512]: info: CoreCommandRouter::volumioPushState Sep 01 08:53:05 volumio volumio[21512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 08:53:05 volumio volumio[21512]: info: CorePlayQueue::getTrack 0 Sep 01 08:53:05 volumio volumio[21512]: 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/F000001hlr1F3YYrWX.flac?guid=0000000004cb49d2000001871e73f5cf&vkey=C951ED47F4A614A44F14B96FC5E99943330897D3F820C3C8F55B46FD1F368591A94681D3845766726207C7EF44B06E61E470AF757A338D29&uin=1259438298&src=F000002d9MOe0bfetF.flac&redirect=1&fromtag=111114","trackType":""} Sep 01 08:53:05 volumio volumio[21512]: verbose: CURRENT POSITION 0 Sep 01 08:53:05 volumio volumio[21512]: info: CoreStateMachine::syncState stateService stop Sep 01 08:53:05 volumio volumio[21512]: info: CoreStateMachine::syncState currentStatus play Sep 01 08:53:05 volumio volumio[21512]: info: CoreCommandRouter::volumioPushState Sep 01 08:53:05 volumio volumio[21512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 08:53:05 volumio volumio[21512]: info: CoreStateMachine::stPlaybackTimer Sep 01 08:53:05 volumio volumio[21512]: info: ------------------------------ 17ms Sep 01 08:53:05 volumio volumio[21512]: info: CoreCommandRouter::volumioGetQueue Sep 01 08:53:05 volumio volumio[21512]: info: CoreStateMachine::getQueue Sep 01 08:53:05 volumio volumio[21512]: info: CorePlayQueue::getQueue Sep 01 08:53:05 volumio volumio[21512]: info: Clearing queue after UPNP request Sep 01 08:53:05 volumio volumio[21512]: info: CoreStateMachine::ClearQueue Sep 01 08:53:05 volumio volumio[21512]: info: CoreStateMachine::stop Sep 01 08:53:05 volumio volumio[21512]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 01 08:53:05 volumio volumio[21512]: UNSET VOLATILE Sep 01 08:53:05 volumio volumio[21512]: info: CorePlayQueue::clearPlayQueue Sep 01 08:53:05 volumio volumio[21512]: info: CorePlayQueue::saveQueue Sep 01 08:53:05 volumio volumio[21512]: info: CoreCommandRouter::volumioPushState Sep 01 08:53:05 volumio volumio[21512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 08:53:05 volumio volumio[21512]: info: CoreCommandRouter::volumioPushQueue Sep 01 08:53:05 volumio volumio[21512]: info: Sep 01 08:53:05 volumio volumio[21512]: ---------------------------- MPD announces system playlist update Sep 01 08:53:05 volumio volumio[21512]: info: Ignoring MPD Status Update Sep 01 08:53:05 volumio volumio[21512]: error: updateQueue error: null Sep 01 08:53:05 volumio volumio[21512]: info: ------------------------------ 5ms Sep 01 08:53:05 volumio volumio[21512]: info: Starting UPNP Playback Sep 01 08:53:05 volumio volumio[21512]: info: Preparing playback through UPNP Sep 01 08:53:05 volumio volumio[21512]: info: CoreCommandRouter::volumioGetState Sep 01 08:53:05 volumio volumio[21512]: info: CorePlayQueue::getTrack 0 Sep 01 08:53:05 volumio volumio[21512]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 01 08:53:06 volumio volumio[21512]: info: Sep 01 08:53:06 volumio volumio[21512]: ---------------------------- MPD announces system playlist update Sep 01 08:53:06 volumio volumio[21512]: info: Ignoring MPD Status Update Sep 01 08:53:06 volumio volumio[21512]: info: Sep 01 08:53:06 volumio volumio[21512]: ---------------------------- MPD announces system playlist update Sep 01 08:53:06 volumio volumio[21512]: info: Ignoring MPD Status Update Sep 01 08:53:06 volumio volumio[21512]: info: ------------------------------ 2ms Sep 01 08:53:06 volumio volumio[21512]: info: ------------------------------ 2ms Sep 01 08:53:06 volumio volumio[21512]: info: Sep 01 08:53:06 volumio volumio[21512]: ---------------------------- MPD announces system playlist update Sep 01 08:53:06 volumio volumio[21512]: info: Ignoring MPD Status Update Sep 01 08:53:06 volumio volumio[21512]: info: ------------------------------ 2ms Sep 01 08:53:06 volumio volumio[21512]: info: Sep 01 08:53:06 volumio volumio[21512]: ---------------------------- MPD announces system playlist update Sep 01 08:53:06 volumio volumio[21512]: info: Ignoring MPD Status Update Sep 01 08:53:06 volumio volumio[21512]: info: ------------------------------ 1ms Sep 01 08:53:06 volumio volumio[21512]: info: Sep 01 08:53:06 volumio volumio[21512]: ---------------------------- MPD announces system playlist update Sep 01 08:53:06 volumio volumio[21512]: info: Ignoring MPD Status Update Sep 01 08:53:06 volumio volumio[21512]: info: ------------------------------ 1ms Sep 01 08:53:06 volumio volumio[21512]: info: Sep 01 08:53:06 volumio volumio[21512]: ---------------------------- MPD announces system playlist update Sep 01 08:53:06 volumio volumio[21512]: info: Ignoring MPD Status Update Sep 01 08:53:06 volumio volumio[21512]: info: ------------------------------ 1ms Sep 01 08:53:11 volumio volumio[21512]: info: Sep 01 08:53:11 volumio volumio[21512]: ---------------------------- MPD announces state update: player Sep 01 08:53:11 volumio volumio[21512]: info: ControllerMpd::getState Sep 01 08:53:11 volumio volumio[21512]: verbose: ControllerMpd::sendMpdCommand status Sep 01 08:53:11 volumio volumio[21512]: verbose: ControllerMpd::parseState Sep 01 08:53:11 volumio volumio[21512]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 01 08:53:11 volumio volumio[21512]: verbose: ControllerMpd::parseTrackInfo Sep 01 08:53:11 volumio volumio[21512]: info: ControllerMpd::pushState Sep 01 08:53:11 volumio volumio[21512]: info: CoreCommandRouter::servicePushState Sep 01 08:53:11 volumio volumio[21512]: info: CoreStateMachine::pushState Sep 01 08:53:11 volumio volumio[21512]: info: CoreCommandRouter::volumioPushState Sep 01 08:53:11 volumio volumio[21512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 08:53:11 volumio volumio[21512]: info: CorePlayQueue::getTrack 0 Sep 01 08:53:11 volumio volumio[21512]: 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/F000001hlr1F3YYrWX.flac?guid=0000000004cb49d2000001871e73f5cf&vkey=C951ED47F4A614A44F14B96FC5E99943330897D3F820C3C8F55B46FD1F368591A94681D3845766726207C7EF44B06E61E470AF757A338D29&uin=1259438298&src=F000002d9MOe0bfetF.flac&redirect=1&fromtag=111114","trackType":""} Sep 01 08:53:11 volumio volumio[21512]: verbose: CURRENT POSITION 0 Sep 01 08:53:11 volumio volumio[21512]: info: CoreStateMachine::syncState stateService stop Sep 01 08:53:11 volumio volumio[21512]: info: CoreStateMachine::syncState currentStatus stop Sep 01 08:53:11 volumio volumio[21512]: info: CoreStateMachine::pushState Sep 01 08:53:11 volumio volumio[21512]: info: CoreCommandRouter::volumioPushState Sep 01 08:53:11 volumio volumio[21512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 08:53:11 volumio volumio[21512]: info: No code Sep 01 08:53:11 volumio volumio[21512]: info: CoreStateMachine::pushState Sep 01 08:53:11 volumio volumio[21512]: info: CoreCommandRouter::volumioPushState Sep 01 08:53:11 volumio volumio[21512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 08:53:11 volumio volumio[21512]: info: ------------------------------ 23ms Sep 01 08:53:11 volumio volumio[21512]: info: Clearing queue after UPNP request Sep 01 08:53:11 volumio volumio[21512]: info: CoreStateMachine::ClearQueue Sep 01 08:53:11 volumio volumio[21512]: info: CoreStateMachine::stop Sep 01 08:53:11 volumio volumio[21512]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 01 08:53:11 volumio volumio[21512]: UNSET VOLATILE Sep 01 08:53:11 volumio volumio[21512]: info: CorePlayQueue::clearPlayQueue Sep 01 08:53:11 volumio volumio[21512]: info: CorePlayQueue::saveQueue Sep 01 08:53:11 volumio volumio[21512]: info: CoreCommandRouter::volumioPushState Sep 01 08:53:11 volumio volumio[21512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 08:53:11 volumio volumio[21512]: info: CoreCommandRouter::volumioPushQueue Sep 01 08:53:11 volumio volumio[21512]: info: Sep 01 08:53:11 volumio volumio[21512]: ---------------------------- MPD announces system playlist update Sep 01 08:53:11 volumio volumio[21512]: info: Ignoring MPD Status Update Sep 01 08:53:11 volumio volumio[21512]: error: updateQueue error: null Sep 01 08:53:11 volumio volumio[21512]: info: ------------------------------ 2ms Sep 01 08:53:11 volumio volumio[21512]: info: Starting UPNP Playback Sep 01 08:53:11 volumio volumio[21512]: info: Preparing playback through UPNP Sep 01 08:53:11 volumio volumio[21512]: info: CoreCommandRouter::volumioGetState Sep 01 08:53:11 volumio volumio[21512]: info: CorePlayQueue::getTrack 0 Sep 01 08:53:11 volumio volumio[21512]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 01 08:53:12 volumio volumio[21512]: info: Sep 01 08:53:12 volumio volumio[21512]: ---------------------------- MPD announces system playlist update Sep 01 08:53:12 volumio volumio[21512]: info: Ignoring MPD Status Update Sep 01 08:53:12 volumio volumio[21512]: info: Sep 01 08:53:12 volumio volumio[21512]: ---------------------------- MPD announces system playlist update Sep 01 08:53:12 volumio volumio[21512]: info: Ignoring MPD Status Update Sep 01 08:53:12 volumio volumio[21512]: info: ------------------------------ 2ms Sep 01 08:53:12 volumio volumio[21512]: info: ------------------------------ 2ms Sep 01 08:53:12 volumio volumio[21512]: info: Sep 01 08:53:12 volumio volumio[21512]: ---------------------------- MPD announces system playlist update Sep 01 08:53:12 volumio volumio[21512]: info: Ignoring MPD Status Update Sep 01 08:53:12 volumio volumio[21512]: info: ------------------------------ 1ms Sep 01 08:53:12 volumio volumio[21512]: info: Sep 01 08:53:12 volumio volumio[21512]: ---------------------------- MPD announces system playlist update Sep 01 08:53:12 volumio volumio[21512]: info: Ignoring MPD Status Update Sep 01 08:53:12 volumio volumio[21512]: info: ------------------------------ 1ms Sep 01 08:53:12 volumio volumio[21512]: info: Sep 01 08:53:12 volumio volumio[21512]: ---------------------------- MPD announces system playlist update Sep 01 08:53:12 volumio volumio[21512]: info: Ignoring MPD Status Update Sep 01 08:53:12 volumio volumio[21512]: info: ------------------------------ 1ms Sep 01 08:53:12 volumio volumio[21512]: info: Sep 01 08:53:12 volumio volumio[21512]: ---------------------------- MPD announces system playlist update Sep 01 08:53:12 volumio volumio[21512]: info: Ignoring MPD Status Update Sep 01 08:53:12 volumio volumio[21512]: info: ------------------------------ 1ms Sep 01 08:53:18 volumio volumio[21512]: info: Sep 01 08:53:18 volumio volumio[21512]: ---------------------------- MPD announces state update: player Sep 01 08:53:18 volumio volumio[21512]: info: ControllerMpd::getState Sep 01 08:53:18 volumio volumio[21512]: verbose: ControllerMpd::sendMpdCommand status Sep 01 08:53:18 volumio volumio[21512]: verbose: ControllerMpd::parseState Sep 01 08:53:18 volumio volumio[21512]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 01 08:53:18 volumio volumio[21512]: info: Sep 01 08:53:18 volumio volumio[21512]: ---------------------------- MPD announces state update: player Sep 01 08:53:18 volumio volumio[21512]: info: ControllerMpd::getState Sep 01 08:53:18 volumio volumio[21512]: verbose: ControllerMpd::sendMpdCommand status Sep 01 08:53:18 volumio volumio[21512]: verbose: ControllerMpd::parseTrackInfo Sep 01 08:53:18 volumio volumio[21512]: verbose: ControllerMpd::parseState Sep 01 08:53:18 volumio volumio[21512]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 01 08:53:18 volumio volumio[21512]: info: ControllerMpd::pushState Sep 01 08:53:18 volumio volumio[21512]: info: CoreCommandRouter::servicePushState Sep 01 08:53:18 volumio volumio[21512]: In UPNP mode Sep 01 08:53:18 volumio volumio[21512]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"后会无期","artist":"G.E.M. 邓紫棋","album":"后会无期 电影原声带","uri":"http://aqqmusic.tc.qq.com/F000003l7OLd3ILjUC.flac?guid=0000000004cb49d2000001871e73f5cf&vkey=B38637088B9373A29901E5C0ACC39F1D06D8F23681C23AB83044EAA335D742DE9B277EE433698AF670EE86D0AD5E3660B4B5F48C66AB4624&uin=1259438298&src=F000003de5C906SZp9.flac&redirect=1&fromtag=111114","trackType":""} Sep 01 08:53:18 volumio volumio[21512]: verbose: CURRENT POSITION 0 Sep 01 08:53:18 volumio volumio[21512]: info: CoreStateMachine::syncState stateService play Sep 01 08:53:18 volumio volumio[21512]: info: CoreStateMachine::syncState currentStatus stop Sep 01 08:53:18 volumio volumio[21512]: info: CoreStateMachine::pushState Sep 01 08:53:18 volumio volumio[21512]: info: CoreCommandRouter::volumioPushState Sep 01 08:53:18 volumio volumio[21512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 08:53:18 volumio volumio[21512]: info: ------------------------------ 37ms Sep 01 08:53:18 volumio volumio[21512]: verbose: ControllerMpd::parseTrackInfo Sep 01 08:53:18 volumio volumio[21512]: info: ControllerMpd::pushState Sep 01 08:53:18 volumio volumio[21512]: info: CoreCommandRouter::servicePushState Sep 01 08:53:18 volumio volumio[21512]: In UPNP mode Sep 01 08:53:18 volumio volumio[21512]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":223,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"后会无期","artist":"G.E.M. 邓紫棋","album":"后会无期 电影原声带","uri":"http://aqqmusic.tc.qq.com/F000003l7OLd3ILjUC.flac?guid=0000000004cb49d2000001871e73f5cf&vkey=B38637088B9373A29901E5C0ACC39F1D06D8F23681C23AB83044EAA335D742DE9B277EE433698AF670EE86D0AD5E3660B4B5F48C66AB4624&uin=1259438298&src=F000003de5C906SZp9.flac&redirect=1&fromtag=111114","trackType":""} Sep 01 08:53:18 volumio volumio[21512]: verbose: CURRENT POSITION 0 Sep 01 08:53:18 volumio volumio[21512]: info: CoreStateMachine::syncState stateService play Sep 01 08:53:18 volumio volumio[21512]: info: CoreStateMachine::syncState currentStatus play Sep 01 08:53:18 volumio volumio[21512]: info: Received an update from plugin. extracting info from payload Sep 01 08:53:18 volumio volumio[21512]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 01 08:53:18 volumio volumio[21512]: info: CoreStateMachine::pushState Sep 01 08:53:18 volumio volumio[21512]: info: CoreCommandRouter::volumioPushState Sep 01 08:53:18 volumio volumio[21512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 08:53:18 volumio volumio[21512]: info: CoreStateMachine::pushState Sep 01 08:53:18 volumio volumio[21512]: info: CoreCommandRouter::volumioPushState Sep 01 08:53:18 volumio volumio[21512]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 08:53:18 volumio volumio[21512]: info: ------------------------------ 21ms Sep 01 08:53:18 volumio volumio[21512]: info: CoreCommandRouter::volumioGetQueue Sep 01 08:53:18 volumio volumio[21512]: info: CoreStateMachine::getQueue Sep 01 08:53:18 volumio volumio[21512]: info: CorePlayQueue::getQueue Sep 01 08:53:18 volumio volumio[21512]: info: CoreCommandRouter::volumioGetQueue Sep 01 08:53:18 volumio volumio[21512]: info: CoreStateMachine::getQueue Sep 01 08:53:18 volumio volumio[21512]: info: CorePlayQueue::getQueue Sep 01 08:53:20 volumio dhcpcd[1016]: eth0: adding route to 192.168.3.0/24 Sep 01 08:53:20 volumio dhcpcd[1016]: eth0: adding default route via 192.168.3.101 Sep 01 08:53:20 volumio dhcpcd[1016]: eth0: ipv4_addroute: File exists Sep 01 08:53:20 volumio dhcpcd[1016]: eth0: removing route to 192.168.3.0/24 Sep 01 08:53:32 volumio volumio[21512]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 01 08:53:32 volumio volumio[21512]: { Error: connect ETIMEDOUT 199.59.149.231:443 Sep 01 08:53:32 volumio volumio[21512]: at Object._errnoException (util.js:1022:11) Sep 01 08:53:32 volumio volumio[21512]: at _exceptionWithHostPort (util.js:1044:20) Sep 01 08:53:32 volumio volumio[21512]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Sep 01 08:53:32 volumio volumio[21512]: code: 'ETIMEDOUT', Sep 01 08:53:32 volumio volumio[21512]: errno: 'ETIMEDOUT', Sep 01 08:53:32 volumio volumio[21512]: syscall: 'connect', Sep 01 08:53:32 volumio volumio[21512]: address: '199.59.149.231', Sep 01 08:53:32 volumio volumio[21512]: port: 443 } Sep 01 08:53:32 volumio volumio[21512]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 01 08:53:32 volumio sudo[22500]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-01 08:52 Sep 01 08:53:32 volumio sudo[22500]: 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"