-- Logs begin at Wed 2024-04-10 03:50:57 UTC, end at Sun 2024-10-27 12:43:54 UTC. -- Oct 27 12:42:17 opera volumio[4816]: info: Oct 27 12:42:17 opera volumio[4816]: ---------------------------- MPD announces state update: player Oct 27 12:42:17 opera volumio[4816]: info: ControllerMpd::getState Oct 27 12:42:17 opera volumio[4816]: verbose: ControllerMpd::sendMpdCommand status Oct 27 12:42:17 opera volumio[4816]: info: sendMpdCommand status took 3 milliseconds Oct 27 12:42:17 opera volumio[4816]: verbose: ControllerMpd::parseState Oct 27 12:42:17 opera volumio[4816]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 12:42:17 opera volumio[4816]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 27 12:42:17 opera volumio[4816]: verbose: ControllerMpd::parseTrackInfo Oct 27 12:42:17 opera volumio[4816]: info: ControllerMpd::pushState Oct 27 12:42:17 opera volumio[4816]: info: CoreCommandRouter::servicePushState Oct 27 12:42:17 opera volumio[4816]: info: CoreStateMachine::pushState Oct 27 12:42:17 opera volumio[4816]: info: CoreCommandRouter::volumioPushState Oct 27 12:42:17 opera volumio[4816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 12:42:17 opera volumio[4816]: info: CorePlayQueue::getTrack 0 Oct 27 12:42:17 opera volumio[4816]: 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":"绿光","artist":"孙燕姿","album":"风筝","uri":"http://sjy6.stream.qqmusic.qq.com/F000001iKjYG0AZ9po.flac?guid=ffffffffcfe987ed00000192c77fcd97&vkey=BE6BAEF8D280DFD85EE31E0177784970C80FC2B5FC9CC5029BC5E60B242DB6E2934467613CD77DFB12D5F3C3214B83CEFBB1A12AC58312A6&uin=1152921505288012961&redirect=1&fromtag=111114","trackType":""} Oct 27 12:42:17 opera volumio[4816]: verbose: CURRENT POSITION 0 Oct 27 12:42:17 opera volumio[4816]: info: CoreStateMachine::syncState stateService stop Oct 27 12:42:17 opera volumio[4816]: info: CoreStateMachine::syncState currentStatus play Oct 27 12:42:17 opera volumio[4816]: info: CoreCommandRouter::volumioPushState Oct 27 12:42:17 opera volumio[4816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 12:42:17 opera volumio[4816]: info: CoreStateMachine::stPlaybackTimer Oct 27 12:42:17 opera volumio[4816]: info: ------------------------------ 26ms Oct 27 12:42:17 opera volumio[4816]: info: CoreCommandRouter::volumioGetQueue Oct 27 12:42:17 opera volumio[4816]: info: CoreStateMachine::getQueue Oct 27 12:42:17 opera volumio[4816]: info: CorePlayQueue::getQueue Oct 27 12:42:17 opera volumio[4816]: info: Clearing queue after UPNP request Oct 27 12:42:17 opera volumio[4816]: info: CoreStateMachine::ClearQueue Oct 27 12:42:17 opera volumio[4816]: info: CoreStateMachine::stop Oct 27 12:42:17 opera volumio[4816]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 12:42:17 opera volumio[4816]: verbose: UNSET VOLATILE Oct 27 12:42:17 opera volumio[4816]: info: CorePlayQueue::clearPlayQueue Oct 27 12:42:17 opera volumio[4816]: info: CorePlayQueue::saveQueue Oct 27 12:42:17 opera volumio[4816]: info: CoreCommandRouter::volumioPushState Oct 27 12:42:17 opera volumio[4816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 12:42:17 opera volumio[4816]: info: CoreCommandRouter::volumioPushQueue Oct 27 12:42:17 opera volumio[4816]: info: Oct 27 12:42:17 opera volumio[4816]: ---------------------------- MPD announces system playlist update Oct 27 12:42:17 opera volumio[4816]: info: Ignoring MPD Status Update Oct 27 12:42:17 opera volumio[4816]: error: updateQueue error: null Oct 27 12:42:17 opera volumio[4816]: info: ------------------------------ 2ms Oct 27 12:42:17 opera volumio[4816]: info: Starting UPNP Playback Oct 27 12:42:17 opera volumio[4816]: info: Preparing playback through UPNP Oct 27 12:42:17 opera volumio[4816]: info: CoreCommandRouter::volumioGetState Oct 27 12:42:17 opera volumio[4816]: info: CorePlayQueue::getTrack 0 Oct 27 12:42:17 opera volumio[4816]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 27 12:42:18 opera volumio[4816]: info: Oct 27 12:42:18 opera volumio[4816]: ---------------------------- MPD announces system playlist update Oct 27 12:42:18 opera volumio[4816]: info: Ignoring MPD Status Update Oct 27 12:42:18 opera volumio[4816]: info: Oct 27 12:42:18 opera volumio[4816]: ---------------------------- MPD announces system playlist update Oct 27 12:42:18 opera volumio[4816]: info: Ignoring MPD Status Update Oct 27 12:42:18 opera volumio[4816]: info: ------------------------------ 2ms Oct 27 12:42:18 opera volumio[4816]: info: ------------------------------ 1ms Oct 27 12:42:18 opera volumio[4816]: info: Oct 27 12:42:18 opera volumio[4816]: ---------------------------- MPD announces system playlist update Oct 27 12:42:18 opera volumio[4816]: info: Ignoring MPD Status Update Oct 27 12:42:18 opera volumio[4816]: info: ------------------------------ 1ms Oct 27 12:42:18 opera volumio[4816]: info: Oct 27 12:42:18 opera volumio[4816]: ---------------------------- MPD announces system playlist update Oct 27 12:42:18 opera volumio[4816]: info: Ignoring MPD Status Update Oct 27 12:42:18 opera volumio[4816]: info: ------------------------------ 1ms Oct 27 12:42:18 opera volumio[4816]: info: Oct 27 12:42:18 opera volumio[4816]: ---------------------------- MPD announces system playlist update Oct 27 12:42:18 opera volumio[4816]: info: Ignoring MPD Status Update Oct 27 12:42:18 opera volumio[4816]: info: ------------------------------ 2ms Oct 27 12:42:18 opera volumio[4816]: info: Oct 27 12:42:18 opera volumio[4816]: ---------------------------- MPD announces system playlist update Oct 27 12:42:18 opera volumio[4816]: info: Ignoring MPD Status Update Oct 27 12:42:18 opera volumio[4816]: info: ------------------------------ 1ms Oct 27 12:42:18 opera volumio[4816]: info: Oct 27 12:42:18 opera volumio[4816]: ---------------------------- MPD announces state update: player Oct 27 12:42:18 opera volumio[4816]: info: ControllerMpd::getState Oct 27 12:42:18 opera volumio[4816]: verbose: ControllerMpd::sendMpdCommand status Oct 27 12:42:18 opera volumio[4816]: info: Oct 27 12:42:18 opera volumio[4816]: ---------------------------- MPD announces state update: player Oct 27 12:42:18 opera volumio[4816]: info: Oct 27 12:42:18 opera volumio[4816]: ---------------------------- MPD announces system playlist update Oct 27 12:42:18 opera volumio[4816]: info: Ignoring MPD Status Update Oct 27 12:42:18 opera volumio[4816]: info: Oct 27 12:42:18 opera volumio[4816]: ---------------------------- MPD announces state update: player Oct 27 12:42:18 opera volumio[4816]: info: ControllerMpd::getState Oct 27 12:42:18 opera volumio[4816]: verbose: ControllerMpd::sendMpdCommand status Oct 27 12:42:18 opera volumio[4816]: info: sendMpdCommand status took 3 milliseconds Oct 27 12:42:18 opera volumio[4816]: info: ControllerMpd::getState Oct 27 12:42:18 opera volumio[4816]: verbose: ControllerMpd::sendMpdCommand status Oct 27 12:42:18 opera volumio[4816]: verbose: ControllerMpd::parseState Oct 27 12:42:18 opera volumio[4816]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 12:42:18 opera volumio[4816]: info: sendMpdCommand status took 4 milliseconds Oct 27 12:42:18 opera volumio[4816]: info: ------------------------------ 6ms Oct 27 12:42:18 opera volumio[4816]: info: sendMpdCommand status took 3 milliseconds Oct 27 12:42:18 opera volumio[4816]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 27 12:42:18 opera volumio[4816]: verbose: ControllerMpd::parseState Oct 27 12:42:18 opera volumio[4816]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 12:42:18 opera volumio[4816]: verbose: ControllerMpd::parseState Oct 27 12:42:18 opera volumio[4816]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 12:42:18 opera volumio[4816]: verbose: ControllerMpd::parseTrackInfo Oct 27 12:42:18 opera volumio[4816]: info: ControllerMpd::pushState Oct 27 12:42:18 opera volumio[4816]: info: CoreCommandRouter::servicePushState Oct 27 12:42:18 opera volumio[4816]: verbose: In UPNP mode Oct 27 12:42:18 opera volumio[4816]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"知足","artist":"五月天","album":"知足 最真杰作选","uri":"http://sjy6.stream.qqmusic.qq.com/F000001EmodV3uo6be.flac?guid=ffffffffcfe987ed00000192c77fcd97&vkey=B4CEBA4F1C0887B131579ED78990C59ACB6F7806E127D3CC21D522755268A019E88DF67C308BC11D3215FDD95399FCDF6925848BFA14BBD1&uin=1152921505288012961&redirect=1&fromtag=111114","trackType":""} Oct 27 12:42:18 opera volumio[4816]: verbose: CURRENT POSITION 0 Oct 27 12:42:18 opera volumio[4816]: info: CoreStateMachine::syncState stateService play Oct 27 12:42:18 opera volumio[4816]: info: CoreStateMachine::syncState currentStatus stop Oct 27 12:42:18 opera volumio[4816]: info: CoreStateMachine::pushState Oct 27 12:42:18 opera volumio[4816]: info: CoreCommandRouter::volumioPushState Oct 27 12:42:18 opera volumio[4816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 12:42:18 opera volumio[4816]: info: ------------------------------ 28ms Oct 27 12:42:18 opera volumio[4816]: info: sendMpdCommand playlistinfo took 18 milliseconds Oct 27 12:42:18 opera volumio[4816]: info: sendMpdCommand playlistinfo took 19 milliseconds Oct 27 12:42:18 opera volumio[4816]: verbose: ControllerMpd::parseTrackInfo Oct 27 12:42:18 opera volumio[4816]: verbose: ControllerMpd::parseTrackInfo Oct 27 12:42:18 opera volumio[4816]: info: ControllerMpd::pushState Oct 27 12:42:18 opera volumio[4816]: info: CoreCommandRouter::servicePushState Oct 27 12:42:18 opera volumio[4816]: verbose: In UPNP mode Oct 27 12:42:18 opera volumio[4816]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"知足","artist":"五月天","album":"知足 最真杰作选","uri":"http://sjy6.stream.qqmusic.qq.com/F000001EmodV3uo6be.flac?guid=ffffffffcfe987ed00000192c77fcd97&vkey=B4CEBA4F1C0887B131579ED78990C59ACB6F7806E127D3CC21D522755268A019E88DF67C308BC11D3215FDD95399FCDF6925848BFA14BBD1&uin=1152921505288012961&redirect=1&fromtag=111114","trackType":""} Oct 27 12:42:18 opera volumio[4816]: verbose: CURRENT POSITION 0 Oct 27 12:42:18 opera volumio[4816]: info: CoreStateMachine::syncState stateService play Oct 27 12:42:18 opera volumio[4816]: info: CoreStateMachine::syncState currentStatus play Oct 27 12:42:18 opera volumio[4816]: info: Received an update from plugin. extracting info from payload Oct 27 12:42:18 opera volumio[4816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 27 12:42:18 opera volumio[4816]: info: CoreStateMachine::pushState Oct 27 12:42:18 opera volumio[4816]: info: CoreCommandRouter::volumioPushState Oct 27 12:42:18 opera volumio[4816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 12:42:18 opera volumio[4816]: info: CoreStateMachine::pushState Oct 27 12:42:18 opera volumio[4816]: info: CoreCommandRouter::volumioPushState Oct 27 12:42:18 opera volumio[4816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 12:42:18 opera volumio[4816]: info: ControllerMpd::pushState Oct 27 12:42:18 opera volumio[4816]: info: CoreCommandRouter::servicePushState Oct 27 12:42:18 opera volumio[4816]: verbose: In UPNP mode Oct 27 12:42:18 opera volumio[4816]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":257,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"知足","artist":"五月天","album":"知足 最真杰作选","uri":"http://sjy6.stream.qqmusic.qq.com/F000001EmodV3uo6be.flac?guid=ffffffffcfe987ed00000192c77fcd97&vkey=B4CEBA4F1C0887B131579ED78990C59ACB6F7806E127D3CC21D522755268A019E88DF67C308BC11D3215FDD95399FCDF6925848BFA14BBD1&uin=1152921505288012961&redirect=1&fromtag=111114","trackType":""} Oct 27 12:42:18 opera volumio[4816]: verbose: CURRENT POSITION 0 Oct 27 12:42:18 opera volumio[4816]: info: CoreStateMachine::syncState stateService play Oct 27 12:42:18 opera volumio[4816]: info: CoreStateMachine::syncState currentStatus play Oct 27 12:42:18 opera volumio[4816]: info: Received an update from plugin. extracting info from payload Oct 27 12:42:18 opera volumio[4816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 27 12:42:18 opera volumio[4816]: info: CoreStateMachine::pushState Oct 27 12:42:18 opera volumio[4816]: info: CoreCommandRouter::volumioPushState Oct 27 12:42:18 opera volumio[4816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 12:42:18 opera volumio[4816]: info: CoreStateMachine::pushState Oct 27 12:42:18 opera volumio[4816]: info: CoreCommandRouter::volumioPushState Oct 27 12:42:18 opera volumio[4816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 12:42:18 opera volumio[4816]: info: ------------------------------ 63ms Oct 27 12:42:18 opera volumio[4816]: info: ------------------------------ 63ms Oct 27 12:42:18 opera volumio[4816]: info: CoreCommandRouter::volumioGetQueue Oct 27 12:42:18 opera volumio[4816]: info: CoreStateMachine::getQueue Oct 27 12:42:18 opera volumio[4816]: info: CorePlayQueue::getQueue Oct 27 12:42:18 opera volumio[4816]: info: CoreCommandRouter::volumioGetQueue Oct 27 12:42:18 opera volumio[4816]: info: CoreStateMachine::getQueue Oct 27 12:42:18 opera volumio[4816]: info: CorePlayQueue::getQueue Oct 27 12:42:18 opera volumio[4816]: info: CoreCommandRouter::volumioGetQueue Oct 27 12:42:18 opera volumio[4816]: info: CoreStateMachine::getQueue Oct 27 12:42:18 opera volumio[4816]: info: CorePlayQueue::getQueue Oct 27 12:42:18 opera volumio[4816]: info: CoreCommandRouter::volumioGetQueue Oct 27 12:42:18 opera volumio[4816]: info: CoreStateMachine::getQueue Oct 27 12:42:18 opera volumio[4816]: info: CorePlayQueue::getQueue Oct 27 12:42:18 opera volumio[4816]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%AD%99%E7%87%95%E5%A7%BF/%E9%A3%8E%E7%AD%9D/57301071-865b-4b3f-baaa-bb4cf871a764.jpg' Oct 27 12:43:54 opera volumio[4816]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 27 12:43:54 opera volumio[4816]: { Error: connect ETIMEDOUT 157.240.12.50:443 Oct 27 12:43:54 opera volumio[4816]: at Object._errnoException (util.js:1022:11) Oct 27 12:43:54 opera volumio[4816]: at _exceptionWithHostPort (util.js:1044:20) Oct 27 12:43:54 opera volumio[4816]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Oct 27 12:43:54 opera volumio[4816]: code: 'ETIMEDOUT', Oct 27 12:43:54 opera volumio[4816]: errno: 'ETIMEDOUT', Oct 27 12:43:54 opera volumio[4816]: syscall: 'connect', Oct 27 12:43:54 opera volumio[4816]: address: '157.240.12.50', Oct 27 12:43:54 opera volumio[4816]: port: 443 } Oct 27 12:43:54 opera volumio[4816]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 27 12:43:54 opera sudo[5685]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-27 12:42 Oct 27 12:43:54 opera sudo[5685]: 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"