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"