Feb 18 03:04:09 volumiomini volumio[1222]: info: Feb 18 03:04:09 volumiomini volumio[1222]: ---------------------------- MPD announces system playlist update Feb 18 03:04:09 volumiomini volumio[1222]: info: Ignoring MPD Status Update Feb 18 03:04:09 volumiomini volumio[1222]: info: Feb 18 03:04:09 volumiomini volumio[1222]: ---------------------------- MPD announces state update: player Feb 18 03:04:09 volumiomini volumio[1222]: info: ControllerMpd::getState Feb 18 03:04:09 volumiomini volumio[1222]: verbose: ControllerMpd::sendMpdCommand status Feb 18 03:04:09 volumiomini volumio[1222]: info: Feb 18 03:04:09 volumiomini volumio[1222]: ---------------------------- MPD announces system playlist update Feb 18 03:04:09 volumiomini volumio[1222]: info: Ignoring MPD Status Update Feb 18 03:04:09 volumiomini volumio[1222]: info: Feb 18 03:04:09 volumiomini volumio[1222]: ---------------------------- MPD announces state update: player Feb 18 03:04:09 volumiomini volumio[1222]: info: ControllerMpd::getState Feb 18 03:04:09 volumiomini volumio[1222]: verbose: ControllerMpd::sendMpdCommand status Feb 18 03:04:09 volumiomini volumio[1222]: info: ------------------------------ 6ms Feb 18 03:04:09 volumiomini volumio[1222]: info: sendMpdCommand status took 4 milliseconds Feb 18 03:04:09 volumiomini volumio[1222]: info: ------------------------------ 3ms Feb 18 03:04:09 volumiomini volumio[1222]: info: sendMpdCommand status took 2 milliseconds Feb 18 03:04:09 volumiomini volumio[1222]: verbose: ControllerMpd::parseState Feb 18 03:04:09 volumiomini volumio[1222]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 03:04:09 volumiomini volumio[1222]: verbose: ControllerMpd::parseState Feb 18 03:04:09 volumiomini volumio[1222]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 03:04:09 volumiomini volumio[1222]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 18 03:04:09 volumiomini volumio[1222]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 18 03:04:09 volumiomini volumio[1222]: verbose: ControllerMpd::parseTrackInfo Feb 18 03:04:09 volumiomini volumio[1222]: verbose: ControllerMpd::parseTrackInfo Feb 18 03:04:09 volumiomini volumio[1222]: info: ControllerMpd::pushState Feb 18 03:04:09 volumiomini volumio[1222]: info: CoreCommandRouter::servicePushState Feb 18 03:04:09 volumiomini volumio[1222]: info: CorePlayQueue::getTrack 0 Feb 18 03:04:09 volumiomini volumio[1222]: verbose: STATE SERVICE {"status":"play","position":0,"seek":360869,"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 before 2000!","artist":"Dance Wave Retro!","album":null,"uri":"https://retro.dancewave.online:443/retrodance.mp3","trackType":"mp3"} Feb 18 03:04:09 volumiomini volumio[1222]: verbose: CURRENT POSITION 0 Feb 18 03:04:09 volumiomini volumio[1222]: info: CoreStateMachine::syncState stateService play Feb 18 03:04:09 volumiomini volumio[1222]: info: CoreStateMachine::syncState currentStatus play Feb 18 03:04:09 volumiomini volumio[1222]: info: Received an update from plugin. extracting info from payload Feb 18 03:04:09 volumiomini volumio[1222]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 03:04:09 volumiomini volumio[1222]: info: CoreStateMachine::pushState Feb 18 03:04:09 volumiomini volumio[1222]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 03:04:09 volumiomini volumio[1222]: info: CoreCommandRouter::volumioPushState Feb 18 03:04:09 volumiomini volumio[1222]: info: CoreStateMachine::pushState Feb 18 03:04:09 volumiomini volumio[1222]: info: CoreCommandRouter::volumioPushState Feb 18 03:04:09 volumiomini volumio[1222]: info: ControllerMpd::pushState Feb 18 03:04:09 volumiomini volumio[1222]: info: CoreCommandRouter::servicePushState Feb 18 03:04:09 volumiomini volumio[1222]: info: CorePlayQueue::getTrack 0 Feb 18 03:04:09 volumiomini volumio[1222]: verbose: STATE SERVICE {"status":"play","position":0,"seek":360869,"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 before 2000!","artist":"Dance Wave Retro!","album":null,"uri":"https://retro.dancewave.online:443/retrodance.mp3","trackType":"mp3"} Feb 18 03:04:09 volumiomini volumio[1222]: verbose: CURRENT POSITION 0 Feb 18 03:04:09 volumiomini volumio[1222]: info: CoreStateMachine::syncState stateService play Feb 18 03:04:09 volumiomini volumio[1222]: info: CoreStateMachine::syncState currentStatus play Feb 18 03:04:09 volumiomini volumio[1222]: info: Received an update from plugin. extracting info from payload Feb 18 03:04:09 volumiomini volumio[1222]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 03:04:09 volumiomini volumio[1222]: info: CoreStateMachine::pushState Feb 18 03:04:09 volumiomini volumio[1222]: info: CoreCommandRouter::volumioPushState Feb 18 03:04:09 volumiomini volumio[1222]: info: CoreStateMachine::pushState Feb 18 03:04:09 volumiomini volumio[1222]: info: CoreCommandRouter::volumioPushState Feb 18 03:04:09 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:09.082+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" state=STATUS_PLAYING positionMs=359875 volume=100 Feb 18 03:04:09 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:09.083+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" id=https://retro.dancewave.online:443/retrodance.mp3 title="All about Dance before 2000!" Feb 18 03:04:09 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:09.084+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" state=STATUS_PLAYING positionMs=359875 volume=100 Feb 18 03:04:09 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:09.085+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" state=STATUS_PLAYING positionMs=359875 volume=100 Feb 18 03:04:09 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:09.085+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" id=https://retro.dancewave.online:443/retrodance.mp3 title="All about Dance before 2000!" Feb 18 03:04:09 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:09.085+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" id=https://retro.dancewave.online:443/retrodance.mp3 title="All about Dance before 2000!" Feb 18 03:04:09 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:09.086+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" state=STATUS_PLAYING positionMs=359875 volume=100 Feb 18 03:04:09 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:09.086+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" id=https://retro.dancewave.online:443/retrodance.mp3 title="All about Dance before 2000!" Feb 18 03:04:09 volumiomini volumio[1222]: info: ------------------------------ 39ms Feb 18 03:04:09 volumiomini volumio[1222]: info: ------------------------------ 38ms Feb 18 03:04:09 volumiomini volumio[1222]: info: [LastFM] Current track has sufficient metadata: title (All about Dance before 2000!) and artist (Dance Wave Retro!) passed on explicitly Feb 18 03:04:09 volumiomini volumio[1222]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Feb 18 03:04:09 volumiomini volumio[1222]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 18 03:04:09 volumiomini volumio[1222]: info: Display-configuration --- → Wakeup triggered Feb 18 03:04:09 volumiomini volumio[1222]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 18 03:04:09 volumiomini volumio[1222]: info: Display-configuration --- → Wakeup triggered Feb 18 03:04:09 volumiomini volumio[1222]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 18 03:04:09 volumiomini volumio[1222]: info: Display-configuration --- → Wakeup triggered Feb 18 03:04:09 volumiomini volumio[1222]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 18 03:04:09 volumiomini volumio[1222]: info: Display-configuration --- → Wakeup triggered Feb 18 03:04:09 volumiomini volumio[1222]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false Feb 18 03:04:09 volumiomini volumio[1222]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false Feb 18 03:04:09 volumiomini volumio[1222]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false Feb 18 03:04:09 volumiomini volumio[1222]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false Feb 18 03:04:09 volumiomini volumio[1222]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 18 03:04:09 volumiomini volumio[1222]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 18 03:04:09 volumiomini volumio[1222]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 18 03:04:09 volumiomini volumio[1222]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 18 03:04:17 volumiomini volumio[1222]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: unknown Engine version: 4 Transport: websocket Total Clients: 13 Feb 18 03:04:17 volumiomini volumio[1222]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: unknown Engine version: 4 Transport: websocket Total Clients: 13 Feb 18 03:04:17 volumiomini volumio[1222]: info: CoreCommandRouter::volumioGetState Feb 18 03:04:17 volumiomini volumio[1222]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 18 03:04:17 volumiomini volumio[1222]: info: CoreCommandRouter::volumioGetQueue Feb 18 03:04:17 volumiomini volumio[1222]: info: CoreStateMachine::getQueue Feb 18 03:04:17 volumiomini volumio[1222]: info: CorePlayQueue::getQueue Feb 18 03:04:24 volumiomini volumio[1222]: info: Feb 18 03:04:24 volumiomini volumio[1222]: ---------------------------- MPD announces system playlist update Feb 18 03:04:24 volumiomini volumio[1222]: info: Ignoring MPD Status Update Feb 18 03:04:24 volumiomini volumio[1222]: info: Feb 18 03:04:24 volumiomini volumio[1222]: ---------------------------- MPD announces state update: player Feb 18 03:04:24 volumiomini volumio[1222]: info: ControllerMpd::getState Feb 18 03:04:24 volumiomini volumio[1222]: verbose: ControllerMpd::sendMpdCommand status Feb 18 03:04:24 volumiomini volumio[1222]: info: Feb 18 03:04:24 volumiomini volumio[1222]: ---------------------------- MPD announces system playlist update Feb 18 03:04:24 volumiomini volumio[1222]: info: Ignoring MPD Status Update Feb 18 03:04:24 volumiomini volumio[1222]: info: Feb 18 03:04:24 volumiomini volumio[1222]: ---------------------------- MPD announces state update: player Feb 18 03:04:24 volumiomini volumio[1222]: info: ControllerMpd::getState Feb 18 03:04:24 volumiomini volumio[1222]: verbose: ControllerMpd::sendMpdCommand status Feb 18 03:04:24 volumiomini volumio[1222]: info: ------------------------------ 11ms Feb 18 03:04:24 volumiomini volumio[1222]: info: sendMpdCommand status took 13 milliseconds Feb 18 03:04:24 volumiomini volumio[1222]: info: ------------------------------ 12ms Feb 18 03:04:24 volumiomini volumio[1222]: info: sendMpdCommand status took 8 milliseconds Feb 18 03:04:24 volumiomini volumio[1222]: verbose: ControllerMpd::parseState Feb 18 03:04:24 volumiomini volumio[1222]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 03:04:24 volumiomini volumio[1222]: verbose: ControllerMpd::parseState Feb 18 03:04:24 volumiomini volumio[1222]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 03:04:24 volumiomini volumio[1222]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 18 03:04:24 volumiomini volumio[1222]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 18 03:04:24 volumiomini volumio[1222]: verbose: ControllerMpd::parseTrackInfo Feb 18 03:04:24 volumiomini volumio[1222]: verbose: ControllerMpd::parseTrackInfo Feb 18 03:04:24 volumiomini volumio[1222]: info: ControllerMpd::pushState Feb 18 03:04:24 volumiomini volumio[1222]: info: CoreCommandRouter::servicePushState Feb 18 03:04:24 volumiomini volumio[1222]: info: CorePlayQueue::getTrack 0 Feb 18 03:04:24 volumiomini volumio[1222]: verbose: STATE SERVICE {"status":"play","position":0,"seek":376763,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave Retro!","album":null,"uri":"https://retro.dancewave.online:443/retrodance.mp3","trackType":"mp3"} Feb 18 03:04:24 volumiomini volumio[1222]: verbose: CURRENT POSITION 0 Feb 18 03:04:24 volumiomini volumio[1222]: info: CoreStateMachine::syncState stateService play Feb 18 03:04:24 volumiomini volumio[1222]: info: CoreStateMachine::syncState currentStatus play Feb 18 03:04:24 volumiomini volumio[1222]: info: Received an update from plugin. extracting info from payload Feb 18 03:04:24 volumiomini volumio[1222]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 03:04:24 volumiomini volumio[1222]: info: CoreStateMachine::pushState Feb 18 03:04:24 volumiomini volumio[1222]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 03:04:24 volumiomini volumio[1222]: info: CoreCommandRouter::volumioPushState Feb 18 03:04:24 volumiomini volumio[1222]: info: CoreStateMachine::pushState Feb 18 03:04:24 volumiomini volumio[1222]: info: CoreCommandRouter::volumioPushState Feb 18 03:04:24 volumiomini volumio[1222]: info: ControllerMpd::pushState Feb 18 03:04:24 volumiomini volumio[1222]: info: CoreCommandRouter::servicePushState Feb 18 03:04:24 volumiomini volumio[1222]: info: CorePlayQueue::getTrack 0 Feb 18 03:04:24 volumiomini volumio[1222]: verbose: STATE SERVICE {"status":"play","position":0,"seek":376763,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave Retro!","album":null,"uri":"https://retro.dancewave.online:443/retrodance.mp3","trackType":"mp3"} Feb 18 03:04:24 volumiomini volumio[1222]: verbose: CURRENT POSITION 0 Feb 18 03:04:24 volumiomini volumio[1222]: info: CoreStateMachine::syncState stateService play Feb 18 03:04:24 volumiomini volumio[1222]: info: CoreStateMachine::syncState currentStatus play Feb 18 03:04:24 volumiomini volumio[1222]: info: Received an update from plugin. extracting info from payload Feb 18 03:04:24 volumiomini volumio[1222]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 03:04:24 volumiomini volumio[1222]: info: CoreStateMachine::pushState Feb 18 03:04:24 volumiomini volumio[1222]: info: CoreCommandRouter::volumioPushState Feb 18 03:04:24 volumiomini volumio[1222]: info: CoreStateMachine::pushState Feb 18 03:04:24 volumiomini volumio[1222]: info: CoreCommandRouter::volumioPushState Feb 18 03:04:24 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:24.921+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" state=STATUS_PLAYING positionMs=375723 volume=100 Feb 18 03:04:24 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:24.922+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" id=https://retro.dancewave.online:443/retrodance.mp3 title="Tracklist: https://dancewave.online" Feb 18 03:04:24 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:24.922+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" state=STATUS_PLAYING positionMs=375723 volume=100 Feb 18 03:04:24 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:24.923+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" id=https://retro.dancewave.online:443/retrodance.mp3 title="Tracklist: https://dancewave.online" Feb 18 03:04:24 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:24.923+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" state=STATUS_PLAYING positionMs=375723 volume=100 Feb 18 03:04:24 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:24.924+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" id=https://retro.dancewave.online:443/retrodance.mp3 title="Tracklist: https://dancewave.online" Feb 18 03:04:24 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:24.925+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" state=STATUS_PLAYING positionMs=375723 volume=100 Feb 18 03:04:24 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:24.925+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" id=https://retro.dancewave.online:443/retrodance.mp3 title="Tracklist: https://dancewave.online" Feb 18 03:04:24 volumiomini volumio[1222]: info: ------------------------------ 65ms Feb 18 03:04:24 volumiomini volumio[1222]: info: ------------------------------ 61ms Feb 18 03:04:24 volumiomini volumio[1222]: info: [LastFM] Current track has sufficient metadata: title (Tracklist: https://dancewave.online) and artist (Dance Wave Retro!) passed on explicitly Feb 18 03:04:24 volumiomini volumio[1222]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Feb 18 03:04:24 volumiomini volumio[1222]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 18 03:04:24 volumiomini volumio[1222]: info: Display-configuration --- → Wakeup triggered Feb 18 03:04:24 volumiomini volumio[1222]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 18 03:04:24 volumiomini volumio[1222]: info: Display-configuration --- → Wakeup triggered Feb 18 03:04:24 volumiomini volumio[1222]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 18 03:04:24 volumiomini volumio[1222]: info: Display-configuration --- → Wakeup triggered Feb 18 03:04:24 volumiomini volumio[1222]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 18 03:04:24 volumiomini volumio[1222]: info: Display-configuration --- → Wakeup triggered Feb 18 03:04:25 volumiomini volumio[1222]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false Feb 18 03:04:25 volumiomini volumio[1222]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false Feb 18 03:04:25 volumiomini volumio[1222]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false Feb 18 03:04:25 volumiomini volumio[1222]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false Feb 18 03:04:25 volumiomini volumio[1222]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 18 03:04:25 volumiomini volumio[1222]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 18 03:04:25 volumiomini volumio[1222]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 18 03:04:25 volumiomini volumio[1222]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 18 03:04:40 volumiomini volumio[1222]: info: Feb 18 03:04:40 volumiomini volumio[1222]: ---------------------------- MPD announces system playlist update Feb 18 03:04:40 volumiomini volumio[1222]: info: Ignoring MPD Status Update Feb 18 03:04:40 volumiomini volumio[1222]: info: Feb 18 03:04:40 volumiomini volumio[1222]: ---------------------------- MPD announces state update: player Feb 18 03:04:40 volumiomini volumio[1222]: info: ControllerMpd::getState Feb 18 03:04:40 volumiomini volumio[1222]: verbose: ControllerMpd::sendMpdCommand status Feb 18 03:04:40 volumiomini volumio[1222]: info: Feb 18 03:04:40 volumiomini volumio[1222]: ---------------------------- MPD announces system playlist update Feb 18 03:04:40 volumiomini volumio[1222]: info: Ignoring MPD Status Update Feb 18 03:04:40 volumiomini volumio[1222]: info: Feb 18 03:04:40 volumiomini volumio[1222]: ---------------------------- MPD announces state update: player Feb 18 03:04:40 volumiomini volumio[1222]: info: ControllerMpd::getState Feb 18 03:04:40 volumiomini volumio[1222]: verbose: ControllerMpd::sendMpdCommand status Feb 18 03:04:40 volumiomini volumio[1222]: info: ------------------------------ 7ms Feb 18 03:04:40 volumiomini volumio[1222]: info: sendMpdCommand status took 6 milliseconds Feb 18 03:04:40 volumiomini volumio[1222]: info: ------------------------------ 4ms Feb 18 03:04:40 volumiomini volumio[1222]: info: sendMpdCommand status took 2 milliseconds Feb 18 03:04:40 volumiomini volumio[1222]: verbose: ControllerMpd::parseState Feb 18 03:04:40 volumiomini volumio[1222]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 03:04:40 volumiomini volumio[1222]: verbose: ControllerMpd::parseState Feb 18 03:04:40 volumiomini volumio[1222]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 03:04:40 volumiomini volumio[1222]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 18 03:04:40 volumiomini volumio[1222]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 18 03:04:40 volumiomini volumio[1222]: verbose: ControllerMpd::parseTrackInfo Feb 18 03:04:40 volumiomini volumio[1222]: verbose: ControllerMpd::parseTrackInfo Feb 18 03:04:40 volumiomini volumio[1222]: info: ControllerMpd::pushState Feb 18 03:04:40 volumiomini volumio[1222]: info: CoreCommandRouter::servicePushState Feb 18 03:04:40 volumiomini volumio[1222]: info: CorePlayQueue::getTrack 0 Feb 18 03:04:40 volumiomini volumio[1222]: verbose: STATE SERVICE {"status":"play","position":0,"seek":392371,"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 before 2000!","artist":"Dance Wave Retro!","album":null,"uri":"https://retro.dancewave.online:443/retrodance.mp3","trackType":"mp3"} Feb 18 03:04:40 volumiomini volumio[1222]: verbose: CURRENT POSITION 0 Feb 18 03:04:40 volumiomini volumio[1222]: info: CoreStateMachine::syncState stateService play Feb 18 03:04:40 volumiomini volumio[1222]: info: CoreStateMachine::syncState currentStatus play Feb 18 03:04:40 volumiomini volumio[1222]: info: Received an update from plugin. extracting info from payload Feb 18 03:04:40 volumiomini volumio[1222]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 03:04:40 volumiomini volumio[1222]: info: CoreStateMachine::pushState Feb 18 03:04:40 volumiomini volumio[1222]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 03:04:40 volumiomini volumio[1222]: info: CoreCommandRouter::volumioPushState Feb 18 03:04:40 volumiomini volumio[1222]: info: CoreStateMachine::pushState Feb 18 03:04:40 volumiomini volumio[1222]: info: CoreCommandRouter::volumioPushState Feb 18 03:04:40 volumiomini volumio[1222]: info: ControllerMpd::pushState Feb 18 03:04:40 volumiomini volumio[1222]: info: CoreCommandRouter::servicePushState Feb 18 03:04:40 volumiomini volumio[1222]: info: CorePlayQueue::getTrack 0 Feb 18 03:04:40 volumiomini volumio[1222]: verbose: STATE SERVICE {"status":"play","position":0,"seek":392371,"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 before 2000!","artist":"Dance Wave Retro!","album":null,"uri":"https://retro.dancewave.online:443/retrodance.mp3","trackType":"mp3"} Feb 18 03:04:40 volumiomini volumio[1222]: verbose: CURRENT POSITION 0 Feb 18 03:04:40 volumiomini volumio[1222]: info: CoreStateMachine::syncState stateService play Feb 18 03:04:40 volumiomini volumio[1222]: info: CoreStateMachine::syncState currentStatus play Feb 18 03:04:40 volumiomini volumio[1222]: info: Received an update from plugin. extracting info from payload Feb 18 03:04:40 volumiomini volumio[1222]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 03:04:40 volumiomini volumio[1222]: info: CoreStateMachine::pushState Feb 18 03:04:40 volumiomini volumio[1222]: info: CoreCommandRouter::volumioPushState Feb 18 03:04:40 volumiomini volumio[1222]: info: CoreStateMachine::pushState Feb 18 03:04:40 volumiomini volumio[1222]: info: CoreCommandRouter::volumioPushState Feb 18 03:04:40 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:40.509+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" state=STATUS_PLAYING positionMs=391320 volume=100 Feb 18 03:04:40 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:40.509+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" state=STATUS_PLAYING positionMs=391320 volume=100 Feb 18 03:04:40 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:40.509+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" id=https://retro.dancewave.online:443/retrodance.mp3 title="All about Dance before 2000!" Feb 18 03:04:40 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:40.509+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" id=https://retro.dancewave.online:443/retrodance.mp3 title="All about Dance before 2000!" Feb 18 03:04:40 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:40.509+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" state=STATUS_PLAYING positionMs=391320 volume=100 Feb 18 03:04:40 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:40.510+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" id=https://retro.dancewave.online:443/retrodance.mp3 title="All about Dance before 2000!" Feb 18 03:04:40 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:40.510+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" state=STATUS_PLAYING positionMs=391320 volume=100 Feb 18 03:04:40 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:40.510+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" id=https://retro.dancewave.online:443/retrodance.mp3 title="All about Dance before 2000!" Feb 18 03:04:40 volumiomini volumio[1222]: info: ------------------------------ 45ms Feb 18 03:04:40 volumiomini volumio[1222]: info: ------------------------------ 43ms Feb 18 03:04:40 volumiomini volumio[1222]: info: [LastFM] Current track has sufficient metadata: title (All about Dance before 2000!) and artist (Dance Wave Retro!) passed on explicitly Feb 18 03:04:40 volumiomini volumio[1222]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Feb 18 03:04:40 volumiomini volumio[1222]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 18 03:04:40 volumiomini volumio[1222]: info: Display-configuration --- → Wakeup triggered Feb 18 03:04:40 volumiomini volumio[1222]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 18 03:04:40 volumiomini volumio[1222]: info: Display-configuration --- → Wakeup triggered Feb 18 03:04:40 volumiomini volumio[1222]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 18 03:04:40 volumiomini volumio[1222]: info: Display-configuration --- → Wakeup triggered Feb 18 03:04:40 volumiomini volumio[1222]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 18 03:04:40 volumiomini volumio[1222]: info: Display-configuration --- → Wakeup triggered Feb 18 03:04:40 volumiomini volumio[1222]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false Feb 18 03:04:40 volumiomini volumio[1222]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false Feb 18 03:04:40 volumiomini volumio[1222]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false Feb 18 03:04:40 volumiomini volumio[1222]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false Feb 18 03:04:40 volumiomini volumio[1222]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 18 03:04:40 volumiomini volumio[1222]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 18 03:04:40 volumiomini volumio[1222]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 18 03:04:40 volumiomini volumio[1222]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 18 03:04:56 volumiomini volumio[1222]: info: Feb 18 03:04:56 volumiomini volumio[1222]: ---------------------------- MPD announces system playlist update Feb 18 03:04:56 volumiomini volumio[1222]: info: Ignoring MPD Status Update Feb 18 03:04:56 volumiomini volumio[1222]: info: Feb 18 03:04:56 volumiomini volumio[1222]: ---------------------------- MPD announces state update: player Feb 18 03:04:56 volumiomini volumio[1222]: info: ControllerMpd::getState Feb 18 03:04:56 volumiomini volumio[1222]: verbose: ControllerMpd::sendMpdCommand status Feb 18 03:04:56 volumiomini volumio[1222]: info: Feb 18 03:04:56 volumiomini volumio[1222]: ---------------------------- MPD announces system playlist update Feb 18 03:04:56 volumiomini volumio[1222]: info: Ignoring MPD Status Update Feb 18 03:04:56 volumiomini volumio[1222]: info: Feb 18 03:04:56 volumiomini volumio[1222]: ---------------------------- MPD announces state update: player Feb 18 03:04:56 volumiomini volumio[1222]: info: ControllerMpd::getState Feb 18 03:04:56 volumiomini volumio[1222]: verbose: ControllerMpd::sendMpdCommand status Feb 18 03:04:56 volumiomini volumio[1222]: info: ------------------------------ 4ms Feb 18 03:04:56 volumiomini volumio[1222]: info: sendMpdCommand status took 3 milliseconds Feb 18 03:04:56 volumiomini volumio[1222]: verbose: ControllerMpd::parseState Feb 18 03:04:56 volumiomini volumio[1222]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 03:04:56 volumiomini volumio[1222]: info: ------------------------------ 4ms Feb 18 03:04:56 volumiomini volumio[1222]: info: sendMpdCommand status took 4 milliseconds Feb 18 03:04:56 volumiomini volumio[1222]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 18 03:04:56 volumiomini volumio[1222]: verbose: ControllerMpd::parseState Feb 18 03:04:56 volumiomini volumio[1222]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 03:04:56 volumiomini volumio[1222]: verbose: ControllerMpd::parseTrackInfo Feb 18 03:04:56 volumiomini volumio[1222]: info: ControllerMpd::pushState Feb 18 03:04:56 volumiomini volumio[1222]: info: CoreCommandRouter::servicePushState Feb 18 03:04:56 volumiomini volumio[1222]: info: CorePlayQueue::getTrack 0 Feb 18 03:04:56 volumiomini volumio[1222]: verbose: STATE SERVICE {"status":"play","position":0,"seek":408067,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave Retro!","album":null,"uri":"https://retro.dancewave.online:443/retrodance.mp3","trackType":"mp3"} Feb 18 03:04:56 volumiomini volumio[1222]: verbose: CURRENT POSITION 0 Feb 18 03:04:56 volumiomini volumio[1222]: info: CoreStateMachine::syncState stateService play Feb 18 03:04:56 volumiomini volumio[1222]: info: CoreStateMachine::syncState currentStatus play Feb 18 03:04:56 volumiomini volumio[1222]: info: Received an update from plugin. extracting info from payload Feb 18 03:04:56 volumiomini volumio[1222]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 03:04:56 volumiomini volumio[1222]: info: CoreStateMachine::pushState Feb 18 03:04:56 volumiomini volumio[1222]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 03:04:56 volumiomini volumio[1222]: info: CoreCommandRouter::volumioPushState Feb 18 03:04:56 volumiomini volumio[1222]: info: CoreStateMachine::pushState Feb 18 03:04:56 volumiomini volumio[1222]: info: CoreCommandRouter::volumioPushState Feb 18 03:04:56 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:56.198+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" state=STATUS_PLAYING positionMs=407153 volume=100 Feb 18 03:04:56 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:56.198+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" id=https://retro.dancewave.online:443/retrodance.mp3 title="Tracklist: https://dancewave.online" Feb 18 03:04:56 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:56.198+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" state=STATUS_PLAYING positionMs=407153 volume=100 Feb 18 03:04:56 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:56.199+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" id=https://retro.dancewave.online:443/retrodance.mp3 title="Tracklist: https://dancewave.online" Feb 18 03:04:56 volumiomini volumio[1222]: info: ------------------------------ 25ms Feb 18 03:04:56 volumiomini volumio[1222]: info: sendMpdCommand playlistinfo took 17 milliseconds Feb 18 03:04:56 volumiomini volumio[1222]: verbose: ControllerMpd::parseTrackInfo Feb 18 03:04:56 volumiomini volumio[1222]: info: ControllerMpd::pushState Feb 18 03:04:56 volumiomini volumio[1222]: info: CoreCommandRouter::servicePushState Feb 18 03:04:56 volumiomini volumio[1222]: info: CorePlayQueue::getTrack 0 Feb 18 03:04:56 volumiomini volumio[1222]: verbose: STATE SERVICE {"status":"play","position":0,"seek":408067,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave Retro!","album":null,"uri":"https://retro.dancewave.online:443/retrodance.mp3","trackType":"mp3"} Feb 18 03:04:56 volumiomini volumio[1222]: verbose: CURRENT POSITION 0 Feb 18 03:04:56 volumiomini volumio[1222]: info: CoreStateMachine::syncState stateService play Feb 18 03:04:56 volumiomini volumio[1222]: info: CoreStateMachine::syncState currentStatus play Feb 18 03:04:56 volumiomini volumio[1222]: info: Received an update from plugin. extracting info from payload Feb 18 03:04:56 volumiomini volumio[1222]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 03:04:56 volumiomini volumio[1222]: info: CoreStateMachine::pushState Feb 18 03:04:56 volumiomini volumio[1222]: info: CoreCommandRouter::volumioPushState Feb 18 03:04:56 volumiomini volumio[1222]: info: CoreStateMachine::pushState Feb 18 03:04:56 volumiomini volumio[1222]: info: CoreCommandRouter::volumioPushState Feb 18 03:04:56 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:56.221+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" state=STATUS_PLAYING positionMs=407153 volume=100 Feb 18 03:04:56 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:56.221+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" state=STATUS_PLAYING positionMs=407153 volume=100 Feb 18 03:04:56 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:56.222+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" id=https://retro.dancewave.online:443/retrodance.mp3 title="Tracklist: https://dancewave.online" Feb 18 03:04:56 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:04:56.222+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" id=https://retro.dancewave.online:443/retrodance.mp3 title="Tracklist: https://dancewave.online" Feb 18 03:04:56 volumiomini volumio[1222]: info: ------------------------------ 47ms Feb 18 03:04:56 volumiomini volumio[1222]: info: [LastFM] Current track has sufficient metadata: title (Tracklist: https://dancewave.online) and artist (Dance Wave Retro!) passed on explicitly Feb 18 03:04:56 volumiomini volumio[1222]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Feb 18 03:04:56 volumiomini volumio[1222]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 18 03:04:56 volumiomini volumio[1222]: info: Display-configuration --- → Wakeup triggered Feb 18 03:04:56 volumiomini volumio[1222]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 18 03:04:56 volumiomini volumio[1222]: info: Display-configuration --- → Wakeup triggered Feb 18 03:04:56 volumiomini volumio[1222]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 18 03:04:56 volumiomini volumio[1222]: info: Display-configuration --- → Wakeup triggered Feb 18 03:04:56 volumiomini volumio[1222]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 18 03:04:56 volumiomini volumio[1222]: info: Display-configuration --- → Wakeup triggered Feb 18 03:04:56 volumiomini volumio[1222]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false Feb 18 03:04:56 volumiomini volumio[1222]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false Feb 18 03:04:56 volumiomini volumio[1222]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false Feb 18 03:04:56 volumiomini volumio[1222]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false Feb 18 03:04:56 volumiomini volumio[1222]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 18 03:04:56 volumiomini volumio[1222]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 18 03:04:56 volumiomini volumio[1222]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 18 03:04:56 volumiomini volumio[1222]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 18 03:05:02 volumiomini volumio[1222]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/ferrum_streaming_control_technology/volumio/bookworm/amd64 Feb 18 03:05:02 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:05:02.102+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 03:05:03 volumiomini volumio[1222]: info: Feb 18 03:05:03 volumiomini volumio[1222]: ---------------------------- MPD announces system playlist update Feb 18 03:05:03 volumiomini volumio[1222]: info: Ignoring MPD Status Update Feb 18 03:05:03 volumiomini volumio[1222]: info: Feb 18 03:05:03 volumiomini volumio[1222]: ---------------------------- MPD announces state update: player Feb 18 03:05:03 volumiomini volumio[1222]: info: ControllerMpd::getState Feb 18 03:05:03 volumiomini volumio[1222]: verbose: ControllerMpd::sendMpdCommand status Feb 18 03:05:03 volumiomini volumio[1222]: info: Feb 18 03:05:03 volumiomini volumio[1222]: ---------------------------- MPD announces system playlist update Feb 18 03:05:03 volumiomini volumio[1222]: info: Ignoring MPD Status Update Feb 18 03:05:03 volumiomini volumio[1222]: info: Feb 18 03:05:03 volumiomini volumio[1222]: ---------------------------- MPD announces state update: player Feb 18 03:05:03 volumiomini volumio[1222]: info: ControllerMpd::getState Feb 18 03:05:03 volumiomini volumio[1222]: verbose: ControllerMpd::sendMpdCommand status Feb 18 03:05:03 volumiomini volumio[1222]: info: ------------------------------ 9ms Feb 18 03:05:03 volumiomini volumio[1222]: info: sendMpdCommand status took 8 milliseconds Feb 18 03:05:03 volumiomini volumio[1222]: info: ------------------------------ 8ms Feb 18 03:05:03 volumiomini volumio[1222]: info: sendMpdCommand status took 5 milliseconds Feb 18 03:05:03 volumiomini volumio[1222]: verbose: ControllerMpd::parseState Feb 18 03:05:03 volumiomini volumio[1222]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 03:05:03 volumiomini volumio[1222]: verbose: ControllerMpd::parseState Feb 18 03:05:03 volumiomini volumio[1222]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 03:05:03 volumiomini volumio[1222]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 18 03:05:03 volumiomini volumio[1222]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 18 03:05:03 volumiomini volumio[1222]: verbose: ControllerMpd::parseTrackInfo Feb 18 03:05:03 volumiomini volumio[1222]: verbose: ControllerMpd::parseTrackInfo Feb 18 03:05:03 volumiomini volumio[1222]: info: ControllerMpd::pushState Feb 18 03:05:03 volumiomini volumio[1222]: info: CoreCommandRouter::servicePushState Feb 18 03:05:03 volumiomini volumio[1222]: info: CorePlayQueue::getTrack 0 Feb 18 03:05:03 volumiomini volumio[1222]: verbose: STATE SERVICE {"status":"play","position":0,"seek":415072,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Dance Wave Retro!","artist":"Dance Wave Retro!","album":null,"uri":"https://retro.dancewave.online:443/retrodance.mp3","trackType":"mp3"} Feb 18 03:05:03 volumiomini volumio[1222]: verbose: CURRENT POSITION 0 Feb 18 03:05:03 volumiomini volumio[1222]: info: CoreStateMachine::syncState stateService play Feb 18 03:05:03 volumiomini volumio[1222]: info: CoreStateMachine::syncState currentStatus play Feb 18 03:05:03 volumiomini volumio[1222]: info: Received an update from plugin. extracting info from payload Feb 18 03:05:03 volumiomini volumio[1222]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 03:05:03 volumiomini volumio[1222]: info: CoreStateMachine::pushState Feb 18 03:05:03 volumiomini volumio[1222]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 03:05:03 volumiomini volumio[1222]: info: CoreCommandRouter::volumioPushState Feb 18 03:05:03 volumiomini volumio[1222]: info: CoreStateMachine::pushState Feb 18 03:05:03 volumiomini volumio[1222]: info: CoreCommandRouter::volumioPushState Feb 18 03:05:03 volumiomini volumio[1222]: info: ControllerMpd::pushState Feb 18 03:05:03 volumiomini volumio[1222]: info: CoreCommandRouter::servicePushState Feb 18 03:05:03 volumiomini volumio[1222]: info: CorePlayQueue::getTrack 0 Feb 18 03:05:03 volumiomini volumio[1222]: verbose: STATE SERVICE {"status":"play","position":0,"seek":415072,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Dance Wave Retro!","artist":"Dance Wave Retro!","album":null,"uri":"https://retro.dancewave.online:443/retrodance.mp3","trackType":"mp3"} Feb 18 03:05:03 volumiomini volumio[1222]: verbose: CURRENT POSITION 0 Feb 18 03:05:03 volumiomini volumio[1222]: info: CoreStateMachine::syncState stateService play Feb 18 03:05:03 volumiomini volumio[1222]: info: CoreStateMachine::syncState currentStatus play Feb 18 03:05:03 volumiomini volumio[1222]: info: Received an update from plugin. extracting info from payload Feb 18 03:05:03 volumiomini volumio[1222]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 03:05:03 volumiomini volumio[1222]: info: CoreStateMachine::pushState Feb 18 03:05:03 volumiomini volumio[1222]: info: CoreCommandRouter::volumioPushState Feb 18 03:05:03 volumiomini volumio[1222]: info: CoreStateMachine::pushState Feb 18 03:05:03 volumiomini volumio[1222]: info: CoreCommandRouter::volumioPushState Feb 18 03:05:03 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:05:03.258+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" state=STATUS_PLAYING positionMs=414168 volume=100 Feb 18 03:05:03 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:05:03.258+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" state=STATUS_PLAYING positionMs=414168 volume=100 Feb 18 03:05:03 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:05:03.258+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" state=STATUS_PLAYING positionMs=414168 volume=100 Feb 18 03:05:03 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:05:03.258+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" state=STATUS_PLAYING positionMs=414168 volume=100 Feb 18 03:05:03 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:05:03.259+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" id=https://retro.dancewave.online:443/retrodance.mp3 title="Dance Wave Retro!" Feb 18 03:05:03 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:05:03.259+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" id=https://retro.dancewave.online:443/retrodance.mp3 title="Dance Wave Retro!" Feb 18 03:05:03 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:05:03.259+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" id=https://retro.dancewave.online:443/retrodance.mp3 title="Dance Wave Retro!" Feb 18 03:05:03 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:05:03.259+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" id=https://retro.dancewave.online:443/retrodance.mp3 title="Dance Wave Retro!" Feb 18 03:05:03 volumiomini volumio[1222]: info: ------------------------------ 47ms Feb 18 03:05:03 volumiomini volumio[1222]: info: ------------------------------ 44ms Feb 18 03:05:03 volumiomini volumio[1222]: info: [LastFM] Current track has sufficient metadata: title (Dance Wave Retro!) and artist (Dance Wave Retro!) passed on explicitly Feb 18 03:05:03 volumiomini volumio[1222]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Feb 18 03:05:03 volumiomini volumio[1222]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 18 03:05:03 volumiomini volumio[1222]: info: Display-configuration --- → Wakeup triggered Feb 18 03:05:03 volumiomini volumio[1222]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 18 03:05:03 volumiomini volumio[1222]: info: Display-configuration --- → Wakeup triggered Feb 18 03:05:03 volumiomini volumio[1222]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 18 03:05:03 volumiomini volumio[1222]: info: Display-configuration --- → Wakeup triggered Feb 18 03:05:03 volumiomini volumio[1222]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 18 03:05:03 volumiomini volumio[1222]: info: Display-configuration --- → Wakeup triggered Feb 18 03:05:03 volumiomini volumio[1222]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false Feb 18 03:05:03 volumiomini volumio[1222]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false Feb 18 03:05:03 volumiomini volumio[1222]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false Feb 18 03:05:03 volumiomini volumio[1222]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false Feb 18 03:05:03 volumiomini volumio[1222]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 18 03:05:03 volumiomini volumio[1222]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 18 03:05:03 volumiomini volumio[1222]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 18 03:05:03 volumiomini volumio[1222]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 18 03:05:03 volumiomini volumio[1222]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/ferrum_streaming_control_technology/volumio/bookworm/amd64 Feb 18 03:05:03 volumiomini volumio[1222]: info: Folder /tmp/plugins removed Feb 18 03:05:03 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:05:03.772+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 03:05:03 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:05:03.899+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 03:05:03 volumiomini volumio[1222]: info: Check plugin dependencies Feb 18 03:05:03 volumiomini volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 18 03:05:03 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:05:03.929+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 03:05:03 volumiomini volumio[1222]: info: Checking if plugin already exists Feb 18 03:05:03 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:05:03.936+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 03:05:03 volumiomini volumio[1222]: info: Rename folder Feb 18 03:05:03 volumiomini volumio[1222]: info: Folder /tmp/downloaded_plugin.zip removed Feb 18 03:05:03 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:05:03.960+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 03:05:03 volumiomini volumio[1222]: info: Move to category Feb 18 03:05:04 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:05:04.125+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 03:05:04 volumiomini volumio[1222]: info: Checking if install.sh is present Feb 18 03:05:04 volumiomini volumio[1222]: info: Executing install.sh Feb 18 03:05:04 volumiomini sudo[18425]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/user_interface/ferrum_streaming_control_technology/install.sh Feb 18 03:05:04 volumiomini sudo[18425]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 18 03:05:04 volumiomini sudo[18425]: pam_unix(sudo:session): session closed for user root Feb 18 03:05:04 volumiomini volumio[1222]: info: Installing ferrum streaming control technology Dependencies Feb 18 03:05:04 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:05:04.193+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 03:05:04 volumiomini volumio[1222]: Plugin install end detected on script Feb 18 03:05:04 volumiomini volumio[1222]: info: Install script completed Feb 18 03:05:04 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:05:04.200+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 03:05:04 volumiomini volumio[1222]: info: Adding reference to registry Feb 18 03:05:04 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:05:04.206+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 03:05:04 volumiomini volumio[1222]: info: Done installing plugin. Feb 18 03:05:04 volumiomini volumio[1222]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 18 03:05:04 volumiomini volumio[1222]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 18 03:05:04 volumiomini volumio[1222]: info: Folder /tmp/plugins removed Feb 18 03:05:04 volumiomini volumio[1222]: info: Folder /tmp/downloaded_plugin.zip removed Feb 18 03:05:04 volumiomini volumio[1222]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 18 03:05:04 volumiomini volumio[1222]: info: Folder /data/temp removed Feb 18 03:05:04 volumiomini volumio[1222]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 18 03:05:04 volumiomini volumio[1222]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 18 03:05:04 volumiomini volumio[1222]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 18 03:05:04 volumiomini volumio[1222]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 18 03:05:06 volumiomini volumio[1222]: info: Enabling plugin ferrum_streaming_control_technology Feb 18 03:05:06 volumiomini volumio[1222]: info: Loading plugin "ferrum_streaming_control_technology"... Feb 18 03:05:06 volumiomini volumio[1222]: error: !!!! WARNING !!!! Feb 18 03:05:06 volumiomini volumio[1222]: error: The plugin user_interface/ferrum_streaming_control_technology failed to load, setting it to stopped. Error: Error: Cannot find module '@hemspzoo/fsct-lib-linux-x64-gnu' Feb 18 03:05:06 volumiomini volumio[1222]: Require stack: Feb 18 03:05:06 volumiomini volumio[1222]: - /data/plugins/user_interface/ferrum_streaming_control_technology/node_modules/@hemspzoo/fsct-lib/index.js Feb 18 03:05:06 volumiomini volumio[1222]: - /data/plugins/user_interface/ferrum_streaming_control_technology/index.js Feb 18 03:05:06 volumiomini volumio[1222]: - /volumio/app/pluginmanager.js Feb 18 03:05:06 volumiomini volumio[1222]: - /volumio/app/index.js Feb 18 03:05:06 volumiomini volumio[1222]: - /volumio/index.js Feb 18 03:05:06 volumiomini volumio[1222]: error: Stack trace: Error: Cannot find module '@hemspzoo/fsct-lib-linux-x64-gnu' Feb 18 03:05:06 volumiomini volumio[1222]: Require stack: Feb 18 03:05:06 volumiomini volumio[1222]: - /data/plugins/user_interface/ferrum_streaming_control_technology/node_modules/@hemspzoo/fsct-lib/index.js Feb 18 03:05:06 volumiomini volumio[1222]: - /data/plugins/user_interface/ferrum_streaming_control_technology/index.js Feb 18 03:05:06 volumiomini volumio[1222]: - /volumio/app/pluginmanager.js Feb 18 03:05:06 volumiomini volumio[1222]: - /volumio/app/index.js Feb 18 03:05:06 volumiomini volumio[1222]: - /volumio/index.js Feb 18 03:05:06 volumiomini volumio[1222]: at Module._resolveFilename (node:internal/modules/cjs/loader:1048:15) Feb 18 03:05:06 volumiomini volumio[1222]: at Module._load (node:internal/modules/cjs/loader:901:27) Feb 18 03:05:06 volumiomini volumio[1222]: at Module.require (node:internal/modules/cjs/loader:1115:19) Feb 18 03:05:06 volumiomini volumio[1222]: at require (node:internal/modules/helpers:130:18) Feb 18 03:05:06 volumiomini volumio[1222]: at Object. (/data/plugins/user_interface/ferrum_streaming_control_technology/node_modules/@hemspzoo/fsct-lib/index.js:190:31) Feb 18 03:05:06 volumiomini volumio[1222]: at Module._compile (node:internal/modules/cjs/loader:1233:14) Feb 18 03:05:06 volumiomini volumio[1222]: at Module._extensions..js (node:internal/modules/cjs/loader:1287:10) Feb 18 03:05:06 volumiomini volumio[1222]: at Module.load (node:internal/modules/cjs/loader:1091:32) Feb 18 03:05:06 volumiomini volumio[1222]: at Module._load (node:internal/modules/cjs/loader:938:12) Feb 18 03:05:06 volumiomini volumio[1222]: at Module.require (node:internal/modules/cjs/loader:1115:19) Feb 18 03:05:06 volumiomini volumio[1222]: at require (node:internal/modules/helpers:130:18) Feb 18 03:05:06 volumiomini volumio[1222]: at Object. (/data/plugins/user_interface/ferrum_streaming_control_technology/index.js:25:118) Feb 18 03:05:06 volumiomini volumio[1222]: at Module._compile (node:internal/modules/cjs/loader:1233:14) Feb 18 03:05:06 volumiomini volumio[1222]: at Module._extensions..js (node:internal/modules/cjs/loader:1287:10) Feb 18 03:05:06 volumiomini volumio[1222]: at Module.load (node:internal/modules/cjs/loader:1091:32) Feb 18 03:05:06 volumiomini volumio[1222]: at Module._load (node:internal/modules/cjs/loader:938:12) Feb 18 03:05:06 volumiomini volumio[1222]: error: !!!! WARNING !!!! Feb 18 03:05:06 volumiomini volumio[1222]: info: Done. Feb 18 03:05:06 volumiomini volumio[1222]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 18 03:05:06 volumiomini volumio[1222]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 18 03:05:06 volumiomini volumio[1222]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 18 03:05:06 volumiomini volumio[1222]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 18 03:05:12 volumiomini volumio[1222]: info: Feb 18 03:05:12 volumiomini volumio[1222]: ---------------------------- MPD announces system playlist update Feb 18 03:05:12 volumiomini volumio[1222]: info: Ignoring MPD Status Update Feb 18 03:05:12 volumiomini volumio[1222]: info: Feb 18 03:05:12 volumiomini volumio[1222]: ---------------------------- MPD announces state update: player Feb 18 03:05:12 volumiomini volumio[1222]: info: ControllerMpd::getState Feb 18 03:05:12 volumiomini volumio[1222]: verbose: ControllerMpd::sendMpdCommand status Feb 18 03:05:12 volumiomini volumio[1222]: info: Feb 18 03:05:12 volumiomini volumio[1222]: ---------------------------- MPD announces system playlist update Feb 18 03:05:12 volumiomini volumio[1222]: info: Ignoring MPD Status Update Feb 18 03:05:12 volumiomini volumio[1222]: info: Feb 18 03:05:12 volumiomini volumio[1222]: ---------------------------- MPD announces state update: player Feb 18 03:05:12 volumiomini volumio[1222]: info: ControllerMpd::getState Feb 18 03:05:12 volumiomini volumio[1222]: verbose: ControllerMpd::sendMpdCommand status Feb 18 03:05:12 volumiomini volumio[1222]: info: ------------------------------ 6ms Feb 18 03:05:12 volumiomini volumio[1222]: info: sendMpdCommand status took 7 milliseconds Feb 18 03:05:12 volumiomini volumio[1222]: info: ------------------------------ 6ms Feb 18 03:05:12 volumiomini volumio[1222]: info: sendMpdCommand status took 5 milliseconds Feb 18 03:05:12 volumiomini volumio[1222]: verbose: ControllerMpd::parseState Feb 18 03:05:12 volumiomini volumio[1222]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 03:05:12 volumiomini volumio[1222]: verbose: ControllerMpd::parseState Feb 18 03:05:12 volumiomini volumio[1222]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 18 03:05:12 volumiomini volumio[1222]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 18 03:05:12 volumiomini volumio[1222]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 18 03:05:12 volumiomini volumio[1222]: verbose: ControllerMpd::parseTrackInfo Feb 18 03:05:12 volumiomini volumio[1222]: verbose: ControllerMpd::parseTrackInfo Feb 18 03:05:12 volumiomini volumio[1222]: info: ControllerMpd::pushState Feb 18 03:05:12 volumiomini volumio[1222]: info: CoreCommandRouter::servicePushState Feb 18 03:05:12 volumiomini volumio[1222]: info: CorePlayQueue::getTrack 0 Feb 18 03:05:12 volumiomini volumio[1222]: verbose: STATE SERVICE {"status":"play","position":0,"seek":424159,"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 before 2000!","artist":"Dance Wave Retro!","album":null,"uri":"https://retro.dancewave.online:443/retrodance.mp3","trackType":"mp3"} Feb 18 03:05:12 volumiomini volumio[1222]: verbose: CURRENT POSITION 0 Feb 18 03:05:12 volumiomini volumio[1222]: info: CoreStateMachine::syncState stateService play Feb 18 03:05:12 volumiomini volumio[1222]: info: CoreStateMachine::syncState currentStatus play Feb 18 03:05:12 volumiomini volumio[1222]: info: Received an update from plugin. extracting info from payload Feb 18 03:05:12 volumiomini volumio[1222]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 03:05:12 volumiomini volumio[1222]: info: CoreStateMachine::pushState Feb 18 03:05:12 volumiomini volumio[1222]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 03:05:12 volumiomini volumio[1222]: info: CoreCommandRouter::volumioPushState Feb 18 03:05:12 volumiomini volumio[1222]: info: ControllerMpd::pushState Feb 18 03:05:12 volumiomini volumio[1222]: info: CoreCommandRouter::servicePushState Feb 18 03:05:12 volumiomini volumio[1222]: info: CorePlayQueue::getTrack 0 Feb 18 03:05:12 volumiomini volumio[1222]: verbose: STATE SERVICE {"status":"play","position":0,"seek":424159,"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 before 2000!","artist":"Dance Wave Retro!","album":null,"uri":"https://retro.dancewave.online:443/retrodance.mp3","trackType":"mp3"} Feb 18 03:05:12 volumiomini volumio[1222]: verbose: CURRENT POSITION 0 Feb 18 03:05:12 volumiomini volumio[1222]: info: CoreStateMachine::syncState stateService play Feb 18 03:05:12 volumiomini volumio[1222]: info: CoreStateMachine::syncState currentStatus play Feb 18 03:05:12 volumiomini volumio[1222]: info: Received an update from plugin. extracting info from payload Feb 18 03:05:12 volumiomini volumio[1222]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 18 03:05:12 volumiomini volumio[1222]: info: CoreStateMachine::pushState Feb 18 03:05:12 volumiomini volumio[1222]: info: CoreCommandRouter::volumioPushState Feb 18 03:05:12 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:05:12.313+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" state=STATUS_PLAYING positionMs=423113 volume=100 Feb 18 03:05:12 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:05:12.313+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" state=STATUS_PLAYING positionMs=423113 volume=100 Feb 18 03:05:12 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:05:12.313+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" id=https://retro.dancewave.online:443/retrodance.mp3 title="All about Dance before 2000!" Feb 18 03:05:12 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:05:12.314+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.82:42418 @ 0xc00051f590" id=https://retro.dancewave.online:443/retrodance.mp3 title="All about Dance before 2000!" Feb 18 03:05:12 volumiomini volumio[1222]: error: ControllerMpd::pushError: TypeError: Cannot read properties of null (reading 'pushState') Feb 18 03:05:12 volumiomini volumio[1222]: error: ControllerMpd::pushError: TypeError: Cannot read properties of null (reading 'pushState') Feb 18 03:05:12 volumiomini volumio[1222]: info: ------------------------------ 47ms Feb 18 03:05:12 volumiomini volumio[1222]: info: ------------------------------ 44ms Feb 18 03:05:12 volumiomini volumio[1222]: info: [LastFM] Current track has sufficient metadata: title (All about Dance before 2000!) and artist (Dance Wave Retro!) passed on explicitly Feb 18 03:05:12 volumiomini volumio[1222]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Feb 18 03:05:12 volumiomini volumio[1222]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 18 03:05:12 volumiomini volumio[1222]: info: Display-configuration --- → Wakeup triggered Feb 18 03:05:12 volumiomini volumio[1222]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms Feb 18 03:05:12 volumiomini volumio[1222]: info: Display-configuration --- → Wakeup triggered Feb 18 03:05:12 volumiomini volumio[1222]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false Feb 18 03:05:12 volumiomini volumio[1222]: info: peppy_screensaver: pushState - status=play service=webradio volatile=false Feb 18 03:05:12 volumiomini volumio[1222]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 18 03:05:12 volumiomini volumio[1222]: info: Display-configuration --- wakeupScreen: DPMS - screen on Feb 18 03:05:22 volumiomini volumio[1222]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/Bluetoothremote/volumio/bookworm/amd64 Feb 18 03:05:22 volumiomini volumio5-onboarding[1897]: time=2026-02-18T03:05:22.314+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 03:05:22 volumiomini volumio[1222]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 18 03:05:22 volumiomini volumio[1222]: TypeError: Cannot read properties of null (reading 'broadcastMessage') Feb 18 03:05:22 volumiomini volumio[1222]: at /volumio/app/index.js:1534:32 Feb 18 03:05:22 volumiomini volumio[1222]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Feb 18 03:05:22 volumiomini volumio[1222]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Feb 18 03:05:22 volumiomini volumio[1222]: at CoreCommandRouter.broadcastMessage (/volumio/app/index.js:1532:13) Feb 18 03:05:22 volumiomini volumio[1222]: at PluginManager.pushMessage (/volumio/app/pluginmanager.js:1594:20) Feb 18 03:05:22 volumiomini volumio[1222]: at PluginManager.installPlugin (/volumio/app/pluginmanager.js:776:8) Feb 18 03:05:22 volumiomini volumio[1222]: at CoreCommandRouter.installPlugin (/volumio/app/index.js:1453:22) Feb 18 03:05:22 volumiomini volumio[1222]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1220:47) Feb 18 03:05:22 volumiomini volumio[1222]: at Socket.emit (node:events:514:28) Feb 18 03:05:22 volumiomini volumio[1222]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Feb 18 03:05:22 volumiomini volumio[1222]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Feb 18 03:05:22 volumiomini volumio[1222]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 18 03:05:22 volumiomini sudo[18510]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-18 03:04' Feb 18 03:05:22 volumiomini sudo[18510]: 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 Feb 5 14:31:57 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6759e875c98b942866984e844891d6c1"