Jan 11 17:51:01 volumio go-librespot[2765]: time="2026-01-11T17:51:01+08:00" level=debug msg="fetched chunk 4/25, size: 524288" uri="spotify:track:7uv632EkfwYhXoqf8rhYrg" Jan 11 17:51:17 volumio go-librespot[2765]: time="2026-01-11T17:51:17+08:00" level=debug msg="fetched chunk 5/25, size: 524288" uri="spotify:track:7uv632EkfwYhXoqf8rhYrg" Jan 11 17:51:27 volumio go-librespot[2765]: time="2026-01-11T17:51:27+08:00" level=trace msg="sent dealer ping" Jan 11 17:51:27 volumio go-librespot[2765]: time="2026-01-11T17:51:27+08:00" level=trace msg="received dealer pong" Jan 11 17:51:33 volumio go-librespot[2765]: time="2026-01-11T17:51:33+08:00" level=debug msg="fetched chunk 6/25, size: 524288" uri="spotify:track:7uv632EkfwYhXoqf8rhYrg" Jan 11 17:51:49 volumio go-librespot[2765]: time="2026-01-11T17:51:49+08:00" level=debug msg="fetched chunk 7/25, size: 524288" uri="spotify:track:7uv632EkfwYhXoqf8rhYrg" Jan 11 17:51:56 volumio go-librespot[2765]: time="2026-01-11T17:51:56+08:00" level=trace msg="received accesspoint ping" Jan 11 17:51:56 volumio go-librespot[2765]: time="2026-01-11T17:51:56+08:00" level=trace msg="received accesspoint pong ack" Jan 11 17:51:57 volumio go-librespot[2765]: time="2026-01-11T17:51:57+08:00" level=trace msg="sent dealer ping" Jan 11 17:51:57 volumio go-librespot[2765]: time="2026-01-11T17:51:57+08:00" level=trace msg="received dealer pong" Jan 11 17:52:04 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 11 17:52:04 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 11 17:52:04 volumio volumio[1254]: info: Discovery: Getting this device information Jan 11 17:52:04 volumio volumio[1254]: info: CoreCommandRouter::volumioGetState Jan 11 17:52:04 volumio volumio[1254]: info: CorePlayQueue::getTrack 0 Jan 11 17:52:04 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 11 17:52:04 volumio volumio[1254]: verbose: New Socket.io Connection to 192.168.1.166:3000 from 192.168.1.65 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Jan 11 17:52:04 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 11 17:52:04 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 11 17:52:05 volumio go-librespot[2765]: time="2026-01-11T17:52:05+08:00" level=debug msg="fetched chunk 8/25, size: 524288" uri="spotify:track:7uv632EkfwYhXoqf8rhYrg" Jan 11 17:52:20 volumio go-librespot[2765]: time="2026-01-11T17:52:20+08:00" level=debug msg="fetched chunk 9/25, size: 524288" uri="spotify:track:7uv632EkfwYhXoqf8rhYrg" Jan 11 17:52:27 volumio go-librespot[2765]: time="2026-01-11T17:52:27+08:00" level=trace msg="sent dealer ping" Jan 11 17:52:27 volumio go-librespot[2765]: time="2026-01-11T17:52:27+08:00" level=trace msg="received dealer pong" Jan 11 17:52:36 volumio go-librespot[2765]: time="2026-01-11T17:52:36+08:00" level=debug msg="fetched chunk 10/25, size: 524288" uri="spotify:track:7uv632EkfwYhXoqf8rhYrg" Jan 11 17:52:36 volumio volumio[1254]: Searching plugin music_service/spop Jan 11 17:52:36 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: spop , search Jan 11 17:52:37 volumio volumio[1254]: info: All search sources collected, pushing search results Jan 11 17:52:39 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Jan 11 17:52:39 volumio volumio[1254]: info: In handleBrowseUri, curUri=spotify:artist:4tZwfgrHOc3mvqYlEYSvVi Jan 11 17:52:40 volumio volumio[1254]: info: Preload queue cleared Jan 11 17:52:40 volumio volumio[1254]: info: Preloading song: spotify:track:0DiWol3AO6WpXZgp0goxAV Jan 11 17:52:40 volumio volumio[1254]: info: Preloading song: spotify:track:2Foc5Q5nqNiosCNqttzHof Jan 11 17:52:40 volumio volumio[1254]: info: Preloading song: spotify:track:5o126gjHW5VqsPQb7Rf2IM Jan 11 17:52:40 volumio volumio[1254]: info: Preloading song: spotify:track:66xHyI6ITToQPm7PdOzIyn Jan 11 17:52:40 volumio volumio[1254]: info: Preloading song: spotify:track:1pKYYY0dkg23sQQXi0Q5zN Jan 11 17:52:40 volumio volumio[1254]: info: Preloading song: spotify:track:2LD2gT7gwAurzdQDQtILds Jan 11 17:52:40 volumio volumio[1254]: info: Preloading song: spotify:track:5W3cjX2J3tjhG8zb6u0qHn Jan 11 17:52:40 volumio volumio[1254]: info: Preloading song: spotify:track:1NeLwFETswx8Fzxl2AFl91 Jan 11 17:52:40 volumio volumio[1254]: info: Preloading song: spotify:track:7tvz58QxYKRLDpGn53i8TG Jan 11 17:52:40 volumio volumio[1254]: info: Preloading song: spotify:track:2VEZx7NWsZ1D0eJ4uv5Fym Jan 11 17:52:40 volumio volumio[1254]: info: Preload queue cleared Jan 11 17:52:40 volumio volumio[1254]: info: Preload queue cleared Jan 11 17:52:40 volumio volumio[1254]: info: No valid Plugin REST Endpoint Jan 11 17:52:40 volumio volumio[1254]: info: No valid Plugin REST Endpoint Jan 11 17:52:51 volumio go-librespot[2765]: time="2026-01-11T17:52:51+08:00" level=debug msg="fetched chunk 11/25, size: 524288" uri="spotify:track:7uv632EkfwYhXoqf8rhYrg" Jan 11 17:52:57 volumio go-librespot[2765]: time="2026-01-11T17:52:57+08:00" level=trace msg="sent dealer ping" Jan 11 17:52:57 volumio go-librespot[2765]: time="2026-01-11T17:52:57+08:00" level=trace msg="received dealer pong" Jan 11 17:52:58 volumio volumio[1254]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Jan 11 17:52:58 volumio volumio[1254]: info: In handleBrowseUri, curUri=spotify:artist:1F83oTuCQlj9S1mUI9vmkm Jan 11 17:52:58 volumio volumio[1254]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 11 17:52:58 volumio volumio[1254]: TypeError: Cannot read properties of undefined (reading 'url') Jan 11 17:52:58 volumio volumio[1254]: at /data/plugins/music_service/spop/index.js:2449:60 Jan 11 17:52:58 volumio volumio[1254]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Jan 11 17:52:58 volumio volumio[1254]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 11 17:52:59 volumio sudo[5483]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-11 17:51' Jan 11 17:52:59 volumio sudo[5483]: 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"