-- Logs begin at Fri 2024-07-12 07:45:05 UTC, end at Sun 2025-01-19 13:20:23 UTC. -- Jan 19 13:20:18 opera volumio[7968]: info: Jan 19 13:20:18 opera volumio[7968]: ---------------------------- MPD announces state update: player Jan 19 13:20:18 opera volumio[7968]: info: ControllerMpd::getState Jan 19 13:20:18 opera volumio[7968]: verbose: ControllerMpd::sendMpdCommand status Jan 19 13:20:18 opera volumio[7968]: info: sendMpdCommand status took 0 milliseconds Jan 19 13:20:18 opera volumio[7968]: verbose: ControllerMpd::parseState Jan 19 13:20:18 opera volumio[7968]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 13:20:18 opera volumio[7968]: info: sendMpdCommand playlistinfo took 0 milliseconds Jan 19 13:20:18 opera volumio[7968]: verbose: ControllerMpd::parseTrackInfo Jan 19 13:20:18 opera volumio[7968]: info: ControllerMpd::pushState Jan 19 13:20:18 opera volumio[7968]: info: CoreCommandRouter::servicePushState Jan 19 13:20:18 opera volumio[7968]: info: CoreStateMachine::pushState Jan 19 13:20:18 opera volumio[7968]: info: CoreCommandRouter::volumioPushState Jan 19 13:20:18 opera volumio[7968]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 13:20:18 opera volumio[7968]: info: CorePlayQueue::getTrack 0 Jan 19 13:20:18 opera volumio[7968]: 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":"Titans","artist":"Vangelis","album":"Alexander (Original Motion Picture Soundtrack)","uri":"http://aqqmusic.tc.qq.com/F000003XeHfI4cdo3k.flac?guid=000000005b56b722000001937137c5ff&vkey=A348CD6E007BD7A506981FE02D2A9EE39F483B4E78BA318CFBE1CA6CFB94F5657CE0242228E7D0D9D5B3C458E9879C7875D0CABF7265F058__v21e2a16b4&uin=1152921504950983260&src=F000000jPrbF16HgnW.flac&redirect=1&fromtag=111114","trackType":""} Jan 19 13:20:18 opera volumio[7968]: verbose: CURRENT POSITION 0 Jan 19 13:20:18 opera volumio[7968]: info: CoreStateMachine::syncState stateService stop Jan 19 13:20:18 opera volumio[7968]: info: CoreStateMachine::syncState currentStatus play Jan 19 13:20:18 opera volumio[7968]: info: CoreStateMachine::play index undefined Jan 19 13:20:18 opera volumio[7968]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 19 13:20:18 opera volumio[7968]: info: CoreStateMachine::pushState Jan 19 13:20:18 opera volumio[7968]: info: CorePlayQueue::getTrack 0 Jan 19 13:20:18 opera volumio[7968]: info: CoreCommandRouter::volumioPushState Jan 19 13:20:18 opera volumio[7968]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 13:20:18 opera volumio[7968]: info: CorePlayQueue::getTrack 0 Jan 19 13:20:18 opera volumio[7968]: info: ------------------------------ 28ms Jan 19 13:20:18 opera volumio[7968]: info: Updating RAAT Signal Path Jan 19 13:20:18 opera volumio[7968]: info: Updating RAAT Signal Path Jan 19 13:20:18 opera volumio[7968]: info: CoreCommandRouter::volumioGetQueue Jan 19 13:20:18 opera volumio[7968]: info: CoreStateMachine::getQueue Jan 19 13:20:18 opera volumio[7968]: info: CorePlayQueue::getQueue Jan 19 13:20:19 opera volumio[7968]: info: Clearing queue after UPNP request Jan 19 13:20:19 opera volumio[7968]: info: CoreStateMachine::ClearQueue Jan 19 13:20:19 opera volumio[7968]: info: CoreStateMachine::stop Jan 19 13:20:19 opera volumio[7968]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 19 13:20:19 opera volumio[7968]: verbose: UNSET VOLATILE Jan 19 13:20:19 opera volumio[7968]: info: CorePlayQueue::clearPlayQueue Jan 19 13:20:19 opera volumio[7968]: info: CorePlayQueue::saveQueue Jan 19 13:20:19 opera volumio[7968]: info: CoreCommandRouter::volumioPushState Jan 19 13:20:19 opera volumio[7968]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 13:20:19 opera volumio[7968]: info: CoreCommandRouter::volumioPushQueue Jan 19 13:20:19 opera volumio[7968]: info: Updating RAAT Signal Path Jan 19 13:20:19 opera volumio[7968]: info: Jan 19 13:20:19 opera volumio[7968]: ---------------------------- MPD announces system playlist update Jan 19 13:20:19 opera volumio[7968]: info: Ignoring MPD Status Update Jan 19 13:20:19 opera volumio[7968]: error: updateQueue error: null Jan 19 13:20:19 opera volumio[7968]: info: ------------------------------ 1ms Jan 19 13:20:19 opera volumio[7968]: info: Starting UPNP Playback Jan 19 13:20:19 opera volumio[7968]: info: Preparing playback through UPNP Jan 19 13:20:19 opera volumio[7968]: info: CoreCommandRouter::volumioGetState Jan 19 13:20:19 opera volumio[7968]: info: CorePlayQueue::getTrack 0 Jan 19 13:20:19 opera volumio[7968]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 19 13:20:19 opera volumio[7968]: info: Jan 19 13:20:19 opera volumio[7968]: ---------------------------- MPD announces system playlist update Jan 19 13:20:19 opera volumio[7968]: info: Ignoring MPD Status Update Jan 19 13:20:19 opera volumio[7968]: info: ------------------------------ 1ms Jan 19 13:20:19 opera volumio[7968]: info: Jan 19 13:20:19 opera volumio[7968]: ---------------------------- MPD announces system playlist update Jan 19 13:20:19 opera volumio[7968]: info: Ignoring MPD Status Update Jan 19 13:20:19 opera volumio[7968]: info: ------------------------------ 1ms Jan 19 13:20:19 opera volumio[7968]: info: Jan 19 13:20:19 opera volumio[7968]: ---------------------------- MPD announces system playlist update Jan 19 13:20:19 opera volumio[7968]: info: Ignoring MPD Status Update Jan 19 13:20:19 opera volumio[7968]: info: ------------------------------ 1ms Jan 19 13:20:19 opera volumio[7968]: info: Jan 19 13:20:19 opera volumio[7968]: ---------------------------- MPD announces system playlist update Jan 19 13:20:19 opera volumio[7968]: info: Ignoring MPD Status Update Jan 19 13:20:19 opera volumio[7968]: info: ------------------------------ 1ms Jan 19 13:20:19 opera volumio[7968]: info: Jan 19 13:20:19 opera volumio[7968]: ---------------------------- MPD announces system playlist update Jan 19 13:20:19 opera volumio[7968]: info: Ignoring MPD Status Update Jan 19 13:20:19 opera volumio[7968]: info: ------------------------------ 1ms Jan 19 13:20:19 opera volumio[7968]: info: Jan 19 13:20:19 opera volumio[7968]: ---------------------------- MPD announces system playlist update Jan 19 13:20:19 opera volumio[7968]: info: Ignoring MPD Status Update Jan 19 13:20:19 opera volumio[7968]: info: ------------------------------ 1ms Jan 19 13:20:20 opera volumio[7968]: info: Jan 19 13:20:20 opera volumio[7968]: ---------------------------- MPD announces state update: player Jan 19 13:20:20 opera volumio[7968]: info: ControllerMpd::getState Jan 19 13:20:20 opera volumio[7968]: verbose: ControllerMpd::sendMpdCommand status Jan 19 13:20:20 opera volumio[7968]: info: sendMpdCommand status took 2 milliseconds Jan 19 13:20:20 opera volumio[7968]: verbose: ControllerMpd::parseState Jan 19 13:20:20 opera volumio[7968]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 13:20:20 opera volumio[7968]: info: Jan 19 13:20:20 opera volumio[7968]: ---------------------------- MPD announces system playlist update Jan 19 13:20:20 opera volumio[7968]: info: Ignoring MPD Status Update Jan 19 13:20:20 opera volumio[7968]: info: Jan 19 13:20:20 opera volumio[7968]: ---------------------------- MPD announces state update: player Jan 19 13:20:20 opera volumio[7968]: info: ControllerMpd::getState Jan 19 13:20:20 opera volumio[7968]: verbose: ControllerMpd::sendMpdCommand status Jan 19 13:20:20 opera volumio[7968]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 19 13:20:20 opera volumio[7968]: verbose: ControllerMpd::parseTrackInfo Jan 19 13:20:20 opera volumio[7968]: info: ControllerMpd::pushState Jan 19 13:20:20 opera volumio[7968]: info: CoreCommandRouter::servicePushState Jan 19 13:20:20 opera volumio[7968]: verbose: In UPNP mode Jan 19 13:20:20 opera volumio[7968]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":153,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"森の小さなレストラン","artist":"手嶌 葵","album":"森の小さなレストラン","uri":"http://aqqmusic.tc.qq.com/M5000002oBJe02bjls.mp3?guid=000000005b56b722000001937137c5ff&vkey=6B077EF9D3A97E8AD1BE874EBB1B737EA87FE3BEEA62F644D7D2752F748442F2FF3BB914471535A95F28239EE2EB2421C11F7BF294A2E78F__v21e2a16b2&uin=1152921504950983260&redirect=1&fromtag=111042","trackType":""} Jan 19 13:20:20 opera volumio[7968]: verbose: CURRENT POSITION 0 Jan 19 13:20:20 opera volumio[7968]: info: CoreStateMachine::syncState stateService play Jan 19 13:20:20 opera volumio[7968]: info: CoreStateMachine::syncState currentStatus stop Jan 19 13:20:20 opera volumio[7968]: info: CoreStateMachine::pushState Jan 19 13:20:20 opera volumio[7968]: info: CoreCommandRouter::volumioPushState Jan 19 13:20:20 opera volumio[7968]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 13:20:20 opera volumio[7968]: info: ------------------------------ 18ms Jan 19 13:20:20 opera volumio[7968]: info: ------------------------------ 12ms Jan 19 13:20:20 opera volumio[7968]: info: sendMpdCommand status took 11 milliseconds Jan 19 13:20:20 opera volumio[7968]: verbose: ControllerMpd::parseState Jan 19 13:20:20 opera volumio[7968]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 19 13:20:20 opera volumio[7968]: info: Updating RAAT Signal Path Jan 19 13:20:20 opera volumio[7968]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 19 13:20:20 opera volumio[7968]: verbose: ControllerMpd::parseTrackInfo Jan 19 13:20:20 opera volumio[7968]: info: ControllerMpd::pushState Jan 19 13:20:20 opera volumio[7968]: info: CoreCommandRouter::servicePushState Jan 19 13:20:20 opera volumio[7968]: verbose: In UPNP mode Jan 19 13:20:20 opera volumio[7968]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":153,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"森の小さなレストラン","artist":"手嶌 葵","album":"森の小さなレストラン","uri":"http://aqqmusic.tc.qq.com/M5000002oBJe02bjls.mp3?guid=000000005b56b722000001937137c5ff&vkey=6B077EF9D3A97E8AD1BE874EBB1B737EA87FE3BEEA62F644D7D2752F748442F2FF3BB914471535A95F28239EE2EB2421C11F7BF294A2E78F__v21e2a16b2&uin=1152921504950983260&redirect=1&fromtag=111042","trackType":""} Jan 19 13:20:20 opera volumio[7968]: verbose: CURRENT POSITION 0 Jan 19 13:20:20 opera volumio[7968]: info: CoreStateMachine::syncState stateService play Jan 19 13:20:20 opera volumio[7968]: info: CoreStateMachine::syncState currentStatus play Jan 19 13:20:20 opera volumio[7968]: info: Received an update from plugin. extracting info from payload Jan 19 13:20:20 opera volumio[7968]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 19 13:20:20 opera volumio[7968]: info: CoreStateMachine::pushState Jan 19 13:20:20 opera volumio[7968]: info: CoreCommandRouter::volumioPushState Jan 19 13:20:20 opera volumio[7968]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 13:20:20 opera volumio[7968]: info: CoreStateMachine::pushState Jan 19 13:20:20 opera volumio[7968]: info: CoreCommandRouter::volumioPushState Jan 19 13:20:20 opera volumio[7968]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 19 13:20:20 opera volumio[7968]: info: ------------------------------ 38ms Jan 19 13:20:20 opera volumio[7968]: info: Updating RAAT Signal Path Jan 19 13:20:20 opera volumio[7968]: info: Updating RAAT Signal Path Jan 19 13:20:20 opera volumio[7968]: info: CoreCommandRouter::volumioGetQueue Jan 19 13:20:20 opera volumio[7968]: info: CoreStateMachine::getQueue Jan 19 13:20:20 opera volumio[7968]: info: CorePlayQueue::getQueue Jan 19 13:20:20 opera volumio[7968]: info: CoreCommandRouter::volumioGetQueue Jan 19 13:20:20 opera volumio[7968]: info: CoreStateMachine::getQueue Jan 19 13:20:20 opera volumio[7968]: info: CorePlayQueue::getQueue Jan 19 13:20:20 opera volumio[7968]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Vangelis/Alexander%20(Original%20Motion%20Picture%20Soundtrack)/954c4141-3522-476b-a410-c45248624b03.jpg' Jan 19 13:20:22 opera volumio[7968]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 19 13:20:22 opera volumio[7968]: { Error: connect ETIMEDOUT 203.111.254.117:443 Jan 19 13:20:22 opera volumio[7968]: at Object._errnoException (util.js:1022:11) Jan 19 13:20:22 opera volumio[7968]: at _exceptionWithHostPort (util.js:1044:20) Jan 19 13:20:22 opera volumio[7968]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jan 19 13:20:22 opera volumio[7968]: code: 'ETIMEDOUT', Jan 19 13:20:22 opera volumio[7968]: errno: 'ETIMEDOUT', Jan 19 13:20:22 opera volumio[7968]: syscall: 'connect', Jan 19 13:20:22 opera volumio[7968]: address: '203.111.254.117', Jan 19 13:20:22 opera volumio[7968]: port: 443 } Jan 19 13:20:22 opera volumio[7968]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 19 13:20:23 opera sudo[10630]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-19 13:19 Jan 19 13:20:23 opera sudo[10630]: 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"