-- Logs begin at Mon 2025-10-27 04:46:11 UTC, end at Mon 2025-10-27 12:00:32 UTC. -- Oct 27 11:59:00 opera-amp150 volumio[10226]: verbose: In UPNP mode Oct 27 11:59:00 opera-amp150 volumio[10226]: verbose: STATE SERVICE {"status":"play","position":4,"seek":0,"duration":860,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Spirit of Time","artist":"Estas Tonne","album":"Spirit of Time","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/singles*20*e5*8d*95*e6*9b*b2/Spirit*20of*20Time.flac","trackType":"flac"} Oct 27 11:59:00 opera-amp150 volumio[10226]: verbose: CURRENT POSITION 0 Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CoreStateMachine::syncState stateService play Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CoreStateMachine::syncState currentStatus play Oct 27 11:59:00 opera-amp150 volumio[10226]: info: Received an update from plugin. extracting info from payload Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CoreStateMachine::pushState Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CoreCommandRouter::volumioPushState Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CoreStateMachine::pushState Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CoreCommandRouter::volumioPushState Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 11:59:00 opera-amp150 volumio[10226]: info: ------------------------------ 13ms Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CoreCommandRouter::volumioGetQueue Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CoreStateMachine::getQueue Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CorePlayQueue::getQueue Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CoreCommandRouter::volumioGetQueue Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CoreStateMachine::getQueue Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CorePlayQueue::getQueue Oct 27 11:59:00 opera-amp150 volumio[10226]: info: Oct 27 11:59:00 opera-amp150 volumio[10226]: ---------------------------- MPD announces system playlist update Oct 27 11:59:00 opera-amp150 volumio[10226]: info: Ignoring MPD Status Update Oct 27 11:59:00 opera-amp150 volumio[10226]: info: Oct 27 11:59:00 opera-amp150 volumio[10226]: ---------------------------- MPD announces state update: player Oct 27 11:59:00 opera-amp150 volumio[10226]: info: ControllerMpd::getState Oct 27 11:59:00 opera-amp150 volumio[10226]: verbose: ControllerMpd::sendMpdCommand status Oct 27 11:59:00 opera-amp150 volumio[10226]: info: ------------------------------ 2ms Oct 27 11:59:00 opera-amp150 volumio[10226]: info: sendMpdCommand status took 3 milliseconds Oct 27 11:59:00 opera-amp150 volumio[10226]: verbose: ControllerMpd::parseState Oct 27 11:59:00 opera-amp150 volumio[10226]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 11:59:00 opera-amp150 volumio[10226]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 27 11:59:00 opera-amp150 volumio[10226]: verbose: ControllerMpd::parseTrackInfo Oct 27 11:59:00 opera-amp150 volumio[10226]: info: ControllerMpd::pushState Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CoreCommandRouter::servicePushState Oct 27 11:59:00 opera-amp150 volumio[10226]: verbose: In UPNP mode Oct 27 11:59:00 opera-amp150 volumio[10226]: verbose: STATE SERVICE {"status":"play","position":4,"seek":0,"duration":860,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"403 Kbps","isStreaming":false,"title":"Spirit of Time","artist":"Estas Tonne","album":"Spirit of Time","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/singles*20*e5*8d*95*e6*9b*b2/Spirit*20of*20Time.flac","trackType":"flac"} Oct 27 11:59:00 opera-amp150 volumio[10226]: verbose: CURRENT POSITION 0 Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CoreStateMachine::syncState stateService play Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CoreStateMachine::syncState currentStatus play Oct 27 11:59:00 opera-amp150 volumio[10226]: info: Received an update from plugin. extracting info from payload Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CoreStateMachine::pushState Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CoreCommandRouter::volumioPushState Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CoreStateMachine::pushState Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CoreCommandRouter::volumioPushState Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 11:59:00 opera-amp150 volumio[10226]: info: ------------------------------ 22ms Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CoreCommandRouter::volumioGetQueue Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CoreStateMachine::getQueue Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CorePlayQueue::getQueue Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CoreCommandRouter::volumioGetQueue Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CoreStateMachine::getQueue Oct 27 11:59:00 opera-amp150 volumio[10226]: info: CorePlayQueue::getQueue Oct 27 11:59:55 opera-amp150 volumio[10226]: info: Oct 27 11:59:55 opera-amp150 volumio[10226]: ---------------------------- MPD announces state update: player Oct 27 11:59:55 opera-amp150 volumio[10226]: info: ControllerMpd::getState Oct 27 11:59:55 opera-amp150 volumio[10226]: verbose: ControllerMpd::sendMpdCommand status Oct 27 11:59:55 opera-amp150 volumio[10226]: info: sendMpdCommand status took 1 milliseconds Oct 27 11:59:55 opera-amp150 volumio[10226]: verbose: ControllerMpd::parseState Oct 27 11:59:55 opera-amp150 volumio[10226]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 11:59:55 opera-amp150 volumio[10226]: info: sendMpdCommand playlistinfo took 24 milliseconds Oct 27 11:59:55 opera-amp150 volumio[10226]: verbose: ControllerMpd::parseTrackInfo Oct 27 11:59:55 opera-amp150 volumio[10226]: info: ControllerMpd::pushState Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CoreCommandRouter::servicePushState Oct 27 11:59:55 opera-amp150 volumio[10226]: verbose: In UPNP mode Oct 27 11:59:55 opera-amp150 volumio[10226]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":740,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Introspection","artist":"Estas Tonne","album":"Introspection","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/singles*20*e5*8d*95*e6*9b*b2/Introspection.flac","trackType":"flac"} Oct 27 11:59:55 opera-amp150 volumio[10226]: verbose: CURRENT POSITION 0 Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CoreStateMachine::syncState stateService play Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CoreStateMachine::syncState currentStatus play Oct 27 11:59:55 opera-amp150 volumio[10226]: info: Received an update from plugin. extracting info from payload Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CoreStateMachine::pushState Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CoreCommandRouter::volumioPushState Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CoreStateMachine::pushState Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CoreCommandRouter::volumioPushState Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 11:59:55 opera-amp150 volumio[10226]: info: ------------------------------ 34ms Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CoreCommandRouter::volumioGetQueue Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CoreStateMachine::getQueue Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CorePlayQueue::getQueue Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CoreCommandRouter::volumioGetQueue Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CoreStateMachine::getQueue Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CorePlayQueue::getQueue Oct 27 11:59:55 opera-amp150 volumio[10226]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Estas%20Tonne/Introspection/c3a38aee-1b3d-4ad9-9474-f3aaa241e15c.jpg' Oct 27 11:59:55 opera-amp150 volumio[10226]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Estas%20Tonne/Introspection/c3a38aee-1b3d-4ad9-9474-f3aaa241e15c.jpg' Oct 27 11:59:55 opera-amp150 volumio[10226]: info: Oct 27 11:59:55 opera-amp150 volumio[10226]: ---------------------------- MPD announces system playlist update Oct 27 11:59:55 opera-amp150 volumio[10226]: info: Ignoring MPD Status Update Oct 27 11:59:55 opera-amp150 volumio[10226]: info: Oct 27 11:59:55 opera-amp150 volumio[10226]: ---------------------------- MPD announces state update: player Oct 27 11:59:55 opera-amp150 volumio[10226]: info: ControllerMpd::getState Oct 27 11:59:55 opera-amp150 volumio[10226]: verbose: ControllerMpd::sendMpdCommand status Oct 27 11:59:55 opera-amp150 volumio[10226]: info: ------------------------------ 4ms Oct 27 11:59:55 opera-amp150 volumio[10226]: info: sendMpdCommand status took 3 milliseconds Oct 27 11:59:55 opera-amp150 volumio[10226]: verbose: ControllerMpd::parseState Oct 27 11:59:55 opera-amp150 volumio[10226]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 11:59:55 opera-amp150 volumio[10226]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 27 11:59:55 opera-amp150 volumio[10226]: verbose: ControllerMpd::parseTrackInfo Oct 27 11:59:55 opera-amp150 volumio[10226]: info: ControllerMpd::pushState Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CoreCommandRouter::servicePushState Oct 27 11:59:55 opera-amp150 volumio[10226]: verbose: In UPNP mode Oct 27 11:59:55 opera-amp150 volumio[10226]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":740,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"656 Kbps","isStreaming":false,"title":"Introspection","artist":"Estas Tonne","album":"Introspection","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/singles*20*e5*8d*95*e6*9b*b2/Introspection.flac","trackType":"flac"} Oct 27 11:59:55 opera-amp150 volumio[10226]: verbose: CURRENT POSITION 0 Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CoreStateMachine::syncState stateService play Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CoreStateMachine::syncState currentStatus play Oct 27 11:59:55 opera-amp150 volumio[10226]: info: Received an update from plugin. extracting info from payload Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CoreStateMachine::pushState Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CoreCommandRouter::volumioPushState Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CoreStateMachine::pushState Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CoreCommandRouter::volumioPushState Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 11:59:55 opera-amp150 volumio[10226]: info: ------------------------------ 23ms Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CoreCommandRouter::volumioGetQueue Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CoreStateMachine::getQueue Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CorePlayQueue::getQueue Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CoreCommandRouter::volumioGetQueue Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CoreStateMachine::getQueue Oct 27 11:59:55 opera-amp150 volumio[10226]: info: CorePlayQueue::getQueue Oct 27 12:00:32 opera-amp150 volumio[10226]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 27 12:00:32 opera-amp150 volumio[10226]: { Error: connect ETIMEDOUT 108.160.166.62:443 Oct 27 12:00:32 opera-amp150 volumio[10226]: at Object._errnoException (util.js:1022:11) Oct 27 12:00:32 opera-amp150 volumio[10226]: at _exceptionWithHostPort (util.js:1044:20) Oct 27 12:00:32 opera-amp150 volumio[10226]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Oct 27 12:00:32 opera-amp150 volumio[10226]: code: 'ETIMEDOUT', Oct 27 12:00:32 opera-amp150 volumio[10226]: errno: 'ETIMEDOUT', Oct 27 12:00:32 opera-amp150 volumio[10226]: syscall: 'connect', Oct 27 12:00:32 opera-amp150 volumio[10226]: address: '108.160.166.62', Oct 27 12:00:32 opera-amp150 volumio[10226]: port: 443 } Oct 27 12:00:32 opera-amp150 volumio[10226]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 27 12:00:32 opera-amp150 sudo[10882]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-27 11:59 Oct 27 12:00:32 opera-amp150 sudo[10882]: 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"