-- Logs begin at Wed 2025-04-30 11:25:21 UTC, end at Wed 2025-04-30 11:40:34 UTC. -- Apr 30 11:39:01 opera volumio[1231]: info: Apr 30 11:39:01 opera volumio[1231]: ---------------------------- MPD announces state update: player Apr 30 11:39:01 opera volumio[1231]: info: ControllerMpd::getState Apr 30 11:39:01 opera volumio[1231]: verbose: ControllerMpd::sendMpdCommand status Apr 30 11:39:01 opera volumio[1231]: info: sendMpdCommand status took 1 milliseconds Apr 30 11:39:01 opera volumio[1231]: verbose: ControllerMpd::parseState Apr 30 11:39:01 opera volumio[1231]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 11:39:01 opera volumio[1231]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 30 11:39:01 opera volumio[1231]: verbose: ControllerMpd::parseTrackInfo Apr 30 11:39:01 opera volumio[1231]: info: ControllerMpd::pushState Apr 30 11:39:01 opera volumio[1231]: info: CoreCommandRouter::servicePushState Apr 30 11:39:01 opera volumio[1231]: info: CoreStateMachine::pushState Apr 30 11:39:02 opera volumio[1231]: info: CoreCommandRouter::volumioPushState Apr 30 11:39:02 opera volumio[1231]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:39:02 opera volumio[1231]: info: CorePlayQueue::getTrack 0 Apr 30 11:39:02 opera volumio[1231]: 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":"Northwind","artist":"Vexento","album":"Northwind","uri":"http://aqqmusic.tc.qq.com/F000002LUEdY4NvGlr.flac?guid=000000005b56b722000001937137c5ff&vkey=D38BE0A3E5B4547AFB1D70B0E0E489AF3CE47CD9762D15BF36BC944100CF008F6DDE9825E07D3DAC8186C10D8B255864CEB099C7E5501D57__v2b9abb61&uin=1152921504950983260&src=F000002O0nB812pWfW.flac&redirect=1&fromtag=111114","trackType":""} Apr 30 11:39:02 opera volumio[1231]: verbose: CURRENT POSITION 0 Apr 30 11:39:02 opera volumio[1231]: info: CoreStateMachine::syncState stateService stop Apr 30 11:39:02 opera volumio[1231]: info: CoreStateMachine::syncState currentStatus play Apr 30 11:39:02 opera volumio[1231]: info: CoreStateMachine::play index undefined Apr 30 11:39:02 opera volumio[1231]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 30 11:39:02 opera volumio[1231]: info: CoreStateMachine::pushState Apr 30 11:39:02 opera volumio[1231]: info: CorePlayQueue::getTrack 0 Apr 30 11:39:02 opera volumio[1231]: info: CoreCommandRouter::volumioPushState Apr 30 11:39:02 opera volumio[1231]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:39:02 opera volumio[1231]: info: CorePlayQueue::getTrack 0 Apr 30 11:39:02 opera volumio[1231]: info: ------------------------------ 20ms Apr 30 11:39:02 opera volumio[1231]: info: CoreCommandRouter::volumioGetQueue Apr 30 11:39:02 opera volumio[1231]: info: CoreStateMachine::getQueue Apr 30 11:39:02 opera volumio[1231]: info: CorePlayQueue::getQueue Apr 30 11:39:02 opera volumio[1231]: info: Updating RAAT Signal Path Apr 30 11:39:02 opera volumio[1231]: info: Updating RAAT Signal Path Apr 30 11:39:02 opera volumio[1231]: info: Clearing queue after UPNP request Apr 30 11:39:02 opera volumio[1231]: info: CoreStateMachine::ClearQueue Apr 30 11:39:02 opera volumio[1231]: info: CoreStateMachine::stop Apr 30 11:39:02 opera volumio[1231]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 30 11:39:02 opera volumio[1231]: verbose: UNSET VOLATILE Apr 30 11:39:02 opera volumio[1231]: info: CorePlayQueue::clearPlayQueue Apr 30 11:39:02 opera volumio[1231]: info: CorePlayQueue::saveQueue Apr 30 11:39:02 opera volumio[1231]: info: CoreCommandRouter::volumioPushState Apr 30 11:39:02 opera volumio[1231]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:39:02 opera volumio[1231]: info: CoreCommandRouter::volumioPushQueue Apr 30 11:39:02 opera volumio[1231]: info: Updating RAAT Signal Path Apr 30 11:39:02 opera volumio[1231]: info: Apr 30 11:39:02 opera volumio[1231]: ---------------------------- MPD announces system playlist update Apr 30 11:39:02 opera volumio[1231]: info: Ignoring MPD Status Update Apr 30 11:39:02 opera volumio[1231]: error: updateQueue error: null Apr 30 11:39:02 opera volumio[1231]: info: ------------------------------ 1ms Apr 30 11:39:02 opera volumio[1231]: info: Starting UPNP Playback Apr 30 11:39:02 opera volumio[1231]: info: Preparing playback through UPNP Apr 30 11:39:02 opera volumio[1231]: info: CoreCommandRouter::volumioGetState Apr 30 11:39:02 opera volumio[1231]: info: CorePlayQueue::getTrack 0 Apr 30 11:39:02 opera volumio[1231]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 30 11:39:02 opera volumio[1231]: info: Apr 30 11:39:02 opera volumio[1231]: ---------------------------- MPD announces system playlist update Apr 30 11:39:02 opera volumio[1231]: info: Ignoring MPD Status Update Apr 30 11:39:02 opera volumio[1231]: info: ------------------------------ 1ms Apr 30 11:39:02 opera volumio[1231]: info: Apr 30 11:39:02 opera volumio[1231]: ---------------------------- MPD announces system playlist update Apr 30 11:39:02 opera volumio[1231]: info: Ignoring MPD Status Update Apr 30 11:39:02 opera volumio[1231]: info: ------------------------------ 1ms Apr 30 11:39:02 opera volumio[1231]: info: Apr 30 11:39:02 opera volumio[1231]: ---------------------------- MPD announces system playlist update Apr 30 11:39:02 opera volumio[1231]: info: Ignoring MPD Status Update Apr 30 11:39:02 opera volumio[1231]: info: ------------------------------ 1ms Apr 30 11:39:02 opera volumio[1231]: info: Apr 30 11:39:02 opera volumio[1231]: ---------------------------- MPD announces system playlist update Apr 30 11:39:02 opera volumio[1231]: info: Ignoring MPD Status Update Apr 30 11:39:02 opera volumio[1231]: info: ------------------------------ 1ms Apr 30 11:39:02 opera volumio[1231]: info: Apr 30 11:39:02 opera volumio[1231]: ---------------------------- MPD announces system playlist update Apr 30 11:39:02 opera volumio[1231]: info: Ignoring MPD Status Update Apr 30 11:39:02 opera volumio[1231]: info: ------------------------------ 1ms Apr 30 11:39:02 opera volumio[1231]: info: Apr 30 11:39:02 opera volumio[1231]: ---------------------------- MPD announces system playlist update Apr 30 11:39:02 opera volumio[1231]: info: Ignoring MPD Status Update Apr 30 11:39:02 opera volumio[1231]: info: ------------------------------ 1ms Apr 30 11:39:03 opera volumio[1231]: info: Apr 30 11:39:03 opera volumio[1231]: ---------------------------- MPD announces state update: player Apr 30 11:39:03 opera volumio[1231]: info: ControllerMpd::getState Apr 30 11:39:03 opera volumio[1231]: verbose: ControllerMpd::sendMpdCommand status Apr 30 11:39:03 opera volumio[1231]: info: sendMpdCommand status took 122 milliseconds Apr 30 11:39:03 opera volumio[1231]: verbose: ControllerMpd::parseState Apr 30 11:39:03 opera volumio[1231]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 11:39:03 opera volumio[1231]: info: Apr 30 11:39:03 opera volumio[1231]: ---------------------------- MPD announces state update: player Apr 30 11:39:03 opera volumio[1231]: info: ControllerMpd::getState Apr 30 11:39:03 opera volumio[1231]: verbose: ControllerMpd::sendMpdCommand status Apr 30 11:39:03 opera volumio[1231]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 30 11:39:03 opera volumio[1231]: verbose: ControllerMpd::parseTrackInfo Apr 30 11:39:03 opera volumio[1231]: info: ControllerMpd::pushState Apr 30 11:39:03 opera volumio[1231]: info: CoreCommandRouter::servicePushState Apr 30 11:39:03 opera volumio[1231]: verbose: In UPNP mode Apr 30 11:39:03 opera volumio[1231]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":200,"samplerate":"48 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"风和日丽","artist":"广汽丰田品牌音乐","album":"听见幸福","uri":"http://aqqmusic.tc.qq.com/F000003Ia3jb0jX3zP.flac?guid=000000005b56b722000001937137c5ff&vkey=CCB7D0E0710AA65697B9DEEECC8D8F009031A2EFC21EB2B62C49F3A9083583547303362EBFDFC03CAA20FD0EFE3435E6532A920BD4CFFF54__v21e2a171d&uin=1152921504950983260&src=F000003nBVYI1fbwLS.flac&redirect=1&fromtag=111114","trackType":""} Apr 30 11:39:03 opera volumio[1231]: verbose: CURRENT POSITION 0 Apr 30 11:39:03 opera volumio[1231]: info: CoreStateMachine::syncState stateService play Apr 30 11:39:03 opera volumio[1231]: info: CoreStateMachine::syncState currentStatus stop Apr 30 11:39:03 opera volumio[1231]: info: CoreStateMachine::pushState Apr 30 11:39:03 opera volumio[1231]: info: CoreCommandRouter::volumioPushState Apr 30 11:39:03 opera volumio[1231]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:39:03 opera volumio[1231]: info: ------------------------------ 133ms Apr 30 11:39:03 opera volumio[1231]: info: sendMpdCommand status took 9 milliseconds Apr 30 11:39:03 opera volumio[1231]: verbose: ControllerMpd::parseState Apr 30 11:39:03 opera volumio[1231]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 11:39:03 opera volumio[1231]: info: Updating RAAT Signal Path Apr 30 11:39:03 opera volumio[1231]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 30 11:39:03 opera volumio[1231]: verbose: ControllerMpd::parseTrackInfo Apr 30 11:39:03 opera volumio[1231]: info: ControllerMpd::pushState Apr 30 11:39:03 opera volumio[1231]: info: CoreCommandRouter::servicePushState Apr 30 11:39:03 opera volumio[1231]: verbose: In UPNP mode Apr 30 11:39:03 opera volumio[1231]: verbose: STATE SERVICE {"status":"play","position":0,"seek":480,"duration":200,"samplerate":"48 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"风和日丽","artist":"广汽丰田品牌音乐","album":"听见幸福","uri":"http://aqqmusic.tc.qq.com/F000003Ia3jb0jX3zP.flac?guid=000000005b56b722000001937137c5ff&vkey=CCB7D0E0710AA65697B9DEEECC8D8F009031A2EFC21EB2B62C49F3A9083583547303362EBFDFC03CAA20FD0EFE3435E6532A920BD4CFFF54__v21e2a171d&uin=1152921504950983260&src=F000003nBVYI1fbwLS.flac&redirect=1&fromtag=111114","trackType":""} Apr 30 11:39:03 opera volumio[1231]: verbose: CURRENT POSITION 0 Apr 30 11:39:03 opera volumio[1231]: info: CoreStateMachine::syncState stateService play Apr 30 11:39:03 opera volumio[1231]: info: CoreStateMachine::syncState currentStatus play Apr 30 11:39:03 opera volumio[1231]: info: Received an update from plugin. extracting info from payload Apr 30 11:39:03 opera volumio[1231]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 30 11:39:03 opera volumio[1231]: info: CoreStateMachine::pushState Apr 30 11:39:03 opera volumio[1231]: info: CoreCommandRouter::volumioPushState Apr 30 11:39:03 opera volumio[1231]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:39:03 opera volumio[1231]: info: CoreStateMachine::pushState Apr 30 11:39:03 opera volumio[1231]: info: CoreCommandRouter::volumioPushState Apr 30 11:39:03 opera volumio[1231]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 11:39:03 opera volumio[1231]: info: ------------------------------ 28ms Apr 30 11:39:03 opera volumio[1231]: info: CoreCommandRouter::volumioGetQueue Apr 30 11:39:03 opera volumio[1231]: info: CoreStateMachine::getQueue Apr 30 11:39:03 opera volumio[1231]: info: CorePlayQueue::getQueue Apr 30 11:39:03 opera volumio[1231]: info: CoreCommandRouter::volumioGetQueue Apr 30 11:39:03 opera volumio[1231]: info: CoreStateMachine::getQueue Apr 30 11:39:03 opera volumio[1231]: info: CorePlayQueue::getQueue Apr 30 11:39:03 opera volumio[1231]: info: Updating RAAT Signal Path Apr 30 11:39:03 opera volumio[1231]: info: Updating RAAT Signal Path Apr 30 11:39:03 opera volumio[1231]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Vexento/Northwind/b7e77745-af0c-465d-adbd-41917fce7659.jpg' Apr 30 11:40:13 opera systemd[1]: Starting Cleanup of Temporary Directories... Apr 30 11:40:13 opera volumio[1231]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 30 11:40:13 opera systemd[1]: Started Cleanup of Temporary Directories. Apr 30 11:40:34 opera volumio[1231]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 30 11:40:34 opera volumio[1231]: { Error: connect ETIMEDOUT 66.220.148.145:443 Apr 30 11:40:34 opera volumio[1231]: at Object._errnoException (util.js:1022:11) Apr 30 11:40:34 opera volumio[1231]: at _exceptionWithHostPort (util.js:1044:20) Apr 30 11:40:34 opera volumio[1231]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Apr 30 11:40:34 opera volumio[1231]: code: 'ETIMEDOUT', Apr 30 11:40:34 opera volumio[1231]: errno: 'ETIMEDOUT', Apr 30 11:40:34 opera volumio[1231]: syscall: 'connect', Apr 30 11:40:34 opera volumio[1231]: address: '66.220.148.145', Apr 30 11:40:34 opera volumio[1231]: port: 443 } Apr 30 11:40:34 opera volumio[1231]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 30 11:40:34 opera sudo[4147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-30 11:39 Apr 30 11:40:34 opera sudo[4147]: 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"