-- Logs begin at Sun 2025-12-28 17:57:57 CET, end at Tue 2025-12-30 15:04:57 CET. -- Dec 30 15:03:03 volumio volumio[1421]: info: CoreCommandRouter::volumioGetState Dec 30 15:03:03 volumio volumio[1421]: info: CorePlayQueue::getTrack 0 Dec 30 15:03:03 volumio volumio[1421]: info: Listing playlists Dec 30 15:03:03 volumio volumio[1421]: info: Listing playlists Dec 30 15:03:13 volumio volumio[1421]: info: CoreCommandRouter::volumioGetState Dec 30 15:03:13 volumio volumio[1421]: info: CorePlayQueue::getTrack 0 Dec 30 15:03:23 volumio volumio[1421]: info: CoreCommandRouter::volumioGetState Dec 30 15:03:23 volumio volumio[1421]: info: CorePlayQueue::getTrack 0 Dec 30 15:03:23 volumio volumio[1421]: info: Listing playlists Dec 30 15:03:23 volumio volumio[1421]: info: Listing playlists Dec 30 15:03:33 volumio volumio[1421]: info: CoreCommandRouter::volumioGetState Dec 30 15:03:33 volumio volumio[1421]: info: CorePlayQueue::getTrack 0 Dec 30 15:03:43 volumio volumio[1421]: info: CoreCommandRouter::volumioGetState Dec 30 15:03:43 volumio volumio[1421]: info: CorePlayQueue::getTrack 0 Dec 30 15:03:43 volumio volumio[1421]: info: Listing playlists Dec 30 15:03:43 volumio volumio[1421]: info: Listing playlists Dec 30 15:03:53 volumio volumio[1421]: info: CoreCommandRouter::volumioGetState Dec 30 15:03:53 volumio volumio[1421]: info: CorePlayQueue::getTrack 0 Dec 30 15:04:03 volumio volumio[1421]: info: CoreCommandRouter::volumioGetState Dec 30 15:04:03 volumio volumio[1421]: info: CorePlayQueue::getTrack 0 Dec 30 15:04:03 volumio volumio[1421]: info: Listing playlists Dec 30 15:04:03 volumio volumio[1421]: info: Listing playlists Dec 30 15:04:13 volumio volumio[1421]: info: CoreCommandRouter::volumioGetState Dec 30 15:04:13 volumio volumio[1421]: info: CorePlayQueue::getTrack 0 Dec 30 15:04:23 volumio volumio[1421]: info: CoreCommandRouter::volumioGetState Dec 30 15:04:23 volumio volumio[1421]: info: CorePlayQueue::getTrack 0 Dec 30 15:04:23 volumio volumio[1421]: info: Listing playlists Dec 30 15:04:23 volumio volumio[1421]: info: Listing playlists Dec 30 15:04:28 volumio volumio[1421]: info: CoreCommandRouter::volumioNext Dec 30 15:04:28 volumio volumio[1421]: info: CoreStateMachine::next Dec 30 15:04:28 volumio volumio[1421]: info: CoreStateMachine::stop Dec 30 15:04:28 volumio volumio[1421]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 15:04:28 volumio volumio[1421]: info: CoreStateMachine::stPlaybackTimer Dec 30 15:04:28 volumio volumio[1421]: info: CoreStateMachine::updateTrackBlock Dec 30 15:04:28 volumio volumio[1421]: info: CorePlayQueue::getTrackBlock Dec 30 15:04:28 volumio volumio[1421]: info: CoreStateMachine::pushState Dec 30 15:04:28 volumio volumio[1421]: info: CorePlayQueue::getTrack 0 Dec 30 15:04:28 volumio volumio[1421]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 15:04:28 volumio volumio[1421]: info: CoreCommandRouter::volumioPushState Dec 30 15:04:28 volumio volumio[1421]: info: CoreStateMachine::serviceStop Dec 30 15:04:28 volumio volumio[1421]: info: CorePlayQueue::getTrack 0 Dec 30 15:04:28 volumio volumio[1421]: info: CoreCommandRouter::serviceStop Dec 30 15:04:28 volumio volumio[1421]: info: ControllerMpd::stop Dec 30 15:04:28 volumio volumio[1421]: verbose: ControllerMpd::sendMpdCommand stop Dec 30 15:04:28 volumio volumio[1421]: SPOTIFY: RECEIVED VOLUMIO VOLUME 96 Dec 30 15:04:28 volumio volumio[1421]: info: Dec 30 15:04:28 volumio volumio[1421]: ---------------------------- MPD announces state update: player Dec 30 15:04:28 volumio volumio[1421]: info: sendMpdCommand stop took 46 milliseconds Dec 30 15:04:28 volumio volumio[1421]: info: ControllerMpd::getState Dec 30 15:04:28 volumio volumio[1421]: verbose: ControllerMpd::sendMpdCommand status Dec 30 15:04:28 volumio volumio[1421]: info: CoreCommandRouter::servicePushState Dec 30 15:04:28 volumio volumio[1421]: info: CoreStateMachine::pushState Dec 30 15:04:28 volumio volumio[1421]: info: CorePlayQueue::getTrack 0 Dec 30 15:04:28 volumio volumio[1421]: info: CoreCommandRouter::volumioPushState Dec 30 15:04:28 volumio volumio[1421]: info: CorePlayQueue::getTrack 0 Dec 30 15:04:28 volumio volumio[1421]: verbose: STATE SERVICE {"status":"stop","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/10274.jpg","uri":"https://stream.radioparadise.com/mellow-flac","name":"Sad Eyed Lady of the Lowlands","title":"Sad Eyed Lady of the Lowlands","artist":"Bob Dylan","album":"Blonde on Blonde","streaming":true,"disableUiControls":true,"duration":666,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Dec 30 15:04:28 volumio volumio[1421]: verbose: CURRENT POSITION 0 Dec 30 15:04:28 volumio volumio[1421]: info: CoreStateMachine::syncState stateService stop Dec 30 15:04:28 volumio volumio[1421]: info: CoreStateMachine::syncState currentStatus stop Dec 30 15:04:28 volumio volumio[1421]: info: CoreStateMachine::pushState Dec 30 15:04:28 volumio volumio[1421]: info: CorePlayQueue::getTrack 0 Dec 30 15:04:28 volumio volumio[1421]: info: CoreCommandRouter::volumioPushState Dec 30 15:04:28 volumio volumio[1421]: info: No code Dec 30 15:04:28 volumio volumio[1421]: info: CoreStateMachine::pushState Dec 30 15:04:28 volumio volumio[1421]: info: CorePlayQueue::getTrack 0 Dec 30 15:04:28 volumio volumio[1421]: info: CoreCommandRouter::volumioPushState Dec 30 15:04:28 volumio volumio[1421]: info: CoreStateMachine::play index undefined Dec 30 15:04:28 volumio volumio[1421]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 15:04:28 volumio volumio[1421]: info: CorePlayQueue::getTrack 1 Dec 30 15:04:28 volumio volumio[1421]: info: sendMpdCommand status took 20 milliseconds Dec 30 15:04:28 volumio volumio[1421]: verbose: ControllerMpd::parseState Dec 30 15:04:28 volumio volumio[1421]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 15:04:28 volumio volumio[1421]: info: Dec 30 15:04:28 volumio volumio[1421]: ---------------------------- MPD announces state update: player Dec 30 15:04:28 volumio volumio[1421]: info: ControllerMpd::getState Dec 30 15:04:28 volumio volumio[1421]: verbose: ControllerMpd::sendMpdCommand status Dec 30 15:04:28 volumio volumio[1421]: SPOTIFY: RECEIVED VOLUMIO VOLUME 96 Dec 30 15:04:28 volumio volumio[1421]: SPOTIFY: RECEIVED VOLUMIO VOLUME 96 Dec 30 15:04:28 volumio volumio[1421]: SPOTIFY: RECEIVED VOLUMIO VOLUME 96 Dec 30 15:04:28 volumio volumio[1421]: info: sendMpdCommand playlistinfo took 8 milliseconds Dec 30 15:04:28 volumio volumio[1421]: info: sendMpdCommand status took 7 milliseconds Dec 30 15:04:28 volumio volumio[1421]: verbose: ControllerMpd::parseTrackInfo Dec 30 15:04:28 volumio volumio[1421]: verbose: ControllerMpd::parseState Dec 30 15:04:28 volumio volumio[1421]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 15:04:28 volumio volumio[1421]: info: ControllerMpd::pushState Dec 30 15:04:28 volumio volumio[1421]: info: CoreCommandRouter::servicePushState Dec 30 15:04:28 volumio volumio[1421]: info: CoreStateMachine::pushState Dec 30 15:04:28 volumio volumio[1421]: info: CorePlayQueue::getTrack 0 Dec 30 15:04:28 volumio volumio[1421]: info: CoreCommandRouter::volumioPushState Dec 30 15:04:28 volumio volumio[1421]: info: CorePlayQueue::getTrack 0 Dec 30 15:04:28 volumio volumio[1421]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Dec 30 15:04:28 volumio volumio[1421]: info: ------------------------------ 43ms Dec 30 15:04:28 volumio volumio[1421]: info: sendMpdCommand playlistinfo took 9 milliseconds Dec 30 15:04:28 volumio volumio[1421]: verbose: ControllerMpd::parseTrackInfo Dec 30 15:04:28 volumio volumio[1421]: info: ControllerMpd::pushState Dec 30 15:04:28 volumio volumio[1421]: info: CoreCommandRouter::servicePushState Dec 30 15:04:28 volumio volumio[1421]: info: CoreStateMachine::pushState Dec 30 15:04:28 volumio volumio[1421]: info: CorePlayQueue::getTrack 0 Dec 30 15:04:28 volumio volumio[1421]: info: CoreCommandRouter::volumioPushState Dec 30 15:04:28 volumio volumio[1421]: info: CorePlayQueue::getTrack 0 Dec 30 15:04:28 volumio volumio[1421]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Dec 30 15:04:28 volumio volumio[1421]: info: ------------------------------ 28ms Dec 30 15:04:28 volumio volumio[1421]: SPOTIFY: RECEIVED VOLUMIO VOLUME 96 Dec 30 15:04:28 volumio volumio[1421]: SPOTIFY: RECEIVED VOLUMIO VOLUME 96 Dec 30 15:04:29 volumio volumio[1421]: info: camilladsp spawned new process with pid 8530, instance 1, run: true Dec 30 15:04:29 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Dec 30 15:04:33 volumio volumio[1421]: info: CoreCommandRouter::volumioGetState Dec 30 15:04:33 volumio volumio[1421]: info: CorePlayQueue::getTrack 0 Dec 30 15:04:35 volumio volumio[1421]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 30 15:04:35 volumio volumio[1421]: info: CURURI: artists:// Dec 30 15:04:35 volumio volumio[1421]: info: Preload queue cleared Dec 30 15:04:37 volumio volumio[1421]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Alliance%20Ethnik/95a33d4f-4b04-439c-a6a2-d05161ae4f7e.jpg' Dec 30 15:04:40 volumio volumio[1421]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 30 15:04:40 volumio volumio[1421]: info: CURURI: music-library Dec 30 15:04:40 volumio volumio[1421]: info: Preload queue cleared Dec 30 15:04:43 volumio volumio[1421]: info: CoreCommandRouter::volumioGetState Dec 30 15:04:43 volumio volumio[1421]: info: CorePlayQueue::getTrack 0 Dec 30 15:04:43 volumio volumio[1421]: info: Listing playlists Dec 30 15:04:43 volumio volumio[1421]: info: Listing playlists Dec 30 15:04:43 volumio volumio[1421]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 30 15:04:43 volumio volumio[1421]: info: CURURI: music-library/USB Dec 30 15:04:43 volumio volumio[1421]: info: Preload queue cleared Dec 30 15:04:44 volumio volumio[1421]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 30 15:04:44 volumio volumio[1421]: info: CURURI: music-library/USB/MUSIC Dec 30 15:04:44 volumio volumio[1421]: info: Preload queue cleared Dec 30 15:04:44 volumio volumio[1421]: info: Preloading song: music-library/USB/MUSIC/After Dark_Mr Kitty.wav Dec 30 15:04:44 volumio volumio[1421]: info: Preloading song: music-library/USB/MUSIC/Scorpius.wav Dec 30 15:04:44 volumio volumio[1421]: info: Exploding uri music-library/USB/MUSIC/After Dark_Mr Kitty.wav in service mpd Dec 30 15:04:44 volumio volumio[1421]: info: ALBUMART /albumart?cacheid=346&web=//extralarge&path=%2Fmnt%2FUSB%2FMUSIC%2FAfter%20Dark_Mr%20Kitty.wav&metadata=false Dec 30 15:04:44 volumio volumio[1421]: info: URI /mnt/USB/MUSIC/After Dark_Mr Kitty.wav Dec 30 15:04:44 volumio volumio[1421]: info: Exploding uri music-library/USB/MUSIC/Scorpius.wav in service mpd Dec 30 15:04:44 volumio volumio[1421]: info: ALBUMART /albumart?cacheid=346&web=//extralarge&path=%2Fmnt%2FUSB%2FMUSIC%2FScorpius.wav&metadata=false Dec 30 15:04:44 volumio volumio[1421]: info: URI /mnt/USB/MUSIC/Scorpius.wav Dec 30 15:04:53 volumio volumio[1421]: info: CoreCommandRouter::volumioGetState Dec 30 15:04:53 volumio volumio[1421]: info: CorePlayQueue::getTrack 0 Dec 30 15:04:55 volumio volumio[1421]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Ignacio%20%27Mazacote%27%20Carillo/ee1cb6d0-12ff-44a8-b018-0e070d660ee2.jpg' Dec 30 15:04:55 volumio volumio[1421]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 30 15:04:55 volumio volumio[1421]: TypeError: Cannot read property 'slice' of null Dec 30 15:04:55 volumio volumio[1421]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:714:41) Dec 30 15:04:55 volumio volumio[1421]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:724:7) Dec 30 15:04:55 volumio volumio[1421]: at Object.onceWrapper (events.js:422:26) Dec 30 15:04:55 volumio volumio[1421]: at ClientRequest.emit (events.js:315:20) Dec 30 15:04:55 volumio volumio[1421]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27) Dec 30 15:04:55 volumio volumio[1421]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17) Dec 30 15:04:55 volumio volumio[1421]: at HTTPParser.execute () Dec 30 15:04:55 volumio volumio[1421]: at TLSSocket.socketOnData (_http_client.js:509:22) Dec 30 15:04:55 volumio volumio[1421]: at TLSSocket.emit (events.js:315:20) Dec 30 15:04:55 volumio volumio[1421]: at addChunk (internal/streams/readable.js:309:12) Dec 30 15:04:55 volumio volumio[1421]: at readableAddChunk (internal/streams/readable.js:284:9) Dec 30 15:04:55 volumio volumio[1421]: at TLSSocket.Readable.push (internal/streams/readable.js:223:10) Dec 30 15:04:55 volumio volumio[1421]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Dec 30 15:04:55 volumio volumio[1421]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 30 15:04:57 volumio sudo[8550]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-30 15:03 Dec 30 15:04:57 volumio sudo[8550]: 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="cd8cf34b47ce852e70b71e6f7b6e0265f7fdb695" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="8f88153f9a18f312d56050e6613b45a852ac819a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 27 Sep 2023 11:35:49 AM CEST" VOLUMIO_VERSION="3.546" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="6823c0d83061ff736b7e0dd4481bc496"