Mar 26 20:50:01 volumiopizero go-librespot[3402]: time="2026-03-26T20:50:01+01:00" level=debug msg="fetched chunk 6/11, size: 524288" uri="spotify:track:3fC4rRqg5oLATBWmsLRl46"
Mar 26 20:50:02 volumiopizero go-librespot[3402]: time="2026-03-26T20:50:02+01:00" level=trace msg="received accesspoint ping"
Mar 26 20:50:02 volumiopizero go-librespot[3402]: time="2026-03-26T20:50:02+01:00" level=trace msg="received accesspoint pong ack"
Mar 26 20:50:11 volumiopizero volumio[3167]: Searching plugin music_service/spop
Mar 26 20:50:11 volumiopizero volumio[3167]: info: CoreCommandRouter::executeOnPlugin: spop , search
Mar 26 20:50:12 volumiopizero volumio[3167]: info: All search sources collected, pushing search results
Mar 26 20:50:14 volumiopizero volumio[3167]: Searching plugin music_service/spop
Mar 26 20:50:14 volumiopizero volumio[3167]: info: CoreCommandRouter::executeOnPlugin: spop , search
Mar 26 20:50:15 volumiopizero volumio[3167]: info: All search sources collected, pushing search results
Mar 26 20:50:16 volumiopizero go-librespot[3402]: time="2026-03-26T20:50:16+01:00" level=debug msg="fetched chunk 7/11, size: 524288" uri="spotify:track:3fC4rRqg5oLATBWmsLRl46"
Mar 26 20:50:17 volumiopizero volumio[3167]: Searching plugin music_service/spop
Mar 26 20:50:17 volumiopizero volumio[3167]: info: CoreCommandRouter::executeOnPlugin: spop , search
Mar 26 20:50:18 volumiopizero volumio[3167]: info: All search sources collected, pushing search results
Mar 26 20:50:20 volumiopizero volumio[3167]: Searching plugin music_service/spop
Mar 26 20:50:20 volumiopizero volumio[3167]: info: CoreCommandRouter::executeOnPlugin: spop , search
Mar 26 20:50:21 volumiopizero volumio[3167]: info: All search sources collected, pushing search results
Mar 26 20:50:25 volumiopizero volumio[3167]: Searching plugin music_service/spop
Mar 26 20:50:25 volumiopizero volumio[3167]: info: CoreCommandRouter::executeOnPlugin: spop , search
Mar 26 20:50:26 volumiopizero volumio[3167]: info: All search sources collected, pushing search results
Mar 26 20:50:29 volumiopizero go-librespot[3402]: time="2026-03-26T20:50:29+01:00" level=trace msg="sent dealer ping"
Mar 26 20:50:29 volumiopizero go-librespot[3402]: time="2026-03-26T20:50:29+01:00" level=trace msg="received dealer pong"
Mar 26 20:50:30 volumiopizero go-librespot[3402]: time="2026-03-26T20:50:30+01:00" level=debug msg="fetched chunk 8/11, size: 524288" uri="spotify:track:3fC4rRqg5oLATBWmsLRl46"
Mar 26 20:50:37 volumiopizero volumio[3167]: Searching plugin music_service/spop
Mar 26 20:50:37 volumiopizero volumio[3167]: info: CoreCommandRouter::executeOnPlugin: spop , search
Mar 26 20:50:38 volumiopizero volumio[3167]: info: All search sources collected, pushing search results
Mar 26 20:50:38 volumiopizero volumio[3167]: Searching plugin music_service/spop
Mar 26 20:50:38 volumiopizero volumio[3167]: info: CoreCommandRouter::executeOnPlugin: spop , search
Mar 26 20:50:39 volumiopizero volumio[3167]: info: All search sources collected, pushing search results
Mar 26 20:50:40 volumiopizero volumio[3167]: Searching plugin music_service/spop
Mar 26 20:50:40 volumiopizero volumio[3167]: info: CoreCommandRouter::executeOnPlugin: spop , search
Mar 26 20:50:41 volumiopizero volumio[3167]: Searching plugin music_service/spop
Mar 26 20:50:41 volumiopizero volumio[3167]: info: CoreCommandRouter::executeOnPlugin: spop , search
Mar 26 20:50:41 volumiopizero volumio[3167]: info: All search sources collected, pushing search results
Mar 26 20:50:42 volumiopizero volumio[3167]: info: All search sources collected, pushing search results
Mar 26 20:50:44 volumiopizero go-librespot[3402]: time="2026-03-26T20:50:44+01:00" level=debug msg="fetched chunk 9/11, size: 524288" uri="spotify:track:3fC4rRqg5oLATBWmsLRl46"
Mar 26 20:50:58 volumiopizero go-librespot[3402]: time="2026-03-26T20:50:58+01:00" level=debug msg="fetched chunk 10/11, size: 524288" uri="spotify:track:3fC4rRqg5oLATBWmsLRl46"
Mar 26 20:50:58 volumiopizero volumio[3167]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri
Mar 26 20:50:58 volumiopizero volumio[3167]: info: In handleBrowseUri, curUri=spotify:artist:3O6zRW8cioTAkEd16YLDfU
Mar 26 20:50:59 volumiopizero go-librespot[3402]: time="2026-03-26T20:50:59+01:00" level=trace msg="sent dealer ping"
Mar 26 20:50:59 volumiopizero go-librespot[3402]: time="2026-03-26T20:50:59+01:00" level=trace msg="received dealer pong"
Mar 26 20:50:59 volumiopizero volumio[3167]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 26 20:50:59 volumiopizero volumio[3167]: TypeError: Cannot read properties of undefined (reading 'url')
Mar 26 20:50:59 volumiopizero volumio[3167]: at /data/plugins/music_service/spop/index.js:2446:60
Mar 26 20:50:59 volumiopizero volumio[3167]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
Mar 26 20:50:59 volumiopizero volumio[3167]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 26 20:51:01 volumiopizero sudo[12683]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-26 20:50'
Mar 26 20:51:01 volumiopizero sudo[12683]: 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="dc61260dec5515dafd2b634881860b4c46c919ff"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri Mar 6 16:46:58 UTC 2026"
VOLUMIO_VERSION="4.103"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="aa741395b8bfc648ff5d04e312f53d2c"