-- Logs begin at Wed 2026-08-26 17:08:32 AEST, end at Wed 2026-08-26 17:21:57 AEST. -- Aug 26 17:20:11 rivoplus ntpd[3465]: 161.43.203.91 local addr 10.1.1.241 -> Aug 26 17:20:12 rivoplus ntpd[3465]: 159.196.3.239 local addr 10.1.1.241 -> Aug 26 17:20:39 rivoplus volumio[3209]: info: CorePlayQueue::getTrack 1 Aug 26 17:20:39 rivoplus volumio[3209]: info: CorePlayQueue::getTrack 2 Aug 26 17:20:39 rivoplus volumio[3209]: info: Prefetching next song Aug 26 17:20:39 rivoplus volumio[3209]: info: DOING PREFETCH IN MPD Aug 26 17:20:39 rivoplus volumio[3209]: verbose: ControllerMpd::sendMpdCommand add "USB/7937-D8AC/Bill Evans Trio - Explorations (2000) [FLAC] [XRCD Remaster]/03 - Beautiful Love (Take 2) - Bill Evans.flac" Aug 26 17:20:39 rivoplus volumio[3209]: info: sendMpdCommand add "USB/7937-D8AC/Bill Evans Trio - Explorations (2000) [FLAC] [XRCD Remaster]/03 - Beautiful Love (Take 2) - Bill Evans.flac" took 5 milliseconds Aug 26 17:20:39 rivoplus volumio[3209]: verbose: ControllerMpd::sendMpdCommand consume 1 Aug 26 17:20:39 rivoplus volumio[3209]: info: Aug 26 17:20:39 rivoplus volumio[3209]: ---------------------------- MPD announces system playlist update Aug 26 17:20:39 rivoplus volumio[3209]: info: Ignoring MPD Status Update Aug 26 17:20:39 rivoplus volumio[3209]: info: Aug 26 17:20:39 rivoplus volumio[3209]: ---------------------------- MPD announces system playlist update Aug 26 17:20:39 rivoplus volumio[3209]: info: Ignoring MPD Status Update Aug 26 17:20:39 rivoplus volumio[3209]: info: Aug 26 17:20:39 rivoplus volumio[3209]: ---------------------------- MPD announces system playlist update Aug 26 17:20:39 rivoplus volumio[3209]: info: Ignoring MPD Status Update Aug 26 17:20:39 rivoplus volumio[3209]: info: sendMpdCommand consume 1 took 10 milliseconds Aug 26 17:20:39 rivoplus volumio[3209]: info: ------------------------------ 10ms Aug 26 17:20:39 rivoplus volumio[3209]: info: ------------------------------ 7ms Aug 26 17:20:39 rivoplus volumio[3209]: info: ------------------------------ 5ms Aug 26 17:20:43 rivoplus volumio[3209]: info: CoreStateMachine::startPlaybackTimer Aug 26 17:20:43 rivoplus volumio[3209]: info: CorePlayQueue::getTrack 2 Aug 26 17:20:44 rivoplus volumio[3209]: info: Aug 26 17:20:44 rivoplus volumio[3209]: ---------------------------- MPD announces system playlist update Aug 26 17:20:44 rivoplus volumio[3209]: info: Ignoring MPD Status Update Aug 26 17:20:44 rivoplus volumio[3209]: info: Aug 26 17:20:44 rivoplus volumio[3209]: ---------------------------- MPD announces state update: player Aug 26 17:20:44 rivoplus volumio[3209]: info: ControllerMpd::getState Aug 26 17:20:44 rivoplus volumio[3209]: verbose: ControllerMpd::sendMpdCommand status Aug 26 17:20:44 rivoplus volumio[3209]: info: ------------------------------ 4ms Aug 26 17:20:44 rivoplus volumio[3209]: info: sendMpdCommand status took 2 milliseconds Aug 26 17:20:44 rivoplus volumio[3209]: verbose: ControllerMpd::parseState Aug 26 17:20:44 rivoplus volumio[3209]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 17:20:44 rivoplus volumio[3209]: info: Aug 26 17:20:44 rivoplus volumio[3209]: ---------------------------- MPD announces system playlist update Aug 26 17:20:44 rivoplus volumio[3209]: info: Ignoring MPD Status Update Aug 26 17:20:44 rivoplus volumio[3209]: info: Aug 26 17:20:44 rivoplus volumio[3209]: ---------------------------- MPD announces state update: player Aug 26 17:20:44 rivoplus volumio[3209]: info: ControllerMpd::getState Aug 26 17:20:44 rivoplus volumio[3209]: verbose: ControllerMpd::sendMpdCommand status Aug 26 17:20:44 rivoplus volumio[3209]: info: Aug 26 17:20:44 rivoplus volumio[3209]: ---------------------------- MPD announces system playlist update Aug 26 17:20:44 rivoplus volumio[3209]: info: Ignoring MPD Status Update Aug 26 17:20:44 rivoplus volumio[3209]: info: Aug 26 17:20:44 rivoplus volumio[3209]: ---------------------------- MPD announces state update: player Aug 26 17:20:44 rivoplus volumio[3209]: info: ControllerMpd::getState Aug 26 17:20:44 rivoplus volumio[3209]: verbose: ControllerMpd::sendMpdCommand status Aug 26 17:20:44 rivoplus volumio[3209]: info: sendMpdCommand playlistinfo took 8 milliseconds Aug 26 17:20:44 rivoplus volumio[3209]: info: ------------------------------ 8ms Aug 26 17:20:44 rivoplus volumio[3209]: info: sendMpdCommand status took 7 milliseconds Aug 26 17:20:44 rivoplus volumio[3209]: info: ------------------------------ 6ms Aug 26 17:20:44 rivoplus volumio[3209]: info: sendMpdCommand status took 5 milliseconds Aug 26 17:20:44 rivoplus volumio[3209]: verbose: ControllerMpd::parseTrackInfo Aug 26 17:20:44 rivoplus volumio[3209]: verbose: ControllerMpd::parseState Aug 26 17:20:44 rivoplus volumio[3209]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 17:20:44 rivoplus volumio[3209]: verbose: ControllerMpd::parseState Aug 26 17:20:44 rivoplus volumio[3209]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 17:20:44 rivoplus volumio[3209]: info: ControllerMpd::pushState Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreCommandRouter::servicePushState Aug 26 17:20:44 rivoplus volumio[3209]: info: CorePlayQueue::getTrack 2 Aug 26 17:20:44 rivoplus volumio[3209]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":307,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"880 Kbps","isStreaming":false,"title":"Beautiful Love (Take 2)","artist":"Bill Evans","album":"Explorations","uri":"USB/7937-D8AC/Bill Evans Trio - Explorations (2000) [FLAC] [XRCD Remaster]/03 - Beautiful Love (Take 2) - Bill Evans.flac","trackType":"flac"} Aug 26 17:20:44 rivoplus volumio[3209]: verbose: CURRENT POSITION 2 Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreStateMachine::syncState stateService play Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreStateMachine::syncState currentStatus play Aug 26 17:20:44 rivoplus volumio[3209]: info: Received an update from plugin. extracting info from payload Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreStateMachine::pushState Aug 26 17:20:44 rivoplus volumio[3209]: info: CorePlayQueue::getTrack 2 Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreCommandRouter::volumioPushState Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreCommandRouter::volumioGetState Aug 26 17:20:44 rivoplus volumio[3209]: info: CorePlayQueue::getTrack 2 Aug 26 17:20:44 rivoplus volumio[3209]: info: MRS: Pushing multiroomSync output update for this device Aug 26 17:20:44 rivoplus volumio[3209]: info: MRS: Pushing multiroomSync output Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreStateMachine::pushState Aug 26 17:20:44 rivoplus volumio[3209]: info: CorePlayQueue::getTrack 2 Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreCommandRouter::volumioPushState Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreCommandRouter::volumioGetState Aug 26 17:20:44 rivoplus volumio[3209]: info: CorePlayQueue::getTrack 2 Aug 26 17:20:44 rivoplus volumio[3209]: info: MRS: Pushing multiroomSync output update for this device Aug 26 17:20:44 rivoplus volumio[3209]: info: MRS: Pushing multiroomSync output Aug 26 17:20:44 rivoplus volumio[3209]: info: ------------------------------ 61ms Aug 26 17:20:44 rivoplus volumio[3209]: info: sendMpdCommand playlistinfo took 48 milliseconds Aug 26 17:20:44 rivoplus volumio[3209]: verbose: ControllerMpd::parseTrackInfo Aug 26 17:20:44 rivoplus volumio[3209]: info: ControllerMpd::pushState Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreCommandRouter::servicePushState Aug 26 17:20:44 rivoplus volumio[3209]: info: CorePlayQueue::getTrack 2 Aug 26 17:20:44 rivoplus volumio[3209]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":307,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"880 Kbps","isStreaming":false,"title":"Beautiful Love (Take 2)","artist":"Bill Evans","album":"Explorations","uri":"USB/7937-D8AC/Bill Evans Trio - Explorations (2000) [FLAC] [XRCD Remaster]/03 - Beautiful Love (Take 2) - Bill Evans.flac","trackType":"flac"} Aug 26 17:20:44 rivoplus volumio[3209]: verbose: CURRENT POSITION 2 Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreStateMachine::syncState stateService play Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreStateMachine::syncState currentStatus play Aug 26 17:20:44 rivoplus volumio[3209]: info: Received an update from plugin. extracting info from payload Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreStateMachine::pushState Aug 26 17:20:44 rivoplus volumio[3209]: info: CorePlayQueue::getTrack 2 Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreCommandRouter::volumioPushState Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreCommandRouter::volumioGetState Aug 26 17:20:44 rivoplus volumio[3209]: info: CorePlayQueue::getTrack 2 Aug 26 17:20:44 rivoplus volumio[3209]: info: MRS: Pushing multiroomSync output update for this device Aug 26 17:20:44 rivoplus volumio[3209]: info: MRS: Pushing multiroomSync output Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreStateMachine::pushState Aug 26 17:20:44 rivoplus volumio[3209]: info: CorePlayQueue::getTrack 2 Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreCommandRouter::volumioPushState Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreCommandRouter::volumioGetState Aug 26 17:20:44 rivoplus volumio[3209]: info: CorePlayQueue::getTrack 2 Aug 26 17:20:44 rivoplus volumio[3209]: info: MRS: Pushing multiroomSync output update for this device Aug 26 17:20:44 rivoplus volumio[3209]: info: MRS: Pushing multiroomSync output Aug 26 17:20:44 rivoplus volumio[3209]: info: ControllerMpd::pushState Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreCommandRouter::servicePushState Aug 26 17:20:44 rivoplus volumio[3209]: info: CorePlayQueue::getTrack 2 Aug 26 17:20:44 rivoplus volumio[3209]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":307,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"880 Kbps","isStreaming":false,"title":"Beautiful Love (Take 2)","artist":"Bill Evans","album":"Explorations","uri":"USB/7937-D8AC/Bill Evans Trio - Explorations (2000) [FLAC] [XRCD Remaster]/03 - Beautiful Love (Take 2) - Bill Evans.flac","trackType":"flac"} Aug 26 17:20:44 rivoplus volumio[3209]: verbose: CURRENT POSITION 2 Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreStateMachine::syncState stateService play Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreStateMachine::syncState currentStatus play Aug 26 17:20:44 rivoplus volumio[3209]: info: Received an update from plugin. extracting info from payload Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreStateMachine::pushState Aug 26 17:20:44 rivoplus volumio[3209]: info: CorePlayQueue::getTrack 2 Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreCommandRouter::volumioPushState Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreCommandRouter::volumioGetState Aug 26 17:20:44 rivoplus volumio[3209]: info: CorePlayQueue::getTrack 2 Aug 26 17:20:44 rivoplus volumio[3209]: info: MRS: Pushing multiroomSync output update for this device Aug 26 17:20:44 rivoplus volumio[3209]: info: MRS: Pushing multiroomSync output Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreStateMachine::pushState Aug 26 17:20:44 rivoplus volumio[3209]: info: CorePlayQueue::getTrack 2 Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreCommandRouter::volumioPushState Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreCommandRouter::volumioGetState Aug 26 17:20:44 rivoplus volumio[3209]: info: CorePlayQueue::getTrack 2 Aug 26 17:20:44 rivoplus volumio[3209]: info: MRS: Pushing multiroomSync output update for this device Aug 26 17:20:44 rivoplus volumio[3209]: info: MRS: Pushing multiroomSync output Aug 26 17:20:44 rivoplus volumio[3209]: info: ------------------------------ 141ms Aug 26 17:20:44 rivoplus volumio[3209]: info: ------------------------------ 140ms Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreStateMachine::pushState Aug 26 17:20:44 rivoplus volumio[3209]: info: CorePlayQueue::getTrack 2 Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreCommandRouter::volumioPushState Aug 26 17:20:44 rivoplus volumio[3209]: info: CoreCommandRouter::volumioGetState Aug 26 17:20:44 rivoplus volumio[3209]: info: CorePlayQueue::getTrack 2 Aug 26 17:20:44 rivoplus volumio[3209]: info: MRS: Pushing multiroomSync output update for this device Aug 26 17:20:44 rivoplus volumio[3209]: info: MRS: Pushing multiroomSync output Aug 26 17:21:16 rivoplus volumio[3209]: info: CoreCommandRouter::volumioGetState Aug 26 17:21:16 rivoplus volumio[3209]: info: CorePlayQueue::getTrack 2 Aug 26 17:21:18 rivoplus volumio[3209]: info: Executing endpoint metavolumio Aug 26 17:21:18 rivoplus volumio[3209]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 26 17:21:18 rivoplus volumio[3209]: info: Executing endpoint metavolumio Aug 26 17:21:18 rivoplus volumio[3209]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 26 17:21:18 rivoplus volumio[3209]: info: Executing endpoint metavolumio Aug 26 17:21:18 rivoplus volumio[3209]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 26 17:21:25 rivoplus volumio[3209]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Aug 26 17:21:25 rivoplus volumio[3209]: info: handleBrowseUri took 205 milliseconds Aug 26 17:21:25 rivoplus volumio[3209]: info: Preload queue cleared Aug 26 17:21:25 rivoplus volumio[3209]: info: Preload queue cleared Aug 26 17:21:34 rivoplus volumio[3209]: Searching plugin music_service/qobuz Aug 26 17:21:34 rivoplus volumio[3209]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 26 17:21:35 rivoplus volumio[3209]: Searching plugin music_service/qobuz Aug 26 17:21:35 rivoplus volumio[3209]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 26 17:21:35 rivoplus volumio[3209]: info: searchQOBUZUri took 609 milliseconds Aug 26 17:21:35 rivoplus volumio[3209]: info: All search sources collected, pushing search results Aug 26 17:21:36 rivoplus volumio[3209]: info: searchQOBUZUri took 2207 milliseconds Aug 26 17:21:36 rivoplus volumio[3209]: info: All search sources collected, pushing search results Aug 26 17:21:37 rivoplus volumio[3209]: Searching plugin music_service/qobuz Aug 26 17:21:37 rivoplus volumio[3209]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 26 17:21:38 rivoplus volumio[3209]: info: searchQOBUZUri took 575 milliseconds Aug 26 17:21:38 rivoplus volumio[3209]: info: All search sources collected, pushing search results Aug 26 17:21:42 rivoplus volumio[3209]: Searching plugin music_service/qobuz Aug 26 17:21:42 rivoplus volumio[3209]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 26 17:21:43 rivoplus volumio[3209]: info: searchQOBUZUri took 1104 milliseconds Aug 26 17:21:43 rivoplus volumio[3209]: info: All search sources collected, pushing search results Aug 26 17:21:47 rivoplus volumio[3209]: Searching plugin music_service/qobuz Aug 26 17:21:47 rivoplus volumio[3209]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 26 17:21:48 rivoplus volumio[3209]: info: searchQOBUZUri took 478 milliseconds Aug 26 17:21:48 rivoplus volumio[3209]: info: All search sources collected, pushing search results Aug 26 17:21:51 rivoplus volumio[3209]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Aug 26 17:21:52 rivoplus ntpd[3465]: 13.55.50.68 local addr 10.1.1.241 -> Aug 26 17:21:52 rivoplus volumio[3209]: info: handleBrowseUri took 1096 milliseconds Aug 26 17:21:52 rivoplus volumio[3209]: info: Preload queue cleared Aug 26 17:21:53 rivoplus volumio[3209]: info: Executing endpoint getSimilarArtists Aug 26 17:21:53 rivoplus volumio[3209]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Aug 26 17:21:53 rivoplus volumio[3209]: info: Executing endpoint getSimilarArtists Aug 26 17:21:53 rivoplus volumio[3209]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Aug 26 17:21:53 rivoplus volumio[3209]: info: Executing endpoint metavolumio Aug 26 17:21:53 rivoplus volumio[3209]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 26 17:21:53 rivoplus volumio[3209]: info: Executing endpoint metavolumio Aug 26 17:21:53 rivoplus volumio[3209]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 26 17:21:54 rivoplus volumio[3209]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Uriah%20Heep/93e5eb7a-18f6-40da-bb98-4e05f1fba68c.jpg' Aug 26 17:21:55 rivoplus volumio[3209]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Thin%20Lizzy/f3be7d43-f679-4f85-b66d-8132dcd876c3.jpg' Aug 26 17:21:55 rivoplus volumio[3209]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Rainbow/00a0ffd9-7f1c-4f81-b36b-f765d40d4a1c.jpg' Aug 26 17:21:56 rivoplus volumio[3209]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 17:21:56 rivoplus volumio[3209]: Error: connect ECONNREFUSED 158.69.210.98:443 Aug 26 17:21:56 rivoplus volumio[3209]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Aug 26 17:21:56 rivoplus volumio[3209]: errno: -111, Aug 26 17:21:56 rivoplus volumio[3209]: code: 'ECONNREFUSED', Aug 26 17:21:56 rivoplus volumio[3209]: syscall: 'connect', Aug 26 17:21:56 rivoplus volumio[3209]: address: '158.69.210.98', Aug 26 17:21:56 rivoplus volumio[3209]: port: 443 Aug 26 17:21:56 rivoplus volumio[3209]: } Aug 26 17:21:56 rivoplus volumio[3209]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 17:21:57 rivoplus sudo[7701]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-26 17:20 Aug 26 17:21:57 rivoplus sudo[7701]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 11:19:27 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo Plus" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo Plus" VOLUMIO_HASH="a7285124ffc88c43265bb2db03526f6a"