Apr 15 18:25:03 music volumio[1151]: info: VolumeController::SetAlsaVolume+ Apr 15 18:25:03 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:25:03 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:25:03 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 18:25:03 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:25:03 music volumio5-onboarding[1891]: time=2026-04-15T08:25:03.296Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_STOPPED positionMs=0 volume=62 Apr 15 18:25:03 music volumio5-onboarding[1891]: time=2026-04-15T08:25:03.296Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id= title= Apr 15 18:25:05 music volumio[1151]: info: VolumeController::SetAlsaVolume+ Apr 15 18:25:05 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:25:05 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:25:05 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 18:25:05 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:25:05 music volumio5-onboarding[1891]: time=2026-04-15T08:25:05.497Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_STOPPED positionMs=0 volume=63 Apr 15 18:25:05 music volumio5-onboarding[1891]: time=2026-04-15T08:25:05.498Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id= title= Apr 15 18:25:06 music volumio[1151]: info: VolumeController::SetAlsaVolume+ Apr 15 18:25:06 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:25:06 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:25:06 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 18:25:06 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:25:06 music volumio5-onboarding[1891]: time=2026-04-15T08:25:06.063Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_STOPPED positionMs=0 volume=64 Apr 15 18:25:06 music volumio5-onboarding[1891]: time=2026-04-15T08:25:06.063Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id= title= Apr 15 18:25:06 music volumio[1151]: info: VolumeController::SetAlsaVolume+ Apr 15 18:25:06 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:25:06 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:25:06 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 18:25:06 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:25:06 music volumio5-onboarding[1891]: time=2026-04-15T08:25:06.378Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_STOPPED positionMs=0 volume=65 Apr 15 18:25:06 music volumio5-onboarding[1891]: time=2026-04-15T08:25:06.378Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id= title= Apr 15 18:25:06 music volumio[1151]: info: VolumeController::SetAlsaVolume+ Apr 15 18:25:06 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:25:06 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:25:06 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 18:25:06 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:25:06 music volumio5-onboarding[1891]: time=2026-04-15T08:25:06.664Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_STOPPED positionMs=0 volume=66 Apr 15 18:25:06 music volumio5-onboarding[1891]: time=2026-04-15T08:25:06.664Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id= title= Apr 15 18:25:06 music volumio[1151]: info: VolumeController::SetAlsaVolume+ Apr 15 18:25:06 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:25:06 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:25:06 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 18:25:06 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:25:06 music volumio5-onboarding[1891]: time=2026-04-15T08:25:06.981Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_STOPPED positionMs=0 volume=67 Apr 15 18:25:06 music volumio5-onboarding[1891]: time=2026-04-15T08:25:06.981Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id= title= Apr 15 18:25:07 music volumio[1151]: info: VolumeController::SetAlsaVolume+ Apr 15 18:25:07 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:25:07 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:25:07 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 18:25:07 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:25:07 music volumio5-onboarding[1891]: time=2026-04-15T08:25:07.281Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_STOPPED positionMs=0 volume=68 Apr 15 18:25:07 music volumio5-onboarding[1891]: time=2026-04-15T08:25:07.281Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id= title= Apr 15 18:25:08 music volumio[1151]: info: VolumeController::SetAlsaVolume+ Apr 15 18:25:08 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:25:08 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:25:08 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 18:25:08 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:25:08 music volumio5-onboarding[1891]: time=2026-04-15T08:25:08.047Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_STOPPED positionMs=0 volume=69 Apr 15 18:25:08 music volumio5-onboarding[1891]: time=2026-04-15T08:25:08.047Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id= title= Apr 15 18:25:09 music volumio[1151]: info: VolumeController::SetAlsaVolume+ Apr 15 18:25:09 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:25:09 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:25:09 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 18:25:09 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:25:09 music volumio5-onboarding[1891]: time=2026-04-15T08:25:09.545Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_STOPPED positionMs=0 volume=70 Apr 15 18:25:09 music volumio5-onboarding[1891]: time=2026-04-15T08:25:09.545Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id= title= Apr 15 18:25:10 music volumio[1151]: info: VolumeController::SetAlsaVolume+ Apr 15 18:25:10 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:25:10 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:25:10 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 18:25:10 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:25:10 music volumio5-onboarding[1891]: time=2026-04-15T08:25:10.047Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_STOPPED positionMs=0 volume=71 Apr 15 18:25:10 music volumio5-onboarding[1891]: time=2026-04-15T08:25:10.047Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id= title= Apr 15 18:25:10 music volumio[1151]: info: VolumeController::SetAlsaVolume+ Apr 15 18:25:10 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:25:10 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:25:10 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 18:25:10 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:25:10 music volumio5-onboarding[1891]: time=2026-04-15T08:25:10.565Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_STOPPED positionMs=0 volume=72 Apr 15 18:25:10 music volumio5-onboarding[1891]: time=2026-04-15T08:25:10.565Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id= title= Apr 15 18:25:11 music volumio[1151]: info: VolumeController::SetAlsaVolume+ Apr 15 18:25:11 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:25:11 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:25:11 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 18:25:11 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:25:11 music volumio5-onboarding[1891]: time=2026-04-15T08:25:11.080Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_STOPPED positionMs=0 volume=73 Apr 15 18:25:11 music volumio5-onboarding[1891]: time=2026-04-15T08:25:11.080Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id= title= Apr 15 18:25:11 music volumio[1151]: info: VolumeController::SetAlsaVolume+ Apr 15 18:25:11 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:25:11 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:25:11 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 18:25:11 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:25:11 music volumio5-onboarding[1891]: time=2026-04-15T08:25:11.514Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_STOPPED positionMs=0 volume=74 Apr 15 18:25:11 music volumio5-onboarding[1891]: time=2026-04-15T08:25:11.514Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id= title= Apr 15 18:25:11 music volumio[1151]: info: VolumeController::SetAlsaVolume+ Apr 15 18:25:11 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:25:11 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:25:11 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 18:25:11 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:25:11 music volumio5-onboarding[1891]: time=2026-04-15T08:25:11.980Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_STOPPED positionMs=0 volume=75 Apr 15 18:25:11 music volumio5-onboarding[1891]: time=2026-04-15T08:25:11.981Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id= title= Apr 15 18:25:12 music volumio[1151]: info: VolumeController::SetAlsaVolume+ Apr 15 18:25:12 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:25:12 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:25:12 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 18:25:12 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:25:12 music volumio5-onboarding[1891]: time=2026-04-15T08:25:12.431Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_STOPPED positionMs=0 volume=76 Apr 15 18:25:12 music volumio5-onboarding[1891]: time=2026-04-15T08:25:12.431Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id= title= Apr 15 18:25:12 music volumio[1151]: info: VolumeController::SetAlsaVolume+ Apr 15 18:25:12 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:25:12 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:25:12 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 18:25:12 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:25:12 music volumio5-onboarding[1891]: time=2026-04-15T08:25:12.863Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_STOPPED positionMs=0 volume=77 Apr 15 18:25:12 music volumio5-onboarding[1891]: time=2026-04-15T08:25:12.863Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id= title= Apr 15 18:25:13 music volumio[1151]: info: VolumeController::SetAlsaVolume+ Apr 15 18:25:13 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:25:13 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:25:13 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 18:25:13 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:25:13 music volumio5-onboarding[1891]: time=2026-04-15T08:25:13.282Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_STOPPED positionMs=0 volume=78 Apr 15 18:25:13 music volumio5-onboarding[1891]: time=2026-04-15T08:25:13.282Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id= title= Apr 15 18:25:13 music volumio[1151]: info: VolumeController::SetAlsaVolume+ Apr 15 18:25:13 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:25:13 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:25:13 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 18:25:13 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:25:13 music volumio5-onboarding[1891]: time=2026-04-15T08:25:13.663Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_STOPPED positionMs=0 volume=79 Apr 15 18:25:13 music volumio5-onboarding[1891]: time=2026-04-15T08:25:13.664Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id= title= Apr 15 18:25:14 music volumio[1151]: info: VolumeController::SetAlsaVolume+ Apr 15 18:25:14 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:25:14 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:25:14 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 18:25:14 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:25:14 music volumio5-onboarding[1891]: time=2026-04-15T08:25:14.180Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_STOPPED positionMs=0 volume=80 Apr 15 18:25:14 music volumio5-onboarding[1891]: time=2026-04-15T08:25:14.180Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id= title= Apr 15 18:25:14 music volumio[1151]: info: VolumeController::SetAlsaVolume+ Apr 15 18:25:14 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:25:14 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:25:14 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 18:25:14 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:25:14 music volumio5-onboarding[1891]: time=2026-04-15T08:25:14.661Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_STOPPED positionMs=0 volume=81 Apr 15 18:25:14 music volumio5-onboarding[1891]: time=2026-04-15T08:25:14.661Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id= title= Apr 15 18:25:15 music volumio[1151]: info: VolumeController::SetAlsaVolume+ Apr 15 18:25:15 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:25:15 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:25:15 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 18:25:15 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:25:15 music volumio5-onboarding[1891]: time=2026-04-15T08:25:15.227Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_STOPPED positionMs=0 volume=82 Apr 15 18:25:15 music volumio5-onboarding[1891]: time=2026-04-15T08:25:15.227Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id= title= Apr 15 18:25:15 music volumio[1151]: info: VolumeController::SetAlsaVolume+ Apr 15 18:25:15 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:25:15 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:25:15 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 18:25:15 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:25:15 music volumio5-onboarding[1891]: time=2026-04-15T08:25:15.731Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_STOPPED positionMs=0 volume=83 Apr 15 18:25:15 music volumio5-onboarding[1891]: time=2026-04-15T08:25:15.731Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id= title= Apr 15 18:25:16 music volumio[1151]: info: VolumeController::SetAlsaVolume+ Apr 15 18:25:16 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:25:16 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:25:16 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 18:25:16 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:25:16 music volumio5-onboarding[1891]: time=2026-04-15T08:25:16.180Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_STOPPED positionMs=0 volume=84 Apr 15 18:25:16 music volumio5-onboarding[1891]: time=2026-04-15T08:25:16.180Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id= title= Apr 15 18:25:29 music volumio[1151]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 15 18:25:29 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 15 18:25:29 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 15 18:25:29 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 15 18:25:29 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 15 18:25:29 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 15 18:25:29 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 15 18:25:29 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 15 18:25:29 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 15 18:25:29 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 15 18:25:29 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 15 18:25:29 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 15 18:25:29 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 15 18:25:59 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: jellyfin , handleBrowseUri Apr 15 18:25:59 music volumio[1151]: info: [jellyfin-browse] browseUri: jellyfin Apr 15 18:26:00 music volumio[1151]: info: Preload queue cleared Apr 15 18:26:13 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Apr 15 18:26:13 music volumio[1151]: info: Preload queue cleared Apr 15 18:26:16 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Apr 15 18:26:17 music volumio[1151]: info: Preload queue cleared Apr 15 18:26:20 music volumio[1151]: info: Preload queue cleared Apr 15 18:26:20 music volumio[1151]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 15 18:26:20 music volumio[1151]: info: CoreStateMachine::ClearQueue Apr 15 18:26:20 music volumio[1151]: info: CoreStateMachine::stop Apr 15 18:26:20 music volumio[1151]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 15 18:26:20 music volumio[1151]: info: CorePlayQueue::clearPlayQueue Apr 15 18:26:20 music volumio[1151]: info: CorePlayQueue::saveQueue Apr 15 18:26:20 music volumio[1151]: info: CoreCommandRouter::volumioPushQueue Apr 15 18:26:20 music volumio[1151]: info: CoreStateMachine::addQueueItems Apr 15 18:26:20 music volumio[1151]: info: CorePlayQueue::addQueueItems Apr 15 18:26:20 music volumio[1151]: info: Preload queue cleared Apr 15 18:26:20 music volumio[1151]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320 Apr 15 18:26:20 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 15 18:26:20 music volumio[1151]: info: CoreCommandRouter::volumioPushQueue Apr 15 18:26:20 music volumio[1151]: info: CorePlayQueue::saveQueue Apr 15 18:26:20 music volumio[1151]: info: CoreStateMachine::updateTrackBlock Apr 15 18:26:20 music volumio[1151]: info: CorePlayQueue::getTrackBlock Apr 15 18:26:20 music volumio[1151]: info: CoreCommandRouter::volumioPlay Apr 15 18:26:20 music volumio[1151]: info: CoreStateMachine::play index 0 Apr 15 18:26:20 music volumio[1151]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 15 18:26:20 music volumio[1151]: info: CoreStateMachine::stop Apr 15 18:26:20 music volumio[1151]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 15 18:26:20 music volumio[1151]: info: CoreStateMachine::play index undefined Apr 15 18:26:20 music volumio[1151]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 15 18:26:20 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:26:20 music volumio[1151]: info: CoreStateMachine::startPlaybackTimer Apr 15 18:26:20 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:26:20 music volumio[1151]: info: [1776241580617] ControllerWebradio::clearAddPlayTrack Apr 15 18:26:20 music volumio[1151]: verbose: ControllerMpd::sendMpdCommand stop Apr 15 18:26:20 music volumio[1151]: info: sendMpdCommand stop took 1 milliseconds Apr 15 18:26:20 music volumio[1151]: verbose: ControllerMpd::sendMpdCommand clear Apr 15 18:26:20 music volumio[1151]: info: sendMpdCommand clear took 1 milliseconds Apr 15 18:26:20 music volumio[1151]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" Apr 15 18:26:20 music volumio[1151]: info: Apr 15 18:26:20 music volumio[1151]: ---------------------------- MPD announces system playlist update Apr 15 18:26:20 music volumio[1151]: info: Ignoring MPD Status Update Apr 15 18:26:20 music volumio[1151]: info: Apr 15 18:26:20 music volumio[1151]: ---------------------------- MPD announces system playlist update Apr 15 18:26:20 music volumio[1151]: info: Ignoring MPD Status Update Apr 15 18:26:21 music volumio[1151]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" took 499 milliseconds Apr 15 18:26:21 music volumio[1151]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 15 18:26:21 music volumio[1151]: verbose: ControllerMpd::sendMpdCommand play Apr 15 18:26:21 music volumio[1151]: info: Apr 15 18:26:21 music volumio[1151]: ---------------------------- MPD announces system playlist update Apr 15 18:26:21 music volumio[1151]: info: Ignoring MPD Status Update Apr 15 18:26:21 music volumio[1151]: info: ------------------------------ 500ms Apr 15 18:26:21 music volumio[1151]: info: ------------------------------ 500ms Apr 15 18:26:21 music volumio[1151]: info: Apr 15 18:26:21 music volumio[1151]: ---------------------------- MPD announces system playlist update Apr 15 18:26:21 music volumio[1151]: info: Ignoring MPD Status Update Apr 15 18:26:21 music volumio[1151]: info: sendMpdCommand play took 1 milliseconds Apr 15 18:26:21 music volumio[1151]: info: ------------------------------ 1ms Apr 15 18:26:21 music volumio[1151]: info: ------------------------------ 0ms Apr 15 18:26:23 music volumio[1151]: info: Apr 15 18:26:23 music volumio[1151]: ---------------------------- MPD announces state update: player Apr 15 18:26:23 music volumio[1151]: info: ControllerMpd::getState Apr 15 18:26:23 music volumio[1151]: verbose: ControllerMpd::sendMpdCommand status Apr 15 18:26:23 music volumio[1151]: info: Apr 15 18:26:23 music volumio[1151]: ---------------------------- MPD announces state update: player Apr 15 18:26:23 music volumio[1151]: info: ControllerMpd::getState Apr 15 18:26:23 music volumio[1151]: verbose: ControllerMpd::sendMpdCommand status Apr 15 18:26:23 music volumio[1151]: info: Apr 15 18:26:23 music volumio[1151]: ---------------------------- MPD announces state update: player Apr 15 18:26:23 music volumio[1151]: info: sendMpdCommand status took 3 milliseconds Apr 15 18:26:23 music volumio[1151]: info: ControllerMpd::getState Apr 15 18:26:23 music volumio[1151]: verbose: ControllerMpd::sendMpdCommand status Apr 15 18:26:23 music volumio[1151]: info: sendMpdCommand status took 2 milliseconds Apr 15 18:26:23 music volumio[1151]: verbose: ControllerMpd::parseState Apr 15 18:26:23 music volumio[1151]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 15 18:26:23 music volumio[1151]: verbose: ControllerMpd::parseState Apr 15 18:26:23 music volumio[1151]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 15 18:26:23 music volumio[1151]: info: Apr 15 18:26:23 music volumio[1151]: ---------------------------- MPD announces state update: player Apr 15 18:26:23 music volumio[1151]: info: ControllerMpd::getState Apr 15 18:26:23 music volumio[1151]: verbose: ControllerMpd::sendMpdCommand status Apr 15 18:26:23 music volumio[1151]: info: sendMpdCommand status took 1 milliseconds Apr 15 18:26:23 music volumio[1151]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 15 18:26:23 music volumio[1151]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 15 18:26:23 music volumio[1151]: info: sendMpdCommand status took 0 milliseconds Apr 15 18:26:23 music volumio[1151]: verbose: ControllerMpd::parseState Apr 15 18:26:23 music volumio[1151]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 15 18:26:23 music volumio[1151]: verbose: ControllerMpd::parseTrackInfo Apr 15 18:26:23 music volumio[1151]: verbose: ControllerMpd::parseTrackInfo Apr 15 18:26:23 music volumio[1151]: verbose: ControllerMpd::parseState Apr 15 18:26:23 music volumio[1151]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 15 18:26:23 music volumio[1151]: info: ControllerMpd::pushState Apr 15 18:26:23 music volumio[1151]: info: CoreCommandRouter::servicePushState Apr 15 18:26:23 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:26:23 music volumio[1151]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 8314/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 15 18:26:23 music volumio[1151]: verbose: CURRENT POSITION 0 Apr 15 18:26:23 music volumio[1151]: info: CoreStateMachine::syncState stateService play Apr 15 18:26:23 music volumio[1151]: info: CoreStateMachine::syncState currentStatus stop Apr 15 18:26:23 music volumio[1151]: info: ControllerMpd::pushState Apr 15 18:26:23 music volumio[1151]: info: CoreCommandRouter::servicePushState Apr 15 18:26:23 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:26:23 music volumio[1151]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 8314/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 15 18:26:23 music volumio[1151]: verbose: CURRENT POSITION 0 Apr 15 18:26:23 music volumio[1151]: info: CoreStateMachine::syncState stateService play Apr 15 18:26:23 music volumio[1151]: info: CoreStateMachine::syncState currentStatus play Apr 15 18:26:23 music volumio[1151]: info: Received an update from plugin. extracting info from payload Apr 15 18:26:23 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 15 18:26:23 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:26:23 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:26:23 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 18:26:23 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:26:23 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:26:23 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:26:23 music volumio[1151]: info: ------------------------------ 7ms Apr 15 18:26:23 music volumio5-onboarding[1891]: time=2026-04-15T08:26:23.027Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_PLAYING positionMs=0 volume=84 Apr 15 18:26:23 music volumio5-onboarding[1891]: time=2026-04-15T08:26:23.028Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id=https://dancewave.online:443/dance.mp3 title="Dance Wave!" Apr 15 18:26:23 music volumio5-onboarding[1891]: time=2026-04-15T08:26:23.028Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_PLAYING positionMs=0 volume=84 Apr 15 18:26:23 music volumio5-onboarding[1891]: time=2026-04-15T08:26:23.028Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id=https://dancewave.online:443/dance.mp3 title="Dance Wave!" Apr 15 18:26:23 music volumio[1151]: info: ------------------------------ 9ms Apr 15 18:26:23 music volumio[1151]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 15 18:26:23 music volumio[1151]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 15 18:26:23 music volumio[1151]: verbose: ControllerMpd::parseTrackInfo Apr 15 18:26:23 music volumio[1151]: verbose: ControllerMpd::parseTrackInfo Apr 15 18:26:23 music volumio[1151]: info: ControllerMpd::pushState Apr 15 18:26:23 music volumio[1151]: info: CoreCommandRouter::servicePushState Apr 15 18:26:23 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:26:23 music volumio[1151]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 8314/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 15 18:26:23 music volumio[1151]: verbose: CURRENT POSITION 0 Apr 15 18:26:23 music volumio[1151]: info: CoreStateMachine::syncState stateService play Apr 15 18:26:23 music volumio[1151]: info: CoreStateMachine::syncState currentStatus play Apr 15 18:26:23 music volumio[1151]: info: Received an update from plugin. extracting info from payload Apr 15 18:26:23 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 15 18:26:23 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:26:23 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:26:23 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:26:23 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:26:23 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:26:23 music volumio[1151]: info: ControllerMpd::pushState Apr 15 18:26:23 music volumio[1151]: info: CoreCommandRouter::servicePushState Apr 15 18:26:23 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:26:23 music volumio[1151]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 8314/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 15 18:26:23 music volumio[1151]: verbose: CURRENT POSITION 0 Apr 15 18:26:23 music volumio[1151]: info: CoreStateMachine::syncState stateService play Apr 15 18:26:23 music volumio[1151]: info: CoreStateMachine::syncState currentStatus play Apr 15 18:26:23 music volumio[1151]: info: Received an update from plugin. extracting info from payload Apr 15 18:26:23 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 15 18:26:23 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:26:23 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:26:23 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:26:23 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:26:23 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:26:23 music volumio5-onboarding[1891]: time=2026-04-15T08:26:23.036Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_PLAYING positionMs=0 volume=84 Apr 15 18:26:23 music volumio5-onboarding[1891]: time=2026-04-15T08:26:23.036Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id=https://dancewave.online:443/dance.mp3 title="Dance Wave!" Apr 15 18:26:23 music volumio5-onboarding[1891]: time=2026-04-15T08:26:23.037Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_PLAYING positionMs=0 volume=84 Apr 15 18:26:23 music volumio5-onboarding[1891]: time=2026-04-15T08:26:23.037Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id=https://dancewave.online:443/dance.mp3 title="Dance Wave!" Apr 15 18:26:23 music volumio5-onboarding[1891]: time=2026-04-15T08:26:23.038Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_PLAYING positionMs=0 volume=84 Apr 15 18:26:23 music volumio[1151]: info: ------------------------------ 20ms Apr 15 18:26:23 music volumio5-onboarding[1891]: time=2026-04-15T08:26:23.038Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_PLAYING positionMs=0 volume=84 Apr 15 18:26:23 music volumio5-onboarding[1891]: time=2026-04-15T08:26:23.042Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id=https://dancewave.online:443/dance.mp3 title="Dance Wave!" Apr 15 18:26:23 music volumio5-onboarding[1891]: time=2026-04-15T08:26:23.042Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id=https://dancewave.online:443/dance.mp3 title="Dance Wave!" Apr 15 18:26:23 music volumio[1151]: info: ------------------------------ 20ms Apr 15 18:26:23 music volumio[1151]: info: Apr 15 18:26:23 music volumio[1151]: ---------------------------- MPD announces system playlist update Apr 15 18:26:23 music volumio[1151]: info: Ignoring MPD Status Update Apr 15 18:26:23 music volumio[1151]: info: Apr 15 18:26:23 music volumio[1151]: ---------------------------- MPD announces state update: player Apr 15 18:26:23 music volumio[1151]: info: ControllerMpd::getState Apr 15 18:26:23 music volumio[1151]: verbose: ControllerMpd::sendMpdCommand status Apr 15 18:26:23 music volumio[1151]: info: Apr 15 18:26:23 music volumio[1151]: ---------------------------- MPD announces system playlist update Apr 15 18:26:23 music volumio[1151]: info: Ignoring MPD Status Update Apr 15 18:26:23 music volumio[1151]: info: Apr 15 18:26:23 music volumio[1151]: ---------------------------- MPD announces state update: player Apr 15 18:26:23 music volumio[1151]: info: ControllerMpd::getState Apr 15 18:26:23 music volumio[1151]: verbose: ControllerMpd::sendMpdCommand status Apr 15 18:26:23 music volumio[1151]: info: ------------------------------ 1ms Apr 15 18:26:23 music volumio[1151]: info: sendMpdCommand status took 1 milliseconds Apr 15 18:26:23 music volumio[1151]: info: ------------------------------ 1ms Apr 15 18:26:23 music volumio[1151]: info: sendMpdCommand status took 1 milliseconds Apr 15 18:26:23 music volumio[1151]: verbose: ControllerMpd::parseState Apr 15 18:26:23 music volumio[1151]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 15 18:26:23 music volumio[1151]: verbose: ControllerMpd::parseState Apr 15 18:26:23 music volumio[1151]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 15 18:26:23 music volumio[1151]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 15 18:26:23 music volumio[1151]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 15 18:26:23 music volumio[1151]: verbose: ControllerMpd::parseTrackInfo Apr 15 18:26:23 music volumio[1151]: verbose: ControllerMpd::parseTrackInfo Apr 15 18:26:23 music volumio[1151]: info: ControllerMpd::pushState Apr 15 18:26:23 music volumio[1151]: info: CoreCommandRouter::servicePushState Apr 15 18:26:23 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:26:23 music volumio[1151]: verbose: STATE SERVICE {"status":"play","position":0,"seek":844,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 15 18:26:23 music volumio[1151]: verbose: CURRENT POSITION 0 Apr 15 18:26:23 music volumio[1151]: info: CoreStateMachine::syncState stateService play Apr 15 18:26:23 music volumio[1151]: info: CoreStateMachine::syncState currentStatus play Apr 15 18:26:23 music volumio[1151]: info: Received an update from plugin. extracting info from payload Apr 15 18:26:23 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 15 18:26:23 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:26:23 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 18:26:23 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:26:23 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:26:23 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:26:23 music volumio[1151]: info: ControllerMpd::pushState Apr 15 18:26:23 music volumio[1151]: info: CoreCommandRouter::servicePushState Apr 15 18:26:23 music volumio[1151]: info: CorePlayQueue::getTrack 0 Apr 15 18:26:23 music volumio[1151]: verbose: STATE SERVICE {"status":"play","position":0,"seek":844,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Apr 15 18:26:23 music volumio[1151]: verbose: CURRENT POSITION 0 Apr 15 18:26:23 music volumio[1151]: info: CoreStateMachine::syncState stateService play Apr 15 18:26:23 music volumio[1151]: info: CoreStateMachine::syncState currentStatus play Apr 15 18:26:23 music volumio[1151]: info: Received an update from plugin. extracting info from payload Apr 15 18:26:23 music volumio[1151]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 15 18:26:23 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:26:23 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:26:23 music volumio[1151]: info: CoreStateMachine::pushState Apr 15 18:26:23 music volumio[1151]: info: CoreCommandRouter::volumioPushState Apr 15 18:26:23 music volumio5-onboarding[1891]: time=2026-04-15T08:26:23.360Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_PLAYING positionMs=250 volume=84 Apr 15 18:26:23 music volumio5-onboarding[1891]: time=2026-04-15T08:26:23.360Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id=https://dancewave.online:443/dance.mp3 title="All about Dance from 2000 till today!" Apr 15 18:26:23 music volumio5-onboarding[1891]: time=2026-04-15T08:26:23.361Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_PLAYING positionMs=250 volume=84 Apr 15 18:26:23 music volumio5-onboarding[1891]: time=2026-04-15T08:26:23.361Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_PLAYING positionMs=250 volume=84 Apr 15 18:26:23 music volumio5-onboarding[1891]: time=2026-04-15T08:26:23.361Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id=https://dancewave.online:443/dance.mp3 title="All about Dance from 2000 till today!" Apr 15 18:26:23 music volumio5-onboarding[1891]: time=2026-04-15T08:26:23.361Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id=https://dancewave.online:443/dance.mp3 title="All about Dance from 2000 till today!" Apr 15 18:26:23 music volumio5-onboarding[1891]: time=2026-04-15T08:26:23.362Z level=INFO msg="emitting player state changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" state=STATUS_PLAYING positionMs=250 volume=84 Apr 15 18:26:23 music volumio5-onboarding[1891]: time=2026-04-15T08:26:23.362Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.56:51050 @ 0xc000305aa0" id=https://dancewave.online:443/dance.mp3 title="All about Dance from 2000 till today!" Apr 15 18:26:23 music volumio[1151]: info: ------------------------------ 13ms Apr 15 18:26:23 music volumio[1151]: info: ------------------------------ 12ms Apr 15 18:26:25 music volumio[1151]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 15 18:26:25 music volumio[1151]: TypeError: Cannot read properties of null (reading 'slice') Apr 15 18:26:25 music volumio[1151]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Apr 15 18:26:25 music volumio[1151]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Apr 15 18:26:25 music volumio[1151]: at Object.onceWrapper (node:events:629:26) Apr 15 18:26:25 music volumio[1151]: at ClientRequest.emit (node:events:514:28) Apr 15 18:26:25 music volumio[1151]: at HTTPParser.parserOnIncomingClient [as onIncoming] (node:_http_client:693:27) Apr 15 18:26:25 music volumio[1151]: at HTTPParser.parserOnHeadersComplete (node:_http_common:119:17) Apr 15 18:26:25 music volumio[1151]: at TLSSocket.socketOnData (node:_http_client:535:22) Apr 15 18:26:25 music volumio[1151]: at TLSSocket.emit (node:events:514:28) Apr 15 18:26:25 music volumio[1151]: at addChunk (node:internal/streams/readable:343:12) Apr 15 18:26:25 music volumio[1151]: at readableAddChunk (node:internal/streams/readable:316:9) Apr 15 18:26:25 music volumio[1151]: at Readable.push (node:internal/streams/readable:253:10) Apr 15 18:26:25 music volumio[1151]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:190:23) Apr 15 18:26:25 music volumio[1151]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 15 18:26:25 music sudo[3842]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-15 18:25' Apr 15 18:26:25 music sudo[3842]: 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"