-- Logs begin at Mon 2025-02-24 01:27:11 CST, end at Mon 2025-02-24 05:49:41 CST. --
Feb 24 05:48:57 volumio volumio[1226]: info: Clearing queue after UPNP request
Feb 24 05:48:58 volumio volumio[1226]: info: CoreStateMachine::ClearQueue
Feb 24 05:48:58 volumio volumio[1226]: info: CoreStateMachine::stop
Feb 24 05:48:58 volumio volumio[1226]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 24 05:48:58 volumio volumio[1226]: info: CoreStateMachine::stPlaybackTimer
Feb 24 05:48:58 volumio volumio[1226]: info: CoreStateMachine::updateTrackBlock
Feb 24 05:48:58 volumio volumio[1226]: info: CorePlayQueue::getTrackBlock
Feb 24 05:48:58 volumio volumio[1226]: info: CoreStateMachine::pushState
Feb 24 05:48:58 volumio volumio[1226]: info: CorePlayQueue::getTrack 8
Feb 24 05:48:58 volumio volumio[1226]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 24 05:48:58 volumio volumio[1226]: info: CoreCommandRouter::volumioPushState
Feb 24 05:48:58 volumio volumio[1226]: info: CoreStateMachine::serviceStop
Feb 24 05:48:58 volumio volumio[1226]: info: CorePlayQueue::getTrack 8
Feb 24 05:48:58 volumio volumio[1226]: info: ControllerMpd::stop
Feb 24 05:48:58 volumio volumio[1226]: verbose: ControllerMpd::sendMpdCommand stop
Feb 24 05:48:58 volumio volumio[1226]: info: CorePlayQueue::clearPlayQueue
Feb 24 05:48:58 volumio volumio[1226]: info: CorePlayQueue::saveQueue
Feb 24 05:48:58 volumio volumio[1226]: info: CoreCommandRouter::volumioPushState
Feb 24 05:48:58 volumio volumio[1226]: info: CoreCommandRouter::volumioPushQueue
Feb 24 05:48:58 volumio volumio[1226]: info:
Feb 24 05:48:58 volumio volumio[1226]: ---------------------------- MPD announces state update: player
Feb 24 05:48:58 volumio volumio[1226]: info: sendMpdCommand stop took 19 milliseconds
Feb 24 05:48:58 volumio volumio[1226]: info: ControllerMpd::getState
Feb 24 05:48:58 volumio volumio[1226]: verbose: ControllerMpd::sendMpdCommand status
Feb 24 05:48:58 volumio volumio[1226]: info:
Feb 24 05:48:58 volumio volumio[1226]: ---------------------------- MPD announces system playlist update
Feb 24 05:48:58 volumio volumio[1226]: info: Ignoring MPD Status Update
Feb 24 05:48:58 volumio volumio[1226]: info: sendMpdCommand status took 0 milliseconds
Feb 24 05:48:58 volumio volumio[1226]: verbose: ControllerMpd::parseState
Feb 24 05:48:58 volumio volumio[1226]: info: ControllerMpd::pushState
Feb 24 05:48:58 volumio volumio[1226]: info: CoreCommandRouter::servicePushState
Feb 24 05:48:58 volumio volumio[1226]: info: CoreStateMachine::pushState
Feb 24 05:48:58 volumio volumio[1226]: info: CorePlayQueue::getTrack 8
Feb 24 05:48:58 volumio volumio[1226]: info: CoreCommandRouter::volumioPushState
Feb 24 05:48:58 volumio volumio[1226]: info: CorePlayQueue::getTrack 8
Feb 24 05:48:58 volumio volumio[1226]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Feb 24 05:48:58 volumio volumio[1226]: verbose: CURRENT POSITION 8
Feb 24 05:48:58 volumio volumio[1226]: info: CoreStateMachine::syncState stateService stop
Feb 24 05:48:58 volumio volumio[1226]: info: CoreStateMachine::syncState currentStatus stop
Feb 24 05:48:58 volumio volumio[1226]: info: CoreStateMachine::pushState
Feb 24 05:48:58 volumio volumio[1226]: info: CorePlayQueue::getTrack 8
Feb 24 05:48:58 volumio volumio[1226]: info: CoreCommandRouter::volumioPushState
Feb 24 05:48:58 volumio volumio[1226]: info: No code
Feb 24 05:48:58 volumio volumio[1226]: info: CoreStateMachine::pushState
Feb 24 05:48:58 volumio volumio[1226]: info: CorePlayQueue::getTrack 8
Feb 24 05:48:58 volumio volumio[1226]: info: CoreCommandRouter::volumioPushState
Feb 24 05:48:58 volumio volumio[1226]: info: ------------------------------ 7ms
Feb 24 05:48:58 volumio volumio[1226]: error: updateQueue error: null
Feb 24 05:48:58 volumio volumio[1226]: info: ------------------------------ 6ms
Feb 24 05:48:58 volumio volumio[1226]: info: Starting UPNP Playback
Feb 24 05:48:58 volumio volumio[1226]: info: Preparing playback through UPNP
Feb 24 05:48:58 volumio volumio[1226]: info: CoreCommandRouter::volumioGetState
Feb 24 05:48:58 volumio volumio[1226]: info: CorePlayQueue::getTrack 8
Feb 24 05:48:58 volumio volumio[1226]: info: CoreStateMachine::setConsumeUpdateService mpd
Feb 24 05:48:58 volumio volumio[1226]: info:
Feb 24 05:48:58 volumio volumio[1226]: ---------------------------- MPD announces system playlist update
Feb 24 05:48:58 volumio volumio[1226]: info: Ignoring MPD Status Update
Feb 24 05:48:58 volumio volumio[1226]: info: ------------------------------ 1ms
Feb 24 05:48:58 volumio volumio[1226]: info:
Feb 24 05:48:58 volumio volumio[1226]: ---------------------------- MPD announces system playlist update
Feb 24 05:48:58 volumio volumio[1226]: info: Ignoring MPD Status Update
Feb 24 05:48:58 volumio volumio[1226]: info: ------------------------------ 1ms
Feb 24 05:48:58 volumio volumio[1226]: info:
Feb 24 05:48:58 volumio volumio[1226]: ---------------------------- MPD announces system playlist update
Feb 24 05:48:58 volumio volumio[1226]: info: Ignoring MPD Status Update
Feb 24 05:48:58 volumio volumio[1226]: info: ------------------------------ 1ms
Feb 24 05:48:58 volumio volumio[1226]: info:
Feb 24 05:48:58 volumio volumio[1226]: ---------------------------- MPD announces system playlist update
Feb 24 05:48:58 volumio volumio[1226]: info: Ignoring MPD Status Update
Feb 24 05:48:58 volumio volumio[1226]: info: ------------------------------ 0ms
Feb 24 05:48:58 volumio volumio[1226]: info:
Feb 24 05:48:58 volumio volumio[1226]: ---------------------------- MPD announces system playlist update
Feb 24 05:48:58 volumio volumio[1226]: info: Ignoring MPD Status Update
Feb 24 05:48:58 volumio volumio[1226]: info: ------------------------------ 0ms
Feb 24 05:48:58 volumio volumio[1226]: info:
Feb 24 05:48:58 volumio volumio[1226]: ---------------------------- MPD announces system playlist update
Feb 24 05:48:58 volumio volumio[1226]: info: Ignoring MPD Status Update
Feb 24 05:48:58 volumio volumio[1226]: info: ------------------------------ 0ms
Feb 24 05:48:59 volumio volumio[1226]: info:
Feb 24 05:48:59 volumio volumio[1226]: ---------------------------- MPD announces state update: player
Feb 24 05:48:59 volumio volumio[1226]: info: ControllerMpd::getState
Feb 24 05:48:59 volumio volumio[1226]: verbose: ControllerMpd::sendMpdCommand status
Feb 24 05:48:59 volumio volumio[1226]: info:
Feb 24 05:48:59 volumio volumio[1226]: ---------------------------- MPD announces state update: player
Feb 24 05:48:59 volumio volumio[1226]: info: sendMpdCommand status took 6 milliseconds
Feb 24 05:48:59 volumio volumio[1226]: info: ControllerMpd::getState
Feb 24 05:48:59 volumio volumio[1226]: verbose: ControllerMpd::sendMpdCommand status
Feb 24 05:48:59 volumio volumio[1226]: verbose: ControllerMpd::parseState
Feb 24 05:48:59 volumio volumio[1226]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 24 05:48:59 volumio volumio[1226]: info: sendMpdCommand status took 1 milliseconds
Feb 24 05:48:59 volumio volumio[1226]: info: sendMpdCommand playlistinfo took 1 milliseconds
Feb 24 05:48:59 volumio volumio[1226]: verbose: ControllerMpd::parseState
Feb 24 05:48:59 volumio volumio[1226]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 24 05:48:59 volumio volumio[1226]: verbose: ControllerMpd::parseTrackInfo
Feb 24 05:48:59 volumio volumio[1226]: info: ControllerMpd::pushState
Feb 24 05:48:59 volumio volumio[1226]: info: CoreCommandRouter::servicePushState
Feb 24 05:48:59 volumio volumio[1226]: verbose: In UPNP mode
Feb 24 05:48:59 volumio volumio[1226]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"她æ¥å¬æˆ‘的演唱会 (Live)","artist":"å¼ å¦å‹ (Performer)","album":null,"uri":"http://lv.sycdn.kuwo.cn/1cb7761184e3997d76707669a3689cd2/67bb97c9/resource/30106/trackmedia/M500004XFXx31n2Hft.mp3","trackType":"mp3"}
Feb 24 05:48:59 volumio volumio[1226]: verbose: CURRENT POSITION 8
Feb 24 05:48:59 volumio volumio[1226]: info: CoreStateMachine::syncState stateService play
Feb 24 05:48:59 volumio volumio[1226]: info: CoreStateMachine::syncState currentStatus stop
Feb 24 05:48:59 volumio volumio[1226]: info: ------------------------------ 8ms
Feb 24 05:48:59 volumio volumio[1226]: info: sendMpdCommand playlistinfo took 1 milliseconds
Feb 24 05:48:59 volumio volumio[1226]: verbose: ControllerMpd::parseTrackInfo
Feb 24 05:48:59 volumio volumio[1226]: info: ControllerMpd::pushState
Feb 24 05:48:59 volumio volumio[1226]: info: CoreCommandRouter::servicePushState
Feb 24 05:48:59 volumio volumio[1226]: verbose: In UPNP mode
Feb 24 05:48:59 volumio volumio[1226]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"她æ¥å¬æˆ‘的演唱会 (Live)","artist":"å¼ å¦å‹ (Performer)","album":null,"uri":"http://lv.sycdn.kuwo.cn/1cb7761184e3997d76707669a3689cd2/67bb97c9/resource/30106/trackmedia/M500004XFXx31n2Hft.mp3","trackType":"mp3"}
Feb 24 05:48:59 volumio volumio[1226]: verbose: CURRENT POSITION 8
Feb 24 05:48:59 volumio volumio[1226]: info: CoreStateMachine::syncState stateService play
Feb 24 05:48:59 volumio volumio[1226]: info: CoreStateMachine::syncState currentStatus play
Feb 24 05:48:59 volumio volumio[1226]: info: Received an update from plugin. extracting info from payload
Feb 24 05:48:59 volumio volumio[1226]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 24 05:48:59 volumio volumio[1226]: info: CoreStateMachine::pushState
Feb 24 05:48:59 volumio volumio[1226]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 24 05:48:59 volumio volumio[1226]: info: CoreCommandRouter::volumioPushState
Feb 24 05:48:59 volumio volumio[1226]: info: CoreStateMachine::pushState
Feb 24 05:48:59 volumio volumio[1226]: info: CoreCommandRouter::volumioPushState
Feb 24 05:48:59 volumio volumio[1226]: info: ------------------------------ 8ms
Feb 24 05:48:59 volumio volumio[1226]: info:
Feb 24 05:48:59 volumio volumio[1226]: ---------------------------- MPD announces system playlist update
Feb 24 05:48:59 volumio volumio[1226]: info: Ignoring MPD Status Update
Feb 24 05:48:59 volumio volumio[1226]: info:
Feb 24 05:48:59 volumio volumio[1226]: ---------------------------- MPD announces state update: player
Feb 24 05:48:59 volumio volumio[1226]: info: ControllerMpd::getState
Feb 24 05:48:59 volumio volumio[1226]: verbose: ControllerMpd::sendMpdCommand status
Feb 24 05:48:59 volumio volumio[1226]: info: ------------------------------ 4ms
Feb 24 05:48:59 volumio volumio[1226]: info: sendMpdCommand status took 2 milliseconds
Feb 24 05:48:59 volumio volumio[1226]: verbose: ControllerMpd::parseState
Feb 24 05:48:59 volumio volumio[1226]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 24 05:48:59 volumio volumio[1226]: info: sendMpdCommand playlistinfo took 0 milliseconds
Feb 24 05:48:59 volumio volumio[1226]: verbose: ControllerMpd::parseTrackInfo
Feb 24 05:48:59 volumio volumio[1226]: info: ControllerMpd::pushState
Feb 24 05:48:59 volumio volumio[1226]: info: CoreCommandRouter::servicePushState
Feb 24 05:48:59 volumio volumio[1226]: verbose: In UPNP mode
Feb 24 05:48:59 volumio volumio[1226]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":274,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"她æ¥å¬æˆ‘的演唱会","artist":"å¼ å¦å‹","album":"活出生命Live演唱会 (Live)","uri":"http://lv.sycdn.kuwo.cn/1cb7761184e3997d76707669a3689cd2/67bb97c9/resource/30106/trackmedia/M500004XFXx31n2Hft.mp3","trackType":"mp3"}
Feb 24 05:48:59 volumio volumio[1226]: verbose: CURRENT POSITION 8
Feb 24 05:48:59 volumio volumio[1226]: info: CoreStateMachine::syncState stateService play
Feb 24 05:48:59 volumio volumio[1226]: info: CoreStateMachine::syncState currentStatus play
Feb 24 05:48:59 volumio volumio[1226]: info: Received an update from plugin. extracting info from payload
Feb 24 05:48:59 volumio volumio[1226]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 24 05:48:59 volumio volumio[1226]: info: CoreStateMachine::pushState
Feb 24 05:48:59 volumio volumio[1226]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 24 05:48:59 volumio volumio[1226]: info: CoreCommandRouter::volumioPushState
Feb 24 05:48:59 volumio volumio[1226]: info: CoreStateMachine::pushState
Feb 24 05:48:59 volumio volumio[1226]: info: CoreCommandRouter::volumioPushState
Feb 24 05:48:59 volumio volumio[1226]: info: ------------------------------ 11ms
Feb 24 05:48:59 volumio volumio[1226]: info: CoreCommandRouter::volumioGetQueue
Feb 24 05:48:59 volumio volumio[1226]: info: CoreStateMachine::getQueue
Feb 24 05:48:59 volumio volumio[1226]: info: CorePlayQueue::getQueue
Feb 24 05:48:59 volumio volumio[1226]: info: CoreCommandRouter::volumioGetQueue
Feb 24 05:48:59 volumio volumio[1226]: info: CoreStateMachine::getQueue
Feb 24 05:48:59 volumio volumio[1226]: info: CorePlayQueue::getQueue
Feb 24 05:49:41 volumio volumio[1226]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 24 05:49:41 volumio volumio[1226]: Error: connect ETIMEDOUT 174.36.196.242:443
Feb 24 05:49:41 volumio volumio[1226]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
Feb 24 05:49:41 volumio volumio[1226]: errno: -110,
Feb 24 05:49:41 volumio volumio[1226]: code: 'ETIMEDOUT',
Feb 24 05:49:41 volumio volumio[1226]: syscall: 'connect',
Feb 24 05:49:41 volumio volumio[1226]: address: '174.36.196.242',
Feb 24 05:49:41 volumio volumio[1226]: port: 443
Feb 24 05:49:41 volumio volumio[1226]: }
Feb 24 05:49:41 volumio volumio[1226]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 24 05:49:41 volumio sudo[23798]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-24 05:48
Feb 24 05:49:41 volumio sudo[23798]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET"
VOLUMIO_VERSION="3.779"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"