-- Logs begin at Thu 2019-02-14 12:11:58 SAST, end at Fri 2025-10-24 09:59:36 SAST. -- Oct 24 09:58:02 rivoplus volumio[3537]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 24 09:58:02 rivoplus volumio[3537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 24 09:58:02 rivoplus volumio[3537]: info: Discovery: Getting this device information Oct 24 09:58:02 rivoplus volumio[3537]: info: CoreCommandRouter::volumioGetState Oct 24 09:58:02 rivoplus volumio[3537]: info: CorePlayQueue::getTrack 1 Oct 24 09:58:02 rivoplus volumio[3537]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 24 09:58:25 rivoplus volumio[3537]: info: CorePlayQueue::getTrack 1 Oct 24 09:58:25 rivoplus volumio[3537]: info: CorePlayQueue::getTrack 2 Oct 24 09:58:25 rivoplus volumio[3537]: info: Prefetching next song Oct 24 09:58:25 rivoplus volumio[3537]: info: DOING PREFETCH IN MPD Oct 24 09:58:25 rivoplus volumio[3537]: verbose: ControllerMpd::sendMpdCommand add "USB/RIVOMUSE_2/RIVO FLAC/Theuns Jordaan/Vreemde Stad/05 - Beautiful in Beaufort-Wes.flac" Oct 24 09:58:25 rivoplus volumio[3537]: info: Oct 24 09:58:25 rivoplus volumio[3537]: ---------------------------- MPD announces system playlist update Oct 24 09:58:25 rivoplus volumio[3537]: info: Ignoring MPD Status Update Oct 24 09:58:25 rivoplus volumio[3537]: info: sendMpdCommand add "USB/RIVOMUSE_2/RIVO FLAC/Theuns Jordaan/Vreemde Stad/05 - Beautiful in Beaufort-Wes.flac" took 7 milliseconds Oct 24 09:58:25 rivoplus volumio[3537]: verbose: ControllerMpd::sendMpdCommand consume 1 Oct 24 09:58:25 rivoplus volumio[3537]: info: ------------------------------ 5ms Oct 24 09:58:25 rivoplus volumio[3537]: info: sendMpdCommand consume 1 took 2 milliseconds Oct 24 09:58:29 rivoplus volumio[3537]: info: Oct 24 09:58:29 rivoplus volumio[3537]: ---------------------------- MPD announces system playlist update Oct 24 09:58:29 rivoplus volumio[3537]: info: Ignoring MPD Status Update Oct 24 09:58:29 rivoplus volumio[3537]: info: Oct 24 09:58:29 rivoplus volumio[3537]: ---------------------------- MPD announces state update: player Oct 24 09:58:29 rivoplus volumio[3537]: info: ControllerMpd::getState Oct 24 09:58:29 rivoplus volumio[3537]: verbose: ControllerMpd::sendMpdCommand status Oct 24 09:58:29 rivoplus volumio[3537]: info: ------------------------------ 4ms Oct 24 09:58:29 rivoplus volumio[3537]: info: sendMpdCommand status took 3 milliseconds Oct 24 09:58:29 rivoplus volumio[3537]: verbose: ControllerMpd::parseState Oct 24 09:58:29 rivoplus volumio[3537]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 24 09:58:29 rivoplus volumio[3537]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 24 09:58:29 rivoplus volumio[3537]: verbose: ControllerMpd::parseTrackInfo Oct 24 09:58:29 rivoplus volumio[3537]: info: ControllerMpd::pushState Oct 24 09:58:29 rivoplus volumio[3537]: info: CoreCommandRouter::servicePushState Oct 24 09:58:29 rivoplus volumio[3537]: info: CorePlayQueue::getTrack 1 Oct 24 09:58:29 rivoplus volumio[3537]: verbose: STATE SERVICE {"status":"play","position":0,"seek":91,"duration":284,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"612 Kbps","isStreaming":false,"title":"Beautiful in Beaufort-Wes","artist":"Theuns Jordaan","album":"Vreemde Stad","uri":"USB/RIVOMUSE_2/RIVO FLAC/Theuns Jordaan/Vreemde Stad/05 - Beautiful in Beaufort-Wes.flac","trackType":"flac"} Oct 24 09:58:29 rivoplus volumio[3537]: verbose: CURRENT POSITION 1 Oct 24 09:58:29 rivoplus volumio[3537]: info: CoreStateMachine::syncState stateService play Oct 24 09:58:29 rivoplus volumio[3537]: info: CoreStateMachine::syncState currentStatus play Oct 24 09:58:29 rivoplus volumio[3537]: info: Received an update from plugin. extracting info from payload Oct 24 09:58:29 rivoplus volumio[3537]: info: CoreStateMachine::pushState Oct 24 09:58:29 rivoplus volumio[3537]: info: CorePlayQueue::getTrack 1 Oct 24 09:58:29 rivoplus volumio[3537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 09:58:29 rivoplus volumio[3537]: info: CoreCommandRouter::volumioPushState Oct 24 09:58:29 rivoplus volumio[3537]: info: CoreCommandRouter::volumioGetState Oct 24 09:58:29 rivoplus volumio[3537]: info: CorePlayQueue::getTrack 1 Oct 24 09:58:29 rivoplus volumio[3537]: info: MRS: Pushing multiroomSync output update for this device Oct 24 09:58:29 rivoplus volumio[3537]: info: MRS: Pushing multiroomSync output Oct 24 09:58:29 rivoplus volumio[3537]: info: CoreStateMachine::pushState Oct 24 09:58:29 rivoplus volumio[3537]: info: CorePlayQueue::getTrack 1 Oct 24 09:58:29 rivoplus volumio[3537]: info: CoreCommandRouter::volumioPushState Oct 24 09:58:29 rivoplus volumio[3537]: info: CoreCommandRouter::volumioGetState Oct 24 09:58:29 rivoplus volumio[3537]: info: CorePlayQueue::getTrack 1 Oct 24 09:58:29 rivoplus volumio[3537]: info: MRS: Pushing multiroomSync output update for this device Oct 24 09:58:29 rivoplus volumio[3537]: info: MRS: Pushing multiroomSync output Oct 24 09:58:29 rivoplus volumio[3537]: info: ------------------------------ 43ms Oct 24 09:58:29 rivoplus volumio[3537]: info: Signalling Playback active due to playback status change Oct 24 09:58:29 rivoplus volumio[3537]: info: Signalling Playback active due to playback status change Oct 24 09:58:29 rivoplus volumio[3537]: info: Updating RAAT Signal Path Oct 24 09:58:29 rivoplus volumio[3537]: info: Updating RAAT Signal Path Oct 24 09:58:30 rivoplus volumio[3537]: info: CoreStateMachine::startPlaybackTimer Oct 24 09:58:30 rivoplus volumio[3537]: info: CorePlayQueue::getTrack 2 Oct 24 09:58:30 rivoplus volumio[3537]: info: CoreStateMachine::pushState Oct 24 09:58:30 rivoplus volumio[3537]: info: CorePlayQueue::getTrack 2 Oct 24 09:58:30 rivoplus volumio[3537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 09:58:30 rivoplus volumio[3537]: info: CoreCommandRouter::volumioPushState Oct 24 09:58:30 rivoplus volumio[3537]: info: CoreCommandRouter::volumioGetState Oct 24 09:58:30 rivoplus volumio[3537]: info: CorePlayQueue::getTrack 2 Oct 24 09:58:30 rivoplus volumio[3537]: info: MRS: Pushing multiroomSync output update for this device Oct 24 09:58:30 rivoplus volumio[3537]: info: MRS: Pushing multiroomSync output Oct 24 09:58:30 rivoplus volumio[3537]: info: Signalling Playback active due to playback status change Oct 24 09:58:30 rivoplus volumio[3537]: info: Updating RAAT Signal Path Oct 24 09:58:32 rivoplus volumio[3537]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 24 09:58:32 rivoplus volumio[3537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 24 09:58:32 rivoplus volumio[3537]: info: Discovery: Getting this device information Oct 24 09:58:32 rivoplus volumio[3537]: info: CoreCommandRouter::volumioGetState Oct 24 09:58:32 rivoplus volumio[3537]: info: CorePlayQueue::getTrack 2 Oct 24 09:58:32 rivoplus volumio[3537]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 24 09:58:32 rivoplus volumio[3537]: info: Executing endpoint metavolumio Oct 24 09:58:32 rivoplus volumio[3537]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 24 09:58:32 rivoplus volumio[3537]: info: Executing endpoint metavolumio Oct 24 09:58:32 rivoplus volumio[3537]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 24 09:58:32 rivoplus volumio[3537]: info: Executing endpoint metavolumio Oct 24 09:58:32 rivoplus volumio[3537]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 24 09:59:02 rivoplus volumio[3537]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 24 09:59:02 rivoplus volumio[3537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 24 09:59:02 rivoplus volumio[3537]: info: Discovery: Getting this device information Oct 24 09:59:02 rivoplus volumio[3537]: info: CoreCommandRouter::volumioGetState Oct 24 09:59:02 rivoplus volumio[3537]: info: CorePlayQueue::getTrack 2 Oct 24 09:59:02 rivoplus volumio[3537]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 24 09:59:23 rivoplus volumio[3537]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 24 09:59:23 rivoplus volumio[3537]: info: CURURI: genres://Boeremusiek Oct 24 09:59:23 rivoplus volumio[3537]: info: Preload queue cleared Oct 24 09:59:23 rivoplus volumio[3537]: info: Preload queue cleared Oct 24 09:59:32 rivoplus volumio[3537]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 24 09:59:32 rivoplus volumio[3537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 24 09:59:32 rivoplus volumio[3537]: info: Discovery: Getting this device information Oct 24 09:59:32 rivoplus volumio[3537]: info: CoreCommandRouter::volumioGetState Oct 24 09:59:32 rivoplus volumio[3537]: info: CorePlayQueue::getTrack 2 Oct 24 09:59:32 rivoplus volumio[3537]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 24 09:59:35 rivoplus volumio[3537]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 24 09:59:35 rivoplus volumio[3537]: TypeError: Cannot read property 'slice' of null Oct 24 09:59:35 rivoplus volumio[3537]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Oct 24 09:59:35 rivoplus volumio[3537]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Oct 24 09:59:35 rivoplus volumio[3537]: at Object.onceWrapper (events.js:520:26) Oct 24 09:59:35 rivoplus volumio[3537]: at ClientRequest.emit (events.js:400:28) Oct 24 09:59:35 rivoplus volumio[3537]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:647:27) Oct 24 09:59:35 rivoplus volumio[3537]: at HTTPParser.parserOnHeadersComplete (_http_common.js:127:17) Oct 24 09:59:35 rivoplus volumio[3537]: at TLSSocket.socketOnData (_http_client.js:515:22) Oct 24 09:59:35 rivoplus volumio[3537]: at TLSSocket.emit (events.js:400:28) Oct 24 09:59:35 rivoplus volumio[3537]: at addChunk (internal/streams/readable.js:293:12) Oct 24 09:59:35 rivoplus volumio[3537]: at readableAddChunk (internal/streams/readable.js:267:9) Oct 24 09:59:35 rivoplus volumio[3537]: at TLSSocket.Readable.push (internal/streams/readable.js:206:10) Oct 24 09:59:35 rivoplus volumio[3537]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Oct 24 09:59:35 rivoplus volumio[3537]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 24 09:59:36 rivoplus sudo[16604]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-24 09:58 Oct 24 09:59:36 rivoplus sudo[16604]: 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="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:23:19 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="ca35d8983c8e34dfa9cca80071cf9105"