-- Logs begin at Wed 2021-12-01 13:09:13 UTC, end at Thu 2024-04-25 16:29:54 UTC. -- Apr 25 16:28:02 opera volumio[1139]: info: Apr 25 16:28:02 opera volumio[1139]: ---------------------------- MPD announces state update: player Apr 25 16:28:02 opera volumio[1139]: info: ControllerMpd::getState Apr 25 16:28:02 opera volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Apr 25 16:28:02 opera volumio[1139]: info: sendMpdCommand status took 0 milliseconds Apr 25 16:28:02 opera volumio[1139]: verbose: ControllerMpd::parseState Apr 25 16:28:02 opera volumio[1139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 25 16:28:02 opera volumio[1139]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 25 16:28:02 opera volumio[1139]: verbose: ControllerMpd::parseTrackInfo Apr 25 16:28:02 opera volumio[1139]: info: ControllerMpd::pushState Apr 25 16:28:02 opera volumio[1139]: info: CoreCommandRouter::servicePushState Apr 25 16:28:02 opera volumio[1139]: info: CoreStateMachine::pushState Apr 25 16:28:02 opera volumio[1139]: info: CoreCommandRouter::volumioPushState Apr 25 16:28:02 opera volumio[1139]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 25 16:28:02 opera volumio[1139]: info: CorePlayQueue::getTrack 0 Apr 25 16:28:02 opera volumio[1139]: 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":"Maria Elena","artist":"Los Indios Tabajaras","album":"Maria Elena","uri":"http://sjy6.stream.qqmusic.qq.com/M500003BNLBg17ehIy.mp3?guid=ffffffffd44d833d0000018c2f3bf5bf&vkey=CE8A5519A4F23B0592A7624D4364004A96AE47FC3B82F0CF0FABE193C3389873AF679640BE10F95813C988408FAB1B21810A344C99FB2D29&uin=1152921504950983260&redirect=1&fromtag=111042","trackType":""} Apr 25 16:28:02 opera volumio[1139]: verbose: CURRENT POSITION 0 Apr 25 16:28:02 opera volumio[1139]: info: CoreStateMachine::syncState stateService stop Apr 25 16:28:02 opera volumio[1139]: info: CoreStateMachine::syncState currentStatus play Apr 25 16:28:02 opera volumio[1139]: info: CoreStateMachine::play index undefined Apr 25 16:28:02 opera volumio[1139]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 25 16:28:02 opera volumio[1139]: info: CoreStateMachine::pushState Apr 25 16:28:02 opera volumio[1139]: info: CorePlayQueue::getTrack 0 Apr 25 16:28:02 opera volumio[1139]: info: CoreCommandRouter::volumioPushState Apr 25 16:28:02 opera volumio[1139]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 25 16:28:02 opera volumio[1139]: info: CorePlayQueue::getTrack 0 Apr 25 16:28:02 opera volumio[1139]: info: ------------------------------ 10ms Apr 25 16:28:02 opera volumio[1139]: info: CoreCommandRouter::volumioGetQueue Apr 25 16:28:02 opera volumio[1139]: info: CoreStateMachine::getQueue Apr 25 16:28:02 opera volumio[1139]: info: CorePlayQueue::getQueue Apr 25 16:28:02 opera volumio[1139]: info: Clearing queue after UPNP request Apr 25 16:28:02 opera volumio[1139]: info: CoreStateMachine::ClearQueue Apr 25 16:28:02 opera volumio[1139]: info: CoreStateMachine::stop Apr 25 16:28:02 opera volumio[1139]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 25 16:28:02 opera volumio[1139]: verbose: UNSET VOLATILE Apr 25 16:28:02 opera volumio[1139]: info: CorePlayQueue::clearPlayQueue Apr 25 16:28:02 opera volumio[1139]: info: CorePlayQueue::saveQueue Apr 25 16:28:02 opera volumio[1139]: info: CoreCommandRouter::volumioPushState Apr 25 16:28:02 opera volumio[1139]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 25 16:28:02 opera volumio[1139]: info: CoreCommandRouter::volumioPushQueue Apr 25 16:28:02 opera volumio[1139]: info: Apr 25 16:28:02 opera volumio[1139]: ---------------------------- MPD announces system playlist update Apr 25 16:28:02 opera volumio[1139]: info: Ignoring MPD Status Update Apr 25 16:28:02 opera volumio[1139]: error: updateQueue error: null Apr 25 16:28:02 opera volumio[1139]: info: ------------------------------ 1ms Apr 25 16:28:02 opera volumio[1139]: info: Starting UPNP Playback Apr 25 16:28:02 opera volumio[1139]: info: Preparing playback through UPNP Apr 25 16:28:02 opera volumio[1139]: info: CoreCommandRouter::volumioGetState Apr 25 16:28:02 opera volumio[1139]: info: CorePlayQueue::getTrack 0 Apr 25 16:28:02 opera volumio[1139]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 25 16:28:03 opera volumio[1139]: info: Apr 25 16:28:03 opera volumio[1139]: ---------------------------- MPD announces system playlist update Apr 25 16:28:03 opera volumio[1139]: info: Ignoring MPD Status Update Apr 25 16:28:03 opera volumio[1139]: info: ------------------------------ 1ms Apr 25 16:28:03 opera volumio[1139]: info: Apr 25 16:28:03 opera volumio[1139]: ---------------------------- MPD announces system playlist update Apr 25 16:28:03 opera volumio[1139]: info: Ignoring MPD Status Update Apr 25 16:28:03 opera volumio[1139]: info: ------------------------------ 1ms Apr 25 16:28:03 opera volumio[1139]: info: Apr 25 16:28:03 opera volumio[1139]: ---------------------------- MPD announces system playlist update Apr 25 16:28:03 opera volumio[1139]: info: Ignoring MPD Status Update Apr 25 16:28:03 opera volumio[1139]: info: ------------------------------ 1ms Apr 25 16:28:03 opera volumio[1139]: info: Apr 25 16:28:03 opera volumio[1139]: ---------------------------- MPD announces system playlist update Apr 25 16:28:03 opera volumio[1139]: info: Ignoring MPD Status Update Apr 25 16:28:03 opera volumio[1139]: info: ------------------------------ 0ms Apr 25 16:28:03 opera volumio[1139]: info: Apr 25 16:28:03 opera volumio[1139]: ---------------------------- MPD announces system playlist update Apr 25 16:28:03 opera volumio[1139]: info: Ignoring MPD Status Update Apr 25 16:28:03 opera volumio[1139]: info: ------------------------------ 0ms Apr 25 16:28:03 opera volumio[1139]: info: Apr 25 16:28:03 opera volumio[1139]: ---------------------------- MPD announces system playlist update Apr 25 16:28:03 opera volumio[1139]: info: Ignoring MPD Status Update Apr 25 16:28:03 opera volumio[1139]: info: ------------------------------ 0ms Apr 25 16:28:03 opera volumio[1139]: info: Apr 25 16:28:03 opera volumio[1139]: ---------------------------- MPD announces state update: player Apr 25 16:28:03 opera volumio[1139]: info: ControllerMpd::getState Apr 25 16:28:03 opera volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Apr 25 16:28:03 opera volumio[1139]: info: Apr 25 16:28:03 opera volumio[1139]: ---------------------------- MPD announces state update: player Apr 25 16:28:03 opera volumio[1139]: info: ControllerMpd::getState Apr 25 16:28:03 opera volumio[1139]: verbose: ControllerMpd::sendMpdCommand status Apr 25 16:28:03 opera volumio[1139]: info: sendMpdCommand status took 2 milliseconds Apr 25 16:28:03 opera volumio[1139]: verbose: ControllerMpd::parseState Apr 25 16:28:03 opera volumio[1139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 25 16:28:03 opera volumio[1139]: info: sendMpdCommand status took 2 milliseconds Apr 25 16:28:03 opera volumio[1139]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 25 16:28:03 opera volumio[1139]: verbose: ControllerMpd::parseState Apr 25 16:28:03 opera volumio[1139]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 25 16:28:03 opera volumio[1139]: verbose: ControllerMpd::parseTrackInfo Apr 25 16:28:03 opera volumio[1139]: info: ControllerMpd::pushState Apr 25 16:28:03 opera volumio[1139]: info: CoreCommandRouter::servicePushState Apr 25 16:28:03 opera volumio[1139]: verbose: In UPNP mode Apr 25 16:28:03 opera volumio[1139]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":402,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Tribute","artist":"Yanni","album":"Tribute","uri":"http://sjy6.stream.qqmusic.qq.com/F000001B9gEY2JAKMf.flac?guid=ffffffffd44d833d0000018c2f3bf5bf&vkey=D7C6696CE8D71A34BBFF4408AFD0E360A6F8A9859FBB6ED004C65EE473D5D74ED0657B33A400A814673EB634B5368B99A92D588A3B5F2C4F&uin=1152921504950983260&src=F000001B9gEY2JAKMf.flac&redirect=1&fromtag=111114","trackType":""} Apr 25 16:28:03 opera volumio[1139]: verbose: CURRENT POSITION 0 Apr 25 16:28:03 opera volumio[1139]: info: CoreStateMachine::syncState stateService play Apr 25 16:28:03 opera volumio[1139]: info: CoreStateMachine::syncState currentStatus stop Apr 25 16:28:03 opera volumio[1139]: info: CoreStateMachine::pushState Apr 25 16:28:03 opera volumio[1139]: info: CoreCommandRouter::volumioPushState Apr 25 16:28:03 opera volumio[1139]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 25 16:28:03 opera volumio[1139]: info: ------------------------------ 10ms Apr 25 16:28:03 opera volumio[1139]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 25 16:28:03 opera volumio[1139]: verbose: ControllerMpd::parseTrackInfo Apr 25 16:28:03 opera volumio[1139]: info: ControllerMpd::pushState Apr 25 16:28:03 opera volumio[1139]: info: CoreCommandRouter::servicePushState Apr 25 16:28:03 opera volumio[1139]: verbose: In UPNP mode Apr 25 16:28:03 opera volumio[1139]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":402,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Tribute","artist":"Yanni","album":"Tribute","uri":"http://sjy6.stream.qqmusic.qq.com/F000001B9gEY2JAKMf.flac?guid=ffffffffd44d833d0000018c2f3bf5bf&vkey=D7C6696CE8D71A34BBFF4408AFD0E360A6F8A9859FBB6ED004C65EE473D5D74ED0657B33A400A814673EB634B5368B99A92D588A3B5F2C4F&uin=1152921504950983260&src=F000001B9gEY2JAKMf.flac&redirect=1&fromtag=111114","trackType":""} Apr 25 16:28:03 opera volumio[1139]: verbose: CURRENT POSITION 0 Apr 25 16:28:03 opera volumio[1139]: info: CoreStateMachine::syncState stateService play Apr 25 16:28:03 opera volumio[1139]: info: CoreStateMachine::syncState currentStatus play Apr 25 16:28:03 opera volumio[1139]: info: Received an update from plugin. extracting info from payload Apr 25 16:28:03 opera volumio[1139]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 25 16:28:03 opera volumio[1139]: info: CoreStateMachine::pushState Apr 25 16:28:03 opera volumio[1139]: info: CoreCommandRouter::volumioPushState Apr 25 16:28:03 opera volumio[1139]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 25 16:28:03 opera volumio[1139]: info: CoreStateMachine::pushState Apr 25 16:28:03 opera volumio[1139]: info: CoreCommandRouter::volumioPushState Apr 25 16:28:03 opera volumio[1139]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 25 16:28:03 opera volumio[1139]: info: ------------------------------ 20ms Apr 25 16:28:03 opera volumio[1139]: info: CoreCommandRouter::volumioGetQueue Apr 25 16:28:03 opera volumio[1139]: info: CoreStateMachine::getQueue Apr 25 16:28:03 opera volumio[1139]: info: CorePlayQueue::getQueue Apr 25 16:28:03 opera volumio[1139]: info: CoreCommandRouter::volumioGetQueue Apr 25 16:28:03 opera volumio[1139]: info: CoreStateMachine::getQueue Apr 25 16:28:03 opera volumio[1139]: info: CorePlayQueue::getQueue Apr 25 16:28:03 opera volumio[1139]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Los%20Indios%20Tabajaras/Maria%20Elena/c5795124-5239-4f29-abdd-fe30ecf3daa5.jpg' Apr 25 16:28:03 opera volumio[1139]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Yanni/Tribute/755e4835-6f90-43c8-a4a6-609e431381f0.jpg' Apr 25 16:29:53 opera volumio[1139]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 25 16:29:53 opera volumio[1139]: { Error: connect ETIMEDOUT 128.242.240.218:443 Apr 25 16:29:53 opera volumio[1139]: at Object._errnoException (util.js:1022:11) Apr 25 16:29:53 opera volumio[1139]: at _exceptionWithHostPort (util.js:1044:20) Apr 25 16:29:53 opera volumio[1139]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Apr 25 16:29:53 opera volumio[1139]: code: 'ETIMEDOUT', Apr 25 16:29:53 opera volumio[1139]: errno: 'ETIMEDOUT', Apr 25 16:29:53 opera volumio[1139]: syscall: 'connect', Apr 25 16:29:53 opera volumio[1139]: address: '128.242.240.218', Apr 25 16:29:53 opera volumio[1139]: port: 443 } Apr 25 16:29:53 opera volumio[1139]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 25 16:29:54 opera sudo[12344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-25 16:28 Apr 25 16:29:54 opera sudo[12344]: 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="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="307f91893fca011201acba9973e1c41bd3a0ad5d" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="opera" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Oct 1 16:18:39 CEST 2021" VOLUMIO_VERSION="1.031" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_VENDOR="Opera Consonance" VOLUMIO_MODEL="X5" VOLUMIO_VENDOR_MODEL="Opera X5" VOLUMIO_HASH="8579bfbfd528c599f57acb0dd7167775"