-- Logs begin at Fri 2021-10-01 14:24:27 UTC, end at Fri 2026-02-27 03:58:50 UTC. -- Feb 27 03:57:15 opera-3 volumio[17878]: info: Feb 27 03:57:15 opera-3 volumio[17878]: ---------------------------- MPD announces state update: player Feb 27 03:57:15 opera-3 volumio[17878]: info: ControllerMpd::getState Feb 27 03:57:15 opera-3 volumio[17878]: verbose: ControllerMpd::sendMpdCommand status Feb 27 03:57:15 opera-3 volumio[17878]: info: sendMpdCommand status took 2 milliseconds Feb 27 03:57:15 opera-3 volumio[17878]: verbose: ControllerMpd::parseState Feb 27 03:57:15 opera-3 volumio[17878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 27 03:57:15 opera-3 volumio[17878]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 27 03:57:15 opera-3 volumio[17878]: verbose: ControllerMpd::parseTrackInfo Feb 27 03:57:15 opera-3 volumio[17878]: info: ControllerMpd::pushState Feb 27 03:57:15 opera-3 volumio[17878]: info: CoreCommandRouter::servicePushState Feb 27 03:57:15 opera-3 volumio[17878]: info: CoreStateMachine::pushState Feb 27 03:57:15 opera-3 volumio[17878]: info: CoreCommandRouter::volumioPushState Feb 27 03:57:15 opera-3 volumio[17878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 27 03:57:15 opera-3 volumio[17878]: info: CorePlayQueue::getTrack 0 Feb 27 03:57:15 opera-3 volumio[17878]: 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":"Abracadabra","artist":"Dakota Staton","album":"I Hear Music","uri":"http://43.141.49.24/amobile.music.tc.qq.com/M500001LnUkk0rjwP2.mp3?guid=6b35f34e-529c-41d5-a292-a2c278b2ce8c&vkey=9047D10C6ED11C4366919C4A5A2382F64F968E28AFAC461C07CC9FB8A10800EB2F3BD1D3493904313A20C3B7422CE0266AD7F35D0CCE2DCB__v2b9abeeb&uin=1152921505207979727&fromtag=146045","trackType":""} Feb 27 03:57:15 opera-3 volumio[17878]: verbose: CURRENT POSITION 0 Feb 27 03:57:15 opera-3 volumio[17878]: info: CoreStateMachine::syncState stateService stop Feb 27 03:57:15 opera-3 volumio[17878]: info: CoreStateMachine::syncState currentStatus play Feb 27 03:57:15 opera-3 volumio[17878]: info: CoreStateMachine::play index undefined Feb 27 03:57:15 opera-3 volumio[17878]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 27 03:57:15 opera-3 volumio[17878]: info: CoreStateMachine::pushState Feb 27 03:57:15 opera-3 volumio[17878]: info: CorePlayQueue::getTrack 0 Feb 27 03:57:15 opera-3 volumio[17878]: info: CoreCommandRouter::volumioPushState Feb 27 03:57:15 opera-3 volumio[17878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 27 03:57:15 opera-3 volumio[17878]: info: CorePlayQueue::getTrack 0 Feb 27 03:57:15 opera-3 volumio[17878]: info: ------------------------------ 21ms Feb 27 03:57:15 opera-3 volumio[17878]: info: CoreCommandRouter::volumioGetQueue Feb 27 03:57:15 opera-3 volumio[17878]: info: CoreStateMachine::getQueue Feb 27 03:57:15 opera-3 volumio[17878]: info: CorePlayQueue::getQueue Feb 27 03:57:15 opera-3 volumio[17878]: info: Clearing queue after UPNP request Feb 27 03:57:15 opera-3 volumio[17878]: info: CoreStateMachine::ClearQueue Feb 27 03:57:15 opera-3 volumio[17878]: info: CoreStateMachine::stop Feb 27 03:57:15 opera-3 volumio[17878]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 27 03:57:15 opera-3 volumio[17878]: verbose: UNSET VOLATILE Feb 27 03:57:15 opera-3 volumio[17878]: info: CorePlayQueue::clearPlayQueue Feb 27 03:57:15 opera-3 volumio[17878]: info: CorePlayQueue::saveQueue Feb 27 03:57:15 opera-3 volumio[17878]: info: CoreCommandRouter::volumioPushState Feb 27 03:57:15 opera-3 volumio[17878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 27 03:57:15 opera-3 volumio[17878]: info: CoreCommandRouter::volumioPushQueue Feb 27 03:57:15 opera-3 volumio[17878]: info: Feb 27 03:57:15 opera-3 volumio[17878]: ---------------------------- MPD announces system playlist update Feb 27 03:57:15 opera-3 volumio[17878]: info: Ignoring MPD Status Update Feb 27 03:57:15 opera-3 volumio[17878]: error: updateQueue error: null Feb 27 03:57:15 opera-3 volumio[17878]: info: ------------------------------ 2ms Feb 27 03:57:15 opera-3 volumio[17878]: info: Starting UPNP Playback Feb 27 03:57:15 opera-3 volumio[17878]: info: Preparing playback through UPNP Feb 27 03:57:15 opera-3 volumio[17878]: info: CoreCommandRouter::volumioGetState Feb 27 03:57:16 opera-3 volumio[17878]: info: CorePlayQueue::getTrack 0 Feb 27 03:57:16 opera-3 volumio[17878]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 27 03:57:16 opera-3 volumio[17878]: info: Feb 27 03:57:16 opera-3 volumio[17878]: ---------------------------- MPD announces system playlist update Feb 27 03:57:16 opera-3 volumio[17878]: info: Ignoring MPD Status Update Feb 27 03:57:16 opera-3 volumio[17878]: info: Feb 27 03:57:16 opera-3 volumio[17878]: ---------------------------- MPD announces system playlist update Feb 27 03:57:16 opera-3 volumio[17878]: info: Ignoring MPD Status Update Feb 27 03:57:16 opera-3 volumio[17878]: info: ------------------------------ 1ms Feb 27 03:57:16 opera-3 volumio[17878]: info: ------------------------------ 7ms Feb 27 03:57:16 opera-3 volumio[17878]: info: Feb 27 03:57:16 opera-3 volumio[17878]: ---------------------------- MPD announces system playlist update Feb 27 03:57:16 opera-3 volumio[17878]: info: Ignoring MPD Status Update Feb 27 03:57:16 opera-3 volumio[17878]: info: ------------------------------ 1ms Feb 27 03:57:16 opera-3 volumio[17878]: info: Feb 27 03:57:16 opera-3 volumio[17878]: ---------------------------- MPD announces system playlist update Feb 27 03:57:16 opera-3 volumio[17878]: info: Ignoring MPD Status Update Feb 27 03:57:16 opera-3 volumio[17878]: info: ------------------------------ 0ms Feb 27 03:57:16 opera-3 volumio[17878]: info: Feb 27 03:57:16 opera-3 volumio[17878]: ---------------------------- MPD announces system playlist update Feb 27 03:57:16 opera-3 volumio[17878]: info: Ignoring MPD Status Update Feb 27 03:57:16 opera-3 volumio[17878]: info: ------------------------------ 1ms Feb 27 03:57:16 opera-3 volumio[17878]: info: Feb 27 03:57:16 opera-3 volumio[17878]: ---------------------------- MPD announces system playlist update Feb 27 03:57:16 opera-3 volumio[17878]: info: Ignoring MPD Status Update Feb 27 03:57:16 opera-3 volumio[17878]: info: ------------------------------ 1ms Feb 27 03:57:16 opera-3 volumio[17878]: info: Feb 27 03:57:16 opera-3 volumio[17878]: ---------------------------- MPD announces state update: player Feb 27 03:57:16 opera-3 volumio[17878]: info: ControllerMpd::getState Feb 27 03:57:16 opera-3 volumio[17878]: verbose: ControllerMpd::sendMpdCommand status Feb 27 03:57:16 opera-3 volumio[17878]: info: sendMpdCommand status took 2 milliseconds Feb 27 03:57:16 opera-3 volumio[17878]: verbose: ControllerMpd::parseState Feb 27 03:57:16 opera-3 volumio[17878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 27 03:57:16 opera-3 volumio[17878]: info: Feb 27 03:57:16 opera-3 volumio[17878]: ---------------------------- MPD announces system playlist update Feb 27 03:57:16 opera-3 volumio[17878]: info: Ignoring MPD Status Update Feb 27 03:57:16 opera-3 volumio[17878]: info: Feb 27 03:57:16 opera-3 volumio[17878]: ---------------------------- MPD announces state update: player Feb 27 03:57:16 opera-3 volumio[17878]: info: ControllerMpd::getState Feb 27 03:57:16 opera-3 volumio[17878]: verbose: ControllerMpd::sendMpdCommand status Feb 27 03:57:16 opera-3 volumio[17878]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 27 03:57:16 opera-3 volumio[17878]: verbose: ControllerMpd::parseTrackInfo Feb 27 03:57:16 opera-3 volumio[17878]: info: ControllerMpd::pushState Feb 27 03:57:16 opera-3 volumio[17878]: info: CoreCommandRouter::servicePushState Feb 27 03:57:16 opera-3 volumio[17878]: verbose: In UPNP mode Feb 27 03:57:16 opera-3 volumio[17878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":270,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Satin Birds","artist":"Abel Korzeniowski","album":"W.E. - Music From The Motion Picture","uri":"http://43.141.49.24/amobile.music.tc.qq.com/M5000034O6NI3l6Rhy.mp3?guid=6b35f34e-529c-41d5-a292-a2c278b2ce8c&vkey=607E4362F77E4F3949CF00D7F2FE959A2C553FB6EB3E6117A486B9016A2A5750F905C4597A5DFE3BB954ED74B0DC36FAF124143DFE160ACB__v2b9ab0cd&uin=1152921505207979727&fromtag=146045","trackType":""} Feb 27 03:57:16 opera-3 volumio[17878]: verbose: CURRENT POSITION 0 Feb 27 03:57:16 opera-3 volumio[17878]: info: CoreStateMachine::syncState stateService play Feb 27 03:57:16 opera-3 volumio[17878]: info: CoreStateMachine::syncState currentStatus stop Feb 27 03:57:16 opera-3 volumio[17878]: info: CoreStateMachine::pushState Feb 27 03:57:16 opera-3 volumio[17878]: info: CoreCommandRouter::volumioPushState Feb 27 03:57:16 opera-3 volumio[17878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 27 03:57:16 opera-3 volumio[17878]: info: ------------------------------ 11ms Feb 27 03:57:16 opera-3 volumio[17878]: info: ------------------------------ 8ms Feb 27 03:57:16 opera-3 volumio[17878]: info: sendMpdCommand status took 7 milliseconds Feb 27 03:57:16 opera-3 volumio[17878]: verbose: ControllerMpd::parseState Feb 27 03:57:16 opera-3 volumio[17878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 27 03:57:16 opera-3 volumio[17878]: info: sendMpdCommand playlistinfo took 5 milliseconds Feb 27 03:57:16 opera-3 volumio[17878]: verbose: ControllerMpd::parseTrackInfo Feb 27 03:57:16 opera-3 volumio[17878]: info: ControllerMpd::pushState Feb 27 03:57:16 opera-3 volumio[17878]: info: CoreCommandRouter::servicePushState Feb 27 03:57:16 opera-3 volumio[17878]: verbose: In UPNP mode Feb 27 03:57:16 opera-3 volumio[17878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":270,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Satin Birds","artist":"Abel Korzeniowski","album":"W.E. - Music From The Motion Picture","uri":"http://43.141.49.24/amobile.music.tc.qq.com/M5000034O6NI3l6Rhy.mp3?guid=6b35f34e-529c-41d5-a292-a2c278b2ce8c&vkey=607E4362F77E4F3949CF00D7F2FE959A2C553FB6EB3E6117A486B9016A2A5750F905C4597A5DFE3BB954ED74B0DC36FAF124143DFE160ACB__v2b9ab0cd&uin=1152921505207979727&fromtag=146045","trackType":""} Feb 27 03:57:16 opera-3 volumio[17878]: verbose: CURRENT POSITION 0 Feb 27 03:57:16 opera-3 volumio[17878]: info: CoreStateMachine::syncState stateService play Feb 27 03:57:16 opera-3 volumio[17878]: info: CoreStateMachine::syncState currentStatus play Feb 27 03:57:16 opera-3 volumio[17878]: info: Received an update from plugin. extracting info from payload Feb 27 03:57:16 opera-3 volumio[17878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 27 03:57:16 opera-3 volumio[17878]: info: CoreStateMachine::pushState Feb 27 03:57:16 opera-3 volumio[17878]: info: CoreCommandRouter::volumioPushState Feb 27 03:57:16 opera-3 volumio[17878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 27 03:57:16 opera-3 volumio[17878]: info: CoreStateMachine::pushState Feb 27 03:57:16 opera-3 volumio[17878]: info: CoreCommandRouter::volumioPushState Feb 27 03:57:16 opera-3 volumio[17878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 27 03:57:16 opera-3 volumio[17878]: info: ------------------------------ 23ms Feb 27 03:57:16 opera-3 volumio[17878]: info: CoreCommandRouter::volumioGetQueue Feb 27 03:57:16 opera-3 volumio[17878]: info: CoreStateMachine::getQueue Feb 27 03:57:16 opera-3 volumio[17878]: info: CorePlayQueue::getQueue Feb 27 03:57:16 opera-3 volumio[17878]: info: CoreCommandRouter::volumioGetQueue Feb 27 03:57:16 opera-3 volumio[17878]: info: CoreStateMachine::getQueue Feb 27 03:57:16 opera-3 volumio[17878]: info: CorePlayQueue::getQueue Feb 27 03:57:16 opera-3 volumio[17878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Dakota%20Staton/I%20Hear%20Music/9638a711-7902-4a21-9bac-813fa1015f32.jpg' Feb 27 03:57:16 opera-3 volumio[17878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Abel%20Korzeniowski/W.E.%20-%20Music%20From%20The%20Motion%20Picture/8d6d761d-e8a1-49fb-bfec-19a8150b2fe1.jpg' Feb 27 03:57:39 opera-3 dhcpd[1392]: DHCPDISCOVER from 48:e7:da:4e:f7:af (opera-3) via wlan0 Feb 27 03:57:40 opera-3 dhcpd[1392]: DHCPOFFER on 192.168.211.9 to 48:e7:da:4e:f7:af (opera-3) via wlan0 Feb 27 03:58:44 opera-3 dhcpd[1392]: DHCPDISCOVER from 48:e7:da:4e:f7:af (opera-3) via wlan0 Feb 27 03:58:45 opera-3 dhcpd[1392]: DHCPOFFER on 192.168.211.9 to 48:e7:da:4e:f7:af (opera-3) via wlan0 Feb 27 03:58:50 opera-3 volumio[17878]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 27 03:58:50 opera-3 volumio[17878]: { Error: connect ETIMEDOUT 67.228.102.32:443 Feb 27 03:58:50 opera-3 volumio[17878]: at Object._errnoException (util.js:1022:11) Feb 27 03:58:50 opera-3 volumio[17878]: at _exceptionWithHostPort (util.js:1044:20) Feb 27 03:58:50 opera-3 volumio[17878]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Feb 27 03:58:50 opera-3 volumio[17878]: code: 'ETIMEDOUT', Feb 27 03:58:50 opera-3 volumio[17878]: errno: 'ETIMEDOUT', Feb 27 03:58:50 opera-3 volumio[17878]: syscall: 'connect', Feb 27 03:58:50 opera-3 volumio[17878]: address: '67.228.102.32', Feb 27 03:58:50 opera-3 volumio[17878]: port: 443 } Feb 27 03:58:50 opera-3 volumio[17878]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 27 03:58:50 opera-3 sudo[23231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-27 03:57 Feb 27 03:58:50 opera-3 sudo[23231]: 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"