Aug 26 13:57:00 volumiobw go-librespot[1916]: time="2026-08-26T13:57:00+08:00" level=debug msg="handling play player command from 762cdec66b866e54e46d6c2f56dc914bd9768efd" Aug 26 13:57:00 volumiobw go-librespot[1916]: time="2026-08-26T13:57:00+08:00" level=debug msg="resolved context of track" uri="spotify:album:35QdFULbzmzRWMeH7bHGQR" Aug 26 13:57:00 volumiobw go-librespot[1916]: time="2026-08-26T13:57:00+08:00" level=trace msg="fetched new page 0 with 13 items (list: 13)" uri="spotify:album:35QdFULbzmzRWMeH7bHGQR" Aug 26 13:57:00 volumiobw go-librespot[1916]: time="2026-08-26T13:57:00+08:00" level=debug msg="loading track (paused: false, position: 1ms)" uri="spotify:track:5gRMe4rrHSJBzZ0Pb37PSI" Aug 26 13:57:00 volumiobw go-librespot[1916]: time="2026-08-26T13:57:00+08:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Aug 26 13:57:00 volumiobw go-librespot[1916]: time="2026-08-26T13:57:00+08:00" level=trace msg="emitting websocket event: will_play" Aug 26 13:57:00 volumiobw volumio[1531]: SPOTIFY: received: {"type":"will_play","data":{"context_uri":"spotify:album:35QdFULbzmzRWMeH7bHGQR","uri":"spotify:track:5gRMe4rrHSJBzZ0Pb37PSI","play_origin":"album"}} Aug 26 13:57:00 volumiobw go-librespot[1916]: time="2026-08-26T13:57:00+08:00" level=debug msg="selected format OGG_VORBIS_320 (9de68759a22abe9f3808c2ce269165b2040b348b)" uri="spotify:track:5gRMe4rrHSJBzZ0Pb37PSI" Aug 26 13:57:00 volumiobw go-librespot[1916]: time="2026-08-26T13:57:00+08:00" level=debug msg="requested aes key for file 9de68759a22abe9f3808c2ce269165b2040b348b, gid: 5gRMe4rrHSJBzZ0Pb37PSI" Aug 26 13:57:00 volumiobw go-librespot[1916]: time="2026-08-26T13:57:00+08:00" level=trace msg="found 2 cdn urls" uri="spotify:track:5gRMe4rrHSJBzZ0Pb37PSI" Aug 26 13:57:00 volumiobw go-librespot[1916]: time="2026-08-26T13:57:00+08:00" level=debug msg="fetched first chunk of 15, total size is 7502568 bytes" uri="spotify:track:5gRMe4rrHSJBzZ0Pb37PSI" Aug 26 13:57:00 volumiobw go-librespot[1916]: time="2026-08-26T13:57:00+08:00" level=trace msg="seek to 1ms (diff: 1ms, samples: 44, bytes: 0)" uri="spotify:track:5gRMe4rrHSJBzZ0Pb37PSI" Aug 26 13:57:00 volumiobw go-librespot[1916]: time="2026-08-26T13:57:00+08:00" level=info msg="loaded track \"我親愛的偏執狂\" (paused: false, position: 1ms, duration: 175720ms, prefetched: false)" uri="spotify:track:5gRMe4rrHSJBzZ0Pb37PSI" Aug 26 13:57:00 volumiobw go-librespot[1916]: time="2026-08-26T13:57:00+08:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Aug 26 13:57:00 volumiobw go-librespot[1916]: time="2026-08-26T13:57:00+08:00" level=trace msg="scheduling prefetch in 146s" Aug 26 13:57:00 volumiobw go-librespot[1916]: time="2026-08-26T13:57:00+08:00" level=trace msg="emitting websocket event: metadata" Aug 26 13:57:00 volumiobw go-librespot[1916]: time="2026-08-26T13:57:00+08:00" level=debug msg="sending successful reply for dealer request" Aug 26 13:57:00 volumiobw volumio[1531]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:5gRMe4rrHSJBzZ0Pb37PSI","name":"我親愛的偏執狂","artist_names":["Cheer Chen"],"album_name":"吉他手","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02a003c7dce99c2676a4beac82","position":1,"duration":175720,"release_date":"year:2002 month:8 day:2","track_number":1,"disc_number":1}} Aug 26 13:57:01 volumiobw go-librespot[1916]: time="2026-08-26T13:57:01+08:00" level=debug msg="fetched chunk 2/14, size: 524288" uri="spotify:track:5gRMe4rrHSJBzZ0Pb37PSI" Aug 26 13:57:01 volumiobw go-librespot[1916]: time="2026-08-26T13:57:01+08:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Aug 26 13:57:01 volumiobw go-librespot[1916]: time="2026-08-26T13:57:01+08:00" level=trace msg="emitting websocket event: playing" Aug 26 13:57:01 volumiobw volumio[1531]: SPOTIFY: received: {"type":"playing","data":{"context_uri":"spotify:album:35QdFULbzmzRWMeH7bHGQR","uri":"spotify:track:5gRMe4rrHSJBzZ0Pb37PSI","resume":false,"play_origin":"album"}} Aug 26 13:57:01 volumiobw volumio[1531]: SPOTIFY: PUSH STATE SPOTIFY Aug 26 13:57:01 volumiobw volumio[1531]: SPOTIFY: {"status":"play","service":"spop","title":"我親愛的偏執狂","artist":"Cheer Chen","album":"吉他手","albumart":"https://i.scdn.co/image/ab67616d00001e02a003c7dce99c2676a4beac82","uri":"spotify:track:5gRMe4rrHSJBzZ0Pb37PSI","trackType":"spotify","seek":1,"duration":175,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Aug 26 13:57:01 volumiobw volumio[1531]: info: CoreCommandRouter::servicePushState Aug 26 13:57:01 volumiobw volumio[1531]: info: CoreStateMachine::pushState Aug 26 13:57:01 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 13:57:01 volumiobw volumio[1531]: info: CoreCommandRouter::volumioPushState Aug 26 13:57:01 volumiobw volumio[1531]: SPOTIFY: RECEIVED VOLUMIO VOLUME 99 Aug 26 13:57:01 volumiobw go-librespot[1916]: time="2026-08-26T13:57:01+08:00" level=debug msg="fetched chunk 1/14, size: 524288" uri="spotify:track:5gRMe4rrHSJBzZ0Pb37PSI" Aug 26 13:57:01 volumiobw go-librespot[1916]: time="2026-08-26T13:57:01+08:00" level=debug msg="fetched chunk 3/14, size: 524288" uri="spotify:track:5gRMe4rrHSJBzZ0Pb37PSI" Aug 26 13:57:01 volumiobw volumio[1531]: SPOTIFY: PUSH STATE SPOTIFY Aug 26 13:57:01 volumiobw volumio[1531]: SPOTIFY: {"status":"play","service":"spop","title":"我親愛的偏執狂","artist":"Cheer Chen","album":"吉他手","albumart":"https://i.scdn.co/image/ab67616d00001e02a003c7dce99c2676a4beac82","uri":"spotify:track:5gRMe4rrHSJBzZ0Pb37PSI","trackType":"spotify","seek":1,"duration":175,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Aug 26 13:57:01 volumiobw volumio[1531]: info: CoreCommandRouter::servicePushState Aug 26 13:57:01 volumiobw volumio[1531]: info: CoreStateMachine::pushState Aug 26 13:57:01 volumiobw volumio[1531]: info: CoreCommandRouter::volumioPushState Aug 26 13:57:01 volumiobw volumio[1531]: SPOTIFY: RECEIVED VOLUMIO VOLUME 99 Aug 26 13:57:14 volumiobw go-librespot[1916]: time="2026-08-26T13:57:14+08:00" level=debug msg="fetched chunk 4/14, size: 524288" uri="spotify:track:5gRMe4rrHSJBzZ0Pb37PSI" Aug 26 13:57:20 volumiobw go-librespot[1916]: time="2026-08-26T13:57:20+08:00" level=trace msg="sent dealer ping" Aug 26 13:57:20 volumiobw go-librespot[1916]: time="2026-08-26T13:57:20+08:00" level=trace msg="received dealer pong" Aug 26 13:57:26 volumiobw go-librespot[1916]: time="2026-08-26T13:57:26+08:00" level=debug msg="fetched chunk 5/14, size: 524288" uri="spotify:track:5gRMe4rrHSJBzZ0Pb37PSI" Aug 26 13:57:38 volumiobw go-librespot[1916]: time="2026-08-26T13:57:38+08:00" level=debug msg="fetched chunk 6/14, size: 524288" uri="spotify:track:5gRMe4rrHSJBzZ0Pb37PSI" Aug 26 13:57:50 volumiobw go-librespot[1916]: time="2026-08-26T13:57:50+08:00" level=debug msg="fetched chunk 7/14, size: 524288" uri="spotify:track:5gRMe4rrHSJBzZ0Pb37PSI" Aug 26 13:57:50 volumiobw go-librespot[1916]: time="2026-08-26T13:57:50+08:00" level=trace msg="sent dealer ping" Aug 26 13:57:50 volumiobw go-librespot[1916]: time="2026-08-26T13:57:50+08:00" level=trace msg="received dealer pong" Aug 26 13:57:53 volumiobw sudo[26120]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 26 13:57:53 volumiobw sudo[26120]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 13:57:53 volumiobw sudo[26122]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 26 13:57:53 volumiobw sudo[26122]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 13:57:53 volumiobw sudo[26122]: pam_unix(sudo:session): session closed for user root Aug 26 13:57:53 volumiobw sudo[26120]: pam_unix(sudo:session): session closed for user root Aug 26 13:57:53 volumiobw volumio[1531]: verbose: New Socket.io Connection to 192.168.20.8 from 192.168.20.27 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.5.2 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 7 Aug 26 13:57:54 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 26 13:57:54 volumiobw volumio[1531]: info: CoreCommandRouter::volumioGetVisibleSources Aug 26 13:57:54 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 26 13:57:54 volumiobw volumio[1531]: info: CoreCommandRouter::volumioGetState Aug 26 13:57:54 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 26 13:57:54 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 26 13:57:54 volumiobw volumio[1531]: info: Received Get System Info Aug 26 13:57:54 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 13:57:54 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 13:57:54 volumiobw volumio[1531]: info: Discovery: Getting this device information Aug 26 13:57:54 volumiobw volumio[1531]: info: CoreCommandRouter::volumioGetState Aug 26 13:57:54 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 13:57:54 volumiobw volumio[1531]: info: CoreCommandRouter::volumioGetState Aug 26 13:57:54 volumiobw volumio[1531]: info: Listing playlists Aug 26 13:57:54 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 26 13:57:54 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 26 13:57:54 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 26 13:57:54 volumiobw sudo[26126]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 26 13:57:54 volumiobw sudo[26126]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 13:57:54 volumiobw sudo[26126]: pam_unix(sudo:session): session closed for user root Aug 26 13:57:54 volumiobw sudo[26128]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 26 13:57:54 volumiobw sudo[26128]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 26 13:57:54 volumiobw sudo[26128]: pam_unix(sudo:session): session closed for user root Aug 26 13:57:54 volumiobw volumio[1531]: verbose: New Socket.io Connection to 192.168.20.8 from 192.168.20.27 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.5.2 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 8 Aug 26 13:57:54 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 26 13:57:54 volumiobw volumio[1531]: info: CoreCommandRouter::volumioGetVisibleSources Aug 26 13:57:54 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 26 13:57:54 volumiobw volumio[1531]: info: CoreCommandRouter::volumioGetState Aug 26 13:57:54 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 26 13:57:54 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 26 13:57:54 volumiobw volumio[1531]: info: Received Get System Info Aug 26 13:57:54 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 13:57:54 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 13:57:54 volumiobw volumio[1531]: info: Discovery: Getting this device information Aug 26 13:57:54 volumiobw volumio[1531]: info: CoreCommandRouter::volumioGetState Aug 26 13:57:54 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 13:57:54 volumiobw volumio[1531]: info: CoreCommandRouter::volumioGetState Aug 26 13:57:54 volumiobw volumio[1531]: info: Listing playlists Aug 26 13:57:54 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 26 13:57:54 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 26 13:57:54 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 26 13:57:56 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 26 13:57:56 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 26 13:57:56 volumiobw volumio[1531]: info: Received Get System Info Aug 26 13:57:56 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 13:57:56 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 13:57:56 volumiobw volumio[1531]: info: Discovery: Getting this device information Aug 26 13:57:56 volumiobw volumio[1531]: info: CoreCommandRouter::volumioGetState Aug 26 13:57:56 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 13:57:56 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 26 13:57:59 volumiobw volumio[1531]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 13:57:59 volumiobw volumio[1531]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 13:57:59 volumiobw volumio[1531]: info: Retrieving Cloud Streaming UI Aug 26 13:57:59 volumiobw volumio[1531]: info: Getting Tidal Cloud Configuration Aug 26 13:57:59 volumiobw volumio[1531]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 13:57:59 volumiobw volumio[1531]: info: Getting Qobuz Cloud Configuration Aug 26 13:57:59 volumiobw volumio[1531]: info: Asking plugin for UI Config Aug 26 13:57:59 volumiobw volumio[1531]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 13:57:59 volumiobw volumio[1531]: info: Getting Spotify Cloud Configuration Aug 26 13:57:59 volumiobw volumio[1531]: info: Asking plugin for UI Config Aug 26 13:57:59 volumiobw volumio[1531]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 13:57:59 volumiobw volumio[1531]: info: Saving Spotify Acccount Aug 26 13:57:59 volumiobw volumio[1531]: info: Got Tidal Cloud Configuration Aug 26 13:57:59 volumiobw volumio[1531]: info: Got it Aug 26 13:57:59 volumiobw volumio[1531]: info: Got it Aug 26 13:57:59 volumiobw volumio[1531]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Aug 26 13:57:59 volumiobw volumio[1531]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 13:57:59 volumiobw volumio[1531]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Aug 26 13:57:59 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 26 13:57:59 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 26 13:57:59 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 26 13:57:59 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 26 13:57:59 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 13:57:59 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 13:57:59 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 13:57:59 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 13:57:59 volumiobw volumio[1531]: info: CoreCommandRouter::volumioGetBrowseSources Aug 26 13:57:59 volumiobw volumio[1531]: info: CoreCommandRouter::volumioGetBrowseSources Aug 26 13:57:59 volumiobw volumio[1531]: info: CoreCommandRouter::volumioGetBrowseSources Aug 26 13:57:59 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 26 13:57:59 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Aug 26 13:58:00 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 26 13:58:00 volumiobw volumio[1531]: info: Received Get System Info Aug 26 13:58:00 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 13:58:00 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 13:58:00 volumiobw volumio[1531]: info: Discovery: Getting this device information Aug 26 13:58:00 volumiobw volumio[1531]: info: CoreCommandRouter::volumioGetState Aug 26 13:58:00 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 13:58:02 volumiobw go-librespot[1916]: time="2026-08-26T13:58:02+08:00" level=debug msg="fetched chunk 8/14, size: 524288" uri="spotify:track:5gRMe4rrHSJBzZ0Pb37PSI" Aug 26 13:58:04 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 26 13:58:05 volumiobw volumio[1531]: info: CoreCommandRouter::volumioGetQueue Aug 26 13:58:05 volumiobw volumio[1531]: info: CoreStateMachine::getQueue Aug 26 13:58:05 volumiobw volumio[1531]: info: CorePlayQueue::getQueue Aug 26 13:58:07 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 26 13:58:07 volumiobw volumio[1531]: info: CURURI: music-library Aug 26 13:58:07 volumiobw volumio[1531]: info: Preload queue cleared Aug 26 13:58:08 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 26 13:58:08 volumiobw volumio[1531]: info: CURURI: music-library/USB Aug 26 13:58:11 volumiobw volumio[1531]: info: Preload queue cleared Aug 26 13:58:11 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 26 13:58:11 volumiobw volumio[1531]: info: CURURI: music-library/USB/Transcend Aug 26 13:58:11 volumiobw volumio[1531]: info: Preload queue cleared Aug 26 13:58:14 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 26 13:58:14 volumiobw volumio[1531]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 26 13:58:14 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 26 13:58:14 volumiobw volumio[1531]: info: Received Get System Version Aug 26 13:58:14 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 26 13:58:14 volumiobw volumio[1531]: info: Received Get System Info Aug 26 13:58:14 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 13:58:14 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 13:58:14 volumiobw volumio[1531]: info: Discovery: Getting this device information Aug 26 13:58:14 volumiobw volumio[1531]: info: CoreCommandRouter::volumioGetState Aug 26 13:58:14 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 13:58:14 volumiobw go-librespot[1916]: time="2026-08-26T13:58:14+08:00" level=debug msg="fetched chunk 9/14, size: 524288" uri="spotify:track:5gRMe4rrHSJBzZ0Pb37PSI" Aug 26 13:58:20 volumiobw go-librespot[1916]: time="2026-08-26T13:58:20+08:00" level=trace msg="sent dealer ping" Aug 26 13:58:20 volumiobw go-librespot[1916]: time="2026-08-26T13:58:20+08:00" level=trace msg="received dealer pong" Aug 26 13:58:27 volumiobw go-librespot[1916]: time="2026-08-26T13:58:27+08:00" level=debug msg="fetched chunk 10/14, size: 524288" uri="spotify:track:5gRMe4rrHSJBzZ0Pb37PSI" Aug 26 13:58:39 volumiobw go-librespot[1916]: time="2026-08-26T13:58:39+08:00" level=debug msg="fetched chunk 11/14, size: 524288" uri="spotify:track:5gRMe4rrHSJBzZ0Pb37PSI" Aug 26 13:58:42 volumiobw volumio[1531]: Searching plugin music_service/mpd Aug 26 13:58:42 volumiobw volumio[1531]: info: CoreCommandRouter::executeOnPlugin: mpd , search Aug 26 13:58:43 volumiobw volumio[1531]: info: All search sources collected, pushing search results Aug 26 13:58:45 volumiobw volumio[1531]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 13:58:45 volumiobw volumio[1531]: AggregateError Aug 26 13:58:45 volumiobw volumio[1531]: at internalConnectMultiple (node:net:1114:18) Aug 26 13:58:45 volumiobw volumio[1531]: at afterConnectMultiple (node:net:1667:5) { Aug 26 13:58:45 volumiobw volumio[1531]: code: 'ECONNREFUSED', Aug 26 13:58:45 volumiobw volumio[1531]: [errors]: [ Aug 26 13:58:45 volumiobw volumio[1531]: Error: connect ECONNREFUSED 158.69.209.125:443 Aug 26 13:58:45 volumiobw volumio[1531]: at createConnectionError (node:net:1634:14) Aug 26 13:58:45 volumiobw volumio[1531]: at afterConnectMultiple (node:net:1664:40) { Aug 26 13:58:45 volumiobw volumio[1531]: errno: -111, Aug 26 13:58:45 volumiobw volumio[1531]: code: 'ECONNREFUSED', Aug 26 13:58:45 volumiobw volumio[1531]: syscall: 'connect', Aug 26 13:58:45 volumiobw volumio[1531]: address: '158.69.209.125', Aug 26 13:58:45 volumiobw volumio[1531]: port: 443 Aug 26 13:58:45 volumiobw volumio[1531]: }, Aug 26 13:58:45 volumiobw volumio[1531]: Error: connect ECONNREFUSED 158.69.210.98:443 Aug 26 13:58:45 volumiobw volumio[1531]: at createConnectionError (node:net:1634:14) Aug 26 13:58:45 volumiobw volumio[1531]: at afterConnectMultiple (node:net:1664:40) { Aug 26 13:58:45 volumiobw volumio[1531]: errno: -111, Aug 26 13:58:45 volumiobw volumio[1531]: code: 'ECONNREFUSED', Aug 26 13:58:45 volumiobw volumio[1531]: syscall: 'connect', Aug 26 13:58:45 volumiobw volumio[1531]: address: '158.69.210.98', Aug 26 13:58:45 volumiobw volumio[1531]: port: 443 Aug 26 13:58:45 volumiobw volumio[1531]: } Aug 26 13:58:45 volumiobw volumio[1531]: ] Aug 26 13:58:45 volumiobw volumio[1531]: } Aug 26 13:58:45 volumiobw volumio[1531]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 13:58:45 volumiobw sudo[26222]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-26 13:57' Aug 26 13:58:45 volumiobw sudo[26222]: 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"