-- Logs begin at Thu 2026-01-08 04:55:33 UTC, end at Tue 2026-06-02 09:51:18 UTC. -- Jun 02 09:50:03 opera volumio[21174]: info: CALLMETHOD: music_service cd_controller getRipInfo Jun 02 09:50:03 opera volumio[21174]: info: CoreCommandRouter::executeOnPlugin: cd_controller , getRipInfo Jun 02 09:50:11 opera volumio[21174]: info: CALLMETHOD: music_service cd_controller ripCD [object Object] Jun 02 09:50:11 opera volumio[21174]: info: CoreCommandRouter::executeOnPlugin: cd_controller , ripCD Jun 02 09:50:11 opera volumio[21174]: info: Starting CD RIP Jun 02 09:50:11 opera volumio[1635]: [Vollibrespot] : couldn't parse packet from V4(192.168.3.21:5353): query type 65 is invalid Jun 02 09:50:12 opera volumio[1635]: [Vollibrespot] : couldn't parse packet from V4(192.168.3.21:5353): query type 65 is invalid Jun 02 09:50:15 opera volumio[21174]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 02 09:50:15 opera volumio[21174]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jun 02 09:50:15 opera volumio[21174]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jun 02 09:50:15 opera volumio[21174]: error: Could not retrieve plugin system_controller my_volumio Jun 02 09:50:15 opera volumio[21174]: info: Received Get System Version Jun 02 09:50:15 opera volumio[21174]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 02 09:50:18 opera volumio[21174]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:50:18 opera volumio[21174]: info: Jun 02 09:50:18 opera volumio[21174]: ---------------------------- MPD announces state update: update Jun 02 09:50:18 opera volumio[21174]: info: ControllerMpd::getState Jun 02 09:50:18 opera volumio[21174]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:50:18 opera volumio[21174]: info: sendMpdCommand status took 2 milliseconds Jun 02 09:50:18 opera volumio[21174]: info: sendMpdCommand status took 1 milliseconds Jun 02 09:50:18 opera volumio[21174]: verbose: ControllerMpd::parseState Jun 02 09:50:18 opera volumio[21174]: info: Command Router : Notfying DB Updatetrue Jun 02 09:50:18 opera volumio[21174]: info: CoreCommandRouter::Close All Modals sent Jun 02 09:50:18 opera volumio[21174]: verbose: ControllerMpd::parseState Jun 02 09:50:18 opera volumio[21174]: info: ControllerMpd::pushState Jun 02 09:50:18 opera volumio[21174]: info: CoreCommandRouter::servicePushState Jun 02 09:50:18 opera volumio[21174]: info: CoreStateMachine::pushState Jun 02 09:50:18 opera volumio[21174]: info: CorePlayQueue::getTrack 0 Jun 02 09:50:18 opera volumio[21174]: info: CoreCommandRouter::volumioPushState Jun 02 09:50:18 opera volumio[21174]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:50:18 opera volumio[21174]: info: CorePlayQueue::getTrack 0 Jun 02 09:50:18 opera volumio[21174]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 02 09:50:18 opera volumio[21174]: verbose: CURRENT POSITION 0 Jun 02 09:50:18 opera volumio[21174]: info: CoreStateMachine::syncState stateService stop Jun 02 09:50:18 opera volumio[21174]: info: CoreStateMachine::syncState currentStatus stop Jun 02 09:50:18 opera volumio[21174]: info: CoreStateMachine::pushState Jun 02 09:50:18 opera volumio[21174]: info: CorePlayQueue::getTrack 0 Jun 02 09:50:18 opera volumio[21174]: info: CoreCommandRouter::volumioPushState Jun 02 09:50:18 opera volumio[21174]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:50:18 opera volumio[21174]: info: No code Jun 02 09:50:18 opera volumio[21174]: info: CoreStateMachine::pushState Jun 02 09:50:18 opera volumio[21174]: info: CorePlayQueue::getTrack 0 Jun 02 09:50:18 opera volumio[21174]: info: CoreCommandRouter::volumioPushState Jun 02 09:50:18 opera volumio[21174]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:50:18 opera volumio[21174]: info: ------------------------------ 55ms Jun 02 09:50:18 opera volumio[21174]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:50:18 opera volumio[21174]: info: Jun 02 09:50:18 opera volumio[21174]: ---------------------------- MPD announces state update: update Jun 02 09:50:18 opera volumio[21174]: info: ControllerMpd::getState Jun 02 09:50:18 opera volumio[21174]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:50:18 opera volumio[21174]: info: Updating RAAT Signal Path Jun 02 09:50:18 opera volumio[21174]: info: Updating RAAT Signal Path Jun 02 09:50:18 opera volumio[21174]: info: Updating RAAT Signal Path Jun 02 09:50:18 opera volumio[21174]: info: sendMpdCommand status took 23 milliseconds Jun 02 09:50:18 opera volumio[21174]: info: sendMpdCommand status took 23 milliseconds Jun 02 09:50:18 opera volumio[21174]: verbose: ControllerMpd::parseState Jun 02 09:50:18 opera volumio[21174]: info: Command Router : Notfying DB Updatefalse Jun 02 09:50:18 opera volumio[21174]: info: CoreCommandRouter::Close All Modals sent Jun 02 09:50:18 opera volumio[21174]: verbose: ControllerMpd::parseState Jun 02 09:50:18 opera volumio[21174]: info: ControllerMpd::pushState Jun 02 09:50:18 opera volumio[21174]: info: CoreCommandRouter::servicePushState Jun 02 09:50:18 opera volumio[21174]: info: CoreStateMachine::pushState Jun 02 09:50:18 opera volumio[21174]: info: CorePlayQueue::getTrack 0 Jun 02 09:50:18 opera volumio[21174]: info: CoreCommandRouter::volumioPushState Jun 02 09:50:18 opera volumio[21174]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:50:18 opera volumio[21174]: info: CorePlayQueue::getTrack 0 Jun 02 09:50:18 opera volumio[21174]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 02 09:50:18 opera volumio[21174]: verbose: CURRENT POSITION 0 Jun 02 09:50:18 opera volumio[21174]: info: CoreStateMachine::syncState stateService stop Jun 02 09:50:18 opera volumio[21174]: info: CoreStateMachine::syncState currentStatus stop Jun 02 09:50:18 opera volumio[21174]: info: CoreStateMachine::pushState Jun 02 09:50:18 opera volumio[21174]: info: CorePlayQueue::getTrack 0 Jun 02 09:50:18 opera volumio[21174]: info: CoreCommandRouter::volumioPushState Jun 02 09:50:18 opera volumio[21174]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:50:18 opera volumio[21174]: info: No code Jun 02 09:50:18 opera volumio[21174]: info: CoreStateMachine::pushState Jun 02 09:50:18 opera volumio[21174]: info: CorePlayQueue::getTrack 0 Jun 02 09:50:18 opera volumio[21174]: info: CoreCommandRouter::volumioPushState Jun 02 09:50:18 opera volumio[21174]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:50:18 opera volumio[21174]: info: ------------------------------ 82ms Jun 02 09:50:18 opera volumio[21174]: info: Updating RAAT Signal Path Jun 02 09:50:18 opera volumio[21174]: info: Updating RAAT Signal Path Jun 02 09:50:18 opera volumio[21174]: info: Updating RAAT Signal Path Jun 02 09:51:14 opera volumio[21174]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:51:14 opera volumio[21174]: info: Jun 02 09:51:14 opera volumio[21174]: ---------------------------- MPD announces state update: update Jun 02 09:51:14 opera volumio[21174]: info: ControllerMpd::getState Jun 02 09:51:14 opera volumio[21174]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:51:14 opera volumio[21174]: info: sendMpdCommand status took 2 milliseconds Jun 02 09:51:14 opera volumio[21174]: info: sendMpdCommand status took 1 milliseconds Jun 02 09:51:14 opera volumio[21174]: verbose: ControllerMpd::parseState Jun 02 09:51:15 opera volumio[21174]: info: Command Router : Notfying DB Updatetrue Jun 02 09:51:15 opera volumio[21174]: info: CoreCommandRouter::Close All Modals sent Jun 02 09:51:15 opera volumio[21174]: verbose: ControllerMpd::parseState Jun 02 09:51:15 opera volumio[21174]: info: ControllerMpd::pushState Jun 02 09:51:15 opera volumio[21174]: info: CoreCommandRouter::servicePushState Jun 02 09:51:15 opera volumio[21174]: info: CoreStateMachine::pushState Jun 02 09:51:15 opera volumio[21174]: info: CorePlayQueue::getTrack 0 Jun 02 09:51:15 opera volumio[21174]: info: CoreCommandRouter::volumioPushState Jun 02 09:51:15 opera volumio[21174]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:51:15 opera volumio[21174]: info: CorePlayQueue::getTrack 0 Jun 02 09:51:15 opera volumio[21174]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 02 09:51:15 opera volumio[21174]: verbose: CURRENT POSITION 0 Jun 02 09:51:15 opera volumio[21174]: info: CoreStateMachine::syncState stateService stop Jun 02 09:51:15 opera volumio[21174]: info: CoreStateMachine::syncState currentStatus stop Jun 02 09:51:15 opera volumio[21174]: info: CoreStateMachine::pushState Jun 02 09:51:15 opera volumio[21174]: info: CorePlayQueue::getTrack 0 Jun 02 09:51:15 opera volumio[21174]: info: CoreCommandRouter::volumioPushState Jun 02 09:51:15 opera volumio[21174]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:51:15 opera volumio[21174]: info: No code Jun 02 09:51:15 opera volumio[21174]: info: CoreStateMachine::pushState Jun 02 09:51:15 opera volumio[21174]: info: CorePlayQueue::getTrack 0 Jun 02 09:51:15 opera volumio[21174]: info: CoreCommandRouter::volumioPushState Jun 02 09:51:15 opera volumio[21174]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:51:15 opera volumio[21174]: info: ------------------------------ 754ms Jun 02 09:51:15 opera volumio[21174]: info: MPD Database updated - AlbumList cache refreshed Jun 02 09:51:15 opera volumio[21174]: info: Jun 02 09:51:15 opera volumio[21174]: ---------------------------- MPD announces state update: database Jun 02 09:51:15 opera volumio[21174]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:51:15 opera volumio[21174]: info: Jun 02 09:51:15 opera volumio[21174]: ---------------------------- MPD announces state update: update Jun 02 09:51:15 opera volumio[21174]: info: ControllerMpd::getState Jun 02 09:51:15 opera volumio[21174]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:51:15 opera volumio[21174]: info: ControllerMpd::getState Jun 02 09:51:15 opera volumio[21174]: verbose: ControllerMpd::sendMpdCommand status Jun 02 09:51:15 opera volumio[21174]: info: Updating RAAT Signal Path Jun 02 09:51:15 opera volumio[21174]: info: Updating RAAT Signal Path Jun 02 09:51:15 opera volumio[21174]: info: Updating RAAT Signal Path Jun 02 09:51:15 opera volumio[21174]: info: sendMpdCommand status took 44 milliseconds Jun 02 09:51:15 opera volumio[21174]: info: sendMpdCommand status took 44 milliseconds Jun 02 09:51:15 opera volumio[21174]: info: sendMpdCommand status took 43 milliseconds Jun 02 09:51:15 opera volumio[21174]: verbose: ControllerMpd::parseState Jun 02 09:51:15 opera volumio[21174]: info: Command Router : Notfying DB Updatefalse Jun 02 09:51:15 opera volumio[21174]: info: CoreCommandRouter::Close All Modals sent Jun 02 09:51:15 opera volumio[21174]: verbose: ControllerMpd::parseState Jun 02 09:51:15 opera volumio[21174]: verbose: ControllerMpd::parseState Jun 02 09:51:15 opera volumio[21174]: info: ControllerMpd::pushState Jun 02 09:51:15 opera volumio[21174]: info: CoreCommandRouter::servicePushState Jun 02 09:51:15 opera volumio[21174]: info: CoreStateMachine::pushState Jun 02 09:51:15 opera volumio[21174]: info: CorePlayQueue::getTrack 0 Jun 02 09:51:15 opera volumio[21174]: info: CoreCommandRouter::volumioPushState Jun 02 09:51:15 opera volumio[21174]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:51:15 opera volumio[21174]: info: CorePlayQueue::getTrack 0 Jun 02 09:51:15 opera volumio[21174]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 02 09:51:15 opera volumio[21174]: verbose: CURRENT POSITION 0 Jun 02 09:51:15 opera volumio[21174]: info: CoreStateMachine::syncState stateService stop Jun 02 09:51:15 opera volumio[21174]: info: CoreStateMachine::syncState currentStatus stop Jun 02 09:51:15 opera volumio[21174]: info: CoreStateMachine::pushState Jun 02 09:51:15 opera volumio[21174]: info: CorePlayQueue::getTrack 0 Jun 02 09:51:15 opera volumio[21174]: info: CoreCommandRouter::volumioPushState Jun 02 09:51:15 opera volumio[21174]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:51:15 opera volumio[21174]: info: No code Jun 02 09:51:15 opera volumio[21174]: info: CoreStateMachine::pushState Jun 02 09:51:15 opera volumio[21174]: info: CorePlayQueue::getTrack 0 Jun 02 09:51:15 opera volumio[21174]: info: CoreCommandRouter::volumioPushState Jun 02 09:51:15 opera volumio[21174]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:51:15 opera volumio[21174]: info: ControllerMpd::pushState Jun 02 09:51:15 opera volumio[21174]: info: CoreCommandRouter::servicePushState Jun 02 09:51:15 opera volumio[21174]: info: CoreStateMachine::pushState Jun 02 09:51:15 opera volumio[21174]: info: CorePlayQueue::getTrack 0 Jun 02 09:51:15 opera volumio[21174]: info: CoreCommandRouter::volumioPushState Jun 02 09:51:15 opera volumio[21174]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:51:15 opera volumio[21174]: info: CorePlayQueue::getTrack 0 Jun 02 09:51:15 opera volumio[21174]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 02 09:51:15 opera volumio[21174]: verbose: CURRENT POSITION 0 Jun 02 09:51:15 opera volumio[21174]: info: CoreStateMachine::syncState stateService stop Jun 02 09:51:15 opera volumio[21174]: info: CoreStateMachine::syncState currentStatus stop Jun 02 09:51:15 opera volumio[21174]: info: CoreStateMachine::pushState Jun 02 09:51:15 opera volumio[21174]: info: CorePlayQueue::getTrack 0 Jun 02 09:51:15 opera volumio[21174]: info: CoreCommandRouter::volumioPushState Jun 02 09:51:15 opera volumio[21174]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:51:15 opera volumio[21174]: info: No code Jun 02 09:51:15 opera volumio[21174]: info: CoreStateMachine::pushState Jun 02 09:51:15 opera volumio[21174]: info: CorePlayQueue::getTrack 0 Jun 02 09:51:15 opera volumio[21174]: info: CoreCommandRouter::volumioPushState Jun 02 09:51:15 opera volumio[21174]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 09:51:15 opera volumio[21174]: info: ------------------------------ 119ms Jun 02 09:51:15 opera volumio[21174]: info: ------------------------------ 120ms Jun 02 09:51:15 opera volumio[21174]: info: Updating RAAT Signal Path Jun 02 09:51:15 opera volumio[21174]: info: Updating RAAT Signal Path Jun 02 09:51:15 opera volumio[21174]: info: Updating RAAT Signal Path Jun 02 09:51:15 opera volumio[21174]: info: Updating RAAT Signal Path Jun 02 09:51:15 opera volumio[21174]: info: Updating RAAT Signal Path Jun 02 09:51:15 opera volumio[21174]: info: Updating RAAT Signal Path Jun 02 09:51:18 opera volumio[21174]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 09:51:18 opera volumio[21174]: { Error: connect ETIMEDOUT 59.188.250.54:443 Jun 02 09:51:18 opera volumio[21174]: at Object._errnoException (util.js:1022:11) Jun 02 09:51:18 opera volumio[21174]: at _exceptionWithHostPort (util.js:1044:20) Jun 02 09:51:18 opera volumio[21174]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jun 02 09:51:18 opera volumio[21174]: code: 'ETIMEDOUT', Jun 02 09:51:18 opera volumio[21174]: errno: 'ETIMEDOUT', Jun 02 09:51:18 opera volumio[21174]: syscall: 'connect', Jun 02 09:51:18 opera volumio[21174]: address: '59.188.250.54', Jun 02 09:51:18 opera volumio[21174]: port: 443 } Jun 02 09:51:18 opera volumio[21174]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 09:51:18 opera sudo[26174]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-06-02 09:50 Jun 02 09:51:18 opera sudo[26174]: 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"