-- Logs begin at Fri 2024-07-12 07:45:05 UTC, end at Tue 2025-06-24 13:55:50 UTC. -- Jun 24 13:54:44 opera volumio[1130]: info: Jun 24 13:54:44 opera volumio[1130]: ---------------------------- MPD announces state update: player Jun 24 13:54:44 opera volumio[1130]: info: ControllerMpd::getState Jun 24 13:54:44 opera volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Jun 24 13:54:44 opera volumio[1130]: info: sendMpdCommand status took 3 milliseconds Jun 24 13:54:44 opera volumio[1130]: verbose: ControllerMpd::parseState Jun 24 13:54:44 opera volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 13:54:44 opera volumio[1130]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 24 13:54:44 opera volumio[1130]: verbose: ControllerMpd::parseTrackInfo Jun 24 13:54:44 opera volumio[1130]: info: ControllerMpd::pushState Jun 24 13:54:44 opera volumio[1130]: info: CoreCommandRouter::servicePushState Jun 24 13:54:44 opera volumio[1130]: info: CoreStateMachine::pushState Jun 24 13:54:44 opera volumio[1130]: info: CoreCommandRouter::volumioPushState Jun 24 13:54:44 opera volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 13:54:44 opera volumio[1130]: info: CorePlayQueue::getTrack 0 Jun 24 13:54:44 opera volumio[1130]: 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":"Chewing-Gum","artist":"Vendredi sur mer","album":"Chewing-Gum","uri":"http://aqqmusic.tc.qq.com/M500002EKhNk4JQOzh.mp3?guid=000000005b56b722000001937137c5ff&vkey=C45F6195C4455378A12CFB8E12A236FE55E05279E53E627647653C9D06BFF0B9E241B7045C4B223586738606ED2727C45821B86D1896906C__v2b9abf4e&uin=1152921504950983260&src=M500002EKhNk4JQOzh.mp3&redirect=1&fromtag=111042","trackType":""} Jun 24 13:54:44 opera volumio[1130]: verbose: CURRENT POSITION 0 Jun 24 13:54:44 opera volumio[1130]: info: CoreStateMachine::syncState stateService stop Jun 24 13:54:44 opera volumio[1130]: info: CoreStateMachine::syncState currentStatus play Jun 24 13:54:44 opera volumio[1130]: info: CoreStateMachine::play index undefined Jun 24 13:54:44 opera volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 24 13:54:44 opera volumio[1130]: info: CoreStateMachine::pushState Jun 24 13:54:44 opera volumio[1130]: info: CorePlayQueue::getTrack 0 Jun 24 13:54:44 opera volumio[1130]: info: CoreCommandRouter::volumioPushState Jun 24 13:54:44 opera volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 13:54:44 opera volumio[1130]: info: CorePlayQueue::getTrack 0 Jun 24 13:54:44 opera volumio[1130]: info: ------------------------------ 23ms Jun 24 13:54:44 opera volumio[1130]: info: CoreCommandRouter::volumioGetQueue Jun 24 13:54:44 opera volumio[1130]: info: CoreStateMachine::getQueue Jun 24 13:54:44 opera volumio[1130]: info: CorePlayQueue::getQueue Jun 24 13:54:44 opera volumio[1130]: info: Updating RAAT Signal Path Jun 24 13:54:44 opera volumio[1130]: info: Updating RAAT Signal Path Jun 24 13:54:44 opera volumio[1130]: info: Clearing queue after UPNP request Jun 24 13:54:44 opera volumio[1130]: info: CoreStateMachine::ClearQueue Jun 24 13:54:44 opera volumio[1130]: info: CoreStateMachine::stop Jun 24 13:54:44 opera volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 24 13:54:44 opera volumio[1130]: verbose: UNSET VOLATILE Jun 24 13:54:44 opera volumio[1130]: info: CorePlayQueue::clearPlayQueue Jun 24 13:54:44 opera volumio[1130]: info: CorePlayQueue::saveQueue Jun 24 13:54:44 opera volumio[1130]: info: CoreCommandRouter::volumioPushState Jun 24 13:54:44 opera volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 13:54:44 opera volumio[1130]: info: CoreCommandRouter::volumioPushQueue Jun 24 13:54:44 opera volumio[1130]: info: Updating RAAT Signal Path Jun 24 13:54:44 opera volumio[1130]: info: Jun 24 13:54:44 opera volumio[1130]: ---------------------------- MPD announces system playlist update Jun 24 13:54:44 opera volumio[1130]: info: Ignoring MPD Status Update Jun 24 13:54:44 opera volumio[1130]: error: updateQueue error: null Jun 24 13:54:44 opera volumio[1130]: info: ------------------------------ 1ms Jun 24 13:54:44 opera volumio[1130]: info: Starting UPNP Playback Jun 24 13:54:44 opera volumio[1130]: info: Preparing playback through UPNP Jun 24 13:54:44 opera volumio[1130]: info: CoreCommandRouter::volumioGetState Jun 24 13:54:44 opera volumio[1130]: info: CorePlayQueue::getTrack 0 Jun 24 13:54:44 opera volumio[1130]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 24 13:54:45 opera volumio[1130]: info: Jun 24 13:54:45 opera volumio[1130]: ---------------------------- MPD announces system playlist update Jun 24 13:54:45 opera volumio[1130]: info: Ignoring MPD Status Update Jun 24 13:54:45 opera volumio[1130]: info: Jun 24 13:54:45 opera volumio[1130]: ---------------------------- MPD announces system playlist update Jun 24 13:54:45 opera volumio[1130]: info: Ignoring MPD Status Update Jun 24 13:54:45 opera volumio[1130]: info: ------------------------------ 2ms Jun 24 13:54:45 opera volumio[1130]: info: ------------------------------ 2ms Jun 24 13:54:45 opera volumio[1130]: info: Jun 24 13:54:45 opera volumio[1130]: ---------------------------- MPD announces system playlist update Jun 24 13:54:45 opera volumio[1130]: info: Ignoring MPD Status Update Jun 24 13:54:45 opera volumio[1130]: info: ------------------------------ 1ms Jun 24 13:54:45 opera volumio[1130]: info: Jun 24 13:54:45 opera volumio[1130]: ---------------------------- MPD announces system playlist update Jun 24 13:54:45 opera volumio[1130]: info: Ignoring MPD Status Update Jun 24 13:54:45 opera volumio[1130]: info: ------------------------------ 1ms Jun 24 13:54:45 opera volumio[1130]: info: Jun 24 13:54:45 opera volumio[1130]: ---------------------------- MPD announces system playlist update Jun 24 13:54:45 opera volumio[1130]: info: Ignoring MPD Status Update Jun 24 13:54:45 opera volumio[1130]: info: Jun 24 13:54:45 opera volumio[1130]: ---------------------------- MPD announces system playlist update Jun 24 13:54:45 opera volumio[1130]: info: Ignoring MPD Status Update Jun 24 13:54:45 opera volumio[1130]: info: ------------------------------ 1ms Jun 24 13:54:45 opera volumio[1130]: info: ------------------------------ 1ms Jun 24 13:54:45 opera volumio[1130]: info: Jun 24 13:54:45 opera volumio[1130]: ---------------------------- MPD announces state update: player Jun 24 13:54:45 opera volumio[1130]: info: ControllerMpd::getState Jun 24 13:54:45 opera volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Jun 24 13:54:45 opera volumio[1130]: info: Jun 24 13:54:45 opera volumio[1130]: ---------------------------- MPD announces state update: player Jun 24 13:54:45 opera volumio[1130]: info: Jun 24 13:54:45 opera volumio[1130]: ---------------------------- MPD announces system playlist update Jun 24 13:54:45 opera volumio[1130]: info: Ignoring MPD Status Update Jun 24 13:54:45 opera volumio[1130]: info: ControllerMpd::getState Jun 24 13:54:45 opera volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Jun 24 13:54:45 opera volumio[1130]: info: sendMpdCommand status took 3 milliseconds Jun 24 13:54:45 opera volumio[1130]: verbose: ControllerMpd::parseState Jun 24 13:54:45 opera volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 13:54:45 opera volumio[1130]: info: sendMpdCommand status took 3 milliseconds Jun 24 13:54:45 opera volumio[1130]: info: ------------------------------ 6ms Jun 24 13:54:45 opera volumio[1130]: info: sendMpdCommand playlistinfo took 3 milliseconds Jun 24 13:54:45 opera volumio[1130]: verbose: ControllerMpd::parseState Jun 24 13:54:45 opera volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 13:54:45 opera volumio[1130]: verbose: ControllerMpd::parseTrackInfo Jun 24 13:54:45 opera volumio[1130]: info: ControllerMpd::pushState Jun 24 13:54:45 opera volumio[1130]: info: CoreCommandRouter::servicePushState Jun 24 13:54:45 opera volumio[1130]: verbose: In UPNP mode Jun 24 13:54:45 opera volumio[1130]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":287,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"858 Kbps","isStreaming":false,"title":"谁令你心痴","artist":"邓瑞霞","album":"我今生有你","uri":"http://aqqmusic.tc.qq.com/F000003WHhUB1hZMto.flac?guid=000000005b56b722000001937137c5ff&vkey=9A394312EEB020A13D48056A97063B3350D7BC261F7CE294A63BCE61523D055748C5F450C067CF951872A5F8775B87CD6AF1553C45CED7A5__v2b9abe8c&uin=1152921504950983260&redirect=1&fromtag=111114","trackType":""} Jun 24 13:54:45 opera volumio[1130]: verbose: CURRENT POSITION 0 Jun 24 13:54:45 opera volumio[1130]: info: CoreStateMachine::syncState stateService play Jun 24 13:54:45 opera volumio[1130]: info: CoreStateMachine::syncState currentStatus stop Jun 24 13:54:45 opera volumio[1130]: info: CoreStateMachine::pushState Jun 24 13:54:45 opera volumio[1130]: info: CoreCommandRouter::volumioPushState Jun 24 13:54:45 opera volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 13:54:45 opera volumio[1130]: info: ------------------------------ 20ms Jun 24 13:54:45 opera volumio[1130]: info: sendMpdCommand playlistinfo took 11 milliseconds Jun 24 13:54:45 opera volumio[1130]: verbose: ControllerMpd::parseTrackInfo Jun 24 13:54:45 opera volumio[1130]: info: ControllerMpd::pushState Jun 24 13:54:45 opera volumio[1130]: info: CoreCommandRouter::servicePushState Jun 24 13:54:45 opera volumio[1130]: verbose: In UPNP mode Jun 24 13:54:45 opera volumio[1130]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":287,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"858 Kbps","isStreaming":false,"title":"谁令你心痴","artist":"邓瑞霞","album":"我今生有你","uri":"http://aqqmusic.tc.qq.com/F000003WHhUB1hZMto.flac?guid=000000005b56b722000001937137c5ff&vkey=9A394312EEB020A13D48056A97063B3350D7BC261F7CE294A63BCE61523D055748C5F450C067CF951872A5F8775B87CD6AF1553C45CED7A5__v2b9abe8c&uin=1152921504950983260&redirect=1&fromtag=111114","trackType":""} Jun 24 13:54:45 opera volumio[1130]: verbose: CURRENT POSITION 0 Jun 24 13:54:45 opera volumio[1130]: info: CoreStateMachine::syncState stateService play Jun 24 13:54:45 opera volumio[1130]: info: CoreStateMachine::syncState currentStatus play Jun 24 13:54:45 opera volumio[1130]: info: Received an update from plugin. extracting info from payload Jun 24 13:54:45 opera volumio[1130]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 24 13:54:45 opera volumio[1130]: info: CoreStateMachine::pushState Jun 24 13:54:45 opera volumio[1130]: info: CoreCommandRouter::volumioPushState Jun 24 13:54:45 opera volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 13:54:45 opera volumio[1130]: info: CoreStateMachine::pushState Jun 24 13:54:45 opera volumio[1130]: info: CoreCommandRouter::volumioPushState Jun 24 13:54:45 opera volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 13:54:45 opera volumio[1130]: info: ------------------------------ 52ms Jun 24 13:54:45 opera volumio[1130]: info: CoreCommandRouter::volumioGetQueue Jun 24 13:54:45 opera volumio[1130]: info: CoreStateMachine::getQueue Jun 24 13:54:45 opera volumio[1130]: info: CorePlayQueue::getQueue Jun 24 13:54:45 opera volumio[1130]: info: CoreCommandRouter::volumioGetQueue Jun 24 13:54:45 opera volumio[1130]: info: CoreStateMachine::getQueue Jun 24 13:54:45 opera volumio[1130]: info: CorePlayQueue::getQueue Jun 24 13:54:45 opera volumio[1130]: info: Updating RAAT Signal Path Jun 24 13:54:45 opera volumio[1130]: info: Updating RAAT Signal Path Jun 24 13:54:45 opera volumio[1130]: info: Updating RAAT Signal Path Jun 24 13:54:45 opera volumio[1130]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Vendredi%20sur%20mer/Chewing-Gum/af37b964-e0e8-49ba-b133-8b9c5318e2cf.png' Jun 24 13:55:49 opera volumio[1130]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 24 13:55:49 opera volumio[1130]: { Error: connect ETIMEDOUT 108.160.163.112:443 Jun 24 13:55:49 opera volumio[1130]: at Object._errnoException (util.js:1022:11) Jun 24 13:55:49 opera volumio[1130]: at _exceptionWithHostPort (util.js:1044:20) Jun 24 13:55:49 opera volumio[1130]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jun 24 13:55:49 opera volumio[1130]: code: 'ETIMEDOUT', Jun 24 13:55:49 opera volumio[1130]: errno: 'ETIMEDOUT', Jun 24 13:55:49 opera volumio[1130]: syscall: 'connect', Jun 24 13:55:49 opera volumio[1130]: address: '108.160.163.112', Jun 24 13:55:49 opera volumio[1130]: port: 443 } Jun 24 13:55:49 opera volumio[1130]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 24 13:55:50 opera sudo[3258]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-24 13:54 Jun 24 13:55:50 opera sudo[3258]: 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"