-- Logs begin at Mon 2024-03-25 15:04:43 UTC, end at Wed 2024-04-24 14:34:56 UTC. -- Apr 24 14:33:00 opera volumio[11996]: info: Clearing queue after UPNP request Apr 24 14:33:00 opera volumio[11996]: info: CoreStateMachine::ClearQueue Apr 24 14:33:00 opera volumio[11996]: info: CoreStateMachine::stop Apr 24 14:33:00 opera volumio[11996]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 24 14:33:00 opera volumio[11996]: verbose: UNSET VOLATILE Apr 24 14:33:00 opera volumio[11996]: info: CorePlayQueue::clearPlayQueue Apr 24 14:33:00 opera volumio[11996]: info: CorePlayQueue::saveQueue Apr 24 14:33:00 opera volumio[11996]: info: CoreCommandRouter::volumioPushState Apr 24 14:33:00 opera volumio[11996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 14:33:00 opera volumio[11996]: info: CoreCommandRouter::volumioPushQueue Apr 24 14:33:00 opera volumio[11996]: info: Updating RAAT Signal Path Apr 24 14:33:00 opera volumio[11996]: info: Apr 24 14:33:00 opera volumio[11996]: ---------------------------- MPD announces system playlist update Apr 24 14:33:00 opera volumio[11996]: info: Ignoring MPD Status Update Apr 24 14:33:00 opera volumio[11996]: error: updateQueue error: null Apr 24 14:33:00 opera volumio[11996]: info: ------------------------------ 4ms Apr 24 14:33:00 opera volumio[11996]: info: Starting UPNP Playback Apr 24 14:33:00 opera volumio[11996]: info: Preparing playback through UPNP Apr 24 14:33:00 opera volumio[11996]: info: CoreCommandRouter::volumioGetState Apr 24 14:33:00 opera volumio[11996]: info: CorePlayQueue::getTrack 0 Apr 24 14:33:00 opera volumio[11996]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 24 14:33:00 opera volumio[11996]: info: Apr 24 14:33:00 opera volumio[11996]: ---------------------------- MPD announces system playlist update Apr 24 14:33:00 opera volumio[11996]: info: Ignoring MPD Status Update Apr 24 14:33:00 opera volumio[11996]: info: ------------------------------ 2ms Apr 24 14:33:00 opera volumio[11996]: info: Apr 24 14:33:00 opera volumio[11996]: ---------------------------- MPD announces system playlist update Apr 24 14:33:00 opera volumio[11996]: info: Ignoring MPD Status Update Apr 24 14:33:00 opera volumio[11996]: info: ------------------------------ 1ms Apr 24 14:33:00 opera volumio[11996]: info: Apr 24 14:33:00 opera volumio[11996]: ---------------------------- MPD announces system playlist update Apr 24 14:33:00 opera volumio[11996]: info: Ignoring MPD Status Update Apr 24 14:33:00 opera volumio[11996]: info: ------------------------------ 1ms Apr 24 14:33:00 opera volumio[11996]: info: Apr 24 14:33:00 opera volumio[11996]: ---------------------------- MPD announces system playlist update Apr 24 14:33:00 opera volumio[11996]: info: Ignoring MPD Status Update Apr 24 14:33:00 opera volumio[11996]: info: ------------------------------ 1ms Apr 24 14:33:00 opera volumio[11996]: info: Apr 24 14:33:00 opera volumio[11996]: ---------------------------- MPD announces system playlist update Apr 24 14:33:00 opera volumio[11996]: info: Ignoring MPD Status Update Apr 24 14:33:00 opera volumio[11996]: info: ------------------------------ 0ms Apr 24 14:33:00 opera volumio[11996]: info: Apr 24 14:33:00 opera volumio[11996]: ---------------------------- MPD announces system playlist update Apr 24 14:33:00 opera volumio[11996]: info: Ignoring MPD Status Update Apr 24 14:33:00 opera volumio[11996]: info: ------------------------------ 0ms Apr 24 14:33:01 opera volumio[11996]: info: Apr 24 14:33:01 opera volumio[11996]: ---------------------------- MPD announces state update: player Apr 24 14:33:01 opera volumio[11996]: info: ControllerMpd::getState Apr 24 14:33:01 opera volumio[11996]: verbose: ControllerMpd::sendMpdCommand status Apr 24 14:33:01 opera volumio[11996]: info: Apr 24 14:33:01 opera volumio[11996]: ---------------------------- MPD announces state update: player Apr 24 14:33:01 opera volumio[11996]: info: sendMpdCommand status took 1 milliseconds Apr 24 14:33:01 opera volumio[11996]: info: ControllerMpd::getState Apr 24 14:33:01 opera volumio[11996]: verbose: ControllerMpd::sendMpdCommand status Apr 24 14:33:01 opera volumio[11996]: verbose: ControllerMpd::parseState Apr 24 14:33:01 opera volumio[11996]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 14:33:01 opera volumio[11996]: info: Apr 24 14:33:01 opera volumio[11996]: ---------------------------- MPD announces system playlist update Apr 24 14:33:01 opera volumio[11996]: info: Ignoring MPD Status Update Apr 24 14:33:01 opera volumio[11996]: info: sendMpdCommand status took 1 milliseconds Apr 24 14:33:01 opera volumio[11996]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 24 14:33:01 opera volumio[11996]: verbose: ControllerMpd::parseState Apr 24 14:33:01 opera volumio[11996]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 24 14:33:01 opera volumio[11996]: verbose: ControllerMpd::parseTrackInfo Apr 24 14:33:01 opera volumio[11996]: info: ControllerMpd::pushState Apr 24 14:33:01 opera volumio[11996]: info: CoreCommandRouter::servicePushState Apr 24 14:33:01 opera volumio[11996]: verbose: In UPNP mode Apr 24 14:33:01 opera volumio[11996]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":233,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"花街70号","artist":"林子祥","album":"十三子祥","uri":"http://fsandroid.hw.kugou.com/202404242232/145c414980b84c0aca8e1b9ef2b4999f/v3/e53869113dab536fcf5b20c3d3cb7964/yp/full/a1005_u860592677_d1ssm9k2gidxy4m5c9b1hnurd_p2_mx28210009_qflac_s4028725913.flac","trackType":"flac"} Apr 24 14:33:01 opera volumio[11996]: verbose: CURRENT POSITION 0 Apr 24 14:33:01 opera volumio[11996]: info: CoreStateMachine::syncState stateService play Apr 24 14:33:01 opera volumio[11996]: info: CoreStateMachine::syncState currentStatus stop Apr 24 14:33:01 opera volumio[11996]: info: CoreStateMachine::pushState Apr 24 14:33:01 opera volumio[11996]: info: CoreCommandRouter::volumioPushState Apr 24 14:33:01 opera volumio[11996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 14:33:01 opera volumio[11996]: info: ------------------------------ 14ms Apr 24 14:33:01 opera volumio[11996]: info: ------------------------------ 11ms Apr 24 14:33:01 opera volumio[11996]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 24 14:33:01 opera volumio[11996]: verbose: ControllerMpd::parseTrackInfo Apr 24 14:33:01 opera volumio[11996]: info: ControllerMpd::pushState Apr 24 14:33:01 opera volumio[11996]: info: CoreCommandRouter::servicePushState Apr 24 14:33:01 opera volumio[11996]: verbose: In UPNP mode Apr 24 14:33:01 opera volumio[11996]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":233,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"772 Kbps","isStreaming":false,"title":"花街70号","artist":"林子祥","album":"十三子祥","uri":"http://fsandroid.hw.kugou.com/202404242232/145c414980b84c0aca8e1b9ef2b4999f/v3/e53869113dab536fcf5b20c3d3cb7964/yp/full/a1005_u860592677_d1ssm9k2gidxy4m5c9b1hnurd_p2_mx28210009_qflac_s4028725913.flac","trackType":"flac"} Apr 24 14:33:01 opera volumio[11996]: verbose: CURRENT POSITION 0 Apr 24 14:33:01 opera volumio[11996]: info: CoreStateMachine::syncState stateService play Apr 24 14:33:01 opera volumio[11996]: info: CoreStateMachine::syncState currentStatus play Apr 24 14:33:01 opera volumio[11996]: info: Received an update from plugin. extracting info from payload Apr 24 14:33:01 opera volumio[11996]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 24 14:33:01 opera volumio[11996]: info: CoreStateMachine::pushState Apr 24 14:33:01 opera volumio[11996]: info: CoreCommandRouter::volumioPushState Apr 24 14:33:01 opera volumio[11996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 14:33:01 opera volumio[11996]: info: CoreStateMachine::pushState Apr 24 14:33:01 opera volumio[11996]: info: CoreCommandRouter::volumioPushState Apr 24 14:33:01 opera volumio[11996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 24 14:33:01 opera volumio[11996]: info: ------------------------------ 26ms Apr 24 14:33:01 opera volumio[11996]: info: Updating RAAT Signal Path Apr 24 14:33:01 opera volumio[11996]: info: Updating RAAT Signal Path Apr 24 14:33:01 opera volumio[11996]: info: Updating RAAT Signal Path Apr 24 14:33:01 opera volumio[11996]: info: CoreCommandRouter::volumioGetQueue Apr 24 14:33:01 opera volumio[11996]: info: CoreStateMachine::getQueue Apr 24 14:33:01 opera volumio[11996]: info: CorePlayQueue::getQueue Apr 24 14:33:01 opera volumio[11996]: info: CoreCommandRouter::volumioGetQueue Apr 24 14:33:01 opera volumio[11996]: info: CoreStateMachine::getQueue Apr 24 14:33:01 opera volumio[11996]: info: CorePlayQueue::getQueue Apr 24 14:33:01 opera volumio[11996]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9E%97%E5%AD%90%E7%A5%A5/71810e4e-c85e-442a-b237-26998f70a1cc.jpg' Apr 24 14:33:01 opera volumio[11996]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9E%97%E5%AD%90%E7%A5%A5/%E5%8D%81%E4%B8%89%E5%AD%90%E7%A5%A5/07e99616-94d1-4084-8b74-9f63e2e2c692.jpg' Apr 24 14:34:56 opera volumio[11996]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 24 14:34:56 opera volumio[11996]: { Error: connect ETIMEDOUT 173.244.209.150:80 Apr 24 14:34:56 opera volumio[11996]: at Object._errnoException (util.js:1022:11) Apr 24 14:34:56 opera volumio[11996]: at _exceptionWithHostPort (util.js:1044:20) Apr 24 14:34:56 opera volumio[11996]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Apr 24 14:34:56 opera volumio[11996]: code: 'ETIMEDOUT', Apr 24 14:34:56 opera volumio[11996]: errno: 'ETIMEDOUT', Apr 24 14:34:56 opera volumio[11996]: syscall: 'connect', Apr 24 14:34:56 opera volumio[11996]: address: '173.244.209.150', Apr 24 14:34:56 opera volumio[11996]: port: 80 } Apr 24 14:34:56 opera volumio[11996]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 24 14:34:56 opera sudo[21487]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-24 14:33 Apr 24 14:34:56 opera sudo[21487]: 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"