Jan 09 00:23:08 volumio volumio[1369]: info: Clearing queue after UPNP request Jan 09 00:23:08 volumio volumio[1369]: info: CoreStateMachine::ClearQueue Jan 09 00:23:08 volumio volumio[1369]: info: CoreStateMachine::stop Jan 09 00:23:08 volumio volumio[1369]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 00:23:08 volumio volumio[1369]: info: CorePlayQueue::clearPlayQueue Jan 09 00:23:08 volumio volumio[1369]: info: CorePlayQueue::saveQueue Jan 09 00:23:08 volumio volumio[1369]: info: CoreCommandRouter::volumioPushState Jan 09 00:23:08 volumio volumio[1369]: info: CoreCommandRouter::volumioPushQueue Jan 09 00:23:08 volumio volumio[1369]: info: Jan 09 00:23:08 volumio volumio[1369]: ---------------------------- MPD announces system playlist update Jan 09 00:23:08 volumio volumio[1369]: info: Ignoring MPD Status Update Jan 09 00:23:08 volumio volumio[1369]: error: updateQueue error: null Jan 09 00:23:08 volumio volumio[1369]: info: ------------------------------ 1ms Jan 09 00:23:08 volumio volumio[1369]: info: Starting UPNP Playback Jan 09 00:23:08 volumio volumio[1369]: info: Preparing playback through UPNP Jan 09 00:23:08 volumio volumio[1369]: info: CoreCommandRouter::volumioGetState Jan 09 00:23:08 volumio volumio[1369]: info: CorePlayQueue::getTrack 0 Jan 09 00:23:08 volumio volumio[1369]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 09 00:23:09 volumio volumio[1369]: info: Clearing queue after UPNP request Jan 09 00:23:09 volumio volumio[1369]: info: CoreStateMachine::ClearQueue Jan 09 00:23:09 volumio volumio[1369]: info: CoreStateMachine::stop Jan 09 00:23:09 volumio volumio[1369]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 00:23:09 volumio volumio[1369]: info: CorePlayQueue::clearPlayQueue Jan 09 00:23:09 volumio volumio[1369]: info: CorePlayQueue::saveQueue Jan 09 00:23:09 volumio volumio[1369]: info: CoreCommandRouter::volumioPushState Jan 09 00:23:09 volumio volumio[1369]: info: CoreCommandRouter::volumioPushQueue Jan 09 00:23:09 volumio volumio[1369]: info: Jan 09 00:23:09 volumio volumio[1369]: ---------------------------- MPD announces system playlist update Jan 09 00:23:09 volumio volumio[1369]: info: Ignoring MPD Status Update Jan 09 00:23:09 volumio volumio[1369]: error: updateQueue error: null Jan 09 00:23:09 volumio volumio[1369]: info: ------------------------------ 2ms Jan 09 00:23:09 volumio volumio[1369]: info: Starting UPNP Playback Jan 09 00:23:09 volumio volumio[1369]: info: Preparing playback through UPNP Jan 09 00:23:09 volumio volumio[1369]: info: CoreCommandRouter::volumioGetState Jan 09 00:23:09 volumio volumio[1369]: info: CorePlayQueue::getTrack 0 Jan 09 00:23:09 volumio volumio[1369]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 09 00:23:09 volumio volumio[1369]: info: Clearing queue after UPNP request Jan 09 00:23:10 volumio volumio[1369]: info: CoreStateMachine::ClearQueue Jan 09 00:23:10 volumio volumio[1369]: info: CoreStateMachine::stop Jan 09 00:23:10 volumio volumio[1369]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 00:23:10 volumio volumio[1369]: info: CorePlayQueue::clearPlayQueue Jan 09 00:23:10 volumio volumio[1369]: info: CorePlayQueue::saveQueue Jan 09 00:23:10 volumio volumio[1369]: info: CoreCommandRouter::volumioPushState Jan 09 00:23:10 volumio volumio[1369]: info: CoreCommandRouter::volumioPushQueue Jan 09 00:23:10 volumio volumio[1369]: info: Jan 09 00:23:10 volumio volumio[1369]: ---------------------------- MPD announces system playlist update Jan 09 00:23:10 volumio volumio[1369]: info: Ignoring MPD Status Update Jan 09 00:23:10 volumio volumio[1369]: error: updateQueue error: null Jan 09 00:23:10 volumio volumio[1369]: info: ------------------------------ 2ms Jan 09 00:23:10 volumio volumio[1369]: info: Starting UPNP Playback Jan 09 00:23:10 volumio volumio[1369]: info: Preparing playback through UPNP Jan 09 00:23:10 volumio volumio[1369]: info: CoreCommandRouter::volumioGetState Jan 09 00:23:10 volumio volumio[1369]: info: CorePlayQueue::getTrack 0 Jan 09 00:23:10 volumio volumio[1369]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 09 00:23:10 volumio volumio[1369]: info: Jan 09 00:23:10 volumio volumio[1369]: ---------------------------- MPD announces system playlist update Jan 09 00:23:10 volumio volumio[1369]: info: Ignoring MPD Status Update Jan 09 00:23:10 volumio volumio[1369]: info: ------------------------------ 1ms Jan 09 00:23:10 volumio volumio[1369]: info: Jan 09 00:23:10 volumio volumio[1369]: ---------------------------- MPD announces system playlist update Jan 09 00:23:10 volumio volumio[1369]: info: Ignoring MPD Status Update Jan 09 00:23:10 volumio volumio[1369]: info: ------------------------------ 0ms Jan 09 00:23:10 volumio volumio[1369]: info: Jan 09 00:23:10 volumio volumio[1369]: ---------------------------- MPD announces system playlist update Jan 09 00:23:10 volumio volumio[1369]: info: Ignoring MPD Status Update Jan 09 00:23:10 volumio volumio[1369]: info: ------------------------------ 1ms Jan 09 00:23:10 volumio volumio[1369]: info: Jan 09 00:23:10 volumio volumio[1369]: ---------------------------- MPD announces system playlist update Jan 09 00:23:10 volumio volumio[1369]: info: Ignoring MPD Status Update Jan 09 00:23:10 volumio volumio[1369]: info: ------------------------------ 1ms Jan 09 00:23:10 volumio volumio[1369]: info: Jan 09 00:23:10 volumio volumio[1369]: ---------------------------- MPD announces system playlist update Jan 09 00:23:10 volumio volumio[1369]: info: Ignoring MPD Status Update Jan 09 00:23:10 volumio volumio[1369]: info: ------------------------------ 0ms Jan 09 00:23:10 volumio volumio[1369]: info: Jan 09 00:23:10 volumio volumio[1369]: ---------------------------- MPD announces system playlist update Jan 09 00:23:10 volumio volumio[1369]: info: Ignoring MPD Status Update Jan 09 00:23:10 volumio volumio[1369]: info: ------------------------------ 1ms Jan 09 00:23:10 volumio volumio[1369]: info: Jan 09 00:23:10 volumio volumio[1369]: ---------------------------- MPD announces state update: player Jan 09 00:23:10 volumio volumio[1369]: info: ControllerMpd::getState Jan 09 00:23:10 volumio volumio[1369]: verbose: ControllerMpd::sendMpdCommand status Jan 09 00:23:10 volumio volumio[1369]: info: Jan 09 00:23:10 volumio volumio[1369]: ---------------------------- MPD announces state update: player Jan 09 00:23:10 volumio volumio[1369]: info: sendMpdCommand status took 4 milliseconds Jan 09 00:23:10 volumio volumio[1369]: info: ControllerMpd::getState Jan 09 00:23:10 volumio volumio[1369]: verbose: ControllerMpd::sendMpdCommand status Jan 09 00:23:10 volumio volumio[1369]: verbose: ControllerMpd::parseState Jan 09 00:23:10 volumio volumio[1369]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 00:23:10 volumio volumio[1369]: info: sendMpdCommand status took 2 milliseconds Jan 09 00:23:10 volumio volumio[1369]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 09 00:23:10 volumio volumio[1369]: verbose: ControllerMpd::parseState Jan 09 00:23:10 volumio volumio[1369]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 00:23:10 volumio volumio[1369]: verbose: ControllerMpd::parseTrackInfo Jan 09 00:23:10 volumio volumio[1369]: info: ControllerMpd::pushState Jan 09 00:23:10 volumio volumio[1369]: info: CoreCommandRouter::servicePushState Jan 09 00:23:10 volumio volumio[1369]: verbose: In UPNP mode Jan 09 00:23:10 volumio volumio[1369]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":65,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Mahabbat (2023 Edit)","artist":null,"album":"The Best Feeling Music No.23","uri":"http://aqqmusic.tc.qq.com/F000003qa7JV39gLw6.flac?guid=0F7804D660D349E28F8750D46F577ED8&vkey=01F7DEE0E9EEA1973B0F1977DD14F874BF650FFB76A8C1C55A270916CD28BDF1AA878EFC3F3FD16077D3D1CD365F30985CA128386563E9CC__v21ea05cca&uin=70154162&src=F000001bsw850Yi4mK.flac&redirect=1&fromtag=101114","trackType":""} Jan 09 00:23:10 volumio volumio[1369]: verbose: CURRENT POSITION 0 Jan 09 00:23:10 volumio volumio[1369]: info: CoreStateMachine::syncState stateService play Jan 09 00:23:10 volumio volumio[1369]: info: CoreStateMachine::syncState currentStatus stop Jan 09 00:23:10 volumio volumio[1369]: info: ------------------------------ 8ms Jan 09 00:23:10 volumio volumio[1369]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 09 00:23:10 volumio volumio[1369]: verbose: ControllerMpd::parseTrackInfo Jan 09 00:23:10 volumio volumio[1369]: info: ControllerMpd::pushState Jan 09 00:23:10 volumio volumio[1369]: info: CoreCommandRouter::servicePushState Jan 09 00:23:10 volumio volumio[1369]: verbose: In UPNP mode Jan 09 00:23:10 volumio volumio[1369]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":65,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Mahabbat (2023 Edit)","artist":null,"album":"The Best Feeling Music No.23","uri":"http://aqqmusic.tc.qq.com/F000003qa7JV39gLw6.flac?guid=0F7804D660D349E28F8750D46F577ED8&vkey=01F7DEE0E9EEA1973B0F1977DD14F874BF650FFB76A8C1C55A270916CD28BDF1AA878EFC3F3FD16077D3D1CD365F30985CA128386563E9CC__v21ea05cca&uin=70154162&src=F000001bsw850Yi4mK.flac&redirect=1&fromtag=101114","trackType":""} Jan 09 00:23:10 volumio volumio[1369]: verbose: CURRENT POSITION 0 Jan 09 00:23:10 volumio volumio[1369]: info: CoreStateMachine::syncState stateService play Jan 09 00:23:10 volumio volumio[1369]: info: CoreStateMachine::syncState currentStatus play Jan 09 00:23:10 volumio volumio[1369]: info: Received an update from plugin. extracting info from payload Jan 09 00:23:10 volumio volumio[1369]: info: CoreStateMachine::pushState Jan 09 00:23:10 volumio volumio[1369]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 00:23:10 volumio volumio[1369]: info: CoreCommandRouter::volumioPushState Jan 09 00:23:10 volumio volumio[1369]: info: CoreStateMachine::pushState Jan 09 00:23:10 volumio volumio[1369]: info: CoreCommandRouter::volumioPushState Jan 09 00:23:10 volumio volumio[1369]: info: ------------------------------ 9ms Jan 09 00:23:10 volumio volumio[1369]: info: Jan 09 00:23:10 volumio volumio[1369]: ---------------------------- MPD announces system playlist update Jan 09 00:23:10 volumio volumio[1369]: info: Ignoring MPD Status Update Jan 09 00:23:10 volumio volumio[1369]: info: Jan 09 00:23:10 volumio volumio[1369]: ---------------------------- MPD announces state update: player Jan 09 00:23:10 volumio volumio[1369]: info: ControllerMpd::getState Jan 09 00:23:10 volumio volumio[1369]: verbose: ControllerMpd::sendMpdCommand status Jan 09 00:23:10 volumio volumio[1369]: info: ------------------------------ 3ms Jan 09 00:23:10 volumio volumio[1369]: info: sendMpdCommand status took 3 milliseconds Jan 09 00:23:10 volumio volumio[1369]: verbose: ControllerMpd::parseState Jan 09 00:23:10 volumio volumio[1369]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 09 00:23:10 volumio volumio[1369]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 09 00:23:10 volumio volumio[1369]: verbose: ControllerMpd::parseTrackInfo Jan 09 00:23:10 volumio volumio[1369]: info: ControllerMpd::pushState Jan 09 00:23:10 volumio volumio[1369]: info: CoreCommandRouter::servicePushState Jan 09 00:23:10 volumio volumio[1369]: verbose: In UPNP mode Jan 09 00:23:10 volumio volumio[1369]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":65,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1206 Kbps","isStreaming":false,"title":"Mahabbat (2023 Edit)","artist":"Various Artists","album":"The Best Feeling Music No.23","uri":"http://aqqmusic.tc.qq.com/F000003qa7JV39gLw6.flac?guid=0F7804D660D349E28F8750D46F577ED8&vkey=01F7DEE0E9EEA1973B0F1977DD14F874BF650FFB76A8C1C55A270916CD28BDF1AA878EFC3F3FD16077D3D1CD365F30985CA128386563E9CC__v21ea05cca&uin=70154162&src=F000001bsw850Yi4mK.flac&redirect=1&fromtag=101114","trackType":""} Jan 09 00:23:10 volumio volumio[1369]: verbose: CURRENT POSITION 0 Jan 09 00:23:10 volumio volumio[1369]: info: CoreStateMachine::syncState stateService play Jan 09 00:23:10 volumio volumio[1369]: info: CoreStateMachine::syncState currentStatus play Jan 09 00:23:10 volumio volumio[1369]: info: Received an update from plugin. extracting info from payload Jan 09 00:23:10 volumio volumio[1369]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 09 00:23:10 volumio volumio[1369]: info: CoreStateMachine::pushState Jan 09 00:23:10 volumio volumio[1369]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 00:23:10 volumio volumio[1369]: info: CoreCommandRouter::volumioPushState Jan 09 00:23:10 volumio volumio[1369]: info: CoreStateMachine::pushState Jan 09 00:23:10 volumio volumio[1369]: info: CoreCommandRouter::volumioPushState Jan 09 00:23:10 volumio volumio[1369]: info: ------------------------------ 11ms Jan 09 00:23:10 volumio volumio[1369]: info: CoreCommandRouter::volumioGetQueue Jan 09 00:23:10 volumio volumio[1369]: info: CoreStateMachine::getQueue Jan 09 00:23:10 volumio volumio[1369]: info: CorePlayQueue::getQueue Jan 09 00:23:10 volumio volumio[1369]: info: CoreCommandRouter::volumioGetQueue Jan 09 00:23:10 volumio volumio[1369]: info: CoreStateMachine::getQueue Jan 09 00:23:10 volumio volumio[1369]: info: CorePlayQueue::getQueue Jan 09 00:23:28 volumio upmpdcli[17949]: 87 Jan 09 00:23:28 volumio upmpdcli[17951]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 09 00:23:28 volumio upmpdcli[17951]: Dload Upload Total Spent Left Speed Jan 09 00:23:28 volumio volumio[1369]: info: Jan 09 00:23:28 volumio volumio[1369]: ---------------------------- Client requests Volume 87 Jan 09 00:23:28 volumio volumio[1369]: info: VolumeController::SetAlsaVolume87 Jan 09 00:23:28 volumio volumio[1369]: info: CoreStateMachine::pushState Jan 09 00:23:28 volumio volumio[1369]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 00:23:28 volumio volumio[1369]: info: CoreCommandRouter::volumioPushState Jan 09 00:23:28 volumio upmpdcli[17951]: [158B blob data] Jan 09 00:23:28 volumio volumio[1369]: info: CoreCommandRouter::volumioGetQueue Jan 09 00:23:28 volumio upmpdcli[17951]: {"time":1767889408112,"response":"volume Success"} Jan 09 00:23:28 volumio upmpdcli[17949]: 87 Jan 09 00:23:28 volumio volumio[1369]: info: CoreStateMachine::getQueue Jan 09 00:23:28 volumio volumio[1369]: info: CorePlayQueue::getQueue Jan 09 00:24:05 volumio volumio[1369]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 09 00:24:05 volumio volumio[1369]: Error: connect ETIMEDOUT 173.252.105.21:443 Jan 09 00:24:05 volumio volumio[1369]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Jan 09 00:24:05 volumio volumio[1369]: errno: -110, Jan 09 00:24:05 volumio volumio[1369]: code: 'ETIMEDOUT', Jan 09 00:24:05 volumio volumio[1369]: syscall: 'connect', Jan 09 00:24:05 volumio volumio[1369]: address: '173.252.105.21', Jan 09 00:24:05 volumio volumio[1369]: port: 443 Jan 09 00:24:05 volumio volumio[1369]: } Jan 09 00:24:05 volumio volumio[1369]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 09 00:24:06 volumio sudo[18140]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-09 00:23' Jan 09 00:24:06 volumio sudo[18140]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 21:07:15 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="4b5c74f40f473b90a542bf010b97924b"