-- Logs begin at Fri 2024-07-12 07:45:05 UTC, end at Mon 2025-05-26 12:43:32 UTC. -- May 26 12:43:14 opera volumio[4672]: info: May 26 12:43:14 opera volumio[4672]: ---------------------------- MPD announces state update: player May 26 12:43:14 opera volumio[4672]: info: ControllerMpd::getState May 26 12:43:14 opera volumio[4672]: verbose: ControllerMpd::sendMpdCommand status May 26 12:43:14 opera volumio[4672]: info: sendMpdCommand status took 1 milliseconds May 26 12:43:14 opera volumio[4672]: verbose: ControllerMpd::parseState May 26 12:43:14 opera volumio[4672]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 26 12:43:14 opera volumio[4672]: info: sendMpdCommand playlistinfo took 1 milliseconds May 26 12:43:14 opera volumio[4672]: verbose: ControllerMpd::parseTrackInfo May 26 12:43:14 opera volumio[4672]: info: ControllerMpd::pushState May 26 12:43:14 opera volumio[4672]: info: CoreCommandRouter::servicePushState May 26 12:43:14 opera volumio[4672]: info: CoreStateMachine::pushState May 26 12:43:14 opera volumio[4672]: info: CoreCommandRouter::volumioPushState May 26 12:43:14 opera volumio[4672]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 26 12:43:14 opera volumio[4672]: info: CorePlayQueue::getTrack 0 May 26 12:43:14 opera volumio[4672]: 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":"GEMINI “The Curious”","artist":"Tony Ann","album":"90°","uri":"http://aqqmusic.tc.qq.com/M500001EsYTc22MRuY.mp3?guid=000000005b56b722000001937137c5ff&vkey=F5E80F077903E03E0B3146E7D28D2BBA7FBB3F552326BDEEBB43B605167E8EEC5A486C4826680AAF71D6A17B02AEA7B28FDC40DDEF517E03__v2b9ab2c0&uin=1152921504950983260&src=M500000GyXzB4YjGSM.mp3&redirect=1&fromtag=111042","trackType":""} May 26 12:43:14 opera volumio[4672]: verbose: CURRENT POSITION 0 May 26 12:43:14 opera volumio[4672]: info: CoreStateMachine::syncState stateService stop May 26 12:43:14 opera volumio[4672]: info: CoreStateMachine::syncState currentStatus play May 26 12:43:14 opera volumio[4672]: info: CoreStateMachine::play index undefined May 26 12:43:14 opera volumio[4672]: info: CoreStateMachine::setConsumeUpdateService undefined May 26 12:43:14 opera volumio[4672]: info: CoreStateMachine::pushState May 26 12:43:14 opera volumio[4672]: info: CorePlayQueue::getTrack 0 May 26 12:43:14 opera volumio[4672]: info: CoreCommandRouter::volumioPushState May 26 12:43:14 opera volumio[4672]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 26 12:43:14 opera volumio[4672]: info: CorePlayQueue::getTrack 0 May 26 12:43:14 opera volumio[4672]: info: ------------------------------ 15ms May 26 12:43:14 opera volumio[4672]: info: Updating RAAT Signal Path May 26 12:43:14 opera volumio[4672]: info: Updating RAAT Signal Path May 26 12:43:14 opera volumio[4672]: info: CoreCommandRouter::volumioGetQueue May 26 12:43:14 opera volumio[4672]: info: CoreStateMachine::getQueue May 26 12:43:14 opera volumio[4672]: info: CorePlayQueue::getQueue May 26 12:43:14 opera volumio[4672]: info: Clearing queue after UPNP request May 26 12:43:14 opera volumio[4672]: info: CoreStateMachine::ClearQueue May 26 12:43:14 opera volumio[4672]: info: CoreStateMachine::stop May 26 12:43:14 opera volumio[4672]: info: CoreStateMachine::setConsumeUpdateService undefined May 26 12:43:14 opera volumio[4672]: verbose: UNSET VOLATILE May 26 12:43:14 opera volumio[4672]: info: CorePlayQueue::clearPlayQueue May 26 12:43:14 opera volumio[4672]: info: CorePlayQueue::saveQueue May 26 12:43:14 opera volumio[4672]: info: CoreCommandRouter::volumioPushState May 26 12:43:14 opera volumio[4672]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 26 12:43:14 opera volumio[4672]: info: CoreCommandRouter::volumioPushQueue May 26 12:43:14 opera volumio[4672]: info: Updating RAAT Signal Path May 26 12:43:14 opera volumio[4672]: info: May 26 12:43:14 opera volumio[4672]: ---------------------------- MPD announces system playlist update May 26 12:43:14 opera volumio[4672]: info: Ignoring MPD Status Update May 26 12:43:14 opera volumio[4672]: error: updateQueue error: null May 26 12:43:14 opera volumio[4672]: info: ------------------------------ 1ms May 26 12:43:14 opera volumio[4672]: info: Starting UPNP Playback May 26 12:43:14 opera volumio[4672]: info: Preparing playback through UPNP May 26 12:43:14 opera volumio[4672]: info: CoreCommandRouter::volumioGetState May 26 12:43:14 opera volumio[4672]: info: CorePlayQueue::getTrack 0 May 26 12:43:14 opera volumio[4672]: info: CoreStateMachine::setConsumeUpdateService mpd May 26 12:43:15 opera volumio[4672]: info: May 26 12:43:15 opera volumio[4672]: ---------------------------- MPD announces system playlist update May 26 12:43:15 opera volumio[4672]: info: Ignoring MPD Status Update May 26 12:43:15 opera volumio[4672]: info: ------------------------------ 1ms May 26 12:43:15 opera volumio[4672]: info: May 26 12:43:15 opera volumio[4672]: ---------------------------- MPD announces system playlist update May 26 12:43:15 opera volumio[4672]: info: Ignoring MPD Status Update May 26 12:43:15 opera volumio[4672]: info: ------------------------------ 1ms May 26 12:43:15 opera volumio[4672]: info: May 26 12:43:15 opera volumio[4672]: ---------------------------- MPD announces system playlist update May 26 12:43:15 opera volumio[4672]: info: Ignoring MPD Status Update May 26 12:43:15 opera volumio[4672]: info: ------------------------------ 1ms May 26 12:43:15 opera volumio[4672]: info: May 26 12:43:15 opera volumio[4672]: ---------------------------- MPD announces system playlist update May 26 12:43:15 opera volumio[4672]: info: Ignoring MPD Status Update May 26 12:43:15 opera volumio[4672]: info: ------------------------------ 1ms May 26 12:43:15 opera volumio[4672]: info: May 26 12:43:15 opera volumio[4672]: ---------------------------- MPD announces system playlist update May 26 12:43:15 opera volumio[4672]: info: Ignoring MPD Status Update May 26 12:43:15 opera volumio[4672]: info: ------------------------------ 0ms May 26 12:43:15 opera volumio[4672]: info: May 26 12:43:15 opera volumio[4672]: ---------------------------- MPD announces system playlist update May 26 12:43:15 opera volumio[4672]: info: Ignoring MPD Status Update May 26 12:43:15 opera volumio[4672]: info: ------------------------------ 1ms May 26 12:43:15 opera volumio[4672]: info: May 26 12:43:15 opera volumio[4672]: ---------------------------- MPD announces state update: player May 26 12:43:15 opera volumio[4672]: info: ControllerMpd::getState May 26 12:43:15 opera volumio[4672]: verbose: ControllerMpd::sendMpdCommand status May 26 12:43:15 opera volumio[4672]: info: May 26 12:43:15 opera volumio[4672]: ---------------------------- MPD announces system playlist update May 26 12:43:15 opera volumio[4672]: info: Ignoring MPD Status Update May 26 12:43:15 opera volumio[4672]: info: May 26 12:43:15 opera volumio[4672]: ---------------------------- MPD announces state update: player May 26 12:43:15 opera volumio[4672]: info: sendMpdCommand status took 6 milliseconds May 26 12:43:15 opera volumio[4672]: info: ControllerMpd::getState May 26 12:43:15 opera volumio[4672]: verbose: ControllerMpd::sendMpdCommand status May 26 12:43:15 opera volumio[4672]: verbose: ControllerMpd::parseState May 26 12:43:15 opera volumio[4672]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 26 12:43:15 opera volumio[4672]: info: ------------------------------ 7ms May 26 12:43:15 opera volumio[4672]: info: sendMpdCommand status took 2 milliseconds May 26 12:43:15 opera volumio[4672]: info: sendMpdCommand playlistinfo took 2 milliseconds May 26 12:43:15 opera volumio[4672]: verbose: ControllerMpd::parseState May 26 12:43:15 opera volumio[4672]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 26 12:43:15 opera volumio[4672]: verbose: ControllerMpd::parseTrackInfo May 26 12:43:15 opera volumio[4672]: info: ControllerMpd::pushState May 26 12:43:15 opera volumio[4672]: info: CoreCommandRouter::servicePushState May 26 12:43:15 opera volumio[4672]: verbose: In UPNP mode May 26 12:43:15 opera volumio[4672]: verbose: STATE SERVICE {"status":"play","position":0,"seek":46,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"千支针刺在心","artist":"邓瑞霞","album":"金唱片2","uri":"http://aqqmusic.tc.qq.com/M5000006hrG33Uj4aH.mp3?guid=000000005b56b722000001937137c5ff&vkey=4E9F0E9FD762759A3F23E7AF6BC3CCA5085ABEA3BB3D06A3544CE0975EE40B210EEFCAE916E1C9E583588FD0DC3CE5408F044E5D2BFEA54C__v2b9abf8b&uin=1152921504950983260&redirect=1&fromtag=111042","trackType":""} May 26 12:43:15 opera volumio[4672]: verbose: CURRENT POSITION 0 May 26 12:43:15 opera volumio[4672]: info: CoreStateMachine::syncState stateService play May 26 12:43:15 opera volumio[4672]: info: CoreStateMachine::syncState currentStatus stop May 26 12:43:15 opera volumio[4672]: info: CoreStateMachine::pushState May 26 12:43:15 opera volumio[4672]: info: CoreCommandRouter::volumioPushState May 26 12:43:15 opera volumio[4672]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 26 12:43:15 opera volumio[4672]: info: ------------------------------ 16ms May 26 12:43:15 opera volumio[4672]: info: sendMpdCommand playlistinfo took 7 milliseconds May 26 12:43:15 opera volumio[4672]: verbose: ControllerMpd::parseTrackInfo May 26 12:43:15 opera volumio[4672]: info: ControllerMpd::pushState May 26 12:43:15 opera volumio[4672]: info: CoreCommandRouter::servicePushState May 26 12:43:15 opera volumio[4672]: verbose: In UPNP mode May 26 12:43:15 opera volumio[4672]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":250,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"千支针刺在心","artist":"邓瑞霞","album":"金唱片2","uri":"http://aqqmusic.tc.qq.com/M5000006hrG33Uj4aH.mp3?guid=000000005b56b722000001937137c5ff&vkey=4E9F0E9FD762759A3F23E7AF6BC3CCA5085ABEA3BB3D06A3544CE0975EE40B210EEFCAE916E1C9E583588FD0DC3CE5408F044E5D2BFEA54C__v2b9abf8b&uin=1152921504950983260&redirect=1&fromtag=111042","trackType":""} May 26 12:43:15 opera volumio[4672]: verbose: CURRENT POSITION 0 May 26 12:43:15 opera volumio[4672]: info: CoreStateMachine::syncState stateService play May 26 12:43:15 opera volumio[4672]: info: CoreStateMachine::syncState currentStatus play May 26 12:43:15 opera volumio[4672]: info: Received an update from plugin. extracting info from payload May 26 12:43:15 opera volumio[4672]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 26 12:43:15 opera volumio[4672]: info: CoreStateMachine::pushState May 26 12:43:15 opera volumio[4672]: info: CoreCommandRouter::volumioPushState May 26 12:43:15 opera volumio[4672]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 26 12:43:15 opera volumio[4672]: info: CoreStateMachine::pushState May 26 12:43:15 opera volumio[4672]: info: CoreCommandRouter::volumioPushState May 26 12:43:15 opera volumio[4672]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 26 12:43:15 opera volumio[4672]: info: ------------------------------ 32ms May 26 12:43:15 opera volumio[4672]: info: Updating RAAT Signal Path May 26 12:43:15 opera volumio[4672]: info: Updating RAAT Signal Path May 26 12:43:15 opera volumio[4672]: info: Updating RAAT Signal Path May 26 12:43:15 opera volumio[4672]: info: CoreCommandRouter::volumioGetQueue May 26 12:43:15 opera volumio[4672]: info: CoreStateMachine::getQueue May 26 12:43:15 opera volumio[4672]: info: CorePlayQueue::getQueue May 26 12:43:15 opera volumio[4672]: info: CoreCommandRouter::volumioGetQueue May 26 12:43:15 opera volumio[4672]: info: CoreStateMachine::getQueue May 26 12:43:15 opera volumio[4672]: info: CorePlayQueue::getQueue May 26 12:43:15 opera volumio[4672]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Tony%20Ann/90%C2%B0/a5128363-a428-4b38-b4f3-e5bb817e3284.jpg' May 26 12:43:32 opera volumio[4672]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 26 12:43:32 opera volumio[4672]: { Error: connect ETIMEDOUT 103.226.246.99:443 May 26 12:43:32 opera volumio[4672]: at Object._errnoException (util.js:1022:11) May 26 12:43:32 opera volumio[4672]: at _exceptionWithHostPort (util.js:1044:20) May 26 12:43:32 opera volumio[4672]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) May 26 12:43:32 opera volumio[4672]: code: 'ETIMEDOUT', May 26 12:43:32 opera volumio[4672]: errno: 'ETIMEDOUT', May 26 12:43:32 opera volumio[4672]: syscall: 'connect', May 26 12:43:32 opera volumio[4672]: address: '103.226.246.99', May 26 12:43:32 opera volumio[4672]: port: 443 } May 26 12:43:32 opera volumio[4672]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 26 12:43:32 opera sudo[8060]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-26 12:42 May 26 12:43:32 opera sudo[8060]: 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="047a38c6e11e7058b10d3038ac9dcbff94f92828" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="opera" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Apr 8 17:29:57 CEST 2022" VOLUMIO_VERSION="1.033" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_VENDOR="Opera Consonance" VOLUMIO_MODEL="X5" VOLUMIO_VENDOR_MODEL="Opera X5" VOLUMIO_HASH="77fa3b0bf86939c934741dd9bb62adcc"