-- Logs begin at Wed 2025-10-29 04:42:08 UTC, end at Thu 2025-10-30 06:33:45 UTC. -- Oct 30 06:33:28 volumio volumio[28802]: info: Oct 30 06:33:28 volumio volumio[28802]: ---------------------------- MPD announces state update: player Oct 30 06:33:28 volumio volumio[28802]: info: ControllerMpd::getState Oct 30 06:33:28 volumio volumio[28802]: verbose: ControllerMpd::sendMpdCommand status Oct 30 06:33:28 volumio volumio[28802]: info: sendMpdCommand status took 1 milliseconds Oct 30 06:33:28 volumio volumio[28802]: verbose: ControllerMpd::parseState Oct 30 06:33:28 volumio volumio[28802]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 30 06:33:28 volumio volumio[28802]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 30 06:33:28 volumio volumio[28802]: verbose: ControllerMpd::parseTrackInfo Oct 30 06:33:28 volumio volumio[28802]: info: ControllerMpd::pushState Oct 30 06:33:28 volumio volumio[28802]: info: CoreCommandRouter::servicePushState Oct 30 06:33:28 volumio volumio[28802]: info: CoreStateMachine::pushState Oct 30 06:33:28 volumio volumio[28802]: info: CoreCommandRouter::volumioPushState Oct 30 06:33:28 volumio volumio[28802]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:33:28 volumio volumio[28802]: info: CorePlayQueue::getTrack 0 Oct 30 06:33:28 volumio volumio[28802]: 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://192.168.1.17:58909/bridge-123.flac","trackType":"flac"} Oct 30 06:33:28 volumio volumio[28802]: verbose: CURRENT POSITION 0 Oct 30 06:33:28 volumio volumio[28802]: info: CoreStateMachine::syncState stateService stop Oct 30 06:33:28 volumio volumio[28802]: info: CoreStateMachine::syncState currentStatus play Oct 30 06:33:28 volumio volumio[28802]: info: CoreCommandRouter::volumioPushState Oct 30 06:33:28 volumio volumio[28802]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:33:28 volumio volumio[28802]: info: CoreStateMachine::stPlaybackTimer Oct 30 06:33:28 volumio volumio[28802]: info: ------------------------------ 4ms Oct 30 06:33:28 volumio volumio[28802]: info: CoreCommandRouter::volumioGetQueue Oct 30 06:33:28 volumio volumio[28802]: info: CoreStateMachine::getQueue Oct 30 06:33:28 volumio volumio[28802]: info: CorePlayQueue::getQueue Oct 30 06:33:28 volumio volumio[28802]: info: Clearing queue after UPNP request Oct 30 06:33:28 volumio volumio[28802]: info: CoreStateMachine::ClearQueue Oct 30 06:33:28 volumio volumio[28802]: info: CoreStateMachine::stop Oct 30 06:33:28 volumio volumio[28802]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 30 06:33:28 volumio volumio[28802]: UNSET VOLATILE Oct 30 06:33:28 volumio volumio[28802]: info: CorePlayQueue::clearPlayQueue Oct 30 06:33:28 volumio volumio[28802]: info: CorePlayQueue::saveQueue Oct 30 06:33:28 volumio volumio[28802]: info: CoreCommandRouter::volumioPushState Oct 30 06:33:28 volumio volumio[28802]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:33:28 volumio volumio[28802]: info: CoreCommandRouter::volumioPushQueue Oct 30 06:33:28 volumio volumio[28802]: info: Oct 30 06:33:28 volumio volumio[28802]: ---------------------------- MPD announces system playlist update Oct 30 06:33:28 volumio volumio[28802]: info: Ignoring MPD Status Update Oct 30 06:33:28 volumio volumio[28802]: error: updateQueue error: null Oct 30 06:33:28 volumio volumio[28802]: info: ------------------------------ 1ms Oct 30 06:33:28 volumio volumio[28802]: info: Starting UPNP Playback Oct 30 06:33:28 volumio volumio[28802]: info: Preparing playback through UPNP Oct 30 06:33:28 volumio volumio[28802]: info: CoreCommandRouter::volumioGetState Oct 30 06:33:28 volumio volumio[28802]: info: CorePlayQueue::getTrack 0 Oct 30 06:33:28 volumio volumio[28802]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 30 06:33:29 volumio volumio[28802]: info: Oct 30 06:33:29 volumio volumio[28802]: ---------------------------- MPD announces system playlist update Oct 30 06:33:29 volumio volumio[28802]: info: Ignoring MPD Status Update Oct 30 06:33:29 volumio volumio[28802]: info: ------------------------------ 0ms Oct 30 06:33:29 volumio volumio[28802]: info: Oct 30 06:33:29 volumio volumio[28802]: ---------------------------- MPD announces system playlist update Oct 30 06:33:29 volumio volumio[28802]: info: Ignoring MPD Status Update Oct 30 06:33:29 volumio volumio[28802]: info: ------------------------------ 1ms Oct 30 06:33:29 volumio volumio[28802]: info: Oct 30 06:33:29 volumio volumio[28802]: ---------------------------- MPD announces system playlist update Oct 30 06:33:29 volumio volumio[28802]: info: Ignoring MPD Status Update Oct 30 06:33:29 volumio volumio[28802]: info: ------------------------------ 0ms Oct 30 06:33:29 volumio volumio[28802]: info: Oct 30 06:33:29 volumio volumio[28802]: ---------------------------- MPD announces system playlist update Oct 30 06:33:29 volumio volumio[28802]: info: Ignoring MPD Status Update Oct 30 06:33:29 volumio volumio[28802]: info: ------------------------------ 1ms Oct 30 06:33:29 volumio volumio[28802]: info: Oct 30 06:33:29 volumio volumio[28802]: ---------------------------- MPD announces system playlist update Oct 30 06:33:29 volumio volumio[28802]: info: Ignoring MPD Status Update Oct 30 06:33:29 volumio volumio[28802]: info: ------------------------------ 0ms Oct 30 06:33:29 volumio volumio[28802]: info: Oct 30 06:33:29 volumio volumio[28802]: ---------------------------- MPD announces system playlist update Oct 30 06:33:29 volumio volumio[28802]: info: Ignoring MPD Status Update Oct 30 06:33:29 volumio volumio[28802]: info: ------------------------------ 1ms Oct 30 06:33:30 volumio volumio[28802]: info: Oct 30 06:33:30 volumio volumio[28802]: ---------------------------- MPD announces state update: player Oct 30 06:33:30 volumio volumio[28802]: info: ControllerMpd::getState Oct 30 06:33:30 volumio volumio[28802]: verbose: ControllerMpd::sendMpdCommand status Oct 30 06:33:30 volumio volumio[28802]: info: Oct 30 06:33:30 volumio volumio[28802]: ---------------------------- MPD announces state update: player Oct 30 06:33:30 volumio volumio[28802]: info: sendMpdCommand status took 1 milliseconds Oct 30 06:33:30 volumio volumio[28802]: info: ControllerMpd::getState Oct 30 06:33:30 volumio volumio[28802]: verbose: ControllerMpd::sendMpdCommand status Oct 30 06:33:30 volumio volumio[28802]: verbose: ControllerMpd::parseState Oct 30 06:33:30 volumio volumio[28802]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 30 06:33:30 volumio volumio[28802]: info: sendMpdCommand status took 1 milliseconds Oct 30 06:33:30 volumio volumio[28802]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 30 06:33:30 volumio volumio[28802]: verbose: ControllerMpd::parseState Oct 30 06:33:30 volumio volumio[28802]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 30 06:33:30 volumio volumio[28802]: verbose: ControllerMpd::parseTrackInfo Oct 30 06:33:30 volumio volumio[28802]: info: ControllerMpd::pushState Oct 30 06:33:30 volumio volumio[28802]: info: CoreCommandRouter::servicePushState Oct 30 06:33:30 volumio volumio[28802]: In UPNP mode Oct 30 06:33:30 volumio volumio[28802]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":166,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"草原上升起不落的太阳","artist":"丁晓红","album":"梦回草原","uri":"http://192.168.1.17:37909/bridge-124.flac","trackType":"flac"} Oct 30 06:33:30 volumio volumio[28802]: verbose: CURRENT POSITION 0 Oct 30 06:33:30 volumio volumio[28802]: info: CoreStateMachine::syncState stateService play Oct 30 06:33:30 volumio volumio[28802]: info: CoreStateMachine::syncState currentStatus stop Oct 30 06:33:30 volumio volumio[28802]: info: CoreStateMachine::pushState Oct 30 06:33:30 volumio volumio[28802]: info: CoreCommandRouter::volumioPushState Oct 30 06:33:30 volumio volumio[28802]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:33:30 volumio volumio[28802]: info: ------------------------------ 5ms Oct 30 06:33:30 volumio volumio[28802]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 30 06:33:30 volumio volumio[28802]: verbose: ControllerMpd::parseTrackInfo Oct 30 06:33:30 volumio volumio[28802]: info: ControllerMpd::pushState Oct 30 06:33:30 volumio volumio[28802]: info: CoreCommandRouter::servicePushState Oct 30 06:33:30 volumio volumio[28802]: In UPNP mode Oct 30 06:33:30 volumio volumio[28802]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":166,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"386 Kbps","isStreaming":false,"title":"草原上升起不落的太阳","artist":"丁晓红","album":"梦回草原","uri":"http://192.168.1.17:37909/bridge-124.flac","trackType":"flac"} Oct 30 06:33:30 volumio volumio[28802]: verbose: CURRENT POSITION 0 Oct 30 06:33:30 volumio volumio[28802]: info: CoreStateMachine::syncState stateService play Oct 30 06:33:30 volumio volumio[28802]: info: CoreStateMachine::syncState currentStatus play Oct 30 06:33:30 volumio volumio[28802]: info: Received an update from plugin. extracting info from payload Oct 30 06:33:30 volumio volumio[28802]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 30 06:33:30 volumio volumio[28802]: info: CoreStateMachine::pushState Oct 30 06:33:30 volumio volumio[28802]: info: CoreCommandRouter::volumioPushState Oct 30 06:33:30 volumio volumio[28802]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:33:30 volumio volumio[28802]: info: CoreStateMachine::pushState Oct 30 06:33:30 volumio volumio[28802]: info: CoreCommandRouter::volumioPushState Oct 30 06:33:30 volumio volumio[28802]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 06:33:30 volumio volumio[28802]: info: ------------------------------ 9ms Oct 30 06:33:30 volumio volumio[28802]: info: CoreCommandRouter::volumioGetQueue Oct 30 06:33:30 volumio volumio[28802]: info: CoreStateMachine::getQueue Oct 30 06:33:30 volumio volumio[28802]: info: CorePlayQueue::getQueue Oct 30 06:33:30 volumio volumio[28802]: info: CoreCommandRouter::volumioGetQueue Oct 30 06:33:30 volumio volumio[28802]: info: CoreStateMachine::getQueue Oct 30 06:33:30 volumio volumio[28802]: info: CorePlayQueue::getQueue Oct 30 06:33:45 volumio volumio[28802]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 30 06:33:45 volumio volumio[28802]: { Error: connect ETIMEDOUT 199.96.62.17:443 Oct 30 06:33:45 volumio volumio[28802]: at Object._errnoException (util.js:1022:11) Oct 30 06:33:45 volumio volumio[28802]: at _exceptionWithHostPort (util.js:1044:20) Oct 30 06:33:45 volumio volumio[28802]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Oct 30 06:33:45 volumio volumio[28802]: code: 'ETIMEDOUT', Oct 30 06:33:45 volumio volumio[28802]: errno: 'ETIMEDOUT', Oct 30 06:33:45 volumio volumio[28802]: syscall: 'connect', Oct 30 06:33:45 volumio volumio[28802]: address: '199.96.62.17', Oct 30 06:33:45 volumio volumio[28802]: port: 443 } Oct 30 06:33:45 volumio volumio[28802]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 30 06:33:45 volumio sudo[12303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-30 06:32 Oct 30 06:33:45 volumio sudo[12303]: 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="cd11dc738d0d82822d0aa776d0729686b82e3758" VOLUMIO_FE_VERSION="537e3f50b5a8aa9bdf42f94adc80b348609b5c47" VOLUMIO_BE_VERSION="d7e6c614214d5dc616fddcbcfefc47e1990da7b1" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Sep 8 12:33:16 CEST 2021" VOLUMIO_VERSION="2.909" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="6e5c976a6d85b8b7d7e4e3388d208cd8"