-- Logs begin at Sun 2025-07-13 01:08:56 UTC, end at Mon 2026-01-12 04:21:59 UTC. -- Jan 12 04:20:09 opera volumio[1252]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 12 04:20:10 opera volumio[1252]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 12 04:21:05 opera volumio[1252]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 12 04:21:13 opera volumio[1252]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 12 04:21:14 opera volumio[1252]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 12 04:21:16 opera volumio[1252]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 12 04:21:16 opera volumio[1252]: info: CoreStateMachine::ClearQueue Jan 12 04:21:16 opera volumio[1252]: info: CoreStateMachine::stop Jan 12 04:21:16 opera volumio[1252]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 12 04:21:16 opera volumio[1252]: verbose: UNSET VOLATILE Jan 12 04:21:16 opera volumio[1252]: info: CoreStateMachine::stPlaybackTimer Jan 12 04:21:16 opera volumio[1252]: info: CoreStateMachine::updateTrackBlock Jan 12 04:21:16 opera volumio[1252]: info: CorePlayQueue::getTrackBlock Jan 12 04:21:16 opera volumio[1252]: info: CoreStateMachine::pushState Jan 12 04:21:16 opera volumio[1252]: info: CorePlayQueue::getTrack 0 Jan 12 04:21:16 opera volumio[1252]: info: CoreCommandRouter::volumioPushState Jan 12 04:21:16 opera volumio[1252]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 04:21:16 opera volumio[1252]: info: CoreStateMachine::serviceStop Jan 12 04:21:16 opera volumio[1252]: info: CorePlayQueue::getTrack 0 Jan 12 04:21:16 opera volumio[1252]: info: CoreCommandRouter::serviceStop Jan 12 04:21:16 opera volumio[1252]: info: [1768191676439] ControllerUPNPBrowser::stop Jan 12 04:21:16 opera volumio[1252]: verbose: ControllerMpd::sendMpdCommand stop Jan 12 04:21:16 opera volumio[1252]: info: CorePlayQueue::clearPlayQueue Jan 12 04:21:16 opera volumio[1252]: info: CorePlayQueue::saveQueue Jan 12 04:21:16 opera volumio[1252]: info: CoreCommandRouter::volumioPushState Jan 12 04:21:16 opera volumio[1252]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 04:21:16 opera volumio[1252]: info: CoreCommandRouter::volumioPushQueue Jan 12 04:21:16 opera volumio[1252]: info: CoreStateMachine::addQueueItems Jan 12 04:21:16 opera volumio[1252]: info: CorePlayQueue::addQueueItems Jan 12 04:21:16 opera volumio[1252]: info: Adding Item to queue: upnp/folder/http://192.168.3.34:9791/23af3df5-b670-42d2-89a7-12418e207b15/upnp.org-ContentDirectory-1/control@0$folders$f1873$f1924$f1925 Jan 12 04:21:16 opera volumio[1252]: info: Exploding uri upnp/folder/http://192.168.3.34:9791/23af3df5-b670-42d2-89a7-12418e207b15/upnp.org-ContentDirectory-1/control@0$folders$f1873$f1924$f1925 in service upnp_browser Jan 12 04:21:16 opera volumio[1252]: info: Updating RAAT Signal Path Jan 12 04:21:16 opera volumio[1252]: info: Updating RAAT Signal Path Jan 12 04:21:16 opera volumio[1252]: info: CorePlayQueue::saveQueue Jan 12 04:21:16 opera volumio[1252]: info: CoreCommandRouter::volumioPushQueue Jan 12 04:21:16 opera volumio[1252]: info: CoreStateMachine::updateTrackBlock Jan 12 04:21:16 opera volumio[1252]: info: CorePlayQueue::getTrackBlock Jan 12 04:21:16 opera volumio[1252]: info: CoreCommandRouter::volumioPlay Jan 12 04:21:16 opera volumio[1252]: verbose: UNSET VOLATILE Jan 12 04:21:16 opera volumio[1252]: info: CoreStateMachine::play index 0 Jan 12 04:21:16 opera volumio[1252]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 12 04:21:16 opera volumio[1252]: info: CoreStateMachine::stop Jan 12 04:21:16 opera volumio[1252]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 12 04:21:16 opera volumio[1252]: verbose: UNSET VOLATILE Jan 12 04:21:16 opera volumio[1252]: info: CoreStateMachine::play index undefined Jan 12 04:21:16 opera volumio[1252]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 12 04:21:16 opera volumio[1252]: info: CorePlayQueue::getTrack 0 Jan 12 04:21:16 opera volumio[1252]: info: CoreStateMachine::startPlaybackTimer Jan 12 04:21:16 opera volumio[1252]: info: CorePlayQueue::getTrack 0 Jan 12 04:21:16 opera volumio[1252]: info: [1768191676478] ControllerUPNPBrowser::clearAddPlayTrack Jan 12 04:21:16 opera volumio[1252]: verbose: ControllerMpd::sendMpdCommand stop Jan 12 04:21:16 opera volumio[1252]: info: Jan 12 04:21:16 opera volumio[1252]: ---------------------------- MPD announces state update: player Jan 12 04:21:16 opera volumio[1252]: info: sendMpdCommand stop took 58 milliseconds Jan 12 04:21:16 opera volumio[1252]: info: ControllerMpd::getState Jan 12 04:21:16 opera volumio[1252]: verbose: ControllerMpd::sendMpdCommand status Jan 12 04:21:16 opera volumio[1252]: info: sendMpdCommand stop took 20 milliseconds Jan 12 04:21:16 opera volumio[1252]: verbose: ControllerMpd::sendMpdCommand clear Jan 12 04:21:16 opera volumio[1252]: info: Jan 12 04:21:16 opera volumio[1252]: ---------------------------- MPD announces system playlist update Jan 12 04:21:16 opera volumio[1252]: info: Ignoring MPD Status Update Jan 12 04:21:16 opera volumio[1252]: info: sendMpdCommand status took 8 milliseconds Jan 12 04:21:16 opera volumio[1252]: info: sendMpdCommand clear took 7 milliseconds Jan 12 04:21:16 opera volumio[1252]: verbose: ControllerMpd::parseState Jan 12 04:21:16 opera volumio[1252]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 12 04:21:16 opera volumio[1252]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.3.34:9790/minimserver/*/music/*e6*b5*8b*e8*af*95/Everest*20SDBR-3018*20*e9*98*bf*e4*bc*a6*c2*b7*e7*a7*91*e6*99*ae*e5*85*b0*e3*80*8a*e7*ac*ac*e4*b8*89*e4*ba*a4*e5*93*8d*e6*9b*b2*e3*80*8bAaron*20Copland-Symphony*20No.3*20(1959)/Everest*20SDBR-3018*20*e9*98*bf*e4*bc*a6*c2*b7*e7*a7*91*e6*99*ae*e5*85*b0*e3*80*8a*e7*ac*ac*e4*b8*89*e4*ba*a4*e5*93*8d*e6*9b*b2*e3*80*8bAaron*20Copland-Symphony*20No.3*20(1959)/01*20-*20Symphony*20No.*203-*20I.*20Molto*20moderato.flac" Jan 12 04:21:16 opera volumio[1252]: error: updateQueue error: null Jan 12 04:21:16 opera volumio[1252]: info: ------------------------------ 3ms Jan 12 04:21:16 opera volumio[1252]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 12 04:21:16 opera volumio[1252]: verbose: ControllerMpd::parseTrackInfo Jan 12 04:21:16 opera volumio[1252]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 12 04:21:16 opera volumio[1252]: info: ------------------------------ 12ms Jan 12 04:21:16 opera volumio[1252]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.3.34:9790/minimserver/*/music/*e6*b5*8b*e8*af*95/Everest*20SDBR-3018*20*e9*98*bf*e4*bc*a6*c2*b7*e7*a7*91*e6*99*ae*e5*85*b0*e3*80*8a*e7*ac*ac*e4*b8*89*e4*ba*a4*e5*93*8d*e6*9b*b2*e3*80*8bAaron*20Copland-Symphony*20No.3*20(1959)/Everest*20SDBR-3018*20*e9*98*bf*e4*bc*a6*c2*b7*e7*a7*91*e6*99*ae*e5*85*b0*e3*80*8a*e7*ac*ac*e4*b8*89*e4*ba*a4*e5*93*8d*e6*9b*b2*e3*80*8bAaron*20Copland-Symphony*20No.3*20(1959)/01*20-*20Symphony*20No.*203-*20I.*20Molto*20moderato.flac" Jan 12 04:21:16 opera volumio[1252]: info: Jan 12 04:21:16 opera volumio[1252]: ---------------------------- MPD announces system playlist update Jan 12 04:21:16 opera volumio[1252]: info: Ignoring MPD Status Update Jan 12 04:21:16 opera volumio[1252]: info: sendMpdCommand add "http://192.168.3.34:9790/minimserver/*/music/*e6*b5*8b*e8*af*95/Everest*20SDBR-3018*20*e9*98*bf*e4*bc*a6*c2*b7*e7*a7*91*e6*99*ae*e5*85*b0*e3*80*8a*e7*ac*ac*e4*b8*89*e4*ba*a4*e5*93*8d*e6*9b*b2*e3*80*8bAaron*20Copland-Symphony*20No.3*20(1959)/Everest*20SDBR-3018*20*e9*98*bf*e4*bc*a6*c2*b7*e7*a7*91*e6*99*ae*e5*85*b0*e3*80*8a*e7*ac*ac*e4*b8*89*e4*ba*a4*e5*93*8d*e6*9b*b2*e3*80*8bAaron*20Copland-Symphony*20No.3*20(1959)/01*20-*20Symphony*20No.*203-*20I.*20Molto*20moderato.flac" took 3 milliseconds Jan 12 04:21:16 opera volumio[1252]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 12 04:21:16 opera volumio[1252]: verbose: ControllerMpd::sendMpdCommand play Jan 12 04:21:16 opera volumio[1252]: info: ------------------------------ 4ms Jan 12 04:21:16 opera volumio[1252]: info: sendMpdCommand play took 2 milliseconds Jan 12 04:21:16 opera volumio[1252]: info: Jan 12 04:21:16 opera volumio[1252]: ---------------------------- MPD announces state update: player Jan 12 04:21:16 opera volumio[1252]: info: ControllerMpd::getState Jan 12 04:21:16 opera volumio[1252]: verbose: ControllerMpd::sendMpdCommand status Jan 12 04:21:16 opera volumio[1252]: info: sendMpdCommand status took 125 milliseconds Jan 12 04:21:16 opera volumio[1252]: verbose: ControllerMpd::parseState Jan 12 04:21:16 opera volumio[1252]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 12 04:21:16 opera volumio[1252]: info: Jan 12 04:21:16 opera volumio[1252]: ---------------------------- MPD announces state update: player Jan 12 04:21:16 opera volumio[1252]: info: ControllerMpd::getState Jan 12 04:21:16 opera volumio[1252]: verbose: ControllerMpd::sendMpdCommand status Jan 12 04:21:16 opera volumio[1252]: info: Jan 12 04:21:16 opera volumio[1252]: ---------------------------- MPD announces system playlist update Jan 12 04:21:16 opera volumio[1252]: info: Ignoring MPD Status Update Jan 12 04:21:16 opera volumio[1252]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 12 04:21:16 opera volumio[1252]: info: sendMpdCommand status took 3 milliseconds Jan 12 04:21:16 opera volumio[1252]: verbose: ControllerMpd::parseTrackInfo Jan 12 04:21:16 opera volumio[1252]: verbose: ControllerMpd::parseState Jan 12 04:21:16 opera volumio[1252]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 12 04:21:16 opera volumio[1252]: info: ControllerMpd::pushState Jan 12 04:21:16 opera volumio[1252]: info: CoreCommandRouter::servicePushState Jan 12 04:21:16 opera volumio[1252]: info: CorePlayQueue::getTrack 0 Jan 12 04:21:16 opera volumio[1252]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":571,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Symphony No. 3: I. Molto moderato","artist":"London Symphony Orchestra, Aaron Copland","album":"Copland: Symphony No. 3","uri":"http://192.168.3.34:9790/minimserver/*/music/*e6*b5*8b*e8*af*95/Everest*20SDBR-3018*20*e9*98*bf*e4*bc*a6*c2*b7*e7*a7*91*e6*99*ae*e5*85*b0*e3*80*8a*e7*ac*ac*e4*b8*89*e4*ba*a4*e5*93*8d*e6*9b*b2*e3*80*8bAaron*20Copland-Symphony*20No.3*20(1959)/Everest*20SDBR-3018*20*e9*98*bf*e4*bc*a6*c2*b7*e7*a7*91*e6*99*ae*e5*85*b0*e3*80*8a*e7*ac*ac*e4*b8*89*e4*ba*a4*e5*93*8d*e6*9b*b2*e3*80*8bAaron*20Copland-Symphony*20No.3*20(1959)/01*20-*20Symphony*20No.*203-*20I.*20Molto*20moderato.flac","trackType":"flac"} Jan 12 04:21:16 opera volumio[1252]: verbose: CURRENT POSITION 0 Jan 12 04:21:16 opera volumio[1252]: info: CoreStateMachine::syncState stateService play Jan 12 04:21:16 opera volumio[1252]: info: CoreStateMachine::syncState currentStatus stop Jan 12 04:21:16 opera volumio[1252]: info: CoreStateMachine::pushState Jan 12 04:21:16 opera volumio[1252]: info: CoreCommandRouter::volumioPushState Jan 12 04:21:16 opera volumio[1252]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 04:21:16 opera volumio[1252]: info: ------------------------------ 141ms Jan 12 04:21:16 opera volumio[1252]: info: ------------------------------ 12ms Jan 12 04:21:16 opera volumio[1252]: info: sendMpdCommand playlistinfo took 11 milliseconds Jan 12 04:21:16 opera volumio[1252]: verbose: ControllerMpd::parseTrackInfo Jan 12 04:21:16 opera volumio[1252]: info: ControllerMpd::pushState Jan 12 04:21:16 opera volumio[1252]: info: CoreCommandRouter::servicePushState Jan 12 04:21:16 opera volumio[1252]: info: CorePlayQueue::getTrack 0 Jan 12 04:21:16 opera volumio[1252]: verbose: STATE SERVICE {"status":"play","position":0,"seek":61,"duration":571,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4198 Kbps","isStreaming":false,"title":"Symphony No. 3: I. Molto moderato","artist":"London Symphony Orchestra, Aaron Copland","album":"Copland: Symphony No. 3","uri":"http://192.168.3.34:9790/minimserver/*/music/*e6*b5*8b*e8*af*95/Everest*20SDBR-3018*20*e9*98*bf*e4*bc*a6*c2*b7*e7*a7*91*e6*99*ae*e5*85*b0*e3*80*8a*e7*ac*ac*e4*b8*89*e4*ba*a4*e5*93*8d*e6*9b*b2*e3*80*8bAaron*20Copland-Symphony*20No.3*20(1959)/Everest*20SDBR-3018*20*e9*98*bf*e4*bc*a6*c2*b7*e7*a7*91*e6*99*ae*e5*85*b0*e3*80*8a*e7*ac*ac*e4*b8*89*e4*ba*a4*e5*93*8d*e6*9b*b2*e3*80*8bAaron*20Copland-Symphony*20No.3*20(1959)/01*20-*20Symphony*20No.*203-*20I.*20Molto*20moderato.flac","trackType":"flac"} Jan 12 04:21:16 opera volumio[1252]: verbose: CURRENT POSITION 0 Jan 12 04:21:16 opera volumio[1252]: info: CoreStateMachine::syncState stateService play Jan 12 04:21:16 opera volumio[1252]: info: CoreStateMachine::syncState currentStatus play Jan 12 04:21:16 opera volumio[1252]: info: Received an update from plugin. extracting info from payload Jan 12 04:21:16 opera volumio[1252]: info: CoreStateMachine::pushState Jan 12 04:21:16 opera volumio[1252]: info: CoreCommandRouter::volumioPushState Jan 12 04:21:16 opera volumio[1252]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 04:21:16 opera volumio[1252]: info: CoreStateMachine::pushState Jan 12 04:21:16 opera volumio[1252]: info: CoreCommandRouter::volumioPushState Jan 12 04:21:16 opera volumio[1252]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 04:21:16 opera volumio[1252]: info: ------------------------------ 26ms Jan 12 04:21:16 opera volumio[1252]: info: CoreCommandRouter::volumioGetQueue Jan 12 04:21:16 opera volumio[1252]: info: CoreStateMachine::getQueue Jan 12 04:21:16 opera volumio[1252]: info: CorePlayQueue::getQueue Jan 12 04:21:16 opera volumio[1252]: info: Updating RAAT Signal Path Jan 12 04:21:16 opera volumio[1252]: info: CoreCommandRouter::volumioGetQueue Jan 12 04:21:16 opera volumio[1252]: info: CoreStateMachine::getQueue Jan 12 04:21:16 opera volumio[1252]: info: CorePlayQueue::getQueue Jan 12 04:21:16 opera volumio[1252]: info: Updating RAAT Signal Path Jan 12 04:21:16 opera volumio[1252]: info: CoreCommandRouter::volumioGetQueue Jan 12 04:21:16 opera volumio[1252]: info: CoreStateMachine::getQueue Jan 12 04:21:16 opera volumio[1252]: info: CorePlayQueue::getQueue Jan 12 04:21:16 opera volumio[1252]: info: Updating RAAT Signal Path Jan 12 04:21:34 opera volumio[1252]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 12 04:21:36 opera volumio[1252]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 12 04:21:42 opera volumio[1252]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 12 04:21:49 opera volumio[1252]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 12 04:21:58 opera volumio[1252]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jan 12 04:21:59 opera volumio[1252]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Paul%20Mauriat/The%20Seven%20Seas/76d574ba-e904-4245-9b36-69a66c112e1e.jpg' Jan 12 04:21:59 opera volumio[1252]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 12 04:21:59 opera volumio[1252]: { Error: connect ECONNREFUSED 199.59.148.7:443 Jan 12 04:21:59 opera volumio[1252]: at Object._errnoException (util.js:1022:11) Jan 12 04:21:59 opera volumio[1252]: at _exceptionWithHostPort (util.js:1044:20) Jan 12 04:21:59 opera volumio[1252]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jan 12 04:21:59 opera volumio[1252]: code: 'ECONNREFUSED', Jan 12 04:21:59 opera volumio[1252]: errno: 'ECONNREFUSED', Jan 12 04:21:59 opera volumio[1252]: syscall: 'connect', Jan 12 04:21:59 opera volumio[1252]: address: '199.59.148.7', Jan 12 04:21:59 opera volumio[1252]: port: 443 } Jan 12 04:21:59 opera volumio[1252]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 12 04:21:59 opera sudo[13845]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-12 04:20 Jan 12 04:21:59 opera sudo[13845]: 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"