-- Logs begin at Wed 2024-05-01 04:39:49 UTC, end at Tue 2025-10-28 11:52:24 UTC. -- Oct 28 11:52:21 opera-amp150 volumio[22469]: info: Clearing queue after UPNP request Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CoreStateMachine::ClearQueue Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CoreStateMachine::stop Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 11:52:21 opera-amp150 volumio[22469]: verbose: UNSET VOLATILE Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CoreStateMachine::stPlaybackTimer Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CoreStateMachine::updateTrackBlock Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CorePlayQueue::getTrackBlock Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CoreStateMachine::pushState Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CorePlayQueue::getTrack 0 Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CoreCommandRouter::volumioPushState Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CoreStateMachine::serviceStop Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CorePlayQueue::getTrack 0 Oct 28 11:52:21 opera-amp150 volumio[22469]: info: ControllerMpd::stop Oct 28 11:52:21 opera-amp150 volumio[22469]: verbose: ControllerMpd::sendMpdCommand stop Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CorePlayQueue::clearPlayQueue Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CorePlayQueue::saveQueue Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CoreCommandRouter::volumioPushState Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CoreCommandRouter::volumioPushQueue Oct 28 11:52:21 opera-amp150 volumio[22469]: info: Oct 28 11:52:21 opera-amp150 volumio[22469]: ---------------------------- MPD announces system playlist update Oct 28 11:52:21 opera-amp150 volumio[22469]: info: Ignoring MPD Status Update Oct 28 11:52:21 opera-amp150 volumio[22469]: info: Oct 28 11:52:21 opera-amp150 volumio[22469]: ---------------------------- MPD announces state update: player Oct 28 11:52:21 opera-amp150 volumio[22469]: info: ControllerMpd::getState Oct 28 11:52:21 opera-amp150 volumio[22469]: verbose: ControllerMpd::sendMpdCommand status Oct 28 11:52:21 opera-amp150 volumio[22469]: info: sendMpdCommand stop took 28 milliseconds Oct 28 11:52:21 opera-amp150 volumio[22469]: error: updateQueue error: null Oct 28 11:52:21 opera-amp150 volumio[22469]: info: ------------------------------ 8ms Oct 28 11:52:21 opera-amp150 volumio[22469]: info: sendMpdCommand status took 2 milliseconds Oct 28 11:52:21 opera-amp150 volumio[22469]: verbose: ControllerMpd::parseState Oct 28 11:52:21 opera-amp150 volumio[22469]: info: ControllerMpd::pushState Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CoreCommandRouter::servicePushState Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CoreStateMachine::pushState Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CorePlayQueue::getTrack 0 Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CoreCommandRouter::volumioPushState Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CorePlayQueue::getTrack 0 Oct 28 11:52:21 opera-amp150 volumio[22469]: 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} Oct 28 11:52:21 opera-amp150 volumio[22469]: verbose: CURRENT POSITION 0 Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CoreStateMachine::syncState stateService stop Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CoreStateMachine::syncState currentStatus stop Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CoreStateMachine::pushState Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CorePlayQueue::getTrack 0 Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CoreCommandRouter::volumioPushState Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 28 11:52:21 opera-amp150 volumio[22469]: info: No code Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CoreStateMachine::pushState Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CorePlayQueue::getTrack 0 Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CoreCommandRouter::volumioPushState Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 28 11:52:21 opera-amp150 volumio[22469]: info: ------------------------------ 21ms Oct 28 11:52:21 opera-amp150 volumio[22469]: info: Starting UPNP Playback Oct 28 11:52:21 opera-amp150 volumio[22469]: info: Preparing playback through UPNP Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CoreCommandRouter::volumioGetState Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CorePlayQueue::getTrack 0 Oct 28 11:52:21 opera-amp150 volumio[22469]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 28 11:52:22 opera-amp150 volumio[22469]: info: Oct 28 11:52:22 opera-amp150 volumio[22469]: ---------------------------- MPD announces system playlist update Oct 28 11:52:22 opera-amp150 volumio[22469]: info: Ignoring MPD Status Update Oct 28 11:52:22 opera-amp150 volumio[22469]: info: ------------------------------ 2ms Oct 28 11:52:22 opera-amp150 volumio[22469]: info: Oct 28 11:52:22 opera-amp150 volumio[22469]: ---------------------------- MPD announces system playlist update Oct 28 11:52:22 opera-amp150 volumio[22469]: info: Ignoring MPD Status Update Oct 28 11:52:22 opera-amp150 volumio[22469]: info: ------------------------------ 1ms Oct 28 11:52:22 opera-amp150 volumio[22469]: info: Oct 28 11:52:22 opera-amp150 volumio[22469]: ---------------------------- MPD announces system playlist update Oct 28 11:52:22 opera-amp150 volumio[22469]: info: Ignoring MPD Status Update Oct 28 11:52:22 opera-amp150 volumio[22469]: info: ------------------------------ 1ms Oct 28 11:52:22 opera-amp150 volumio[22469]: info: Oct 28 11:52:22 opera-amp150 volumio[22469]: ---------------------------- MPD announces system playlist update Oct 28 11:52:22 opera-amp150 volumio[22469]: info: Ignoring MPD Status Update Oct 28 11:52:22 opera-amp150 volumio[22469]: info: ------------------------------ 1ms Oct 28 11:52:22 opera-amp150 volumio[22469]: info: Oct 28 11:52:22 opera-amp150 volumio[22469]: ---------------------------- MPD announces system playlist update Oct 28 11:52:22 opera-amp150 volumio[22469]: info: Ignoring MPD Status Update Oct 28 11:52:22 opera-amp150 volumio[22469]: info: ------------------------------ 1ms Oct 28 11:52:22 opera-amp150 volumio[22469]: info: Oct 28 11:52:22 opera-amp150 volumio[22469]: ---------------------------- MPD announces system playlist update Oct 28 11:52:22 opera-amp150 volumio[22469]: info: Ignoring MPD Status Update Oct 28 11:52:22 opera-amp150 volumio[22469]: info: ------------------------------ 1ms Oct 28 11:52:23 opera-amp150 volumio[22469]: info: Oct 28 11:52:23 opera-amp150 volumio[22469]: ---------------------------- MPD announces state update: player Oct 28 11:52:23 opera-amp150 volumio[22469]: info: ControllerMpd::getState Oct 28 11:52:23 opera-amp150 volumio[22469]: verbose: ControllerMpd::sendMpdCommand status Oct 28 11:52:23 opera-amp150 volumio[22469]: info: Oct 28 11:52:23 opera-amp150 volumio[22469]: ---------------------------- MPD announces system playlist update Oct 28 11:52:23 opera-amp150 volumio[22469]: info: Ignoring MPD Status Update Oct 28 11:52:23 opera-amp150 volumio[22469]: info: Oct 28 11:52:23 opera-amp150 volumio[22469]: ---------------------------- MPD announces state update: player Oct 28 11:52:23 opera-amp150 volumio[22469]: info: ControllerMpd::getState Oct 28 11:52:23 opera-amp150 volumio[22469]: verbose: ControllerMpd::sendMpdCommand status Oct 28 11:52:23 opera-amp150 volumio[22469]: info: sendMpdCommand status took 2 milliseconds Oct 28 11:52:23 opera-amp150 volumio[22469]: verbose: ControllerMpd::parseState Oct 28 11:52:23 opera-amp150 volumio[22469]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 11:52:23 opera-amp150 volumio[22469]: info: ------------------------------ 9ms Oct 28 11:52:23 opera-amp150 volumio[22469]: info: sendMpdCommand status took 11 milliseconds Oct 28 11:52:23 opera-amp150 volumio[22469]: info: sendMpdCommand playlistinfo took 9 milliseconds Oct 28 11:52:23 opera-amp150 volumio[22469]: verbose: ControllerMpd::parseState Oct 28 11:52:23 opera-amp150 volumio[22469]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 11:52:23 opera-amp150 volumio[22469]: verbose: ControllerMpd::parseTrackInfo Oct 28 11:52:23 opera-amp150 volumio[22469]: info: ControllerMpd::pushState Oct 28 11:52:23 opera-amp150 volumio[22469]: info: CoreCommandRouter::servicePushState Oct 28 11:52:23 opera-amp150 volumio[22469]: verbose: In UPNP mode Oct 28 11:52:23 opera-amp150 volumio[22469]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":3876,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"266 Kbps","isStreaming":false,"title":"Internal Flight","artist":"Estas Tonne","album":"Internal Flight","uri":"http://192.168.31.237:9790/minimserver/*/Multimedia/*e6*97*a0*e6*8d*9f*e6*a0*bc*e5*bc*8f*e9*9f*b3*e4*b9*90/*e6*97*a0*e6*8d*9f*e6*a0*bc*e5*bc*8f*e6*96*b0*e9*9f*b3*e4*b9*90/*e5*9b*bd*e5*a4*96/Estas*20Tonne/2013*20-*20Internal*20Flight/Internal*20Flight.flac","trackType":"flac"} Oct 28 11:52:23 opera-amp150 volumio[22469]: verbose: CURRENT POSITION 0 Oct 28 11:52:23 opera-amp150 volumio[22469]: info: CoreStateMachine::syncState stateService play Oct 28 11:52:23 opera-amp150 volumio[22469]: info: CoreStateMachine::syncState currentStatus stop Oct 28 11:52:23 opera-amp150 volumio[22469]: info: CoreStateMachine::pushState Oct 28 11:52:23 opera-amp150 volumio[22469]: info: CoreCommandRouter::volumioPushState Oct 28 11:52:23 opera-amp150 volumio[22469]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 28 11:52:23 opera-amp150 volumio[22469]: info: ------------------------------ 33ms Oct 28 11:52:23 opera-amp150 volumio[22469]: info: sendMpdCommand playlistinfo took 20 milliseconds Oct 28 11:52:23 opera-amp150 volumio[22469]: verbose: ControllerMpd::parseTrackInfo Oct 28 11:52:23 opera-amp150 volumio[22469]: info: ControllerMpd::pushState Oct 28 11:52:23 opera-amp150 volumio[22469]: info: CoreCommandRouter::servicePushState Oct 28 11:52:23 opera-amp150 volumio[22469]: verbose: In UPNP mode Oct 28 11:52:23 opera-amp150 volumio[22469]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":3876,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"259 Kbps","isStreaming":false,"title":"Internal Flight","artist":"Estas Tonne","album":"Internal Flight","uri":"http://192.168.31.237:9790/minimserver/*/Multimedia/*e6*97*a0*e6*8d*9f*e6*a0*bc*e5*bc*8f*e9*9f*b3*e4*b9*90/*e6*97*a0*e6*8d*9f*e6*a0*bc*e5*bc*8f*e6*96*b0*e9*9f*b3*e4*b9*90/*e5*9b*bd*e5*a4*96/Estas*20Tonne/2013*20-*20Internal*20Flight/Internal*20Flight.flac","trackType":"flac"} Oct 28 11:52:23 opera-amp150 volumio[22469]: verbose: CURRENT POSITION 0 Oct 28 11:52:23 opera-amp150 volumio[22469]: info: CoreStateMachine::syncState stateService play Oct 28 11:52:23 opera-amp150 volumio[22469]: info: CoreStateMachine::syncState currentStatus play Oct 28 11:52:23 opera-amp150 volumio[22469]: info: Received an update from plugin. extracting info from payload Oct 28 11:52:23 opera-amp150 volumio[22469]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 28 11:52:23 opera-amp150 volumio[22469]: info: CoreStateMachine::pushState Oct 28 11:52:23 opera-amp150 volumio[22469]: info: CoreCommandRouter::volumioPushState Oct 28 11:52:23 opera-amp150 volumio[22469]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 28 11:52:23 opera-amp150 volumio[22469]: info: CoreStateMachine::pushState Oct 28 11:52:23 opera-amp150 volumio[22469]: info: CoreCommandRouter::volumioPushState Oct 28 11:52:23 opera-amp150 volumio[22469]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 28 11:52:23 opera-amp150 volumio[22469]: info: ------------------------------ 45ms Oct 28 11:52:23 opera-amp150 volumio[22469]: info: CoreCommandRouter::volumioGetQueue Oct 28 11:52:23 opera-amp150 volumio[22469]: info: CoreStateMachine::getQueue Oct 28 11:52:23 opera-amp150 volumio[22469]: info: CorePlayQueue::getQueue Oct 28 11:52:23 opera-amp150 volumio[22469]: info: CoreCommandRouter::volumioGetQueue Oct 28 11:52:23 opera-amp150 volumio[22469]: info: CoreStateMachine::getQueue Oct 28 11:52:23 opera-amp150 volumio[22469]: info: CorePlayQueue::getQueue Oct 28 11:52:24 opera-amp150 volumio[22469]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 28 11:52:24 opera-amp150 volumio[22469]: { Error: connect ECONNREFUSED 4.78.139.54:443 Oct 28 11:52:24 opera-amp150 volumio[22469]: at Object._errnoException (util.js:1022:11) Oct 28 11:52:24 opera-amp150 volumio[22469]: at _exceptionWithHostPort (util.js:1044:20) Oct 28 11:52:24 opera-amp150 volumio[22469]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Oct 28 11:52:24 opera-amp150 volumio[22469]: code: 'ECONNREFUSED', Oct 28 11:52:24 opera-amp150 volumio[22469]: errno: 'ECONNREFUSED', Oct 28 11:52:24 opera-amp150 volumio[22469]: syscall: 'connect', Oct 28 11:52:24 opera-amp150 volumio[22469]: address: '4.78.139.54', Oct 28 11:52:24 opera-amp150 volumio[22469]: port: 443 } Oct 28 11:52:24 opera-amp150 volumio[22469]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 28 11:52:24 opera-amp150 sudo[29782]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-28 11:51 Oct 28 11:52:24 opera-amp150 sudo[29782]: 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"