-- Logs begin at Thu 2019-02-14 12:11:59 SAST, end at Sat 2025-12-20 18:31:37 SAST. -- Dec 20 18:30:08 ftvolumio volumio[962]: verbose: New Socket.io Connection to 192.168.82.195:3000 from 192.168.82.194 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Dec 20 18:30:08 ftvolumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 18:30:08 ftvolumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 18:30:08 ftvolumio volumio[962]: info: Discovery: Getting this device information Dec 20 18:30:08 ftvolumio volumio[962]: info: CoreCommandRouter::volumioGetState Dec 20 18:30:08 ftvolumio volumio[962]: info: CorePlayQueue::getTrack 13 Dec 20 18:30:08 ftvolumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 18:30:28 ftvolumio go-librespot[1322]: time="2025-12-20T18:30:28+02:00" level=trace msg="sent dealer ping" Dec 20 18:30:28 ftvolumio go-librespot[1322]: time="2025-12-20T18:30:28+02:00" level=trace msg="received dealer pong" Dec 20 18:30:30 ftvolumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 20 18:30:30 ftvolumio volumio[962]: info: CURURI: artists://Deep%20Blue%20Something Dec 20 18:30:30 ftvolumio volumio[962]: info: Preload queue cleared Dec 20 18:30:30 ftvolumio volumio[962]: info: Preload queue cleared Dec 20 18:30:30 ftvolumio volumio[962]: info: Preloading song: music-library/USB/Elements/mp3/mp3/Deep Blue Something - Breakfast At Tiffany's.mp3 Dec 20 18:30:30 ftvolumio volumio[962]: info: Preloading song: music-library/USB/Elements/mp3/mp3/Deep Blue Something - Breakfast At Tiffanys.mp3 Dec 20 18:30:30 ftvolumio volumio[962]: info: Preloading song: music-library/USB/Elements/mp3/mp33/Billboard Top 100 of 1996/1996-039-Deep_Blue_Something-Breakfast_At_Tiffany's.mp3 Dec 20 18:30:30 ftvolumio volumio[962]: info: Preloading song: music-library/USB/Elements/mp3/mp33/Deep Blue Something/Deep Blue Something - Breakfast At Tiffany's.mp3 Dec 20 18:30:30 ftvolumio volumio[962]: info: Exploding uri music-library/USB/Elements/mp3/mp3/Deep Blue Something - Breakfast At Tiffany's.mp3 in service mpd Dec 20 18:30:31 ftvolumio volumio[962]: info: ALBUMART /albumart?cacheid=248&web=Deep%20Blue%20Something//extralarge&path=%2Fmnt%2FUSB%2FElements%2Fmp3%2Fmp3%2FDeep%20Blue%20Something%20-%20Breakfast%20At%20Tiffany's.mp3&metadata=false Dec 20 18:30:31 ftvolumio volumio[962]: info: URI /mnt/USB/Elements/mp3/mp3/Deep Blue Something - Breakfast At Tiffany's.mp3 Dec 20 18:30:31 ftvolumio volumio[962]: info: Exploding uri music-library/USB/Elements/mp3/mp3/Deep Blue Something - Breakfast At Tiffanys.mp3 in service mpd Dec 20 18:30:31 ftvolumio volumio[962]: info: ALBUMART /albumart?cacheid=248&web=Deep%20Blue%20Something//extralarge&path=%2Fmnt%2FUSB%2FElements%2Fmp3%2Fmp3%2FDeep%20Blue%20Something%20-%20Breakfast%20At%20Tiffanys.mp3&metadata=false Dec 20 18:30:31 ftvolumio volumio[962]: info: URI /mnt/USB/Elements/mp3/mp3/Deep Blue Something - Breakfast At Tiffanys.mp3 Dec 20 18:30:31 ftvolumio volumio[962]: info: Exploding uri music-library/USB/Elements/mp3/mp33/Billboard Top 100 of 1996/1996-039-Deep_Blue_Something-Breakfast_At_Tiffany's.mp3 in service mpd Dec 20 18:30:31 ftvolumio volumio[962]: info: ALBUMART /albumart?cacheid=248&web=Deep%20Blue%20Something/Billboard%20Top%20100%20of%201996/extralarge&path=%2Fmnt%2FUSB%2FElements%2Fmp3%2Fmp33%2FBillboard%20Top%20100%20of%201996%2F1996-039-Deep_Blue_Something-Breakfast_At_Tiffany's.mp3&metadata=false Dec 20 18:30:31 ftvolumio volumio[962]: info: URI /mnt/USB/Elements/mp3/mp33/Billboard Top 100 of 1996/1996-039-Deep_Blue_Something-Breakfast_At_Tiffany's.mp3 Dec 20 18:30:31 ftvolumio volumio[962]: info: Exploding uri music-library/USB/Elements/mp3/mp33/Deep Blue Something/Deep Blue Something - Breakfast At Tiffany's.mp3 in service mpd Dec 20 18:30:31 ftvolumio volumio[962]: info: ALBUMART /albumart?cacheid=248&web=Deep%20Blue%20Something//extralarge&path=%2Fmnt%2FUSB%2FElements%2Fmp3%2Fmp33%2FDeep%20Blue%20Something%2FDeep%20Blue%20Something%20-%20Breakfast%20At%20Tiffany's.mp3&metadata=false Dec 20 18:30:31 ftvolumio volumio[962]: info: URI /mnt/USB/Elements/mp3/mp33/Deep Blue Something/Deep Blue Something - Breakfast At Tiffany's.mp3 Dec 20 18:30:32 ftvolumio volumio[962]: info: No valid Plugin REST Endpoint Dec 20 18:30:32 ftvolumio volumio[962]: info: No valid Plugin REST Endpoint Dec 20 18:30:39 ftvolumio volumio[962]: verbose: New Socket.io Connection to 192.168.82.195:3000 from 192.168.82.194 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Dec 20 18:30:39 ftvolumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 18:30:39 ftvolumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 18:30:39 ftvolumio volumio[962]: info: Discovery: Getting this device information Dec 20 18:30:39 ftvolumio volumio[962]: info: CoreCommandRouter::volumioGetState Dec 20 18:30:39 ftvolumio volumio[962]: info: CorePlayQueue::getTrack 13 Dec 20 18:30:39 ftvolumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 18:30:41 ftvolumio volumio[962]: info: CoreCommandRouter::volumioAddQueueItems Dec 20 18:30:41 ftvolumio volumio[962]: info: CoreStateMachine::addQueueItems Dec 20 18:30:41 ftvolumio volumio[962]: info: CorePlayQueue::addQueueItems Dec 20 18:30:41 ftvolumio volumio[962]: info: Preload queue cleared Dec 20 18:30:41 ftvolumio volumio[962]: info: Adding Item to queue: music-library/USB/Elements/mp3/mp3/Deep Blue Something - Breakfast At Tiffany's.mp3 Dec 20 18:30:41 ftvolumio volumio[962]: info: Using cached record of: music-library/USB/Elements/mp3/mp3/Deep Blue Something - Breakfast At Tiffany's.mp3 Dec 20 18:30:41 ftvolumio volumio[962]: info: CoreCommandRouter::volumioPushQueue Dec 20 18:30:41 ftvolumio volumio[962]: info: CorePlayQueue::saveQueue Dec 20 18:30:41 ftvolumio volumio[962]: info: CoreStateMachine::updateTrackBlock Dec 20 18:30:41 ftvolumio volumio[962]: info: CorePlayQueue::getTrackBlock Dec 20 18:30:49 ftvolumio go-librespot[1322]: time="2025-12-20T18:30:49+02:00" level=trace msg="received accesspoint ping" Dec 20 18:30:49 ftvolumio go-librespot[1322]: time="2025-12-20T18:30:49+02:00" level=trace msg="received accesspoint pong ack" Dec 20 18:30:58 ftvolumio go-librespot[1322]: time="2025-12-20T18:30:58+02:00" level=trace msg="sent dealer ping" Dec 20 18:30:58 ftvolumio go-librespot[1322]: time="2025-12-20T18:30:58+02:00" level=trace msg="received dealer pong" Dec 20 18:31:09 ftvolumio volumio[962]: verbose: New Socket.io Connection to 192.168.82.195:3000 from 192.168.82.194 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Dec 20 18:31:09 ftvolumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 18:31:09 ftvolumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 18:31:09 ftvolumio volumio[962]: info: Discovery: Getting this device information Dec 20 18:31:09 ftvolumio volumio[962]: info: CoreCommandRouter::volumioGetState Dec 20 18:31:09 ftvolumio volumio[962]: info: CorePlayQueue::getTrack 13 Dec 20 18:31:09 ftvolumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 18:31:24 ftvolumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 20 18:31:24 ftvolumio volumio[962]: info: CURURI: artists://DEPECHE%20MODE Dec 20 18:31:24 ftvolumio volumio[962]: info: Preload queue cleared Dec 20 18:31:24 ftvolumio volumio[962]: info: Preload queue cleared Dec 20 18:31:24 ftvolumio volumio[962]: info: Preloading song: music-library/USB/Elements/mp3/mp3/Depeche mode/DEPECHE MODE - POLICY OF TRUTH.MP3 Dec 20 18:31:24 ftvolumio volumio[962]: info: Exploding uri music-library/USB/Elements/mp3/mp3/Depeche mode/DEPECHE MODE - POLICY OF TRUTH.MP3 in service mpd Dec 20 18:31:24 ftvolumio volumio[962]: info: ALBUMART /albumart?cacheid=248&web=DEPECHE%20MODE//extralarge&path=%2Fmnt%2FUSB%2FElements%2Fmp3%2Fmp3%2FDepeche%20mode%2FDEPECHE%20MODE%20-%20POLICY%20OF%20TRUTH.MP3&metadata=false Dec 20 18:31:24 ftvolumio volumio[962]: info: URI /mnt/USB/Elements/mp3/mp3/Depeche mode/DEPECHE MODE - POLICY OF TRUTH.MP3 Dec 20 18:31:28 ftvolumio go-librespot[1322]: time="2025-12-20T18:31:28+02:00" level=trace msg="sent dealer ping" Dec 20 18:31:28 ftvolumio go-librespot[1322]: time="2025-12-20T18:31:28+02:00" level=trace msg="received dealer pong" Dec 20 18:31:31 ftvolumio volumio[962]: info: No valid Plugin REST Endpoint Dec 20 18:31:31 ftvolumio volumio[962]: info: No valid Plugin REST Endpoint Dec 20 18:31:37 ftvolumio volumio[962]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 20 18:31:37 ftvolumio volumio[962]: TypeError: Cannot read property 'slice' of null Dec 20 18:31:37 ftvolumio volumio[962]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Dec 20 18:31:37 ftvolumio volumio[962]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Dec 20 18:31:37 ftvolumio volumio[962]: at Object.onceWrapper (events.js:422:26) Dec 20 18:31:37 ftvolumio volumio[962]: at ClientRequest.emit (events.js:315:20) Dec 20 18:31:37 ftvolumio volumio[962]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27) Dec 20 18:31:37 ftvolumio volumio[962]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17) Dec 20 18:31:37 ftvolumio volumio[962]: at TLSSocket.socketOnData (_http_client.js:509:22) Dec 20 18:31:37 ftvolumio volumio[962]: at TLSSocket.emit (events.js:315:20) Dec 20 18:31:37 ftvolumio volumio[962]: at addChunk (internal/streams/readable.js:309:12) Dec 20 18:31:37 ftvolumio volumio[962]: at readableAddChunk (internal/streams/readable.js:284:9) Dec 20 18:31:37 ftvolumio volumio[962]: at TLSSocket.Readable.push (internal/streams/readable.js:223:10) Dec 20 18:31:37 ftvolumio volumio[962]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Dec 20 18:31:37 ftvolumio volumio[962]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 20 18:31:37 ftvolumio sudo[17329]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-20 18:30 Dec 20 18:31:37 ftvolumio sudo[17329]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"