-- Logs begin at Thu 2019-02-14 23:11:58 NZDT, end at Sat 2026-01-10 17:39:17 NZDT. -- Jan 10 17:38:01 rivoplus volumio[3103]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 10 17:38:01 rivoplus volumio[3103]: info: CURURI: artists:// Jan 10 17:38:02 rivoplus volumio[3103]: info: Preload queue cleared Jan 10 17:38:21 rivoplus nmbd[3063]: [2026/01/10 17:38:21.620005, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Jan 10 17:38:21 rivoplus nmbd[3063]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.120 for name WORKGROUP<1d>. Jan 10 17:38:21 rivoplus nmbd[3063]: This response was from IP 192.168.1.76, reporting an IP address of 192.168.1.76. Jan 10 17:38:23 rivoplus ntpd[3389]: 162.159.200.123 local addr 192.168.1.120 -> Jan 10 17:38:25 rivoplus ntpd[3389]: 101.100.138.250 local addr 192.168.1.120 -> Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreCommandRouter::volumioSeek Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreStateMachine::seek Jan 10 17:39:02 rivoplus volumio[3103]: info: CorePlayQueue::getTrack 0 Jan 10 17:39:02 rivoplus volumio[3103]: info: TRACKBLOCK {"uri":"music-library/NAS/Vault/Adele/Skyfall - Single/01-Skyfall.flac","service":"mpd","name":"1 - Skyfall","artist":"Adele","album":"Skyfall - Single","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=987&web=Adele/Skyfall%20-%20Single/extralarge&path=%2Fmnt%2FNAS%2FVault%2FAdele%2FSkyfall%20-%20Single&metadata=false","duration":286,"trackType":"flac","samplerate":"96 kHz","bitdepth":"24 bit","channels":2} Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreStateMachine::startPlaybackTimer Jan 10 17:39:02 rivoplus volumio[3103]: info: CorePlayQueue::getTrack 0 Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreCommandRouter::volumioGetVisibleSources Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jan 10 17:39:02 rivoplus volumio[3103]: info: ControllerMpd::seek Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreStateMachine::pushState Jan 10 17:39:02 rivoplus volumio[3103]: info: CorePlayQueue::getTrack 0 Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreCommandRouter::volumioPushState Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreCommandRouter::volumioGetState Jan 10 17:39:02 rivoplus volumio[3103]: info: CorePlayQueue::getTrack 0 Jan 10 17:39:02 rivoplus volumio[3103]: info: Updating RAAT Signal Path Jan 10 17:39:02 rivoplus volumio[3103]: info: Updating RAAT Signal Path Jan 10 17:39:02 rivoplus volumio[3103]: info: Updating RAAT Signal Path Jan 10 17:39:02 rivoplus volumio[3103]: info: Signalling Playback active due to playback status change Jan 10 17:39:02 rivoplus volumio[3103]: error: null Jan 10 17:39:02 rivoplus volumio[3103]: info: Jan 10 17:39:02 rivoplus volumio[3103]: ---------------------------- MPD announces state update: player Jan 10 17:39:02 rivoplus volumio[3103]: info: ControllerMpd::getState Jan 10 17:39:02 rivoplus volumio[3103]: verbose: ControllerMpd::sendMpdCommand status Jan 10 17:39:02 rivoplus volumio[3103]: info: Jan 10 17:39:02 rivoplus volumio[3103]: ---------------------------- MPD announces state update: player Jan 10 17:39:02 rivoplus volumio[3103]: info: ControllerMpd::getState Jan 10 17:39:02 rivoplus volumio[3103]: verbose: ControllerMpd::sendMpdCommand status Jan 10 17:39:02 rivoplus volumio[3103]: info: Jan 10 17:39:02 rivoplus volumio[3103]: ---------------------------- MPD announces state update: player Jan 10 17:39:02 rivoplus volumio[3103]: info: ControllerMpd::getState Jan 10 17:39:02 rivoplus volumio[3103]: verbose: ControllerMpd::sendMpdCommand status Jan 10 17:39:02 rivoplus volumio[3103]: info: sendMpdCommand status took 26 milliseconds Jan 10 17:39:02 rivoplus volumio[3103]: info: sendMpdCommand status took 25 milliseconds Jan 10 17:39:02 rivoplus volumio[3103]: info: sendMpdCommand status took 7 milliseconds Jan 10 17:39:02 rivoplus volumio[3103]: verbose: ControllerMpd::parseState Jan 10 17:39:02 rivoplus volumio[3103]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 17:39:02 rivoplus volumio[3103]: verbose: ControllerMpd::parseState Jan 10 17:39:02 rivoplus volumio[3103]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 17:39:02 rivoplus volumio[3103]: verbose: ControllerMpd::parseState Jan 10 17:39:02 rivoplus volumio[3103]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 17:39:02 rivoplus volumio[3103]: info: sendMpdCommand playlistinfo took 39 milliseconds Jan 10 17:39:02 rivoplus volumio[3103]: info: sendMpdCommand playlistinfo took 41 milliseconds Jan 10 17:39:02 rivoplus volumio[3103]: info: sendMpdCommand playlistinfo took 41 milliseconds Jan 10 17:39:02 rivoplus volumio[3103]: verbose: ControllerMpd::parseTrackInfo Jan 10 17:39:02 rivoplus volumio[3103]: verbose: ControllerMpd::parseTrackInfo Jan 10 17:39:02 rivoplus volumio[3103]: verbose: ControllerMpd::parseTrackInfo Jan 10 17:39:02 rivoplus volumio[3103]: info: ControllerMpd::pushState Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreCommandRouter::servicePushState Jan 10 17:39:02 rivoplus volumio[3103]: info: CorePlayQueue::getTrack 0 Jan 10 17:39:02 rivoplus volumio[3103]: verbose: STATE SERVICE {"status":"play","position":0,"seek":64000,"duration":286,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2912 Kbps","isStreaming":false,"title":"Skyfall","artist":"Adele","album":"Skyfall - Single","uri":"NAS/Vault/Adele/Skyfall - Single/01-Skyfall.flac","trackType":"flac"} Jan 10 17:39:02 rivoplus volumio[3103]: verbose: CURRENT POSITION 0 Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreStateMachine::syncState stateService play Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreStateMachine::syncState currentStatus play Jan 10 17:39:02 rivoplus volumio[3103]: info: Received an update from plugin. extracting info from payload Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreStateMachine::pushState Jan 10 17:39:02 rivoplus volumio[3103]: info: CorePlayQueue::getTrack 0 Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreCommandRouter::volumioPushState Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreCommandRouter::volumioGetState Jan 10 17:39:02 rivoplus volumio[3103]: info: CorePlayQueue::getTrack 0 Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreStateMachine::pushState Jan 10 17:39:02 rivoplus volumio[3103]: info: CorePlayQueue::getTrack 0 Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreCommandRouter::volumioPushState Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreCommandRouter::volumioGetState Jan 10 17:39:02 rivoplus volumio[3103]: info: CorePlayQueue::getTrack 0 Jan 10 17:39:02 rivoplus volumio[3103]: info: ControllerMpd::pushState Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreCommandRouter::servicePushState Jan 10 17:39:02 rivoplus volumio[3103]: info: CorePlayQueue::getTrack 0 Jan 10 17:39:02 rivoplus volumio[3103]: verbose: STATE SERVICE {"status":"play","position":0,"seek":64000,"duration":286,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2912 Kbps","isStreaming":false,"title":"Skyfall","artist":"Adele","album":"Skyfall - Single","uri":"NAS/Vault/Adele/Skyfall - Single/01-Skyfall.flac","trackType":"flac"} Jan 10 17:39:02 rivoplus volumio[3103]: verbose: CURRENT POSITION 0 Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreStateMachine::syncState stateService play Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreStateMachine::syncState currentStatus play Jan 10 17:39:02 rivoplus volumio[3103]: info: Received an update from plugin. extracting info from payload Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreStateMachine::pushState Jan 10 17:39:02 rivoplus volumio[3103]: info: CorePlayQueue::getTrack 0 Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreCommandRouter::volumioPushState Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreCommandRouter::volumioGetState Jan 10 17:39:02 rivoplus volumio[3103]: info: CorePlayQueue::getTrack 0 Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreStateMachine::pushState Jan 10 17:39:02 rivoplus volumio[3103]: info: CorePlayQueue::getTrack 0 Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreCommandRouter::volumioPushState Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreCommandRouter::volumioGetState Jan 10 17:39:02 rivoplus volumio[3103]: info: CorePlayQueue::getTrack 0 Jan 10 17:39:02 rivoplus volumio[3103]: info: ControllerMpd::pushState Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreCommandRouter::servicePushState Jan 10 17:39:02 rivoplus volumio[3103]: info: CorePlayQueue::getTrack 0 Jan 10 17:39:02 rivoplus volumio[3103]: verbose: STATE SERVICE {"status":"play","position":0,"seek":64000,"duration":286,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2912 Kbps","isStreaming":false,"title":"Skyfall","artist":"Adele","album":"Skyfall - Single","uri":"NAS/Vault/Adele/Skyfall - Single/01-Skyfall.flac","trackType":"flac"} Jan 10 17:39:02 rivoplus volumio[3103]: verbose: CURRENT POSITION 0 Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreStateMachine::syncState stateService play Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreStateMachine::syncState currentStatus play Jan 10 17:39:02 rivoplus volumio[3103]: info: Received an update from plugin. extracting info from payload Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreStateMachine::pushState Jan 10 17:39:02 rivoplus volumio[3103]: info: CorePlayQueue::getTrack 0 Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreCommandRouter::volumioPushState Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreCommandRouter::volumioGetState Jan 10 17:39:02 rivoplus volumio[3103]: info: CorePlayQueue::getTrack 0 Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreStateMachine::pushState Jan 10 17:39:02 rivoplus volumio[3103]: info: CorePlayQueue::getTrack 0 Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreCommandRouter::volumioPushState Jan 10 17:39:02 rivoplus volumio[3103]: info: CoreCommandRouter::volumioGetState Jan 10 17:39:02 rivoplus volumio[3103]: info: CorePlayQueue::getTrack 0 Jan 10 17:39:02 rivoplus volumio[3103]: info: ------------------------------ 196ms Jan 10 17:39:02 rivoplus volumio[3103]: info: ------------------------------ 196ms Jan 10 17:39:02 rivoplus volumio[3103]: info: ------------------------------ 180ms Jan 10 17:39:02 rivoplus volumio[3103]: info: Updating RAAT Signal Path Jan 10 17:39:02 rivoplus volumio[3103]: info: Updating RAAT Signal Path Jan 10 17:39:02 rivoplus volumio[3103]: info: Updating RAAT Signal Path Jan 10 17:39:02 rivoplus volumio[3103]: info: Updating RAAT Signal Path Jan 10 17:39:02 rivoplus volumio[3103]: info: Updating RAAT Signal Path Jan 10 17:39:02 rivoplus volumio[3103]: info: Updating RAAT Signal Path Jan 10 17:39:02 rivoplus volumio[3103]: info: Updating RAAT Signal Path Jan 10 17:39:02 rivoplus volumio[3103]: info: Updating RAAT Signal Path Jan 10 17:39:02 rivoplus volumio[3103]: info: Updating RAAT Signal Path Jan 10 17:39:02 rivoplus volumio[3103]: info: Updating RAAT Signal Path Jan 10 17:39:02 rivoplus volumio[3103]: info: Updating RAAT Signal Path Jan 10 17:39:02 rivoplus volumio[3103]: info: Updating RAAT Signal Path Jan 10 17:39:02 rivoplus volumio[3103]: info: Updating RAAT Signal Path Jan 10 17:39:02 rivoplus volumio[3103]: info: Updating RAAT Signal Path Jan 10 17:39:02 rivoplus volumio[3103]: info: Updating RAAT Signal Path Jan 10 17:39:02 rivoplus volumio[3103]: info: Signalling Playback active due to playback status change Jan 10 17:39:02 rivoplus volumio[3103]: info: Signalling Playback active due to playback status change Jan 10 17:39:02 rivoplus volumio[3103]: info: Signalling Playback active due to playback status change Jan 10 17:39:02 rivoplus volumio[3103]: info: Signalling Playback active due to playback status change Jan 10 17:39:02 rivoplus volumio[3103]: info: Signalling Playback active due to playback status change Jan 10 17:39:02 rivoplus volumio[3103]: info: Signalling Playback active due to playback status change Jan 10 17:39:05 rivoplus ntpd[3389]: 202.68.92.244 local addr 192.168.1.120 -> Jan 10 17:39:16 rivoplus volumio[3103]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 10 17:39:16 rivoplus volumio[3103]: TypeError: Cannot read property 'slice' of null Jan 10 17:39:16 rivoplus volumio[3103]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Jan 10 17:39:16 rivoplus volumio[3103]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Jan 10 17:39:16 rivoplus volumio[3103]: at Object.onceWrapper (events.js:520:26) Jan 10 17:39:16 rivoplus volumio[3103]: at ClientRequest.emit (events.js:400:28) Jan 10 17:39:16 rivoplus volumio[3103]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:647:27) Jan 10 17:39:16 rivoplus volumio[3103]: at HTTPParser.parserOnHeadersComplete (_http_common.js:127:17) Jan 10 17:39:16 rivoplus volumio[3103]: at TLSSocket.socketOnData (_http_client.js:515:22) Jan 10 17:39:16 rivoplus volumio[3103]: at TLSSocket.emit (events.js:400:28) Jan 10 17:39:16 rivoplus volumio[3103]: at addChunk (internal/streams/readable.js:293:12) Jan 10 17:39:16 rivoplus volumio[3103]: at readableAddChunk (internal/streams/readable.js:267:9) Jan 10 17:39:16 rivoplus volumio[3103]: at TLSSocket.Readable.push (internal/streams/readable.js:206:10) Jan 10 17:39:16 rivoplus volumio[3103]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Jan 10 17:39:16 rivoplus volumio[3103]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 10 17:39:17 rivoplus sudo[9499]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-10 17:38 Jan 10 17:39:17 rivoplus sudo[9499]: 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="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="2f25e1a98e53e2dbc4f3878604e250b0379f3ea4" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 06:47:33 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo Plus" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo Plus" VOLUMIO_HASH="9e8aa5d6afb5e5d87a87bafae7aa5647"