Feb 26 20:19:30 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioPause Feb 26 20:19:30 volumio-bookworm volumio[710318]: info: CoreStateMachine::pause Feb 26 20:19:30 volumio-bookworm volumio[710318]: info: CoreStateMachine::stPlaybackTimer Feb 26 20:19:30 volumio-bookworm volumio[710318]: info: CoreStateMachine::servicePause Feb 26 20:19:30 volumio-bookworm volumio[710318]: info: CoreCommandRouter::servicePause Feb 26 20:19:30 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Send IPC command: {"command":["set_property","pause",true],"request_id":15} Feb 26 20:19:30 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Got response for command #15: {"request_id":15,"error":"success"} Feb 26 20:19:30 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Status update -> property-change events: [{"subscriptionId":1,"prop":"pause","data":true}] Feb 26 20:19:30 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioGetState Feb 26 20:19:30 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Push Volumio state: {"status":"pause","uri":"https://audio-geo.radioparadise.com/chan/0/x/1188/1/b/1188-0.m4a","title":"Spirit","artist":"Future Islands","album":"Singles","albumart":"https://img.radioparadise.com/covers/l/8801.jpg","trackType":"aac","duration":0,"samplerate":"44.1 kHz","channels":2,"service":"rp2","seek":0,"isStreaming":true,"repeat":null,"repeatSingle":false,"random":null,"volume":47,"mute":false,"disableVolumeControl":false} Feb 26 20:19:30 volumio-bookworm volumio[710318]: info: CoreCommandRouter::servicePushState Feb 26 20:19:30 volumio-bookworm volumio[710318]: info: CoreStateMachine::pushState Feb 26 20:19:30 volumio-bookworm volumio[710318]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 20:19:30 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioPushState Feb 26 20:19:35 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioVolatilePlay Feb 26 20:19:35 volumio-bookworm volumio[710318]: info: CoreStateMachine::volatilePlay Feb 26 20:19:35 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Send IPC command: {"command":["set_property","pause",false],"request_id":16} Feb 26 20:19:35 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Got response for command #16: {"request_id":16,"error":"success"} Feb 26 20:19:35 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Status update -> property-change events: [{"subscriptionId":1,"prop":"pause","data":false}] Feb 26 20:19:35 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioGetState Feb 26 20:19:35 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Push Volumio state: {"status":"play","uri":"https://audio-geo.radioparadise.com/chan/0/x/1188/1/b/1188-0.m4a","title":"Spirit","artist":"Future Islands","album":"Singles","albumart":"https://img.radioparadise.com/covers/l/8801.jpg","trackType":"aac","duration":0,"samplerate":"44.1 kHz","channels":2,"service":"rp2","seek":0,"isStreaming":true,"repeat":null,"repeatSingle":false,"random":null,"volume":47,"mute":false,"disableVolumeControl":false} Feb 26 20:19:35 volumio-bookworm volumio[710318]: info: CoreCommandRouter::servicePushState Feb 26 20:19:35 volumio-bookworm volumio[710318]: info: CoreStateMachine::pushState Feb 26 20:19:35 volumio-bookworm volumio[710318]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 20:19:35 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioPushState Feb 26 20:19:35 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Audio device underrun detected. Feb 26 20:19:43 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioNext Feb 26 20:19:43 volumio-bookworm volumio[710318]: info: CoreStateMachine::next Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: Obtained updated block Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: ------------- Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: Block summary Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: ------------- Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: Stream URL: https://audio-geo.radioparadise.com/dj/1/10014809.m4a?2843576 Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: Bitrate: 64k aac Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: Tracks: Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: 0. Listener-supported (0:07) Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: Going to start playback of current track Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioGetState Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Send IPC command: {"command":["set_property","loop-file","no"],"request_id":17} Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Got response for command #17: {"request_id":17,"error":"success"} Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Push Volumio state: {"status":"pause","albumart":"https://img.radioparadise.com/covers/l/101.jpg","uri":"https://audio-geo.radioparadise.com/dj/1/10014809.m4a?2843576","seek":0,"duration":0,"service":"rp2","isStreaming":true,"repeat":null,"repeatSingle":false,"random":null,"volume":47,"mute":false,"disableVolumeControl":false,"title":"Listener-supported","artist":"Commercial-free"} Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: CoreCommandRouter::servicePushState Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: CoreStateMachine::pushState Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioPushState Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Send IPC command: {"command":["loadfile","https://audio-geo.radioparadise.com/dj/1/10014809.m4a?2843576","replace","start=0"],"request_id":18} Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Got response for command #18: {"data":{"playlist_entry_id":2},"request_id":18,"error":"success"} Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Status update -> property-change events: [{"subscriptionId":6,"prop":"audio-params"},{"subscriptionId":7,"prop":"audio-codec-name"}] Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioGetState Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Send IPC command: {"command":["set_property","pause",false],"request_id":19} Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Push Volumio state: {"status":"play","uri":"https://audio-geo.radioparadise.com/dj/1/10014809.m4a?2843576","title":"Listener-supported","artist":"Commercial-free","albumart":"https://img.radioparadise.com/covers/l/101.jpg","duration":0,"service":"rp2","seek":0,"isStreaming":true,"repeat":null,"repeatSingle":false,"random":null,"volume":47,"mute":false,"disableVolumeControl":false} Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: CoreCommandRouter::servicePushState Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: CoreStateMachine::pushState Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioPushState Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: Started playback of "Listener-supported" - estimated finish time: 2/26/2026, 8:19:51 PM Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: Reached end of stream in current block. Going to obtain next block. Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Got response for command #19: {"request_id":19,"error":"success"} Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Status update -> property-change events: [{"subscriptionId":2,"prop":"duration"},{"subscriptionId":8,"prop":"media-title","data":"10014809.m4a?2843576"},{"subscriptionId":9,"prop":"metadata"}] Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioGetState Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Push Volumio state: {"status":"play","uri":"https://audio-geo.radioparadise.com/dj/1/10014809.m4a?2843576","title":"Listener-supported","artist":"Commercial-free","albumart":"https://img.radioparadise.com/covers/l/101.jpg","duration":0,"service":"rp2","seek":0,"isStreaming":true,"repeat":null,"repeatSingle":false,"random":null,"volume":47,"mute":false,"disableVolumeControl":false} Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: CoreCommandRouter::servicePushState Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: CoreStateMachine::pushState Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioPushState Feb 26 20:19:44 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Feb 26 20:19:45 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) (+) Audio --aid=1 (*) (aac 2ch 44100Hz) Feb 26 20:19:45 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Status update -> property-change events: [{"subscriptionId":2,"prop":"duration","data":7.523265},{"subscriptionId":7,"prop":"audio-codec-name","data":"aac"},{"subscriptionId":9,"prop":"metadata","data":{"major_brand":"M4A ","minor_version":"0","compatible_brands":"M4A mp42isom","creation_time":"2026-02-26T07:35:30.000000Z","encoder":"fdkaac 1.0.0, libfdk-aac 4.0.1, CBR 64kbps","iTunSMPB":" 00000000 00000800 000004A7 0000000000027B59 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000","language":"und","vendor_id":"[0][0][0][0]"}}] Feb 26 20:19:45 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioGetState Feb 26 20:19:45 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Push Volumio state: {"status":"play","uri":"https://audio-geo.radioparadise.com/dj/1/10014809.m4a?2843576","title":"Listener-supported","artist":"Commercial-free","albumart":"https://img.radioparadise.com/covers/l/101.jpg","trackType":"aac","duration":0,"service":"rp2","seek":0,"isStreaming":true,"repeat":null,"repeatSingle":false,"random":null,"volume":47,"mute":false,"disableVolumeControl":false} Feb 26 20:19:45 volumio-bookworm volumio[710318]: info: CoreCommandRouter::servicePushState Feb 26 20:19:45 volumio-bookworm volumio[710318]: info: CoreStateMachine::pushState Feb 26 20:19:45 volumio-bookworm volumio[710318]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 20:19:45 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioPushState Feb 26 20:19:45 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioGetState Feb 26 20:19:45 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Push Volumio state: {"status":"play","uri":"https://audio-geo.radioparadise.com/dj/1/10014809.m4a?2843576","title":"Listener-supported","artist":"Commercial-free","albumart":"https://img.radioparadise.com/covers/l/101.jpg","trackType":"aac","duration":0,"service":"rp2","seek":0,"isStreaming":true,"repeat":null,"repeatSingle":false,"random":null,"volume":47,"mute":false,"disableVolumeControl":false} Feb 26 20:19:45 volumio-bookworm volumio[710318]: info: CoreCommandRouter::servicePushState Feb 26 20:19:45 volumio-bookworm volumio[710318]: info: CoreStateMachine::pushState Feb 26 20:19:45 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioPushState Feb 26 20:19:52 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Status update -> property-change events: [{"subscriptionId":7,"prop":"audio-codec-name"}] Feb 26 20:19:52 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioGetState Feb 26 20:19:52 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Push Volumio state: {"status":"play","uri":"https://audio-geo.radioparadise.com/dj/1/10014809.m4a?2843576","title":"Listener-supported","artist":"Commercial-free","albumart":"https://img.radioparadise.com/covers/l/101.jpg","duration":0,"service":"rp2","seek":0,"isStreaming":true,"repeat":null,"repeatSingle":false,"random":null,"volume":47,"mute":false,"disableVolumeControl":false} Feb 26 20:19:52 volumio-bookworm volumio[710318]: info: CoreCommandRouter::servicePushState Feb 26 20:19:52 volumio-bookworm volumio[710318]: info: CoreStateMachine::pushState Feb 26 20:19:52 volumio-bookworm volumio[710318]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 20:19:52 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioPushState Feb 26 20:19:52 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Feb 26 20:19:53 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Status update -> property-change events: [{"subscriptionId":2,"prop":"duration"}] Feb 26 20:19:53 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioGetState Feb 26 20:19:53 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Push Volumio state: {"status":"play","uri":"https://audio-geo.radioparadise.com/dj/1/10014809.m4a?2843576","title":"Listener-supported","artist":"Commercial-free","albumart":"https://img.radioparadise.com/covers/l/101.jpg","duration":0,"service":"rp2","seek":0,"isStreaming":true,"repeat":null,"repeatSingle":false,"random":null,"volume":47,"mute":false,"disableVolumeControl":false} Feb 26 20:19:53 volumio-bookworm volumio[710318]: info: CoreCommandRouter::servicePushState Feb 26 20:19:53 volumio-bookworm volumio[710318]: info: CoreStateMachine::pushState Feb 26 20:19:53 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioPushState Feb 26 20:19:53 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Status update -> property-change events: [{"subscriptionId":3,"prop":"idle-active","data":true},{"subscriptionId":8,"prop":"media-title"},{"subscriptionId":9,"prop":"metadata"}] Feb 26 20:19:53 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Player status "stopped" - unsetting ourselves as current service... Feb 26 20:19:53 volumio-bookworm volumio[710318]: verbose: UNSET VOLATILE: Service: rp2 Feb 26 20:19:53 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Volatile state unset, stopping playback (if any)... Feb 26 20:19:53 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Push Volumio state: {"status":"stop","albumart":"https://img.radioparadise.com/covers/l/101.jpg","uri":"","seek":0,"duration":0,"service":"rp2","isStreaming":true,"repeat":null,"repeatSingle":false,"random":null,"volume":47,"mute":false,"disableVolumeControl":false,"title":"Listener-supported","artist":"Commercial-free"} Feb 26 20:19:53 volumio-bookworm volumio[710318]: info: CoreCommandRouter::servicePushState Feb 26 20:19:53 volumio-bookworm volumio[710318]: info: CoreStateMachine::pushState Feb 26 20:19:53 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioPushState Feb 26 20:19:53 volumio-bookworm volumio[710318]: info: CorePlayQueue::getTrack 0 Feb 26 20:19:53 volumio-bookworm volumio[710318]: verbose: STATE SERVICE {"status":"stop","albumart":"https://img.radioparadise.com/covers/l/101.jpg","uri":"","seek":0,"duration":0,"service":"rp2","isStreaming":true,"repeat":null,"repeatSingle":false,"random":null,"volume":47,"mute":false,"disableVolumeControl":false,"title":"Listener-supported","artist":"Commercial-free"} Feb 26 20:19:53 volumio-bookworm volumio[710318]: verbose: CURRENT POSITION 0 Feb 26 20:19:53 volumio-bookworm volumio[710318]: info: CoreStateMachine::syncState stateService stop Feb 26 20:19:53 volumio-bookworm volumio[710318]: info: CoreStateMachine::syncState currentStatus play Feb 26 20:19:53 volumio-bookworm volumio[710318]: info: CoreStateMachine::play index undefined Feb 26 20:19:53 volumio-bookworm volumio[710318]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 26 20:19:53 volumio-bookworm volumio[710318]: info: CoreStateMachine::pushState Feb 26 20:19:53 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioPushState Feb 26 20:19:53 volumio-bookworm volumio[710318]: info: CorePlayQueue::getTrack 1 Feb 26 20:19:53 volumio-bookworm volumio[710318]: info: CoreStateMachine::startPlaybackTimer Feb 26 20:19:53 volumio-bookworm volumio[710318]: info: CorePlayQueue::getTrack 1 Feb 26 20:19:53 volumio-bookworm volumio[710318]: info: [rp2] clearAddPlayTrack: rp2/channel@id=1 Feb 26 20:19:53 volumio-bookworm volumio[710318]: info: CoreStateMachine::pushState Feb 26 20:19:53 volumio-bookworm volumio[710318]: info: CorePlayQueue::getTrack 1 Feb 26 20:19:53 volumio-bookworm volumio[710318]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 20:19:53 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioPushState Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: Obtained block for channel "1" Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: ------------- Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: Block summary Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: ------------- Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: Stream URL: https://audio-geo.radioparadise.com/chan/1/x/1309/1/b/1309-0.m4a Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: Bitrate: 64k aac Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: Tracks: Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: 0. Every Breath You Take (4:02) Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: Going to start playback of current track at 2:43 (track position in stream: 24:18) Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioGetState Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: CorePlayQueue::getTrack 1 Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Stopping playback by current service... Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioStop Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: CoreStateMachine::stop Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Setting ourselves as the current service... Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Send IPC command: {"command":["set_property","loop-file","no"],"request_id":20} Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Got response for command #20: {"request_id":20,"error":"success"} Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Push Volumio state: {"status":"pause","albumart":"https://img.radioparadise.com/covers/l/17094.jpg","uri":"https://audio-geo.radioparadise.com/chan/1/x/1309/1/b/1309-0.m4a","seek":0,"duration":0,"service":"rp2","isStreaming":true,"repeat":null,"repeatSingle":false,"random":null,"volume":47,"mute":false,"disableVolumeControl":false,"title":"Every Breath You Take","artist":"The Police","album":"Synchronicity"} Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: CoreCommandRouter::servicePushState Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: CoreStateMachine::pushState Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioPushState Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Send IPC command: {"command":["loadfile","https://audio-geo.radioparadise.com/chan/1/x/1309/1/b/1309-0.m4a","replace","start=1621.388"],"request_id":21} Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Got response for command #21: {"data":{"playlist_entry_id":3},"request_id":21,"error":"success"} Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Status update -> property-change events: [{"subscriptionId":3,"prop":"idle-active","data":false},{"subscriptionId":8,"prop":"media-title","data":"1309-0.m4a"}] Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioGetState Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Send IPC command: {"command":["set_property","pause",false],"request_id":22} Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Push Volumio state: {"status":"play","uri":"https://audio-geo.radioparadise.com/chan/1/x/1309/1/b/1309-0.m4a","title":"Every Breath You Take","artist":"The Police","album":"Synchronicity","albumart":"https://img.radioparadise.com/covers/l/17094.jpg","duration":0,"service":"rp2","seek":0,"isStreaming":true,"repeat":null,"repeatSingle":false,"random":null,"volume":47,"mute":false,"disableVolumeControl":false} Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: CoreCommandRouter::servicePushState Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: CoreStateMachine::pushState Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioPushState Feb 26 20:19:54 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Got response for command #22: {"request_id":22,"error":"success"} Feb 26 20:19:58 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) (+) Audio --aid=1 (*) (aac 2ch 44100Hz) Feb 26 20:19:58 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Status update -> property-change events: [{"subscriptionId":2,"prop":"duration","data":1700.304399},{"subscriptionId":7,"prop":"audio-codec-name","data":"aac"},{"subscriptionId":9,"prop":"metadata","data":{"major_brand":"M4A ","minor_version":"0","compatible_brands":"M4A mp42isom","creation_time":"2026-02-13T17:29:54.000000Z","encoder":"fdkaac 1.0.0, libfdk-aac 4.0.1, CBR 64kbps","iTunSMPB":" 00000000 00000800 000007E2 00000000023C041E 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000","language":"und","vendor_id":"[0][0][0][0]"}}] Feb 26 20:19:58 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioGetState Feb 26 20:19:58 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Push Volumio state: {"status":"play","uri":"https://audio-geo.radioparadise.com/chan/1/x/1309/1/b/1309-0.m4a","title":"Every Breath You Take","artist":"The Police","album":"Synchronicity","albumart":"https://img.radioparadise.com/covers/l/17094.jpg","trackType":"aac","duration":0,"service":"rp2","seek":0,"isStreaming":true,"repeat":null,"repeatSingle":false,"random":null,"volume":47,"mute":false,"disableVolumeControl":false} Feb 26 20:19:58 volumio-bookworm volumio[710318]: info: CoreCommandRouter::servicePushState Feb 26 20:19:58 volumio-bookworm volumio[710318]: info: CoreStateMachine::pushState Feb 26 20:19:58 volumio-bookworm volumio[710318]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 20:19:58 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioPushState Feb 26 20:19:58 volumio-bookworm volumio[710318]: info: Started playback of "Every Breath You Take" - estimated finish time: 2/26/2026, 8:21:17 PM Feb 26 20:19:59 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) AO: [alsa] 44100Hz stereo 2ch float Feb 26 20:19:59 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Status update -> property-change events: [{"subscriptionId":6,"prop":"audio-params","data":{"samplerate":44100,"channel-count":2,"channels":"stereo","hr-channels":"stereo","format":"floatp"}}] Feb 26 20:19:59 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioGetState Feb 26 20:19:59 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Push Volumio state: {"status":"play","uri":"https://audio-geo.radioparadise.com/chan/1/x/1309/1/b/1309-0.m4a","title":"Every Breath You Take","artist":"The Police","album":"Synchronicity","albumart":"https://img.radioparadise.com/covers/l/17094.jpg","trackType":"aac","duration":0,"samplerate":"44.1 kHz","channels":2,"service":"rp2","seek":0,"isStreaming":true,"repeat":null,"repeatSingle":false,"random":null,"volume":47,"mute":false,"disableVolumeControl":false} Feb 26 20:19:59 volumio-bookworm volumio[710318]: info: CoreCommandRouter::servicePushState Feb 26 20:19:59 volumio-bookworm volumio[710318]: info: CoreStateMachine::pushState Feb 26 20:19:59 volumio-bookworm volumio[710318]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 20:19:59 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioPushState Feb 26 20:19:59 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioGetState Feb 26 20:19:59 volumio-bookworm volumio[710318]: info: [rp2] [mpv] (PID: 710642) Push Volumio state: {"status":"play","uri":"https://audio-geo.radioparadise.com/chan/1/x/1309/1/b/1309-0.m4a","title":"Every Breath You Take","artist":"The Police","album":"Synchronicity","albumart":"https://img.radioparadise.com/covers/l/17094.jpg","trackType":"aac","duration":0,"samplerate":"44.1 kHz","channels":2,"service":"rp2","seek":0,"isStreaming":true,"repeat":null,"repeatSingle":false,"random":null,"volume":47,"mute":false,"disableVolumeControl":false} Feb 26 20:19:59 volumio-bookworm volumio[710318]: info: CoreCommandRouter::servicePushState Feb 26 20:19:59 volumio-bookworm volumio[710318]: info: CoreStateMachine::pushState Feb 26 20:19:59 volumio-bookworm volumio[710318]: info: CoreCommandRouter::volumioPushState Feb 26 20:20:14 volumio-bookworm volumio[710318]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 26 20:20:14 volumio-bookworm volumio[710318]: Error: Timed out waiting for player event "stopped" Feb 26 20:20:14 volumio-bookworm volumio[710318]: at Timeout._onTimeout (/data/plugins/music_service/rp2/node_modules/rp.js/dist/core/PlayerWrapper.js:315:24) Feb 26 20:20:14 volumio-bookworm volumio[710318]: at listOnTimeout (node:internal/timers:573:17) Feb 26 20:20:14 volumio-bookworm volumio[710318]: at process.processTimers (node:internal/timers:514:7) Feb 26 20:20:14 volumio-bookworm volumio[710318]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 26 20:20:14 volumio-bookworm sudo[711069]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-26 20:19' Feb 26 20:20:14 volumio-bookworm sudo[711069]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Jan 29 19:39:59 UTC 2026" VOLUMIO_VERSION="4.095" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="74c63cee45d5bfd28ff086a4d5cd8925"