-- Logs begin at Fri 2025-06-13 04:58:27 CEST, end at Fri 2025-06-20 10:06:54 CEST. -- Jun 20 10:06:48 duckie systemd-timedated[1304]: Changed local time to Fri Jun 20 10:06:48 2025 Jun 20 10:06:48 duckie sudo[1302]: pam_unix(sudo:session): session closed for user root Jun 20 10:06:48 duckie volumio-time-update[598]: volumio-time-update-util: System time updated successfully. Jun 20 10:06:48 duckie systemd[1]: Starting Daily apt download activities... Jun 20 10:06:48 duckie volumio[1070]: info: Discovery: A device disappeared from network Jun 20 10:06:48 duckie volumio[1070]: info: Discovery: Device duckie disappeared from network Jun 20 10:06:48 duckie systemd[1]: Started Volumio Time Update Utility. Jun 20 10:06:48 duckie systemd[1]: Reached target Multi-User System. Jun 20 10:06:48 duckie systemd[1]: Reached target Graphical Interface. Jun 20 10:06:48 duckie systemd[1]: Starting Update UTMP about System Runlevel Changes... Jun 20 10:06:48 duckie systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jun 20 10:06:48 duckie systemd[1]: Started Update UTMP about System Runlevel Changes. Jun 20 10:06:48 duckie volumio[1070]: info: Discovery: adding b1673fab-c4ff-4760-83c2-c4cec0b40ff6 Jun 20 10:06:48 duckie volumio[1070]: info: Discovery: Found device duckie Jun 20 10:06:48 duckie volumio[1070]: info: CoreCommandRouter::volumioGetState Jun 20 10:06:48 duckie volumio[1070]: info: CorePlayQueue::getTrack 0 Jun 20 10:06:48 duckie systemd[1]: systemd-hostnamed.service: Succeeded. Jun 20 10:06:48 duckie systemd[1]: apt-daily.service: Succeeded. Jun 20 10:06:48 duckie systemd[1]: Started Daily apt download activities. Jun 20 10:06:48 duckie systemd[1]: Starting Daily apt upgrade and clean activities... Jun 20 10:06:49 duckie systemd[1]: apt-daily-upgrade.service: Succeeded. Jun 20 10:06:49 duckie systemd[1]: Started Daily apt upgrade and clean activities. Jun 20 10:06:49 duckie systemd[1]: Startup finished in 12.129s (kernel) + 35.333s (userspace) = 47.462s. Jun 20 10:06:49 duckie volumio[1070]: info: go-librespot daemon successfully initialized Jun 20 10:06:51 duckie volumio[1070]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jun 20 10:06:52 duckie go-librespot[1269]: time="2025-06-20T10:06:52+02:00" level=debug msg="handling transfer player command from 3a9c0839ade27a995594d18b0860b8e18e2c49f1" Jun 20 10:06:52 duckie volumio[1070]: info: Initializing connection to go-librespot Websocket Jun 20 10:06:52 duckie go-librespot[1269]: time="2025-06-20T10:06:52+02:00" level=debug msg="new websocket client" Jun 20 10:06:52 duckie volumio[1070]: info: Connection to go-librespot Websocket established Jun 20 10:06:52 duckie go-librespot[1269]: time="2025-06-20T10:06:52+02:00" level=debug msg="resolved context of track" uri="spotify:station:playlist:3hmURI9C8KurQkotOCLvMU" Jun 20 10:06:52 duckie go-librespot[1269]: time="2025-06-20T10:06:52+02:00" level=trace msg="fetched new page 0 with 50 items (list: 50)" uri="spotify:station:playlist:3hmURI9C8KurQkotOCLvMU" Jun 20 10:06:53 duckie go-librespot[1269]: time="2025-06-20T10:06:53+02:00" level=trace msg="fetched new page from (has next: true)" uri="spotify:station:playlist:3hmURI9C8KurQkotOCLvMU" Jun 20 10:06:53 duckie go-librespot[1269]: time="2025-06-20T10:06:53+02:00" level=trace msg="fetched new page 1 with 50 items (list: 100)" uri="spotify:station:playlist:3hmURI9C8KurQkotOCLvMU" Jun 20 10:06:53 duckie go-librespot[1269]: time="2025-06-20T10:06:53+02:00" level=trace msg="fetched new page from (has next: true)" uri="spotify:station:playlist:3hmURI9C8KurQkotOCLvMU" Jun 20 10:06:53 duckie go-librespot[1269]: time="2025-06-20T10:06:53+02:00" level=trace msg="fetched new page 2 with 50 items (list: 150)" uri="spotify:station:playlist:3hmURI9C8KurQkotOCLvMU" Jun 20 10:06:53 duckie go-librespot[1269]: time="2025-06-20T10:06:53+02:00" level=trace msg="fetched new page from (has next: true)" uri="spotify:station:playlist:3hmURI9C8KurQkotOCLvMU" Jun 20 10:06:53 duckie go-librespot[1269]: time="2025-06-20T10:06:53+02:00" level=trace msg="fetched new page 3 with 50 items (list: 200)" uri="spotify:station:playlist:3hmURI9C8KurQkotOCLvMU" Jun 20 10:06:53 duckie go-librespot[1269]: time="2025-06-20T10:06:53+02:00" level=warning msg="failed seeking to track in context spotify:station:playlist:3hmURI9C8KurQkotOCLvMU" error="failed fetching tracks for seek: failed moving to next index 200 (page 4): failed fetching next page: invalid status code from page at radio-apollo/v5/tracks/spotify:station:playlist:3hmURI9C8KurQkotOCLvMU?salt=983465&autoplay=false&count=50&isVideo=false&prev_tracks=6px77nsx8HmckG9YuKmiP2,1EJIEPzahlUiev5IQ1HnuL,0fsj3HxzBHev6EJ7OLFE3r,6Hfvn9qguufsmHp0uk3y3r,6LPQVBRDTZK539mKAbyMHC,7HXYoe65kmrPrJR1r0DGtW,5y9gFWBjJBLsVsVoj92Oee,4tEO5sXXoEOtxEPZJ15pgO,6txdprcclRZ0CyIVlnpHKX,1VMqkvlOqaH0HP0nsj1bx5,5nk6wxUSFUBxUKxjz0fKD6,6DjbtbgegRkzPjNJpm48Dh,1otJ6j1Hoz4kaKbfJ63tq7,6J17MkMmuzBiIOjRH6MOBZ,1Y9knEZGtCICyGuyIaKTbL,6S4IKAt5xCnbc7NiNG75eR,4kgGJcXALI1ppNA4NdkTw9,3yYe6csPthNTUCcg6PVGjs,7lcLiplycYdoXQBwwuFCb3,1L21YTLKh6eJaIjQWRgzo7,2Qy1PMD1NksqykcMqcJS0O,2UGbP8kUes3O5rncqkVdzk,00qOE7OjRl0BpYiCiweZB2,3Oeuxw27oYmLF3jflwVK4F,23YjDCSDxHOViabNYzl3TG,17lu4tymfnhmcIDlzBbtAb,2tHA8Z3oj4KUwqkJr6HfqD,3nFHbBj7H4fv99spt5WvvA,7ciPAEXgZJZNSwoEk1eBAK,11oBg7EA3BgPLWrIx4Rv7D,4FN9YT2xVbYCw6C6KlL3CV,5Q916vqrwfON21qlJiXpSz,6xMHglHoafdDFGXS6qfwSH,5t5rCnsgRBtcKqTB7SbD1Q,6Hp98J9Z9hRE100nivqg86,55WrYzR1SHfXeeU6DJbk3Y,6IaEEtM7QT42CDlTSHmnPK,4tUma2etb9HVEHTeIdJjl3,4wKTPZe1AgKNPObJ357dZK,1gw3nz0tcMNwMO2ZwFT8OE,4ENa9MbktJjV3HiTnlsg2b,5ZgnPqNvtMFeLpahZUuLf3,47hFbqM9aihAvz1FtWBv9f,2xpvmhp8j0UL9mCEqB1U0L,36vTL8WP4ZoD1bbUaW0V3E,4JWrm8PbScXc7AYkfXgWTd,0KlprCNZnru5bkqnhUM4Y9,1xOYHCW3Qmm2nvKXRovJks,7lRVXzYDdXywXHMeoZZsXl,72l70Nix3AIJ9XBAljgeR1&minimal=true?salt=799343&autoplay=false&count=50&isVideo=false&prev_tracks=6px77nsx8HmckG9YuKmiP2,1EJIEPzahlUiev5IQ1HnuL,0fsj3HxzBHev6EJ7OLFE3r,6LPQVBRDTZK539mKAbyMHC,6Hfvn9qguufsmHp0uk3y3r,1Y9knEZGtCICyGuyIaKTbL,5y9gFWBjJBLsVsVoj92Oee,4tEO5sXXoEOtxEPZJ15pgO,5nk6wxUSFUBxUKxjz0fKD6,6DjbtbgegRkzPjNJpm48Dh,1VMqkvlOqaH0HP0nsj1bx5,7HXYoe65kmrPrJR1r0DGtW,7lcLiplycYdoXQBwwuFCb3,6J17MkMmuzBiIOjRH6MOBZ,6txdprcclRZ0CyIVlnpHKX,11oBg7EA3BgPLWrIx4Rv7D,3nFHbBj7H4fv99spt5WvvA,4kgGJcXALI1ppNA4NdkTw9,7lRVXzYDdXywXHMeoZZsXl,1L21YTLKh6eJaIjQWRgzo7,7ciPAEXgZJZNSwoEk1eBAK,55WrYzR1SHfXeeU6DJbk3Y,5t5rCnsgRBtcKqTB7SbD1Q,2xpvmhp8j0UL9mCEqB1U0L,4FN9YT2xVbYCw6C6KlL3CV,17lu4tymfnhmcIDlzBbtAb,6Hp98J9Z9hRE100nivqg86,3yYe6csPthNTUCcg6PVGjs,6S4IKAt5xCnbc7NiNG75eR,2Qy1PMD1NksqykcMqcJS0O,23YjDCSDxHOViabNYzl3TG,4dDurgTN3eGyU0ghzFJ0T1,0KlprCNZnru5bkqnhUM4Y9,3Oeuxw27oYmLF3jflwVK4F,2UGbP8kUes3O5rncqkVdzk,1xOYHCW3Qmm2nvKXRovJks,6IaEEtM7QT42CDlTSHmnPK,5Q916vqrwfON21qlJiXpSz,4ENa9MbktJjV3HiTnlsg2b,00qOE7OjRl0BpYiCiweZB2,03L665O2Uc76D0QOVTmYkc,5xy6EutTYrw9HJZE2ZYWth,1otJ6j1Hoz4kaKbfJ63tq7,2tHA8Z3oj4KUwqkJr6HfqD,7I0mAU0RCFqokOL9sTbhnH,6xMHglHoafdDFGXS6qfwSH,4JWrm8PbScXc7AYkfXgWTd,4tUma2etb9HVEHTeIdJjl3,2BxuYgBSxm2UYnt4u6umpF,19BxV1kM3xyHLmBwrD3X9f?salt=158079&autoplay=false&count=50&isVideo=false&prev_tracks=5y9gFWBjJBLsVsVoj92Oee,1EJIEPzahlUiev5IQ1HnuL,0fsj3HxzBHev6EJ7OLFE3r,6LPQVBRDTZK539mKAbyMHC,6Hfvn9qguufsmHp0uk3y3r,1Y9knEZGtCICyGuyIaKTbL,6px77nsx8HmckG9YuKmiP2,4tEO5sXXoEOtxEPZJ15pgO,4kgGJcXALI1ppNA4NdkTw9,7HXYoe65kmrPrJR1r0DGtW,3nFHbBj7H4fv99spt5WvvA,6txdprcclRZ0CyIVlnpHKX,6IaEEtM7QT42CDlTSHmnPK,6J17MkMmuzBiIOjRH6MOBZ,5nk6wxUSFUBxUKxjz0fKD6,11oBg7EA3BgPLWrIx4Rv7D,5t5rCnsgRBtcKqTB7SbD1Q,7ciPAEXgZJZNSwoEk1eBAK,7lcLiplycYdoXQBwwuFCb3,1L21YTLKh6eJaIjQWRgzo7,5Q916vqrwfON21qlJiXpSz,3yYe6csPthNTUCcg6PVGjs,2UGbP8kUes3O5rncqkVdzk,2Qy1PMD1NksqykcMqcJS0O,7lRVXzYDdXywXHMeoZZsXl,17lu4tymfnhmcIDlzBbtAb,00qOE7OjRl0BpYiCiweZB2,6DjbtbgegRkzPjNJpm48Dh,6S4IKAt5xCnbc7NiNG75eR,4tUma2etb9HVEHTeIdJjl3,1otJ6j1Hoz4kaKbfJ63tq7,4ENa9MbktJjV3HiTnlsg2b,2xpvmhp8j0UL9mCEqB1U0L,55WrYzR1SHfXeeU6DJbk3Y,1gw3nz0tcMNwMO2ZwFT8OE,4dDurgTN3eGyU0ghzFJ0T1,4FN9YT2xVbYCw6C6KlL3CV,6Hp98J9Z9hRE100nivqg86,6xMHglHoafdDFGXS6qfwSH,3Oeuxw27oYmLF3jflwVK4F,03L665O2Uc76D0QOVTmYkc,1xOYHCW3Qmm2nvKXRovJks,1rlC4fERGHFgEMOEj1MOSG,0KlprCNZnru5bkqnhUM4Y9,19BxV1kM3xyHLmBwrD3X9f,5ZgnPqNvtMFeLpahZUuLf3,4JWrm8PbScXc7AYkfXgWTd,2tHA8Z3oj4KUwqkJr6HfqD,0R8vaqcl7316PnMAWFTSK3,7I0mAU0RCFqokOL9sTbhnH?salt=287983&autoplay=false&count=50&isVideo=false&prev_tracks=5y9gFWBjJBLsVsVoj92Oee,1EJIEPzahlUiev5IQ1HnuL,0fsj3HxzBHev6EJ7OLFE3r,6LPQVBRDTZK539mKAbyMHC,6Hfvn9qguufsmHp0uk3y3r,7HXYoe65kmrPrJR1r0DGtW,6px77nsx8HmckG9YuKmiP2,4tEO5sXXoEOtxEPZJ15pgO,4kgGJcXALI1ppNA4NdkTw9,1Y9knEZGtCICyGuyIaKTbL,5t5rCnsgRBtcKqTB7SbD1Q,6DjbtbgegRkzPjNJpm48Dh,6IaEEtM7QT42CDlTSHmnPK,1L21YTLKh6eJaIjQWRgzo7,5nk6wxUSFUBxUKxjz0fKD6,6txdprcclRZ0CyIVlnpHKX,1VMqkvlOqaH0HP0nsj1bx5,3yYe6csPthNTUCcg6PVGjs,7lRVXzYDdXywXHMeoZZsXl,6J17MkMmuzBiIOjRH6MOBZ,5Q916vqrwfON21qlJiXpSz,7ciPAEXgZJZNSwoEk1eBAK,2UGbP8kUes3O5rncqkVdzk,00qOE7OjRl0BpYiCiweZB2,1otJ6j1Hoz4kaKbfJ63tq7,17lu4tymfnhmcIDlzBbtAb,4tUma2etb9HVEHTeIdJjl3,4ENa9MbktJjV3HiTnlsg2b,3nFHbBj7H4fv99spt5WvvA,11oBg7EA3BgPLWrIx4Rv7D,7lcLiplycYdoXQBwwuFCb3,2xpvmhp8j0UL9mCEqB1U0L,4sOlbksuGHyUkSafNnho2f,0KlprCNZnru5bkqnhUM4Y9,6S4IKAt5xCnbc7NiNG75eR,3Oeuxw27oYmLF3jflwVK4F,2BxuYgBSxm2UYnt4u6umpF,6xMHglHoafdDFGXS6qfwSH,2tHA8Z3oj4KUwqkJr6HfqD,7I0mAU0RCFqokOL9sTbhnH,03L665O2Uc76D0QOVTmYkc,55WrYzR1SHfXeeU6DJbk3Y,23YjDCSDxHOViabNYzl3TG,5xy6EutTYrw9HJZE2ZYWth,4dDurgTN3eGyU0ghzFJ0T1,6Hp98J9Z9hRE100nivqg86,6XYwdH9hJcpkq8C5wsZ0Mm,5ZgnPqNvtMFeLpahZUuLf3,36DwqDbgWWn48i4Lc2Ncib,6P1zaBgYv8c1A0vdJ6bBMV: 414" Jun 20 10:06:53 duckie go-librespot[1269]: time="2025-06-20T10:06:53+02:00" level=debug msg="loading track (paused: true, position: 7971ms)" uri="spotify:track:6px77nsx8HmckG9YuKmiP2" Jun 20 10:06:54 duckie go-librespot[1269]: time="2025-06-20T10:06:54+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 20 10:06:54 duckie go-librespot[1269]: time="2025-06-20T10:06:54+02:00" level=trace msg="emitting websocket event: will_play" Jun 20 10:06:54 duckie volumio[1070]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:6px77nsx8HmckG9YuKmiP2","play_origin":""}} Jun 20 10:06:54 duckie go-librespot[1269]: time="2025-06-20T10:06:54+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 345" Jun 20 10:06:54 duckie go-librespot[1269]: time="2025-06-20T10:06:54+02:00" level=debug msg="selected format OGG_VORBIS_320 (d1a427cbae810331e1f9bee05f53b7a4bb85ae06)" uri="spotify:track:6px77nsx8HmckG9YuKmiP2" Jun 20 10:06:54 duckie go-librespot[1269]: time="2025-06-20T10:06:54+02:00" level=debug msg="requested aes key for file d1a427cbae810331e1f9bee05f53b7a4bb85ae06, gid: 6px77nsx8HmckG9YuKmiP2" Jun 20 10:06:54 duckie go-librespot[1269]: time="2025-06-20T10:06:54+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1365" Jun 20 10:06:54 duckie go-librespot[1269]: time="2025-06-20T10:06:54+02:00" level=debug msg="fetched first chunk of 19, total size is 9611176 bytes" uri="spotify:track:6px77nsx8HmckG9YuKmiP2" Jun 20 10:06:54 duckie go-librespot[1269]: time="2025-06-20T10:06:54+02:00" level=trace msg="seek to 7971ms (diff: 80ms, samples: 351521, bytes: 276607)" uri="spotify:track:6px77nsx8HmckG9YuKmiP2" Jun 20 10:06:54 duckie go-librespot[1269]: time="2025-06-20T10:06:54+02:00" level=debug msg="alsa driver configured, rate = 44100 bps, period time = 5102 us, period size = 225 frames, buffer time = 500000 us, buffer size = 22050 frames, periods per buffer = 98 frames" Jun 20 10:06:54 duckie go-librespot[1269]: time="2025-06-20T10:06:54+02:00" level=debug msg="created new output device" Jun 20 10:06:54 duckie go-librespot[1269]: time="2025-06-20T10:06:54+02:00" level=info msg="loaded track \"Plain Jane\" (paused: true, position: 7971ms, duration: 229266ms, prefetched: false)" uri="spotify:track:6px77nsx8HmckG9YuKmiP2" Jun 20 10:06:54 duckie go-librespot[1269]: time="2025-06-20T10:06:54+02:00" level=debug msg="fetched chunk 1/18, size: 524288" uri="spotify:track:6px77nsx8HmckG9YuKmiP2" Jun 20 10:06:54 duckie go-librespot[1269]: time="2025-06-20T10:06:54+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 20 10:06:54 duckie go-librespot[1269]: time="2025-06-20T10:06:54+02:00" level=trace msg="emitting websocket event: metadata" Jun 20 10:06:54 duckie go-librespot[1269]: time="2025-06-20T10:06:54+02:00" level=trace msg="emitting websocket event: active" Jun 20 10:06:54 duckie go-librespot[1269]: time="2025-06-20T10:06:54+02:00" level=debug msg="sending successful reply for dealer request" Jun 20 10:06:54 duckie go-librespot[1269]: time="2025-06-20T10:06:54+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Jun 20 10:06:54 duckie go-librespot[1269]: time="2025-06-20T10:06:54+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Jun 20 10:06:54 duckie volumio[1070]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:6px77nsx8HmckG9YuKmiP2","name":"Plain Jane","artist_names":["Sammy Hagar"],"album_name":"Street Machine","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02d99dfb5ff8c889d741d81af5","position":7971,"duration":229266,"release_date":"year:1979 month:1 day:1","track_number":5,"disc_number":1}} Jun 20 10:06:54 duckie volumio[1070]: SPOTIFY: received: {"type":"active","data":null} Jun 20 10:06:54 duckie volumio[1070]: info: Aligning Spotify Volume to Volumio Volume Jun 20 10:06:54 duckie volumio[1070]: info: CoreCommandRouter::volumioGetState Jun 20 10:06:54 duckie volumio[1070]: info: CorePlayQueue::getTrack 0 Jun 20 10:06:54 duckie volumio[1070]: info: Setting Spotify Volume from Volumio: 57 Jun 20 10:06:54 duckie go-librespot[1269]: time="2025-06-20T10:06:54+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1128" Jun 20 10:06:54 duckie go-librespot[1269]: time="2025-06-20T10:06:54+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Jun 20 10:06:54 duckie go-librespot[1269]: time="2025-06-20T10:06:54+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 20 10:06:54 duckie go-librespot[1269]: time="2025-06-20T10:06:54+02:00" level=trace msg="emitting websocket event: paused" Jun 20 10:06:54 duckie volumio[1070]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:6px77nsx8HmckG9YuKmiP2","play_origin":""}} Jun 20 10:06:54 duckie volumio[1070]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 20 10:06:54 duckie go-librespot[1269]: time="2025-06-20T10:06:54+02:00" level=debug msg="fetched chunk 2/18, size: 524288" uri="spotify:track:6px77nsx8HmckG9YuKmiP2" Jun 20 10:06:54 duckie volumio[1070]: TypeError: Cannot read property 'service' of undefined Jun 20 10:06:54 duckie volumio[1070]: at ControllerSpotify.identifyPlaybackMode (/data/plugins/music_service/spop/index.js:337:50) Jun 20 10:06:54 duckie volumio[1070]: at ControllerSpotify.parseEventState (/data/plugins/music_service/spop/index.js:271:18) Jun 20 10:06:54 duckie volumio[1070]: at WebSocket.message (/data/plugins/music_service/spop/index.js:190:14) Jun 20 10:06:54 duckie volumio[1070]: at WebSocket.emit (events.js:315:20) Jun 20 10:06:54 duckie volumio[1070]: at Receiver.receiverOnMessage (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1220:20) Jun 20 10:06:54 duckie volumio[1070]: at Receiver.emit (events.js:315:20) Jun 20 10:06:54 duckie volumio[1070]: at Receiver.dataMessage (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:596:14) Jun 20 10:06:54 duckie volumio[1070]: at Receiver.getData (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:496:10) Jun 20 10:06:54 duckie volumio[1070]: at Receiver.startLoop (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:167:16) Jun 20 10:06:54 duckie volumio[1070]: at Receiver._write (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:94:10) Jun 20 10:06:54 duckie volumio[1070]: at writeOrBuffer (internal/streams/writable.js:358:12) Jun 20 10:06:54 duckie volumio[1070]: at Receiver.Writable.write (internal/streams/writable.js:303:10) Jun 20 10:06:54 duckie volumio[1070]: at Socket.socketOnData (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1355:35) Jun 20 10:06:54 duckie volumio[1070]: at Socket.emit (events.js:315:20) Jun 20 10:06:54 duckie volumio[1070]: at addChunk (internal/streams/readable.js:309:12) Jun 20 10:06:54 duckie volumio[1070]: at readableAddChunk (internal/streams/readable.js:284:9) Jun 20 10:06:54 duckie volumio[1070]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 20 10:06:54 duckie go-librespot[1269]: time="2025-06-20T10:06:54+02:00" level=debug msg="fetched chunk 3/18, size: 524288" uri="spotify:track:6px77nsx8HmckG9YuKmiP2" Jun 20 10:06:54 duckie go-librespot[1269]: time="2025-06-20T10:06:54+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 170" Jun 20 10:06:54 duckie go-librespot[1269]: time="2025-06-20T10:06:54+02:00" level=debug msg="skipping dealer message" uri=playback-settings/content-settings-update Jun 20 10:06:54 duckie sudo[1432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-20 10:05 Jun 20 10:06:54 duckie sudo[1432]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"