Dec 10 18:18:06 sono volumio[1193]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 10 18:18:06 sono volumio[1193]: info: CURURI: artists://Adele/21%20(Deluxe%20Edition) Dec 10 18:18:06 sono volumio[1193]: info: Preload queue cleared Dec 10 18:18:10 sono go-librespot[1648]: time="2025-12-10T18:18:10+01:00" level=trace msg="sent dealer ping" Dec 10 18:18:11 sono go-librespot[1648]: time="2025-12-10T18:18:11+01:00" level=trace msg="received dealer pong" Dec 10 18:18:11 sono volumio[1193]: info: Preload queue cleared Dec 10 18:18:11 sono volumio[1193]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 10 18:18:11 sono volumio[1193]: info: CoreStateMachine::ClearQueue Dec 10 18:18:11 sono volumio[1193]: info: CoreStateMachine::stop Dec 10 18:18:11 sono volumio[1193]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 18:18:11 sono volumio[1193]: info: CorePlayQueue::clearPlayQueue Dec 10 18:18:11 sono volumio[1193]: info: CorePlayQueue::saveQueue Dec 10 18:18:11 sono volumio[1193]: info: CoreCommandRouter::volumioPushQueue Dec 10 18:18:11 sono volumio[1193]: info: CoreStateMachine::addQueueItems Dec 10 18:18:11 sono volumio[1193]: info: CorePlayQueue::addQueueItems Dec 10 18:18:11 sono volumio[1193]: info: Preload queue cleared Dec 10 18:18:11 sono volumio[1193]: info: Adding Item to queue: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/01 - Rolling In the Deep.mp3 Dec 10 18:18:11 sono volumio[1193]: info: Using cached record of: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/01 - Rolling In the Deep.mp3 Dec 10 18:18:11 sono volumio[1193]: info: CoreCommandRouter::volumioPushQueue Dec 10 18:18:11 sono volumio[1193]: info: CorePlayQueue::saveQueue Dec 10 18:18:11 sono volumio[1193]: info: CoreStateMachine::updateTrackBlock Dec 10 18:18:11 sono volumio[1193]: info: CorePlayQueue::getTrackBlock Dec 10 18:18:11 sono volumio[1193]: info: CoreCommandRouter::volumioPlay Dec 10 18:18:11 sono volumio[1193]: info: CoreStateMachine::play index 0 Dec 10 18:18:11 sono volumio[1193]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 18:18:11 sono volumio[1193]: info: CoreStateMachine::addQueueItems Dec 10 18:18:11 sono volumio[1193]: info: CorePlayQueue::addQueueItems Dec 10 18:18:11 sono volumio[1193]: info: Preload queue cleared Dec 10 18:18:11 sono volumio[1193]: info: Adding Item to queue: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/02 - Rumour Has It.mp3 Dec 10 18:18:11 sono volumio[1193]: info: Using cached record of: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/02 - Rumour Has It.mp3 Dec 10 18:18:11 sono volumio[1193]: info: Adding Item to queue: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/03 - Turning Tables.mp3 Dec 10 18:18:11 sono volumio[1193]: info: Using cached record of: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/03 - Turning Tables.mp3 Dec 10 18:18:11 sono volumio[1193]: info: Adding Item to queue: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/04 - Don't You Remember.mp3 Dec 10 18:18:11 sono volumio[1193]: info: Using cached record of: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/04 - Don't You Remember.mp3 Dec 10 18:18:11 sono volumio[1193]: info: Adding Item to queue: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/05 - Set Fire to the Rain.mp3 Dec 10 18:18:11 sono volumio[1193]: info: Using cached record of: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/05 - Set Fire to the Rain.mp3 Dec 10 18:18:11 sono volumio[1193]: info: Adding Item to queue: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/06 - He Won't Go.mp3 Dec 10 18:18:11 sono volumio[1193]: info: Using cached record of: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/06 - He Won't Go.mp3 Dec 10 18:18:11 sono volumio[1193]: info: Adding Item to queue: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/07 - Take It All.mp3 Dec 10 18:18:11 sono volumio[1193]: info: Using cached record of: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/07 - Take It All.mp3 Dec 10 18:18:11 sono volumio[1193]: info: Adding Item to queue: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/08 - I'll Be Waiting.mp3 Dec 10 18:18:11 sono volumio[1193]: info: Using cached record of: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/08 - I'll Be Waiting.mp3 Dec 10 18:18:11 sono volumio[1193]: info: Adding Item to queue: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/09 - One and Only.mp3 Dec 10 18:18:11 sono volumio[1193]: info: Using cached record of: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/09 - One and Only.mp3 Dec 10 18:18:11 sono volumio[1193]: info: Adding Item to queue: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/10 - Lovesong.mp3 Dec 10 18:18:11 sono volumio[1193]: info: Using cached record of: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/10 - Lovesong.mp3 Dec 10 18:18:11 sono volumio[1193]: info: Adding Item to queue: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/11 - Someone Like You.mp3 Dec 10 18:18:11 sono volumio[1193]: info: Using cached record of: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/11 - Someone Like You.mp3 Dec 10 18:18:11 sono volumio[1193]: info: Adding Item to queue: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/12 - I Found a Boy (Bonus Track).mp3 Dec 10 18:18:11 sono volumio[1193]: info: Using cached record of: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/12 - I Found a Boy (Bonus Track).mp3 Dec 10 18:18:11 sono volumio[1193]: info: Adding Item to queue: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/13 - Turning Tables (Live Acoustic).mp3 Dec 10 18:18:11 sono volumio[1193]: info: Using cached record of: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/13 - Turning Tables (Live Acoustic).mp3 Dec 10 18:18:11 sono volumio[1193]: info: Adding Item to queue: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/14 - Don't You Remember (Live Acoustic).mp3 Dec 10 18:18:11 sono volumio[1193]: info: Using cached record of: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/14 - Don't You Remember (Live Acoustic).mp3 Dec 10 18:18:11 sono volumio[1193]: info: Adding Item to queue: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/15 - Someone Like You (Live Acoustic).mp3 Dec 10 18:18:11 sono volumio[1193]: info: Using cached record of: music-library/NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/15 - Someone Like You (Live Acoustic).mp3 Dec 10 18:18:11 sono volumio[1193]: info: CoreStateMachine::stop Dec 10 18:18:11 sono volumio[1193]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 18:18:11 sono volumio[1193]: info: CoreCommandRouter::volumioPushQueue Dec 10 18:18:11 sono volumio[1193]: info: CorePlayQueue::saveQueue Dec 10 18:18:11 sono volumio[1193]: info: CoreStateMachine::play index undefined Dec 10 18:18:11 sono volumio[1193]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 10 18:18:11 sono volumio[1193]: info: CoreStateMachine::updateTrackBlock Dec 10 18:18:11 sono volumio[1193]: info: CorePlayQueue::getTrackBlock Dec 10 18:18:11 sono volumio[1193]: info: CorePlayQueue::getTrack 0 Dec 10 18:18:11 sono volumio[1193]: info: CoreStateMachine::startPlaybackTimer Dec 10 18:18:11 sono volumio[1193]: info: CorePlayQueue::getTrack 0 Dec 10 18:18:11 sono volumio[1193]: verbose: ControllerMpd::clearAddPlayTracks NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/01 - Rolling In the Deep.mp3 Dec 10 18:18:11 sono volumio[1193]: verbose: ControllerMpd::sendMpdCommand stop Dec 10 18:18:12 sono volumio[1193]: info: sendMpdCommand stop took 254 milliseconds Dec 10 18:18:12 sono volumio[1193]: verbose: ControllerMpd::sendMpdCommand clear Dec 10 18:18:12 sono volumio[1193]: info: Dec 10 18:18:12 sono volumio[1193]: ---------------------------- MPD announces system playlist update Dec 10 18:18:12 sono volumio[1193]: info: Ignoring MPD Status Update Dec 10 18:18:12 sono volumio[1193]: info: sendMpdCommand clear took 47 milliseconds Dec 10 18:18:12 sono volumio[1193]: verbose: ControllerMpd::sendMpdCommand add "NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/01 - Rolling In the Deep.mp3" Dec 10 18:18:12 sono volumio[1193]: info: Dec 10 18:18:12 sono volumio[1193]: ---------------------------- MPD announces system playlist update Dec 10 18:18:12 sono volumio[1193]: info: Ignoring MPD Status Update Dec 10 18:18:12 sono volumio[1193]: info: Dec 10 18:18:12 sono volumio[1193]: ---------------------------- MPD announces system playlist update Dec 10 18:18:12 sono volumio[1193]: info: Ignoring MPD Status Update Dec 10 18:18:12 sono volumio[1193]: error: updateQueue error: null Dec 10 18:18:12 sono volumio[1193]: info: Dec 10 18:18:12 sono volumio[1193]: ---------------------------- MPD announces system playlist update Dec 10 18:18:12 sono volumio[1193]: info: Ignoring MPD Status Update Dec 10 18:18:12 sono volumio[1193]: info: ------------------------------ 53ms Dec 10 18:18:12 sono volumio[1193]: info: sendMpdCommand add "NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/01 - Rolling In the Deep.mp3" took 44 milliseconds Dec 10 18:18:12 sono volumio[1193]: info: ------------------------------ 41ms Dec 10 18:18:12 sono volumio[1193]: info: ------------------------------ 41ms Dec 10 18:18:12 sono volumio[1193]: verbose: ControllerMpd::sendMpdCommand play Dec 10 18:18:12 sono volumio[1193]: info: Dec 10 18:18:12 sono volumio[1193]: ---------------------------- MPD announces system playlist update Dec 10 18:18:12 sono volumio[1193]: info: Ignoring MPD Status Update Dec 10 18:18:12 sono volumio[1193]: info: Dec 10 18:18:12 sono volumio[1193]: ---------------------------- MPD announces system playlist update Dec 10 18:18:12 sono volumio[1193]: info: Ignoring MPD Status Update Dec 10 18:18:12 sono volumio[1193]: info: ------------------------------ 36ms Dec 10 18:18:12 sono volumio[1193]: info: sendMpdCommand play took 34 milliseconds Dec 10 18:18:12 sono volumio[1193]: info: ------------------------------ 33ms Dec 10 18:18:12 sono volumio[1193]: info: ------------------------------ 32ms Dec 10 18:18:12 sono volumio[1193]: info: Dec 10 18:18:12 sono volumio[1193]: ---------------------------- MPD announces state update: player Dec 10 18:18:12 sono volumio[1193]: info: ControllerMpd::getState Dec 10 18:18:12 sono volumio[1193]: verbose: ControllerMpd::sendMpdCommand status Dec 10 18:18:12 sono volumio[1193]: info: Dec 10 18:18:12 sono volumio[1193]: ---------------------------- MPD announces state update: player Dec 10 18:18:12 sono volumio[1193]: info: ControllerMpd::getState Dec 10 18:18:12 sono volumio[1193]: verbose: ControllerMpd::sendMpdCommand status Dec 10 18:18:12 sono volumio[1193]: info: Dec 10 18:18:12 sono volumio[1193]: ---------------------------- MPD announces state update: player Dec 10 18:18:12 sono volumio[1193]: info: ControllerMpd::getState Dec 10 18:18:12 sono volumio[1193]: verbose: ControllerMpd::sendMpdCommand status Dec 10 18:18:12 sono volumio[1193]: info: Dec 10 18:18:12 sono volumio[1193]: ---------------------------- MPD announces state update: player Dec 10 18:18:12 sono volumio[1193]: info: ControllerMpd::getState Dec 10 18:18:12 sono volumio[1193]: verbose: ControllerMpd::sendMpdCommand status Dec 10 18:18:12 sono volumio[1193]: info: Dec 10 18:18:12 sono volumio[1193]: ---------------------------- MPD announces state update: player Dec 10 18:18:12 sono volumio[1193]: info: ControllerMpd::getState Dec 10 18:18:12 sono volumio[1193]: verbose: ControllerMpd::sendMpdCommand status Dec 10 18:18:12 sono volumio[1193]: info: Dec 10 18:18:12 sono volumio[1193]: ---------------------------- MPD announces state update: player Dec 10 18:18:12 sono volumio[1193]: info: sendMpdCommand status took 173 milliseconds Dec 10 18:18:12 sono volumio[1193]: info: ControllerMpd::getState Dec 10 18:18:12 sono volumio[1193]: verbose: ControllerMpd::sendMpdCommand status Dec 10 18:18:12 sono volumio[1193]: info: sendMpdCommand status took 191 milliseconds Dec 10 18:18:12 sono volumio[1193]: info: sendMpdCommand status took 152 milliseconds Dec 10 18:18:12 sono volumio[1193]: info: sendMpdCommand status took 128 milliseconds Dec 10 18:18:13 sono volumio[1193]: info: sendMpdCommand status took 116 milliseconds Dec 10 18:18:13 sono volumio[1193]: verbose: ControllerMpd::parseState Dec 10 18:18:13 sono volumio[1193]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 18:18:13 sono volumio[1193]: verbose: ControllerMpd::parseState Dec 10 18:18:13 sono volumio[1193]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 18:18:13 sono volumio[1193]: verbose: ControllerMpd::parseState Dec 10 18:18:13 sono volumio[1193]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 18:18:13 sono volumio[1193]: verbose: ControllerMpd::parseState Dec 10 18:18:13 sono volumio[1193]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 18:18:13 sono volumio[1193]: verbose: ControllerMpd::parseState Dec 10 18:18:13 sono volumio[1193]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 18:18:13 sono volumio[1193]: info: sendMpdCommand status took 134 milliseconds Dec 10 18:18:13 sono volumio[1193]: info: sendMpdCommand playlistinfo took 87 milliseconds Dec 10 18:18:13 sono volumio[1193]: info: sendMpdCommand playlistinfo took 30 milliseconds Dec 10 18:18:13 sono volumio[1193]: info: sendMpdCommand playlistinfo took 30 milliseconds Dec 10 18:18:13 sono volumio[1193]: info: sendMpdCommand playlistinfo took 30 milliseconds Dec 10 18:18:13 sono volumio[1193]: info: sendMpdCommand playlistinfo took 30 milliseconds Dec 10 18:18:13 sono volumio[1193]: verbose: ControllerMpd::parseState Dec 10 18:18:13 sono volumio[1193]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 10 18:18:13 sono volumio[1193]: verbose: ControllerMpd::parseTrackInfo Dec 10 18:18:13 sono volumio[1193]: verbose: ControllerMpd::parseTrackInfo Dec 10 18:18:13 sono volumio[1193]: verbose: ControllerMpd::parseTrackInfo Dec 10 18:18:13 sono volumio[1193]: verbose: ControllerMpd::parseTrackInfo Dec 10 18:18:13 sono volumio[1193]: verbose: ControllerMpd::parseTrackInfo Dec 10 18:18:13 sono volumio[1193]: info: ControllerMpd::pushState Dec 10 18:18:13 sono volumio[1193]: info: CoreCommandRouter::servicePushState Dec 10 18:18:13 sono volumio[1193]: info: CorePlayQueue::getTrack 0 Dec 10 18:18:13 sono volumio[1193]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Rolling In the Deep","artist":"Adele","album":"21 (Deluxe Edition)","uri":"NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/01 - Rolling In the Deep.mp3","trackType":"mp3"} Dec 10 18:18:13 sono volumio[1193]: verbose: CURRENT POSITION 0 Dec 10 18:18:13 sono volumio[1193]: info: CoreStateMachine::syncState stateService play Dec 10 18:18:13 sono volumio[1193]: info: CoreStateMachine::syncState currentStatus stop Dec 10 18:18:13 sono volumio[1193]: info: ControllerMpd::pushState Dec 10 18:18:13 sono volumio[1193]: info: CoreCommandRouter::servicePushState Dec 10 18:18:13 sono volumio[1193]: info: CorePlayQueue::getTrack 0 Dec 10 18:18:13 sono volumio[1193]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Rolling In the Deep","artist":"Adele","album":"21 (Deluxe Edition)","uri":"NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/01 - Rolling In the Deep.mp3","trackType":"mp3"} Dec 10 18:18:13 sono volumio[1193]: verbose: CURRENT POSITION 0 Dec 10 18:18:13 sono volumio[1193]: info: CoreStateMachine::syncState stateService play Dec 10 18:18:13 sono volumio[1193]: info: CoreStateMachine::syncState currentStatus play Dec 10 18:18:13 sono volumio[1193]: info: Received an update from plugin. extracting info from payload Dec 10 18:18:13 sono volumio[1193]: info: CoreStateMachine::pushState Dec 10 18:18:13 sono volumio[1193]: info: CorePlayQueue::getTrack 0 Dec 10 18:18:13 sono volumio[1193]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 18:18:13 sono volumio[1193]: info: CoreCommandRouter::volumioPushState Dec 10 18:18:13 sono volumio[1193]: info: CoreStateMachine::pushState Dec 10 18:18:13 sono volumio[1193]: info: CorePlayQueue::getTrack 0 Dec 10 18:18:13 sono volumio[1193]: info: CoreCommandRouter::volumioPushState Dec 10 18:18:13 sono volumio[1193]: info: ControllerMpd::pushState Dec 10 18:18:13 sono volumio[1193]: info: CoreCommandRouter::servicePushState Dec 10 18:18:13 sono volumio[1193]: info: CorePlayQueue::getTrack 0 Dec 10 18:18:13 sono volumio[1193]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":228,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Rolling In the Deep","artist":"Adele","album":"21 (Deluxe Edition)","uri":"NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/01 - Rolling In the Deep.mp3","trackType":"mp3"} Dec 10 18:18:13 sono volumio[1193]: verbose: CURRENT POSITION 0 Dec 10 18:18:13 sono volumio[1193]: info: CoreStateMachine::syncState stateService play Dec 10 18:18:13 sono volumio[1193]: info: CoreStateMachine::syncState currentStatus play Dec 10 18:18:13 sono volumio[1193]: info: Received an update from plugin. extracting info from payload Dec 10 18:18:13 sono volumio[1193]: info: CoreStateMachine::pushState Dec 10 18:18:13 sono volumio[1193]: info: CorePlayQueue::getTrack 0 Dec 10 18:18:13 sono volumio[1193]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 18:18:13 sono volumio[1193]: info: CoreCommandRouter::volumioPushState Dec 10 18:18:13 sono volumio[1193]: info: CoreStateMachine::pushState Dec 10 18:18:13 sono volumio[1193]: info: CorePlayQueue::getTrack 0 Dec 10 18:18:13 sono volumio[1193]: info: CoreCommandRouter::volumioPushState Dec 10 18:18:13 sono volumio[1193]: info: ControllerMpd::pushState Dec 10 18:18:13 sono volumio[1193]: info: CoreCommandRouter::servicePushState Dec 10 18:18:13 sono volumio[1193]: info: CorePlayQueue::getTrack 0 Dec 10 18:18:13 sono volumio[1193]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":228,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"224 Kbps","isStreaming":false,"title":"Rolling In the Deep","artist":"Adele","album":"21 (Deluxe Edition)","uri":"NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/01 - Rolling In the Deep.mp3","trackType":"mp3"} Dec 10 18:18:13 sono volumio[1193]: verbose: CURRENT POSITION 0 Dec 10 18:18:13 sono volumio[1193]: info: CoreStateMachine::syncState stateService play Dec 10 18:18:13 sono volumio[1193]: info: CoreStateMachine::syncState currentStatus play Dec 10 18:18:13 sono volumio[1193]: info: Received an update from plugin. extracting info from payload Dec 10 18:18:13 sono volumio[1193]: info: CoreStateMachine::pushState Dec 10 18:18:13 sono volumio[1193]: info: CorePlayQueue::getTrack 0 Dec 10 18:18:13 sono volumio[1193]: info: CoreCommandRouter::volumioPushState Dec 10 18:18:13 sono volumio[1193]: info: CoreStateMachine::pushState Dec 10 18:18:13 sono volumio[1193]: info: CorePlayQueue::getTrack 0 Dec 10 18:18:13 sono volumio[1193]: info: CoreCommandRouter::volumioPushState Dec 10 18:18:13 sono volumio[1193]: info: ControllerMpd::pushState Dec 10 18:18:13 sono volumio[1193]: info: CoreCommandRouter::servicePushState Dec 10 18:18:13 sono volumio[1193]: info: CorePlayQueue::getTrack 0 Dec 10 18:18:13 sono volumio[1193]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":228,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Rolling In the Deep","artist":"Adele","album":"21 (Deluxe Edition)","uri":"NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/01 - Rolling In the Deep.mp3","trackType":"mp3"} Dec 10 18:18:13 sono volumio[1193]: verbose: CURRENT POSITION 0 Dec 10 18:18:13 sono volumio[1193]: info: CoreStateMachine::syncState stateService play Dec 10 18:18:13 sono volumio[1193]: info: CoreStateMachine::syncState currentStatus play Dec 10 18:18:13 sono volumio[1193]: info: Received an update from plugin. extracting info from payload Dec 10 18:18:13 sono volumio[1193]: info: CoreStateMachine::pushState Dec 10 18:18:13 sono volumio[1193]: info: CorePlayQueue::getTrack 0 Dec 10 18:18:13 sono volumio[1193]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 18:18:13 sono volumio[1193]: info: CoreCommandRouter::volumioPushState Dec 10 18:18:13 sono volumio[1193]: info: CoreStateMachine::pushState Dec 10 18:18:13 sono volumio[1193]: info: CorePlayQueue::getTrack 0 Dec 10 18:18:13 sono volumio[1193]: info: CoreCommandRouter::volumioPushState Dec 10 18:18:13 sono volumio[1193]: info: ------------------------------ 690ms Dec 10 18:18:13 sono volumio[1193]: info: ------------------------------ 1051ms Dec 10 18:18:13 sono volumio[1193]: info: ------------------------------ 1076ms Dec 10 18:18:13 sono volumio[1193]: info: ------------------------------ 1025ms Dec 10 18:18:13 sono volumio[1193]: info: ------------------------------ 991ms Dec 10 18:18:13 sono volumio[1193]: info: sendMpdCommand playlistinfo took 809 milliseconds Dec 10 18:18:13 sono volumio[1193]: verbose: ControllerMpd::parseTrackInfo Dec 10 18:18:13 sono volumio[1193]: info: ControllerMpd::pushState Dec 10 18:18:13 sono volumio[1193]: info: CoreCommandRouter::servicePushState Dec 10 18:18:13 sono volumio[1193]: info: CorePlayQueue::getTrack 0 Dec 10 18:18:13 sono volumio[1193]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1054,"duration":228,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Rolling In the Deep","artist":"Adele","album":"21 (Deluxe Edition)","uri":"NAS/albums/Adele/Adele - 21 [Deluxe Edition](2011)/01 - Rolling In the Deep.mp3","trackType":"mp3"} Dec 10 18:18:13 sono volumio[1193]: verbose: CURRENT POSITION 0 Dec 10 18:18:13 sono volumio[1193]: info: CoreStateMachine::syncState stateService play Dec 10 18:18:13 sono volumio[1193]: info: CoreStateMachine::syncState currentStatus play Dec 10 18:18:13 sono volumio[1193]: info: Received an update from plugin. extracting info from payload Dec 10 18:18:13 sono volumio[1193]: info: CoreStateMachine::pushState Dec 10 18:18:13 sono volumio[1193]: info: CorePlayQueue::getTrack 0 Dec 10 18:18:13 sono volumio[1193]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 10 18:18:13 sono volumio[1193]: info: CoreCommandRouter::volumioPushState Dec 10 18:18:13 sono volumio[1193]: info: CoreStateMachine::pushState Dec 10 18:18:13 sono volumio[1193]: info: CorePlayQueue::getTrack 0 Dec 10 18:18:13 sono volumio[1193]: info: CoreCommandRouter::volumioPushState Dec 10 18:18:13 sono volumio[1193]: info: ------------------------------ 1062ms Dec 10 18:18:14 sono volumio[1193]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 10 18:18:14 sono volumio[1193]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 10 18:18:14 sono volumio[1193]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 10 18:18:14 sono volumio[1193]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 10 18:18:14 sono volumio[1193]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 10 18:18:14 sono volumio[1193]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 10 18:18:14 sono volumio[1193]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 10 18:18:14 sono volumio[1193]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 10 18:18:14 sono volumio[1193]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 10 18:18:14 sono volumio[1193]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 10 18:18:40 sono go-librespot[1648]: time="2025-12-10T18:18:40+01:00" level=trace msg="received accesspoint ping" Dec 10 18:18:40 sono go-librespot[1648]: time="2025-12-10T18:18:40+01:00" level=trace msg="received accesspoint pong ack" Dec 10 18:18:40 sono go-librespot[1648]: time="2025-12-10T18:18:40+01:00" level=trace msg="sent dealer ping" Dec 10 18:18:41 sono go-librespot[1648]: time="2025-12-10T18:18:41+01:00" level=trace msg="received dealer pong" Dec 10 18:19:10 sono go-librespot[1648]: time="2025-12-10T18:19:10+01:00" level=trace msg="sent dealer ping" Dec 10 18:19:11 sono go-librespot[1648]: time="2025-12-10T18:19:11+01:00" level=trace msg="received dealer pong" Dec 10 18:19:40 sono go-librespot[1648]: time="2025-12-10T18:19:40+01:00" level=trace msg="sent dealer ping" Dec 10 18:19:41 sono go-librespot[1648]: time="2025-12-10T18:19:41+01:00" level=trace msg="received dealer pong" Dec 10 18:19:43 sono volumio[1193]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 10 18:19:43 sono volumio[1193]: TypeError: Cannot read properties of null (reading 'slice') Dec 10 18:19:43 sono volumio[1193]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Dec 10 18:19:43 sono volumio[1193]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Dec 10 18:19:43 sono volumio[1193]: at Object.onceWrapper (node:events:629:26) Dec 10 18:19:43 sono volumio[1193]: at ClientRequest.emit (node:events:514:28) Dec 10 18:19:43 sono volumio[1193]: at HTTPParser.parserOnIncomingClient [as onIncoming] (node:_http_client:693:27) Dec 10 18:19:43 sono volumio[1193]: at HTTPParser.parserOnHeadersComplete (node:_http_common:119:17) Dec 10 18:19:43 sono volumio[1193]: at TLSSocket.socketOnData (node:_http_client:535:22) Dec 10 18:19:43 sono volumio[1193]: at TLSSocket.emit (node:events:514:28) Dec 10 18:19:43 sono volumio[1193]: at addChunk (node:internal/streams/readable:343:12) Dec 10 18:19:43 sono volumio[1193]: at readableAddChunk (node:internal/streams/readable:316:9) Dec 10 18:19:43 sono volumio[1193]: at Readable.push (node:internal/streams/readable:253:10) Dec 10 18:19:43 sono volumio[1193]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:190:23) Dec 10 18:19:43 sono volumio[1193]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 10 18:19:50 sono sudo[2216]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-10 18:18' Dec 10 18:19:50 sono sudo[2216]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"