-- Logs begin at Sun 2022-08-07 08:25:03 UTC, end at Sun 2024-03-31 05:27:20 UTC. -- Mar 31 05:27:08 opera volumio[17933]: info: Mar 31 05:27:08 opera volumio[17933]: ---------------------------- MPD announces state update: player Mar 31 05:27:08 opera volumio[17933]: info: ControllerMpd::getState Mar 31 05:27:08 opera volumio[17933]: verbose: ControllerMpd::sendMpdCommand status Mar 31 05:27:08 opera volumio[17933]: info: sendMpdCommand status took 0 milliseconds Mar 31 05:27:08 opera volumio[17933]: verbose: ControllerMpd::parseState Mar 31 05:27:08 opera volumio[17933]: info: ControllerMpd::pushState Mar 31 05:27:08 opera volumio[17933]: info: CoreCommandRouter::servicePushState Mar 31 05:27:08 opera volumio[17933]: info: CoreStateMachine::pushState Mar 31 05:27:08 opera volumio[17933]: info: CoreCommandRouter::volumioPushState Mar 31 05:27:08 opera volumio[17933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 05:27:08 opera volumio[17933]: info: CorePlayQueue::getTrack 0 Mar 31 05:27:08 opera volumio[17933]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 31 05:27:08 opera volumio[17933]: verbose: CURRENT POSITION 0 Mar 31 05:27:08 opera volumio[17933]: info: CoreStateMachine::syncState stateService stop Mar 31 05:27:08 opera volumio[17933]: info: CoreStateMachine::syncState currentStatus play Mar 31 05:27:08 opera volumio[17933]: info: CoreCommandRouter::volumioPushState Mar 31 05:27:08 opera volumio[17933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 05:27:08 opera volumio[17933]: info: CoreStateMachine::stPlaybackTimer Mar 31 05:27:08 opera volumio[17933]: info: ------------------------------ 12ms Mar 31 05:27:08 opera volumio[17933]: info: Updating RAAT Signal Path Mar 31 05:27:08 opera volumio[17933]: info: Updating RAAT Signal Path Mar 31 05:27:08 opera volumio[17933]: info: CoreCommandRouter::volumioGetQueue Mar 31 05:27:08 opera volumio[17933]: info: CoreStateMachine::getQueue Mar 31 05:27:08 opera volumio[17933]: info: CorePlayQueue::getQueue Mar 31 05:27:09 opera volumio[17933]: info: Clearing queue after UPNP request Mar 31 05:27:09 opera volumio[17933]: info: CoreStateMachine::ClearQueue Mar 31 05:27:09 opera volumio[17933]: info: CoreStateMachine::stop Mar 31 05:27:09 opera volumio[17933]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 31 05:27:09 opera volumio[17933]: verbose: UNSET VOLATILE Mar 31 05:27:09 opera volumio[17933]: info: CorePlayQueue::clearPlayQueue Mar 31 05:27:09 opera volumio[17933]: info: CorePlayQueue::saveQueue Mar 31 05:27:09 opera volumio[17933]: info: CoreCommandRouter::volumioPushState Mar 31 05:27:09 opera volumio[17933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 05:27:09 opera volumio[17933]: info: CoreCommandRouter::volumioPushQueue Mar 31 05:27:09 opera volumio[17933]: info: Updating RAAT Signal Path Mar 31 05:27:09 opera volumio[17933]: info: Mar 31 05:27:09 opera volumio[17933]: ---------------------------- MPD announces system playlist update Mar 31 05:27:09 opera volumio[17933]: info: Ignoring MPD Status Update Mar 31 05:27:09 opera volumio[17933]: error: updateQueue error: null Mar 31 05:27:09 opera volumio[17933]: info: ------------------------------ 2ms Mar 31 05:27:09 opera volumio[17933]: info: Starting UPNP Playback Mar 31 05:27:09 opera volumio[17933]: info: Preparing playback through UPNP Mar 31 05:27:09 opera volumio[17933]: info: CoreCommandRouter::volumioGetState Mar 31 05:27:09 opera volumio[17933]: info: CorePlayQueue::getTrack 0 Mar 31 05:27:09 opera volumio[17933]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 31 05:27:10 opera volumio[17933]: info: Mar 31 05:27:10 opera volumio[17933]: ---------------------------- MPD announces system playlist update Mar 31 05:27:10 opera volumio[17933]: info: Ignoring MPD Status Update Mar 31 05:27:10 opera volumio[17933]: info: ------------------------------ 2ms Mar 31 05:27:10 opera volumio[17933]: info: Mar 31 05:27:10 opera volumio[17933]: ---------------------------- MPD announces system playlist update Mar 31 05:27:10 opera volumio[17933]: info: Ignoring MPD Status Update Mar 31 05:27:10 opera volumio[17933]: info: ------------------------------ 6ms Mar 31 05:27:10 opera volumio[17933]: info: Mar 31 05:27:10 opera volumio[17933]: ---------------------------- MPD announces system playlist update Mar 31 05:27:10 opera volumio[17933]: info: Ignoring MPD Status Update Mar 31 05:27:10 opera volumio[17933]: info: ------------------------------ 1ms Mar 31 05:27:10 opera volumio[17933]: info: Mar 31 05:27:10 opera volumio[17933]: ---------------------------- MPD announces system playlist update Mar 31 05:27:10 opera volumio[17933]: info: Ignoring MPD Status Update Mar 31 05:27:10 opera volumio[17933]: info: ------------------------------ 1ms Mar 31 05:27:10 opera volumio[17933]: info: Mar 31 05:27:10 opera volumio[17933]: ---------------------------- MPD announces system playlist update Mar 31 05:27:10 opera volumio[17933]: info: Ignoring MPD Status Update Mar 31 05:27:10 opera volumio[17933]: info: Mar 31 05:27:10 opera volumio[17933]: ---------------------------- MPD announces system playlist update Mar 31 05:27:10 opera volumio[17933]: info: Ignoring MPD Status Update Mar 31 05:27:10 opera volumio[17933]: info: ------------------------------ 1ms Mar 31 05:27:10 opera volumio[17933]: info: ------------------------------ 1ms Mar 31 05:27:11 opera volumio[17933]: info: Mar 31 05:27:11 opera volumio[17933]: ---------------------------- MPD announces state update: player Mar 31 05:27:11 opera volumio[17933]: info: ControllerMpd::getState Mar 31 05:27:11 opera volumio[17933]: verbose: ControllerMpd::sendMpdCommand status Mar 31 05:27:11 opera volumio[17933]: info: Mar 31 05:27:11 opera volumio[17933]: ---------------------------- MPD announces state update: player Mar 31 05:27:11 opera volumio[17933]: info: sendMpdCommand status took 4 milliseconds Mar 31 05:27:11 opera volumio[17933]: info: ControllerMpd::getState Mar 31 05:27:11 opera volumio[17933]: verbose: ControllerMpd::sendMpdCommand status Mar 31 05:27:11 opera volumio[17933]: verbose: ControllerMpd::parseState Mar 31 05:27:11 opera volumio[17933]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 05:27:11 opera volumio[17933]: info: sendMpdCommand status took 4 milliseconds Mar 31 05:27:11 opera volumio[17933]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 31 05:27:11 opera volumio[17933]: verbose: ControllerMpd::parseState Mar 31 05:27:11 opera volumio[17933]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 31 05:27:11 opera volumio[17933]: verbose: ControllerMpd::parseTrackInfo Mar 31 05:27:11 opera volumio[17933]: info: ControllerMpd::pushState Mar 31 05:27:11 opera volumio[17933]: info: CoreCommandRouter::servicePushState Mar 31 05:27:11 opera volumio[17933]: verbose: In UPNP mode Mar 31 05:27:11 opera volumio[17933]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"48 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Goldberg Variations, BWV 988 - Aria (G大调哥德堡变奏曲，BWV 988)","artist":"Fazil Say","album":"J. S. Bach: Goldberg Variations, BWV 988","uri":"http://220.169.152.211/amobile.music.tc.qq.com/F000000tZNkT4PcgFw.flac?guid=ffffffffdb8376ce00000187bcfbf78f&vkey=2C0F2E81B895E3E8CC8CFC542335AA76C714840F626FA0BA21D06E8BF01C4D322A9D33167939A99BD724E94C6D685080E1B737578D7A2D85&uin=2838229&src=F000003meLjR1GslmD.flac&redirect=1&fromtag=111114","trackType":""} Mar 31 05:27:11 opera volumio[17933]: verbose: CURRENT POSITION 0 Mar 31 05:27:11 opera volumio[17933]: info: CoreStateMachine::syncState stateService play Mar 31 05:27:11 opera volumio[17933]: info: CoreStateMachine::syncState currentStatus stop Mar 31 05:27:11 opera volumio[17933]: info: CoreStateMachine::pushState Mar 31 05:27:11 opera volumio[17933]: info: CoreCommandRouter::volumioPushState Mar 31 05:27:11 opera volumio[17933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 05:27:11 opera volumio[17933]: info: ------------------------------ 19ms Mar 31 05:27:11 opera volumio[17933]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 31 05:27:11 opera volumio[17933]: verbose: ControllerMpd::parseTrackInfo Mar 31 05:27:11 opera volumio[17933]: info: ControllerMpd::pushState Mar 31 05:27:11 opera volumio[17933]: info: CoreCommandRouter::servicePushState Mar 31 05:27:11 opera volumio[17933]: verbose: In UPNP mode Mar 31 05:27:11 opera volumio[17933]: verbose: STATE SERVICE {"status":"play","position":0,"seek":480,"duration":277,"samplerate":"48 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Goldberg Variations, BWV 988 - Aria (G大调哥德堡变奏曲，BWV 988)","artist":"Fazil Say","album":"J. S. Bach: Goldberg Variations, BWV 988","uri":"http://220.169.152.211/amobile.music.tc.qq.com/F000000tZNkT4PcgFw.flac?guid=ffffffffdb8376ce00000187bcfbf78f&vkey=2C0F2E81B895E3E8CC8CFC542335AA76C714840F626FA0BA21D06E8BF01C4D322A9D33167939A99BD724E94C6D685080E1B737578D7A2D85&uin=2838229&src=F000003meLjR1GslmD.flac&redirect=1&fromtag=111114","trackType":""} Mar 31 05:27:11 opera volumio[17933]: verbose: CURRENT POSITION 0 Mar 31 05:27:11 opera volumio[17933]: info: CoreStateMachine::syncState stateService play Mar 31 05:27:11 opera volumio[17933]: info: CoreStateMachine::syncState currentStatus play Mar 31 05:27:11 opera volumio[17933]: info: Received an update from plugin. extracting info from payload Mar 31 05:27:11 opera volumio[17933]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 31 05:27:11 opera volumio[17933]: info: CoreStateMachine::pushState Mar 31 05:27:11 opera volumio[17933]: info: CoreCommandRouter::volumioPushState Mar 31 05:27:11 opera volumio[17933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 05:27:11 opera volumio[17933]: info: CoreStateMachine::pushState Mar 31 05:27:11 opera volumio[17933]: info: CoreCommandRouter::volumioPushState Mar 31 05:27:11 opera volumio[17933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 31 05:27:11 opera volumio[17933]: info: ------------------------------ 31ms Mar 31 05:27:11 opera volumio[17933]: info: Updating RAAT Signal Path Mar 31 05:27:11 opera volumio[17933]: info: Updating RAAT Signal Path Mar 31 05:27:11 opera volumio[17933]: info: Updating RAAT Signal Path Mar 31 05:27:11 opera volumio[17933]: info: CoreCommandRouter::volumioGetQueue Mar 31 05:27:11 opera volumio[17933]: info: CoreStateMachine::getQueue Mar 31 05:27:11 opera volumio[17933]: info: CorePlayQueue::getQueue Mar 31 05:27:11 opera volumio[17933]: info: CoreCommandRouter::volumioGetQueue Mar 31 05:27:11 opera volumio[17933]: info: CoreStateMachine::getQueue Mar 31 05:27:11 opera volumio[17933]: info: CorePlayQueue::getQueue Mar 31 05:27:11 opera volumio[17933]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Fazil%20Say/J.%20S.%20Bach%3A%20Goldberg%20Variations%2C%20BWV%20988/8c8893f3-8e36-46ed-89d7-6588756bb1a6.jpg' Mar 31 05:27:20 opera volumio[17933]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 31 05:27:20 opera volumio[17933]: { Error: connect ETIMEDOUT 174.36.228.136:443 Mar 31 05:27:20 opera volumio[17933]: at Object._errnoException (util.js:1022:11) Mar 31 05:27:20 opera volumio[17933]: at _exceptionWithHostPort (util.js:1044:20) Mar 31 05:27:20 opera volumio[17933]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Mar 31 05:27:20 opera volumio[17933]: code: 'ETIMEDOUT', Mar 31 05:27:20 opera volumio[17933]: errno: 'ETIMEDOUT', Mar 31 05:27:20 opera volumio[17933]: syscall: 'connect', Mar 31 05:27:20 opera volumio[17933]: address: '174.36.228.136', Mar 31 05:27:20 opera volumio[17933]: port: 443 } Mar 31 05:27:20 opera volumio[17933]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 31 05:27:20 opera sudo[24809]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-31 05:26 Mar 31 05:27:20 opera sudo[24809]: 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"