-- Logs begin at Wed 2025-04-30 11:25:21 UTC, end at Wed 2025-04-30 11:48:01 UTC. -- Apr 30 11:47:47 opera volumio[5065]: info: Apr 30 11:47:47 opera volumio[5065]: ---------------------------- MPD announces state update: player Apr 30 11:47:47 opera volumio[5065]: info: ControllerMpd::getState Apr 30 11:47:47 opera volumio[5065]: verbose: ControllerMpd::sendMpdCommand status Apr 30 11:47:47 opera volumio[5065]: info: sendMpdCommand status took 1 milliseconds Apr 30 11:47:47 opera volumio[5065]: verbose: ControllerMpd::parseState Apr 30 11:47:47 opera volumio[5065]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 11:47:47 opera volumio[5065]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 30 11:47:47 opera volumio[5065]: verbose: ControllerMpd::parseTrackInfo Apr 30 11:47:47 opera volumio[5065]: info: ControllerMpd::pushState Apr 30 11:47:47 opera volumio[5065]: info: CoreCommandRouter::servicePushState Apr 30 11:47:47 opera volumio[5065]: info: CoreStateMachine::pushState Apr 30 11:47:47 opera volumio[5065]: info: CoreCommandRouter::volumioPushState Apr 30 11:47:47 opera volumio[5065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:47:47 opera volumio[5065]: info: CorePlayQueue::getTrack 0 Apr 30 11:47:47 opera volumio[5065]: 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":"Freedom","artist":"Suntree","album":"Package","uri":"http://aqqmusic.tc.qq.com/F0000015WTNm3WqLEz.flac?guid=000000005b56b722000001937137c5ff&vkey=9CB94FEB9A7408501FC89DA04B4E670CA26D9F3DE21C0923F083DB16804D6DDEDCDBDE88F95391A222E6B95ABDFF8A99867B1FFF7046D662__v2b9abb61&uin=1152921504950983260&src=F0000015WTNm3WqLEz.flac&redirect=1&fromtag=111114","trackType":""} Apr 30 11:47:47 opera volumio[5065]: verbose: CURRENT POSITION 0 Apr 30 11:47:47 opera volumio[5065]: info: CoreStateMachine::syncState stateService stop Apr 30 11:47:47 opera volumio[5065]: info: CoreStateMachine::syncState currentStatus play Apr 30 11:47:47 opera volumio[5065]: info: CoreStateMachine::play index undefined Apr 30 11:47:47 opera volumio[5065]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 30 11:47:47 opera volumio[5065]: info: CoreStateMachine::pushState Apr 30 11:47:47 opera volumio[5065]: info: CorePlayQueue::getTrack 0 Apr 30 11:47:47 opera volumio[5065]: info: CoreCommandRouter::volumioPushState Apr 30 11:47:47 opera volumio[5065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:47:47 opera volumio[5065]: info: CorePlayQueue::getTrack 0 Apr 30 11:47:47 opera volumio[5065]: info: ------------------------------ 19ms Apr 30 11:47:47 opera volumio[5065]: info: Updating RAAT Signal Path Apr 30 11:47:47 opera volumio[5065]: info: Updating RAAT Signal Path Apr 30 11:47:47 opera volumio[5065]: info: CoreCommandRouter::volumioGetQueue Apr 30 11:47:47 opera volumio[5065]: info: CoreStateMachine::getQueue Apr 30 11:47:47 opera volumio[5065]: info: CorePlayQueue::getQueue Apr 30 11:47:47 opera volumio[5065]: info: Clearing queue after UPNP request Apr 30 11:47:47 opera volumio[5065]: info: CoreStateMachine::ClearQueue Apr 30 11:47:47 opera volumio[5065]: info: CoreStateMachine::stop Apr 30 11:47:47 opera volumio[5065]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 30 11:47:47 opera volumio[5065]: verbose: UNSET VOLATILE Apr 30 11:47:47 opera volumio[5065]: info: CorePlayQueue::clearPlayQueue Apr 30 11:47:47 opera volumio[5065]: info: CorePlayQueue::saveQueue Apr 30 11:47:47 opera volumio[5065]: info: CoreCommandRouter::volumioPushState Apr 30 11:47:47 opera volumio[5065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:47:47 opera volumio[5065]: info: CoreCommandRouter::volumioPushQueue Apr 30 11:47:47 opera volumio[5065]: info: Updating RAAT Signal Path Apr 30 11:47:47 opera volumio[5065]: info: Apr 30 11:47:47 opera volumio[5065]: ---------------------------- MPD announces system playlist update Apr 30 11:47:47 opera volumio[5065]: info: Ignoring MPD Status Update Apr 30 11:47:47 opera volumio[5065]: error: updateQueue error: null Apr 30 11:47:47 opera volumio[5065]: info: ------------------------------ 2ms Apr 30 11:47:47 opera volumio[5065]: info: Starting UPNP Playback Apr 30 11:47:47 opera volumio[5065]: info: Preparing playback through UPNP Apr 30 11:47:47 opera volumio[5065]: info: CoreCommandRouter::volumioGetState Apr 30 11:47:47 opera volumio[5065]: info: CorePlayQueue::getTrack 0 Apr 30 11:47:47 opera volumio[5065]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 30 11:47:48 opera volumio[5065]: info: Apr 30 11:47:48 opera volumio[5065]: ---------------------------- MPD announces system playlist update Apr 30 11:47:48 opera volumio[5065]: info: Ignoring MPD Status Update Apr 30 11:47:48 opera volumio[5065]: info: Apr 30 11:47:48 opera volumio[5065]: ---------------------------- MPD announces system playlist update Apr 30 11:47:48 opera volumio[5065]: info: Ignoring MPD Status Update Apr 30 11:47:48 opera volumio[5065]: info: ------------------------------ 2ms Apr 30 11:47:48 opera volumio[5065]: info: ------------------------------ 1ms Apr 30 11:47:48 opera volumio[5065]: info: Apr 30 11:47:48 opera volumio[5065]: ---------------------------- MPD announces system playlist update Apr 30 11:47:48 opera volumio[5065]: info: Ignoring MPD Status Update Apr 30 11:47:48 opera volumio[5065]: info: Apr 30 11:47:48 opera volumio[5065]: ---------------------------- MPD announces system playlist update Apr 30 11:47:48 opera volumio[5065]: info: Ignoring MPD Status Update Apr 30 11:47:48 opera volumio[5065]: info: ------------------------------ 1ms Apr 30 11:47:48 opera volumio[5065]: info: ------------------------------ 1ms Apr 30 11:47:48 opera volumio[5065]: info: Apr 30 11:47:48 opera volumio[5065]: ---------------------------- MPD announces system playlist update Apr 30 11:47:48 opera volumio[5065]: info: Ignoring MPD Status Update Apr 30 11:47:48 opera volumio[5065]: info: Apr 30 11:47:48 opera volumio[5065]: ---------------------------- MPD announces system playlist update Apr 30 11:47:48 opera volumio[5065]: info: Ignoring MPD Status Update Apr 30 11:47:48 opera volumio[5065]: info: ------------------------------ 2ms Apr 30 11:47:48 opera volumio[5065]: info: ------------------------------ 2ms Apr 30 11:47:48 opera volumio[5065]: info: Apr 30 11:47:48 opera volumio[5065]: ---------------------------- MPD announces state update: player Apr 30 11:47:48 opera volumio[5065]: info: ControllerMpd::getState Apr 30 11:47:48 opera volumio[5065]: verbose: ControllerMpd::sendMpdCommand status Apr 30 11:47:48 opera volumio[5065]: info: Apr 30 11:47:48 opera volumio[5065]: ---------------------------- MPD announces state update: player Apr 30 11:47:48 opera volumio[5065]: info: sendMpdCommand status took 2 milliseconds Apr 30 11:47:48 opera volumio[5065]: info: ControllerMpd::getState Apr 30 11:47:48 opera volumio[5065]: verbose: ControllerMpd::sendMpdCommand status Apr 30 11:47:48 opera volumio[5065]: verbose: ControllerMpd::parseState Apr 30 11:47:48 opera volumio[5065]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 11:47:48 opera volumio[5065]: info: Apr 30 11:47:48 opera volumio[5065]: ---------------------------- MPD announces system playlist update Apr 30 11:47:48 opera volumio[5065]: info: Ignoring MPD Status Update Apr 30 11:47:48 opera volumio[5065]: info: sendMpdCommand status took 2 milliseconds Apr 30 11:47:48 opera volumio[5065]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 30 11:47:48 opera volumio[5065]: verbose: ControllerMpd::parseState Apr 30 11:47:48 opera volumio[5065]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 11:47:48 opera volumio[5065]: verbose: ControllerMpd::parseTrackInfo Apr 30 11:47:48 opera volumio[5065]: info: ControllerMpd::pushState Apr 30 11:47:48 opera volumio[5065]: info: CoreCommandRouter::servicePushState Apr 30 11:47:48 opera volumio[5065]: verbose: In UPNP mode Apr 30 11:47:48 opera volumio[5065]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":362,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"VIVI NELL'ARIA","artist":"DJ MAXWELL","album":"TRUST NO ONE","uri":"http://aqqmusic.tc.qq.com/F000000ZiysE0VdYzj.flac?guid=000000005b56b722000001937137c5ff&vkey=72B0E8CE10A7F235A492CA380351F0985040726E35CE117370B67E2B8B0315C752A89B81A3F3FEA884BE15C73A0F742182666A70C431FE1C__v2b9abb64&uin=1152921504950983260&redirect=1&fromtag=111114","trackType":""} Apr 30 11:47:48 opera volumio[5065]: verbose: CURRENT POSITION 0 Apr 30 11:47:48 opera volumio[5065]: info: CoreStateMachine::syncState stateService play Apr 30 11:47:48 opera volumio[5065]: info: CoreStateMachine::syncState currentStatus stop Apr 30 11:47:48 opera volumio[5065]: info: CoreStateMachine::pushState Apr 30 11:47:48 opera volumio[5065]: info: CoreCommandRouter::volumioPushState Apr 30 11:47:48 opera volumio[5065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:47:48 opera volumio[5065]: info: ------------------------------ 14ms Apr 30 11:47:48 opera volumio[5065]: info: ------------------------------ 18ms Apr 30 11:47:48 opera volumio[5065]: info: sendMpdCommand playlistinfo took 17 milliseconds Apr 30 11:47:48 opera volumio[5065]: verbose: ControllerMpd::parseTrackInfo Apr 30 11:47:48 opera volumio[5065]: info: ControllerMpd::pushState Apr 30 11:47:48 opera volumio[5065]: info: CoreCommandRouter::servicePushState Apr 30 11:47:48 opera volumio[5065]: verbose: In UPNP mode Apr 30 11:47:48 opera volumio[5065]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":362,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"907 Kbps","isStreaming":false,"title":"VIVI NELL'ARIA","artist":"DJ MAXWELL","album":"TRUST NO ONE","uri":"http://aqqmusic.tc.qq.com/F000000ZiysE0VdYzj.flac?guid=000000005b56b722000001937137c5ff&vkey=72B0E8CE10A7F235A492CA380351F0985040726E35CE117370B67E2B8B0315C752A89B81A3F3FEA884BE15C73A0F742182666A70C431FE1C__v2b9abb64&uin=1152921504950983260&redirect=1&fromtag=111114","trackType":""} Apr 30 11:47:48 opera volumio[5065]: verbose: CURRENT POSITION 0 Apr 30 11:47:48 opera volumio[5065]: info: CoreStateMachine::syncState stateService play Apr 30 11:47:48 opera volumio[5065]: info: CoreStateMachine::syncState currentStatus play Apr 30 11:47:48 opera volumio[5065]: info: Received an update from plugin. extracting info from payload Apr 30 11:47:48 opera volumio[5065]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 30 11:47:48 opera volumio[5065]: info: CoreStateMachine::pushState Apr 30 11:47:48 opera volumio[5065]: info: CoreCommandRouter::volumioPushState Apr 30 11:47:48 opera volumio[5065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:47:48 opera volumio[5065]: info: CoreStateMachine::pushState Apr 30 11:47:48 opera volumio[5065]: info: CoreCommandRouter::volumioPushState Apr 30 11:47:48 opera volumio[5065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:47:48 opera volumio[5065]: info: ------------------------------ 36ms Apr 30 11:47:48 opera volumio[5065]: info: Updating RAAT Signal Path Apr 30 11:47:48 opera volumio[5065]: info: Updating RAAT Signal Path Apr 30 11:47:48 opera volumio[5065]: info: Updating RAAT Signal Path Apr 30 11:47:48 opera volumio[5065]: info: CoreCommandRouter::volumioGetQueue Apr 30 11:47:48 opera volumio[5065]: info: CoreStateMachine::getQueue Apr 30 11:47:48 opera volumio[5065]: info: CorePlayQueue::getQueue Apr 30 11:47:48 opera volumio[5065]: info: CoreCommandRouter::volumioGetQueue Apr 30 11:47:48 opera volumio[5065]: info: CoreStateMachine::getQueue Apr 30 11:47:48 opera volumio[5065]: info: CorePlayQueue::getQueue Apr 30 11:47:48 opera volumio[5065]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Suntree/Package/8c064366-ad45-43d3-869e-5bea234ddb42.jpg' Apr 30 11:47:48 opera volumio[5065]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/DJ%20MAXWELL/TRUST%20NO%20ONE/fbfc0872-dbee-4522-be58-f37d66f48c9c.jpg' Apr 30 11:48:00 opera volumio[5065]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 30 11:48:00 opera volumio[5065]: { Error: connect ETIMEDOUT 104.31.142.88:443 Apr 30 11:48:00 opera volumio[5065]: at Object._errnoException (util.js:1022:11) Apr 30 11:48:00 opera volumio[5065]: at _exceptionWithHostPort (util.js:1044:20) Apr 30 11:48:00 opera volumio[5065]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Apr 30 11:48:00 opera volumio[5065]: code: 'ETIMEDOUT', Apr 30 11:48:00 opera volumio[5065]: errno: 'ETIMEDOUT', Apr 30 11:48:00 opera volumio[5065]: syscall: 'connect', Apr 30 11:48:00 opera volumio[5065]: address: '104.31.142.88', Apr 30 11:48:00 opera volumio[5065]: port: 443 } Apr 30 11:48:00 opera volumio[5065]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 30 11:48:01 opera sudo[5882]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-30 11:47 Apr 30 11:48:01 opera sudo[5882]: 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"