Feb 27 13:50:00 volumio-pi4 volumio[9572]: info: CoreCommandRouter::volumioGetState Feb 27 13:50:02 volumio-pi4 volumio[9572]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 27 13:50:02 volumio-pi4 volumio[9572]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 27 13:50:07 volumio-pi4 volumio[9572]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 27 13:50:11 volumio-pi4 volumio[9572]: info: CALLMETHOD: music_service rp2 configSaveGeneralSettings [object Object] Feb 27 13:50:11 volumio-pi4 volumio[9572]: info: CoreCommandRouter::executeOnPlugin: rp2 , configSaveGeneralSettings Feb 27 13:50:11 volumio-pi4 volumio[9572]: info: Audio quality set to "4" Feb 27 13:50:11 volumio-pi4 volumio[9572]: info: Restarting playback to apply new quality setting... Feb 27 13:50:11 volumio-pi4 volumio[9572]: info: CoreCommandRouter::volumioGetState Feb 27 13:50:11 volumio-pi4 volumio[9572]: info: [rp2] [mpv] (PID: 10028) Push Volumio state: {"status":"play","uri":"https://audio-geo.radioparadise.com/chan/1/x/1344/3/b/1344-0.m4a","title":"Diamonds On The Soles Of Her Shoes","artist":"Paul Simon","album":"Graceland","albumart":"https://img.radioparadise.com/covers/l/12081.jpg","trackType":"aac","duration":338.1,"samplerate":"320 kbps","service":"rp2","seek":270517.27,"isStreaming":false,"repeat":false,"repeatSingle":false,"random":false,"volume":100,"mute":false,"disableVolumeControl":false} Feb 27 13:50:11 volumio-pi4 volumio[9572]: info: CoreCommandRouter::servicePushState Feb 27 13:50:11 volumio-pi4 volumio[9572]: info: CoreStateMachine::pushState Feb 27 13:50:11 volumio-pi4 volumio[9572]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 27 13:50:11 volumio-pi4 volumio[9572]: info: CoreCommandRouter::volumioPushState Feb 27 13:50:12 volumio-pi4 volumio[9572]: verbose: API: https://api.radioparadise.com/api/play?source=24&event=0&elapsed=0&bitrate=4&action=start&player_id=********&info=true&chan=1&audio_type= Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: Obtained block for channel "1" Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: ------------- Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: Block summary Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: ------------- Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: Stream URL: https://audio-geo.radioparadise.com/chan/1/x/1344/4/b/1344-0.flac Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: Tracks: Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: 0. Diamonds On The Soles Of Her Shoes (5:38) Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: 1. Close to my Fire (3:53) Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: 2. One Big Love (4:25) Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: CoreCommandRouter::volumioGetState Feb 27 13:50:13 volumio-pi4 volumio[9572]: verbose: Current track scheduled playback vs. current time: 2/27/2026, 12:45:09 PM <-> 2/27/2026, 1:50:13 PM Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: Going to start playback of current track at 65:04 (track position in stream: 11:03) Feb 27 13:50:13 volumio-pi4 volumio[9572]: verbose: Waiting for player event "playing"... Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: [rp2] [mpv] (PID: 10028) Push Volumio state: {"status":"play","uri":"https://audio-geo.radioparadise.com/chan/1/x/1344/3/b/1344-0.m4a","title":"Diamonds On The Soles Of Her Shoes","artist":"Paul Simon","album":"Graceland","albumart":"https://img.radioparadise.com/covers/l/12081.jpg","trackType":"flac","duration":338.1,"service":"rp2","seek":272158.789,"isStreaming":false,"repeat":false,"repeatSingle":false,"random":false,"volume":100,"mute":false,"disableVolumeControl":false} Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: CoreCommandRouter::servicePushState Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: CoreStateMachine::pushState Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: CoreCommandRouter::volumioPushState Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: CoreCommandRouter::volumioGetState Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: [rp2] [mpv] (PID: 10028) Send IPC command: {"command":["set_property","loop-file","no"],"request_id":22} Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: [rp2] [mpv] (PID: 10028) Got response for command #22: {"request_id":22,"error":"success"} Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: [rp2] [mpv] (PID: 10028) Push Volumio state: {"status":"pause","albumart":"https://img.radioparadise.com/covers/l/12081.jpg","uri":"https://audio-geo.radioparadise.com/chan/1/x/1344/4/b/1344-0.flac","seek":272210.0140000001,"duration":338.1,"service":"rp2","isStreaming":false,"repeat":false,"repeatSingle":false,"random":false,"volume":100,"mute":false,"disableVolumeControl":false,"title":"Diamonds On The Soles Of Her Shoes","artist":"Paul Simon","album":"Graceland","trackType":"flac"} Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: CoreCommandRouter::servicePushState Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: CoreStateMachine::pushState Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: CoreCommandRouter::volumioPushState Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: [rp2] [mpv] (PID: 10028) Send IPC command: {"command":["loadfile","https://audio-geo.radioparadise.com/chan/1/x/1344/4/b/1344-0.flac","replace","start=4567.336"],"request_id":23} Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: [rp2] [mpv] (PID: 10028) Got response for command #23: {"data":{"playlist_entry_id":3},"request_id":23,"error":"success"} Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: [rp2] [mpv] (PID: 10028) Status update -> property-change events: [{"subscriptionId":7,"prop":"audio-codec-name"}] Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: CoreCommandRouter::volumioGetState Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: [rp2] [mpv] (PID: 10028) Send IPC command: {"command":["set_property","pause",false],"request_id":24} Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: [rp2] [mpv] (PID: 10028) Push Volumio state: {"status":"play","uri":"https://audio-geo.radioparadise.com/chan/1/x/1344/4/b/1344-0.flac","title":"Diamonds On The Soles Of Her Shoes","artist":"Paul Simon","album":"Graceland","albumart":"https://img.radioparadise.com/covers/l/12081.jpg","trackType":"flac","duration":338.1,"service":"rp2","seek":272210.0140000001,"isStreaming":false,"repeat":false,"repeatSingle":false,"random":false,"volume":100,"mute":false,"disableVolumeControl":false} Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: CoreCommandRouter::servicePushState Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: CoreStateMachine::pushState Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: CoreCommandRouter::volumioPushState Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: [rp2] [mpv] (PID: 10028) Got response for command #24: {"request_id":24,"error":"success"} Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: touch_display: Setting screensaver timeout to 0 seconds. Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: [rp2] [mpv] (PID: 10028) Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: [rp2] [mpv] (PID: 10028) Status update -> property-change events: [{"subscriptionId":2,"prop":"duration"},{"subscriptionId":8,"prop":"media-title","data":"1344-0.flac"},{"subscriptionId":9,"prop":"metadata"}] Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: CoreCommandRouter::volumioGetState Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: [rp2] [mpv] (PID: 10028) Push Volumio state: {"status":"play","uri":"https://audio-geo.radioparadise.com/chan/1/x/1344/4/b/1344-0.flac","title":"Diamonds On The Soles Of Her Shoes","artist":"Paul Simon","album":"Graceland","albumart":"https://img.radioparadise.com/covers/l/12081.jpg","trackType":"flac","duration":338.1,"service":"rp2","seek":0,"isStreaming":false,"repeat":false,"repeatSingle":false,"random":false,"volume":100,"mute":false,"disableVolumeControl":false} Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: CoreCommandRouter::servicePushState Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: CoreStateMachine::pushState Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: CoreCommandRouter::volumioPushState Feb 27 13:50:13 volumio-pi4 volumio[9572]: info: touch_display: Setting screensaver timeout to 0 seconds. Feb 27 13:50:15 volumio-pi4 volumio[9572]: info: [rp2] [mpv] (PID: 10028) (+) Audio --aid=1 (flac 2ch 44100Hz) Feb 27 13:50:15 volumio-pi4 volumio[9572]: info: [rp2] [mpv] (PID: 10028) Status update -> property-change events: [{"subscriptionId":2,"prop":"duration","data":1500.661995},{"subscriptionId":7,"prop":"audio-codec-name","data":"flac"}] Feb 27 13:50:15 volumio-pi4 volumio[9572]: info: CoreCommandRouter::volumioGetState Feb 27 13:50:15 volumio-pi4 volumio[9572]: info: [rp2] [mpv] (PID: 10028) Push Volumio state: {"status":"play","uri":"https://audio-geo.radioparadise.com/chan/1/x/1344/4/b/1344-0.flac","title":"Diamonds On The Soles Of Her Shoes","artist":"Paul Simon","album":"Graceland","albumart":"https://img.radioparadise.com/covers/l/12081.jpg","trackType":"flac","duration":338.1,"service":"rp2","seek":0,"isStreaming":false,"repeat":false,"repeatSingle":false,"random":false,"volume":100,"mute":false,"disableVolumeControl":false} Feb 27 13:50:15 volumio-pi4 volumio[9572]: info: CoreCommandRouter::servicePushState Feb 27 13:50:15 volumio-pi4 volumio[9572]: info: CoreStateMachine::pushState Feb 27 13:50:15 volumio-pi4 volumio[9572]: info: CoreCommandRouter::volumioPushState Feb 27 13:50:15 volumio-pi4 volumio[9572]: info: [rp2] [mpv] (PID: 10028) Status update -> property-change events: [{"subscriptionId":9,"prop":"metadata","data":{}}] Feb 27 13:50:15 volumio-pi4 volumio[9572]: info: CoreCommandRouter::volumioGetState Feb 27 13:50:15 volumio-pi4 volumio[9572]: info: [rp2] [mpv] (PID: 10028) Push Volumio state: {"status":"play","uri":"https://audio-geo.radioparadise.com/chan/1/x/1344/4/b/1344-0.flac","title":"Diamonds On The Soles Of Her Shoes","artist":"Paul Simon","album":"Graceland","albumart":"https://img.radioparadise.com/covers/l/12081.jpg","trackType":"flac","duration":338.1,"service":"rp2","seek":3904222,"isStreaming":false,"repeat":false,"repeatSingle":false,"random":false,"volume":100,"mute":false,"disableVolumeControl":false} Feb 27 13:50:15 volumio-pi4 volumio[9572]: info: CoreCommandRouter::servicePushState Feb 27 13:50:15 volumio-pi4 volumio[9572]: info: CoreStateMachine::pushState Feb 27 13:50:15 volumio-pi4 volumio[9572]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 27 13:50:15 volumio-pi4 volumio[9572]: info: CoreCommandRouter::volumioPushState Feb 27 13:50:15 volumio-pi4 volumio[9572]: info: Started playback of "Diamonds On The Soles Of Her Shoes" - estimated finish time: 2/27/2026, 12:50:49 PM Feb 27 13:50:15 volumio-pi4 volumio[9572]: info: CoreCommandRouter::volumioGetState Feb 27 13:50:15 volumio-pi4 volumio[9572]: verbose: After "Diamonds On The Soles Of Her Shoes", the next track will start in (2/27/2026, 12:50:49 PM) Feb 27 13:50:15 volumio-pi4 volumio[9572]: verbose: API: https://api.radioparadise.com/api/update_history?source=24&song_id=2166&chan=1&player_id=********&event=2853433&type=M&slice_num=3&episode_id=0&time_relative=-3905&play_position_millis=3904222&playtime_secs=1772171416 Feb 27 13:50:15 volumio-pi4 volumio[9572]: info: [rp2] [mpv] (PID: 10028) Push Volumio state: {"status":"play","uri":"https://audio-geo.radioparadise.com/chan/1/x/1344/4/b/1344-0.flac","title":"Diamonds On The Soles Of Her Shoes","artist":"Paul Simon","album":"Graceland","albumart":"https://img.radioparadise.com/covers/l/12081.jpg","trackType":"flac","duration":338.1,"service":"rp2","seek":3904222,"isStreaming":false,"repeat":false,"repeatSingle":false,"random":false,"volume":100,"mute":false,"disableVolumeControl":false} Feb 27 13:50:15 volumio-pi4 volumio[9572]: info: CoreCommandRouter::servicePushState Feb 27 13:50:15 volumio-pi4 volumio[9572]: info: CoreStateMachine::pushState Feb 27 13:50:15 volumio-pi4 volumio[9572]: info: CoreCommandRouter::volumioPushState Feb 27 13:50:15 volumio-pi4 volumio[9572]: verbose: Proceeding to next track Feb 27 13:50:15 volumio-pi4 volumio[9572]: verbose: Incremented current track index: "0" -> "1" Feb 27 13:50:15 volumio-pi4 volumio[9572]: info: Proceeded to next track: Close to my Fire (3:53) Feb 27 13:50:15 volumio-pi4 volumio[9572]: info: CoreCommandRouter::volumioGetState Feb 27 13:50:15 volumio-pi4 volumio[9572]: verbose: After "Close to my Fire", the next track will start in 3m 53s (2/27/2026, 1:54:09 PM) Feb 27 13:50:15 volumio-pi4 volumio[9572]: verbose: API: https://api.radioparadise.com/api/update_history?source=24&song_id=45705&chan=1&player_id=********&event=2853434&type=M&slice_num=4&episode_id=0&time_relative=-0&play_position_millis=0&playtime_secs=1772171416 Feb 27 13:50:15 volumio-pi4 volumio[9572]: info: [rp2] [mpv] (PID: 10028) Push Volumio state: {"status":"play","uri":"https://audio-geo.radioparadise.com/chan/1/x/1344/4/b/1344-0.flac","title":"Close to my Fire","artist":"Slackwax","album":"Hôtel Costes, Volume 15","albumart":"https://img.radioparadise.com/covers/l/18820.jpg","trackType":"flac","duration":233.919,"service":"rp2","seek":3566122,"isStreaming":false,"repeat":false,"repeatSingle":false,"random":false,"volume":100,"mute":false,"disableVolumeControl":false} Feb 27 13:50:15 volumio-pi4 volumio[9572]: info: CoreCommandRouter::servicePushState Feb 27 13:50:15 volumio-pi4 volumio[9572]: info: CoreStateMachine::pushState Feb 27 13:50:15 volumio-pi4 volumio[9572]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 27 13:50:15 volumio-pi4 volumio[9572]: info: CoreCommandRouter::volumioPushState Feb 27 13:50:15 volumio-pi4 volumio[9572]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 27 13:50:15 volumio-pi4 volumio[9572]: TypeError: fetch failed Feb 27 13:50:15 volumio-pi4 volumio[9572]: at Object.processResponse (/data/plugins/music_service/rp2/node_modules/undici/lib/web/fetch/index.js:237:16) Feb 27 13:50:15 volumio-pi4 volumio[9572]: at /data/plugins/music_service/rp2/node_modules/undici/lib/web/fetch/index.js:1075:19 Feb 27 13:50:15 volumio-pi4 volumio[9572]: at node:internal/process/task_queues:140:7 Feb 27 13:50:15 volumio-pi4 volumio[9572]: at AsyncResource.runInAsyncScope (node:async_hooks:206:9) Feb 27 13:50:15 volumio-pi4 volumio[9572]: at AsyncResource.runMicrotask (node:internal/process/task_queues:137:8) Feb 27 13:50:15 volumio-pi4 volumio[9572]: at /data/plugins/music_service/rp2/node_modules/undici/index.js:155:7 Feb 27 13:50:15 volumio-pi4 volumio[9572]: at async Session.fetch (/data/plugins/music_service/rp2/node_modules/rp.js/dist/core/Session.js:60:16) Feb 27 13:50:15 volumio-pi4 volumio[9572]: at async API.updateHistory (/data/plugins/music_service/rp2/node_modules/rp.js/dist/core/API.js:103:16) Feb 27 13:50:15 volumio-pi4 volumio[9572]: at async #handleTrackBegin (/data/plugins/music_service/rp2/node_modules/rp.js/dist/core/PlayerWrapper.js:304:9) Feb 27 13:50:15 volumio-pi4 volumio[9572]: at async #playBlock (/data/plugins/music_service/rp2/node_modules/rp.js/dist/core/PlayerWrapper.js:255:13) Feb 27 13:50:15 volumio-pi4 volumio[9572]: at async PlayerWrapper.play (/data/plugins/music_service/rp2/node_modules/rp.js/dist/core/PlayerWrapper.js:146:13) Feb 27 13:50:15 volumio-pi4 volumio[9572]: at async PlayerWrapper.setQuality (/data/plugins/music_service/rp2/node_modules/rp.js/dist/core/PlayerWrapper.js:79:17) Feb 27 13:50:15 volumio-pi4 volumio[9572]: at async RadioParadise.setQuality (/data/plugins/music_service/rp2/node_modules/rp.js/dist/core/RadioParadise.js:49:9) Feb 27 13:50:15 volumio-pi4 volumio[9572]: at async ControllerRP2.configSaveGeneralSettings (/data/plugins/music_service/rp2/dist/index.js:52:13) { Feb 27 13:50:15 volumio-pi4 volumio[9572]: [cause]: SocketError: other side closed Feb 27 13:50:15 volumio-pi4 volumio[9572]: at TLSSocket.onHttpSocketEnd (/data/plugins/music_service/rp2/node_modules/undici/lib/dispatcher/client-h1.js:896:22) Feb 27 13:50:15 volumio-pi4 volumio[9572]: at TLSSocket.emit (node:events:526:35) Feb 27 13:50:15 volumio-pi4 volumio[9572]: at endReadableNT (node:internal/streams/readable:1376:12) Feb 27 13:50:15 volumio-pi4 volumio[9572]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Feb 27 13:50:15 volumio-pi4 volumio[9572]: code: 'UND_ERR_SOCKET', Feb 27 13:50:15 volumio-pi4 volumio[9572]: socket: { Feb 27 13:50:15 volumio-pi4 volumio[9572]: localAddress: '192.168.11.15', Feb 27 13:50:15 volumio-pi4 volumio[9572]: localPort: 50940, Feb 27 13:50:15 volumio-pi4 volumio[9572]: remoteAddress: '34.210.61.151', Feb 27 13:50:15 volumio-pi4 volumio[9572]: remotePort: 443, Feb 27 13:50:15 volumio-pi4 volumio[9572]: remoteFamily: 'IPv4', Feb 27 13:50:15 volumio-pi4 volumio[9572]: timeout: undefined, Feb 27 13:50:15 volumio-pi4 volumio[9572]: bytesWritten: 855, Feb 27 13:50:15 volumio-pi4 volumio[9572]: bytesRead: 1572 Feb 27 13:50:15 volumio-pi4 volumio[9572]: } Feb 27 13:50:15 volumio-pi4 volumio[9572]: } Feb 27 13:50:15 volumio-pi4 volumio[9572]: } Feb 27 13:50:15 volumio-pi4 volumio[9572]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 27 13:50:16 volumio-pi4 sudo[17367]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-27 13:49' Feb 27 13:50:16 volumio-pi4 sudo[17367]: 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"