Jan 11 10:02:08 volumio go-librespot[1734]: time="2026-01-11T10:02:08+05:30" level=debug msg="fetched chunk 20/24, size: 524288" uri="spotify:track:2EZHZQUssxdmWdvYwihKtu" Jan 11 10:02:21 volumio go-librespot[1734]: time="2026-01-11T10:02:21+05:30" level=debug msg="fetched chunk 21/24, size: 524288" uri="spotify:track:2EZHZQUssxdmWdvYwihKtu" Jan 11 10:02:24 volumio go-librespot[1734]: time="2026-01-11T10:02:24+05:30" level=trace msg="sent dealer ping" Jan 11 10:02:24 volumio go-librespot[1734]: time="2026-01-11T10:02:24+05:30" level=trace msg="received dealer pong" Jan 11 10:02:33 volumio go-librespot[1734]: time="2026-01-11T10:02:33+05:30" level=debug msg="fetched chunk 22/24, size: 524288" uri="spotify:track:2EZHZQUssxdmWdvYwihKtu" Jan 11 10:02:46 volumio go-librespot[1734]: time="2026-01-11T10:02:46+05:30" level=debug msg="fetched chunk 23/24, size: 524288" uri="spotify:track:2EZHZQUssxdmWdvYwihKtu" Jan 11 10:02:51 volumio ntpd[1024]: PROTO: 103.136.36.100 unlink local addr 192.168.29.8 -> Jan 11 10:02:54 volumio go-librespot[1734]: time="2026-01-11T10:02:54+05:30" level=trace msg="received accesspoint ping" Jan 11 10:02:54 volumio go-librespot[1734]: time="2026-01-11T10:02:54+05:30" level=trace msg="received accesspoint pong ack" Jan 11 10:02:54 volumio go-librespot[1734]: time="2026-01-11T10:02:54+05:30" level=trace msg="sent dealer ping" Jan 11 10:02:54 volumio go-librespot[1734]: time="2026-01-11T10:02:54+05:30" level=trace msg="received dealer pong" Jan 11 10:02:58 volumio go-librespot[1734]: time="2026-01-11T10:02:58+05:30" level=debug msg="fetched chunk 24/24, size: 72760" uri="spotify:track:2EZHZQUssxdmWdvYwihKtu" Jan 11 10:03:06 volumio go-librespot[1734]: time="2026-01-11T10:03:06+05:30" level=info msg="playback was transferred to V2222" Jan 11 10:03:06 volumio go-librespot[1734]: time="2026-01-11T10:03:06+05:30" level=trace msg="closed output device because of stop command" Jan 11 10:03:06 volumio go-librespot[1734]: time="2026-01-11T10:03:06+05:30" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Jan 11 10:03:06 volumio go-librespot[1734]: time="2026-01-11T10:03:06+05:30" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Jan 11 10:03:06 volumio go-librespot[1734]: time="2026-01-11T10:03:06+05:30" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1197" Jan 11 10:03:06 volumio go-librespot[1734]: time="2026-01-11T10:03:06+05:30" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 455" Jan 11 10:03:06 volumio go-librespot[1734]: time="2026-01-11T10:03:06+05:30" level=debug msg="put connect state inactive" Jan 11 10:03:06 volumio go-librespot[1734]: time="2026-01-11T10:03:06+05:30" level=trace msg="emitting websocket event: inactive" Jan 11 10:03:06 volumio go-librespot[1734]: time="2026-01-11T10:03:06+05:30" level=trace msg="emitting websocket event: stopped" Jan 11 10:03:06 volumio volumio[1336]: SPOTIFY: received: {"type":"inactive","data":null} Jan 11 10:03:06 volumio volumio[1336]: error: Failed to decode event: inactive Jan 11 10:03:06 volumio volumio[1336]: SPOTIFY: received: {"type":"stopped","data":{"play_origin":""}} Jan 11 10:03:06 volumio volumio[1336]: SPOTIFY: PUSH STATE SPOTIFY Jan 11 10:03:06 volumio volumio[1336]: SPOTIFY: {"status":"stop","service":"spop","title":"Ezhimala Poongola","artist":"K. S. Chithra, Mohanlal","album":"Spadikam (Orginal Motion Picture Soundtrack)","albumart":"https://i.scdn.co/image/ab67616d00001e021ffdd415ebb8377e5efca793","uri":"spotify:track:2EZHZQUssxdmWdvYwihKtu","trackType":"spotify","seek":269000,"duration":302,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Jan 11 10:03:06 volumio volumio[1336]: info: CoreCommandRouter::servicePushState Jan 11 10:03:06 volumio volumio[1336]: info: CoreStateMachine::pushState Jan 11 10:03:06 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 10:03:06 volumio volumio[1336]: info: CoreCommandRouter::volumioPushState Jan 11 10:03:06 volumio volumio[1336]: info: CorePlayQueue::getTrack 0 Jan 11 10:03:06 volumio volumio[1336]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received spop Jan 11 10:03:06 volumio volumio[1336]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 10:03:06 volumio go-librespot[1734]: time="2026-01-11T10:03:06+05:30" level=debug msg="dealer connection closed" Jan 11 10:03:06 volumio go-librespot[1734]: time="2026-01-11T10:03:06+05:30" level=debug msg="dealer recv loop stopped" Jan 11 10:03:13 volumio volumio[1336]: verbose: New Socket.io Connection to 192.168.29.8 from 192.168.29.183 UA: Mozilla/5.0 (Linux; Android 15; V2222 Build/AP3A.240905.015.A2_CS; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.146 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Jan 11 10:03:13 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 11 10:03:13 volumio volumio[1336]: info: CoreCommandRouter::volumioGetVisibleSources Jan 11 10:03:13 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 11 10:03:13 volumio volumio[1336]: info: CoreCommandRouter::volumioGetState Jan 11 10:03:13 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 11 10:03:13 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 11 10:03:13 volumio volumio[1336]: info: Received Get System Info Jan 11 10:03:13 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 11 10:03:13 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 11 10:03:13 volumio volumio[1336]: info: Discovery: Getting this device information Jan 11 10:03:13 volumio volumio[1336]: info: CoreCommandRouter::volumioGetState Jan 11 10:03:13 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 11 10:03:13 volumio volumio[1336]: info: CoreCommandRouter::volumioGetState Jan 11 10:03:13 volumio volumio[1336]: info: Listing playlists Jan 11 10:03:13 volumio volumio[1336]: info: CoreCommandRouter::volumioGetQueue Jan 11 10:03:13 volumio volumio[1336]: info: CoreStateMachine::getQueue Jan 11 10:03:13 volumio volumio[1336]: info: CorePlayQueue::getQueue Jan 11 10:03:13 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 11 10:03:25 volumio volumio[1336]: Searching plugin music_service/mpd Jan 11 10:03:25 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jan 11 10:03:26 volumio volumio[1336]: info: All search sources collected, pushing search results Jan 11 10:03:27 volumio volumio[1336]: Searching plugin music_service/mpd Jan 11 10:03:27 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jan 11 10:03:28 volumio volumio[1336]: info: All search sources collected, pushing search results Jan 11 10:03:29 volumio volumio[1336]: Searching plugin music_service/mpd Jan 11 10:03:29 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jan 11 10:03:30 volumio volumio[1336]: info: All search sources collected, pushing search results Jan 11 10:03:31 volumio volumio[1336]: Searching plugin music_service/mpd Jan 11 10:03:31 volumio volumio[1336]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jan 11 10:03:32 volumio volumio[1336]: info: All search sources collected, pushing search results Jan 11 10:03:36 volumio volumio[1336]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 11 10:03:36 volumio volumio[1336]: TypeError: Cannot read properties of null (reading 'slice') Jan 11 10:03:36 volumio volumio[1336]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Jan 11 10:03:36 volumio volumio[1336]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Jan 11 10:03:36 volumio volumio[1336]: at Object.onceWrapper (node:events:629:26) Jan 11 10:03:36 volumio volumio[1336]: at ClientRequest.emit (node:events:514:28) Jan 11 10:03:36 volumio volumio[1336]: at HTTPParser.parserOnIncomingClient [as onIncoming] (node:_http_client:693:27) Jan 11 10:03:36 volumio volumio[1336]: at HTTPParser.parserOnHeadersComplete (node:_http_common:119:17) Jan 11 10:03:36 volumio volumio[1336]: at TLSSocket.socketOnData (node:_http_client:535:22) Jan 11 10:03:36 volumio volumio[1336]: at TLSSocket.emit (node:events:514:28) Jan 11 10:03:36 volumio volumio[1336]: at addChunk (node:internal/streams/readable:343:12) Jan 11 10:03:36 volumio volumio[1336]: at readableAddChunk (node:internal/streams/readable:316:9) Jan 11 10:03:36 volumio volumio[1336]: at Readable.push (node:internal/streams/readable:253:10) Jan 11 10:03:36 volumio volumio[1336]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:190:23) Jan 11 10:03:36 volumio volumio[1336]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 11 10:03:36 volumio sudo[4140]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-11 10:02' Jan 11 10:03:36 volumio sudo[4140]: 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="ec1ce6b3390e13e82b9cc0453f957c4f5298419e" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="8bcc10c3dbcbcb349e9887dc0527d54876b32688" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon Nov 17 16:31:40 UTC 2025" VOLUMIO_VERSION="4.071" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5fbe1bcf6936184712979c0bfaf061f2"