-- Logs begin at Wed 2026-03-25 04:18:06 UTC, end at Fri 2026-03-27 01:56:24 UTC. -- Mar 27 01:55:57 localhost volumio[797]: info: Mar 27 01:55:57 localhost volumio[797]: ---------------------------- MPD announces state update: player Mar 27 01:55:57 localhost volumio[797]: info: ControllerMpd::getState Mar 27 01:55:57 localhost volumio[797]: verbose: ControllerMpd::sendMpdCommand status Mar 27 01:55:57 localhost volumio[797]: info: sendMpdCommand status took 1 milliseconds Mar 27 01:55:57 localhost volumio[797]: verbose: ControllerMpd::parseState Mar 27 01:55:57 localhost volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 27 01:55:57 localhost volumio[797]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 27 01:55:57 localhost volumio[797]: verbose: ControllerMpd::parseTrackInfo Mar 27 01:55:57 localhost volumio[797]: info: ControllerMpd::pushState Mar 27 01:55:57 localhost volumio[797]: info: CoreCommandRouter::servicePushState Mar 27 01:55:57 localhost volumio[797]: info: CoreStateMachine::pushState Mar 27 01:55:57 localhost volumio[797]: info: CoreCommandRouter::volumioPushState Mar 27 01:55:57 localhost volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 27 01:55:57 localhost volumio[797]: info: CorePlayQueue::getTrack 0 Mar 27 01:55:57 localhost volumio[797]: 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":"Do You Miss Me Too","artist":"Mikhail Bennett","album":"After I Pass Away","uri":"http://59.42.240.143/amobile.music.tc.qq.com/F000004XbMR30L66Ej.flac?guid=000000004f276ee30000018d393bd7ef&vkey=C02766A13D10F9CEA65C344C9C81119A25B30E3ED879E2099FB86A826F25F6E82A7FD9E6B286A7ED363ED2BBE31F1F55E66DF6E591775114__v21e2a17f0&uin=1152921504621284401&redirect=1&fromtag=111114","trackType":""} Mar 27 01:55:57 localhost volumio[797]: verbose: CURRENT POSITION 0 Mar 27 01:55:57 localhost volumio[797]: info: CoreStateMachine::syncState stateService stop Mar 27 01:55:57 localhost volumio[797]: info: CoreStateMachine::syncState currentStatus play Mar 27 01:55:57 localhost volumio[797]: info: CoreStateMachine::play index undefined Mar 27 01:55:57 localhost volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 27 01:55:57 localhost volumio[797]: info: CoreStateMachine::pushState Mar 27 01:55:57 localhost volumio[797]: info: CorePlayQueue::getTrack 0 Mar 27 01:55:57 localhost volumio[797]: info: CoreCommandRouter::volumioPushState Mar 27 01:55:57 localhost volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 27 01:55:57 localhost volumio[797]: info: CorePlayQueue::getTrack 0 Mar 27 01:55:57 localhost volumio[797]: info: ------------------------------ 38ms Mar 27 01:55:57 localhost volumio[797]: info: CoreCommandRouter::volumioGetQueue Mar 27 01:55:57 localhost volumio[797]: info: CoreStateMachine::getQueue Mar 27 01:55:57 localhost volumio[797]: info: CorePlayQueue::getQueue Mar 27 01:55:57 localhost volumio[797]: info: Clearing queue after UPNP request Mar 27 01:55:57 localhost volumio[797]: info: CoreStateMachine::ClearQueue Mar 27 01:55:57 localhost volumio[797]: info: CoreStateMachine::stop Mar 27 01:55:57 localhost volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 27 01:55:57 localhost volumio[797]: UNSET VOLATILE Mar 27 01:55:57 localhost volumio[797]: info: CorePlayQueue::clearPlayQueue Mar 27 01:55:57 localhost volumio[797]: info: CorePlayQueue::saveQueue Mar 27 01:55:57 localhost volumio[797]: info: CoreCommandRouter::volumioPushState Mar 27 01:55:57 localhost volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 27 01:55:57 localhost volumio[797]: info: CoreCommandRouter::volumioPushQueue Mar 27 01:55:57 localhost volumio[797]: info: Mar 27 01:55:57 localhost volumio[797]: ---------------------------- MPD announces system playlist update Mar 27 01:55:57 localhost volumio[797]: info: Ignoring MPD Status Update Mar 27 01:55:57 localhost volumio[797]: error: updateQueue error: null Mar 27 01:55:57 localhost volumio[797]: info: ------------------------------ 4ms Mar 27 01:55:57 localhost volumio[797]: info: Starting UPNP Playback Mar 27 01:55:57 localhost volumio[797]: info: Preparing playback through UPNP Mar 27 01:55:57 localhost volumio[797]: info: CoreCommandRouter::volumioGetState Mar 27 01:55:57 localhost volumio[797]: info: CorePlayQueue::getTrack 0 Mar 27 01:55:57 localhost volumio[797]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 27 01:55:58 localhost volumio[797]: info: Mar 27 01:55:58 localhost volumio[797]: ---------------------------- MPD announces system playlist update Mar 27 01:55:58 localhost volumio[797]: info: Ignoring MPD Status Update Mar 27 01:55:58 localhost volumio[797]: info: Mar 27 01:55:58 localhost volumio[797]: ---------------------------- MPD announces system playlist update Mar 27 01:55:58 localhost volumio[797]: info: Ignoring MPD Status Update Mar 27 01:55:58 localhost volumio[797]: info: ------------------------------ 4ms Mar 27 01:55:58 localhost volumio[797]: info: ------------------------------ 3ms Mar 27 01:55:58 localhost volumio[797]: info: Mar 27 01:55:58 localhost volumio[797]: ---------------------------- MPD announces system playlist update Mar 27 01:55:58 localhost volumio[797]: info: Ignoring MPD Status Update Mar 27 01:55:58 localhost volumio[797]: info: ------------------------------ 3ms Mar 27 01:55:58 localhost volumio[797]: info: Mar 27 01:55:58 localhost volumio[797]: ---------------------------- MPD announces system playlist update Mar 27 01:55:58 localhost volumio[797]: info: Ignoring MPD Status Update Mar 27 01:55:58 localhost volumio[797]: info: ------------------------------ 3ms Mar 27 01:55:58 localhost volumio[797]: info: Mar 27 01:55:58 localhost volumio[797]: ---------------------------- MPD announces system playlist update Mar 27 01:55:58 localhost volumio[797]: info: Ignoring MPD Status Update Mar 27 01:55:58 localhost volumio[797]: info: ------------------------------ 3ms Mar 27 01:55:58 localhost volumio[797]: info: Mar 27 01:55:58 localhost volumio[797]: ---------------------------- MPD announces system playlist update Mar 27 01:55:58 localhost volumio[797]: info: Ignoring MPD Status Update Mar 27 01:55:58 localhost volumio[797]: info: ------------------------------ 3ms Mar 27 01:55:58 localhost volumio[797]: info: Mar 27 01:55:58 localhost volumio[797]: ---------------------------- MPD announces state update: player Mar 27 01:55:58 localhost volumio[797]: info: ControllerMpd::getState Mar 27 01:55:58 localhost volumio[797]: verbose: ControllerMpd::sendMpdCommand status Mar 27 01:55:58 localhost volumio[797]: info: sendMpdCommand status took 122 milliseconds Mar 27 01:55:58 localhost volumio[797]: verbose: ControllerMpd::parseState Mar 27 01:55:58 localhost volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 27 01:55:58 localhost volumio[797]: info: Mar 27 01:55:58 localhost volumio[797]: ---------------------------- MPD announces state update: player Mar 27 01:55:58 localhost volumio[797]: info: ControllerMpd::getState Mar 27 01:55:58 localhost volumio[797]: verbose: ControllerMpd::sendMpdCommand status Mar 27 01:55:58 localhost volumio[797]: info: Mar 27 01:55:58 localhost volumio[797]: ---------------------------- MPD announces system playlist update Mar 27 01:55:58 localhost volumio[797]: info: Ignoring MPD Status Update Mar 27 01:55:58 localhost volumio[797]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 27 01:55:58 localhost volumio[797]: info: sendMpdCommand status took 3 milliseconds Mar 27 01:55:58 localhost volumio[797]: verbose: ControllerMpd::parseTrackInfo Mar 27 01:55:58 localhost volumio[797]: verbose: ControllerMpd::parseState Mar 27 01:55:58 localhost volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 27 01:55:58 localhost volumio[797]: info: ControllerMpd::pushState Mar 27 01:55:58 localhost volumio[797]: info: CoreCommandRouter::servicePushState Mar 27 01:55:58 localhost volumio[797]: In UPNP mode Mar 27 01:55:58 localhost volumio[797]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":302,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"玻璃之情","artist":"车厘子的车车","album":"玻璃之情","uri":"http://59.42.240.143/amobile.music.tc.qq.com/F000002j7NZK1SXduw.flac?guid=000000004f276ee30000018d393bd7ef&vkey=7855397F3FB4A0B507B99A61F79D269D7D3FDB1E2D59667A68028BDC96976F4FB4D28B3F6E63A3436C972118E695E171333A2AAB27DE9FF2__v21e297a0b&uin=1152921504621284401&redirect=1&fromtag=111114","trackType":""} Mar 27 01:55:58 localhost volumio[797]: verbose: CURRENT POSITION 0 Mar 27 01:55:58 localhost volumio[797]: info: CoreStateMachine::syncState stateService play Mar 27 01:55:58 localhost volumio[797]: info: CoreStateMachine::syncState currentStatus stop Mar 27 01:55:58 localhost volumio[797]: info: CoreStateMachine::pushState Mar 27 01:55:58 localhost volumio[797]: info: CoreCommandRouter::volumioPushState Mar 27 01:55:58 localhost volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 27 01:55:58 localhost volumio[797]: info: ------------------------------ 165ms Mar 27 01:55:58 localhost volumio[797]: info: ------------------------------ 38ms Mar 27 01:55:58 localhost volumio[797]: info: sendMpdCommand playlistinfo took 61 milliseconds Mar 27 01:55:58 localhost volumio[797]: verbose: ControllerMpd::parseTrackInfo Mar 27 01:55:58 localhost volumio[797]: info: ControllerMpd::pushState Mar 27 01:55:58 localhost volumio[797]: info: CoreCommandRouter::servicePushState Mar 27 01:55:58 localhost volumio[797]: In UPNP mode Mar 27 01:55:58 localhost volumio[797]: verbose: STATE SERVICE {"status":"play","position":0,"seek":373,"duration":302,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1136 Kbps","isStreaming":false,"title":"玻璃之情","artist":"车厘子的车车","album":"玻璃之情","uri":"http://59.42.240.143/amobile.music.tc.qq.com/F000002j7NZK1SXduw.flac?guid=000000004f276ee30000018d393bd7ef&vkey=7855397F3FB4A0B507B99A61F79D269D7D3FDB1E2D59667A68028BDC96976F4FB4D28B3F6E63A3436C972118E695E171333A2AAB27DE9FF2__v21e297a0b&uin=1152921504621284401&redirect=1&fromtag=111114","trackType":""} Mar 27 01:55:58 localhost volumio[797]: verbose: CURRENT POSITION 0 Mar 27 01:55:58 localhost volumio[797]: info: CoreStateMachine::syncState stateService play Mar 27 01:55:58 localhost volumio[797]: info: CoreStateMachine::syncState currentStatus play Mar 27 01:55:58 localhost volumio[797]: info: Received an update from plugin. extracting info from payload Mar 27 01:55:58 localhost volumio[797]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 27 01:55:58 localhost volumio[797]: info: CoreStateMachine::pushState Mar 27 01:55:58 localhost volumio[797]: info: CoreCommandRouter::volumioPushState Mar 27 01:55:58 localhost volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 27 01:55:58 localhost volumio[797]: info: CoreStateMachine::pushState Mar 27 01:55:58 localhost volumio[797]: info: CoreCommandRouter::volumioPushState Mar 27 01:55:58 localhost volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 27 01:55:58 localhost volumio[797]: info: ------------------------------ 120ms Mar 27 01:55:58 localhost volumio[797]: info: CoreCommandRouter::volumioGetQueue Mar 27 01:55:58 localhost volumio[797]: info: CoreStateMachine::getQueue Mar 27 01:55:58 localhost volumio[797]: info: CorePlayQueue::getQueue Mar 27 01:55:58 localhost volumio[797]: info: CoreCommandRouter::volumioGetQueue Mar 27 01:55:58 localhost volumio[797]: info: CoreStateMachine::getQueue Mar 27 01:55:58 localhost volumio[797]: info: CorePlayQueue::getQueue Mar 27 01:55:59 localhost volumio[797]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Mikhail%20Bennett/After%20I%20Pass%20Away/4c60f4eb-9ff0-4d72-a0aa-f70e006c9863.jpg' Mar 27 01:56:23 localhost volumio[797]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 27 01:56:23 localhost volumio[797]: { Error: connect ETIMEDOUT 108.160.167.148:443 Mar 27 01:56:23 localhost volumio[797]: at Object._errnoException (util.js:1022:11) Mar 27 01:56:23 localhost volumio[797]: at _exceptionWithHostPort (util.js:1044:20) Mar 27 01:56:23 localhost volumio[797]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Mar 27 01:56:23 localhost volumio[797]: code: 'ETIMEDOUT', Mar 27 01:56:23 localhost volumio[797]: errno: 'ETIMEDOUT', Mar 27 01:56:23 localhost volumio[797]: syscall: 'connect', Mar 27 01:56:23 localhost volumio[797]: address: '108.160.167.148', Mar 27 01:56:23 localhost volumio[797]: port: 443 } Mar 27 01:56:23 localhost volumio[797]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 27 01:56:24 localhost sudo[5228]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-27 01:55 Mar 27 01:56:24 localhost sudo[5228]: 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="e81b2037a65d8f554cb0c857a1007d659ad7f838" VOLUMIO_FE_VERSION="e489037accd8e0b2dcbd6e0b054400d8cd36d4e2" VOLUMIO_BE_VERSION="25875b197c75cd1ac7eb5664d94cdd19afb06985" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Feb 19 17:57:53 CET 2021" VOLUMIO_VERSION="2.873" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="aa20cea461a8f0bd689fe0d5d2a83194"