Dec 23 18:23:18 volumio go-librespot[1449]: time="2025-12-23T18:23:18Z" level=trace msg="sent dealer ping" Dec 23 18:23:18 volumio go-librespot[1449]: time="2025-12-23T18:23:18Z" level=trace msg="received dealer pong" Dec 23 18:23:48 volumio go-librespot[1449]: time="2025-12-23T18:23:48Z" level=trace msg="sent dealer ping" Dec 23 18:23:48 volumio go-librespot[1449]: time="2025-12-23T18:23:48Z" level=trace msg="received dealer pong" Dec 23 18:24:02 volumio sudo[28764]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 23 18:24:02 volumio sudo[28764]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 18:24:02 volumio sudo[28764]: pam_unix(sudo:session): session closed for user root Dec 23 18:24:02 volumio sudo[28766]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 23 18:24:02 volumio sudo[28766]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 18:24:02 volumio sudo[28766]: pam_unix(sudo:session): session closed for user root Dec 23 18:24:02 volumio volumio[1162]: verbose: New Socket.io Connection to 192.168.5.183 from 192.168.5.149 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.2 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 5 Dec 23 18:24:02 volumio sudo[28770]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 23 18:24:02 volumio sudo[28770]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 18:24:02 volumio sudo[28770]: pam_unix(sudo:session): session closed for user root Dec 23 18:24:02 volumio sudo[28772]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 23 18:24:02 volumio sudo[28772]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 18:24:02 volumio sudo[28772]: pam_unix(sudo:session): session closed for user root Dec 23 18:24:02 volumio volumio[1162]: verbose: New Socket.io Connection to 192.168.5.183 from 192.168.5.149 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.2 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 5 Dec 23 18:24:02 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 23 18:24:02 volumio volumio[1162]: info: CoreCommandRouter::volumioGetVisibleSources Dec 23 18:24:02 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 23 18:24:02 volumio volumio[1162]: info: CoreCommandRouter::volumioGetState Dec 23 18:24:02 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 23 18:24:02 volumio volumio[1162]: info: CoreCommandRouter::volumioGetQueue Dec 23 18:24:02 volumio volumio[1162]: info: CoreStateMachine::getQueue Dec 23 18:24:02 volumio volumio[1162]: info: CorePlayQueue::getQueue Dec 23 18:24:02 volumio volumio[1162]: info: Listing playlists Dec 23 18:24:02 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 23 18:24:02 volumio volumio[1162]: info: Received Get System Info Dec 23 18:24:02 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 23 18:24:02 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 23 18:24:02 volumio volumio[1162]: info: Discovery: Getting this device information Dec 23 18:24:02 volumio volumio[1162]: info: CoreCommandRouter::volumioGetState Dec 23 18:24:02 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 23 18:24:02 volumio volumio[1162]: info: CoreCommandRouter::volumioGetState Dec 23 18:24:02 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 23 18:24:02 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 23 18:24:02 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 23 18:24:04 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 23 18:24:04 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 23 18:24:04 volumio volumio[1162]: info: Received Get System Info Dec 23 18:24:04 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 23 18:24:04 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 23 18:24:04 volumio volumio[1162]: info: Discovery: Getting this device information Dec 23 18:24:04 volumio volumio[1162]: info: CoreCommandRouter::volumioGetState Dec 23 18:24:04 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 23 18:24:05 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 23 18:24:05 volumio volumio[1162]: info: Received Get System Info Dec 23 18:24:05 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 23 18:24:05 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 23 18:24:05 volumio volumio[1162]: info: Discovery: Getting this device information Dec 23 18:24:05 volumio volumio[1162]: info: CoreCommandRouter::volumioGetState Dec 23 18:24:05 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 23 18:24:10 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Dec 23 18:24:10 volumio volumio[1162]: info: In handleBrowseUri, curUri=spotify Dec 23 18:24:11 volumio volumio[1162]: info: New access token = BQAXgARNXINMxaEJEmIkD6wkCrE29oCOlC-CcERCiVSsR78y5HnvKgsJhIrJNnRd9UvtoSgFx2IKfG1PYd4h_5xrXW4PvQaqRlwIFDAF2UgZm1LIlpa6Co_vY-6jbvDgEL0ZnC6-WrGoOmif84fF0sNpapoplWjyshVmzQFMdKQz-KXwDvrA47iTakooq6pAMDfDpZluwDay8hsvO1HaHldppu3-cbN6po5u9DrD1Rww450Lm3yXJy3WEuit3h4MYsPJ_aiofZafKyMACtsttF_8vrpVNVnFFApaTCC0 Dec 23 18:24:11 volumio volumio[1162]: info: New access token = BQAqG8he12raKIzbod-189cIswm6L_vc35SMWb4mwiaZhs7PltMNMcAs0lg07RakKWVeR9E8mWWx_pk0pFpaLeSzn5spE1n4spuzT5B1tGhizqIieZ3mZ8lg3ZdarZQtU2FUavJCLhtocf_bfrfxaSj1rmX7daRBQc0S54fa8vxD5HxmD5ag2Ticc_dgxENL5A-OT2TS558YmlAhJkK1uXxVLu6NVXRKExbynE0h4YSjwsDrNLFxwX95-ok9HUP41W1oDnvITx4t--Bot7UtL5ktLGihf_omR1g6lGoj Dec 23 18:24:11 volumio volumio[1162]: info: New access token = BQB-pWt207kscXLlgkWBb73ZHiOBq8SHO4tN6wBXt_NQatHZJcUdk9afMsN0J5QkpFsGHPGLyCOR80h1UhHwfH9jiGom9L5htlE5XHVcoCGj0GqK9oOk6qWUFvub93srd225abDoEDy6zx3t_lQMIhT8NTs_UXrGXWBiW2dHC9lWY4o7mdy7m8F-ia8gHQybdGOw4QpbeNFTWOBP3IJecDoGjMg52mcbFEZ7xy-ngoGDd6k_B4Z1CBAlPDyHn8298dKRNm0bEnq5oqfp2Eh6OxlOLsjK0p5ec3j6rPIY Dec 23 18:24:11 volumio volumio[1162]: info: Preload queue cleared Dec 23 18:24:11 volumio volumio[1162]: info: Preload queue cleared Dec 23 18:24:11 volumio volumio[1162]: info: Preload queue cleared Dec 23 18:24:11 volumio volumio[1162]: info: Preload queue cleared Dec 23 18:24:12 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 23 18:24:16 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Dec 23 18:24:16 volumio volumio[1162]: info: In handleBrowseUri, curUri=spotify/myalbums Dec 23 18:24:18 volumio go-librespot[1449]: time="2025-12-23T18:24:18Z" level=trace msg="sent dealer ping" Dec 23 18:24:18 volumio go-librespot[1449]: time="2025-12-23T18:24:18Z" level=trace msg="received dealer pong" Dec 23 18:24:21 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 23 18:24:21 volumio volumio[1162]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 23 18:24:21 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 23 18:24:21 volumio volumio[1162]: info: Received Get System Version Dec 23 18:24:21 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 23 18:24:21 volumio volumio[1162]: info: Received Get System Info Dec 23 18:24:21 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 23 18:24:21 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 23 18:24:21 volumio volumio[1162]: info: Discovery: Getting this device information Dec 23 18:24:21 volumio volumio[1162]: info: CoreCommandRouter::volumioGetState Dec 23 18:24:21 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 23 18:24:22 volumio volumio[1162]: Searching plugin music_service/spop Dec 23 18:24:22 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: spop , search Dec 23 18:24:23 volumio volumio[1162]: info: All search sources collected, pushing search results Dec 23 18:24:25 volumio volumio[1162]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Dec 23 18:24:25 volumio volumio[1162]: info: In handleBrowseUri, curUri=spotify:artist:5EcDrRQgqYSBbBdIt0bEr7 Dec 23 18:24:26 volumio volumio[1162]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 23 18:24:26 volumio volumio[1162]: TypeError: Cannot read properties of undefined (reading 'url') Dec 23 18:24:26 volumio volumio[1162]: at /data/plugins/music_service/spop/index.js:2449:60 Dec 23 18:24:26 volumio volumio[1162]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Dec 23 18:24:26 volumio volumio[1162]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 23 18:24:27 volumio sudo[28831]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-23 18:23' Dec 23 18:24:27 volumio sudo[28831]: 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"