Feb 11 09:58:00 music volumio[1271]: info: CorePlayQueue::getTrack 9 Feb 11 09:58:00 music volumio[1271]: info: CorePlayQueue::getTrack 10 Feb 11 09:58:00 music volumio[1271]: info: Prefetching next song Feb 11 09:58:00 music volumio[1271]: info: DOING PREFETCH IN MPD Feb 11 09:58:00 music volumio[1271]: verbose: ControllerMpd::sendMpdCommand add "USB/Nvme_500Go/Musiques/Nicolas Jaar/Space is Only Noise/Almost Fell.flac" Feb 11 09:58:00 music volumio[1271]: info: Feb 11 09:58:00 music volumio[1271]: ---------------------------- MPD announces system playlist update Feb 11 09:58:00 music volumio[1271]: info: Ignoring MPD Status Update Feb 11 09:58:00 music volumio[1271]: info: sendMpdCommand add "USB/Nvme_500Go/Musiques/Nicolas Jaar/Space is Only Noise/Almost Fell.flac" took 1 milliseconds Feb 11 09:58:00 music volumio[1271]: verbose: ControllerMpd::sendMpdCommand consume 1 Feb 11 09:58:00 music volumio[1271]: info: Feb 11 09:58:00 music volumio[1271]: ---------------------------- MPD announces state update: options Feb 11 09:58:00 music volumio[1271]: info: ------------------------------ 1ms Feb 11 09:58:00 music volumio[1271]: info: sendMpdCommand consume 1 took 1 milliseconds Feb 11 09:58:00 music volumio[1271]: info: ControllerMpd::getState Feb 11 09:58:00 music volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Feb 11 09:58:00 music volumio[1271]: info: sendMpdCommand status took 0 milliseconds Feb 11 09:58:00 music volumio[1271]: verbose: ControllerMpd::parseState Feb 11 09:58:00 music volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 09:58:00 music volumio[1271]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 11 09:58:00 music volumio[1271]: verbose: ControllerMpd::parseTrackInfo Feb 11 09:58:00 music volumio[1271]: info: ControllerMpd::pushState Feb 11 09:58:00 music volumio[1271]: info: CoreCommandRouter::servicePushState Feb 11 09:58:00 music volumio[1271]: info: CorePlayQueue::getTrack 9 Feb 11 09:58:00 music volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":251117,"duration":256,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2264 Kbps","isStreaming":false,"title":"Enjoy The Silence","artist":"Depeche Mode","album":"The Best Of Volume 1","uri":"USB/Nvme_500Go/Musiques/Depeche Mode/The Best Of Volume 1/B01 Enjoy The Silence.flac","trackType":"flac"} Feb 11 09:58:00 music volumio[1271]: verbose: CURRENT POSITION 9 Feb 11 09:58:00 music volumio[1271]: info: CoreStateMachine::syncState stateService play Feb 11 09:58:00 music volumio[1271]: info: CoreStateMachine::syncState currentStatus play Feb 11 09:58:00 music volumio[1271]: info: Received an update from plugin. extracting info from payload Feb 11 09:58:00 music volumio[1271]: info: CoreStateMachine::pushState Feb 11 09:58:00 music volumio[1271]: info: CorePlayQueue::getTrack 9 Feb 11 09:58:00 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 09:58:00 music volumio[1271]: info: CoreCommandRouter::volumioPushState Feb 11 09:58:00 music volumio[1271]: info: CoreStateMachine::pushState Feb 11 09:58:00 music volumio[1271]: info: CorePlayQueue::getTrack 9 Feb 11 09:58:00 music volumio[1271]: info: CoreCommandRouter::volumioPushState Feb 11 09:58:00 music volumio[1271]: info: ------------------------------ 6ms Feb 11 09:58:00 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:00 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:00 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:00 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:00 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:00 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:00 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:00 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:00 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:00 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:00 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:00 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:04 music volumio[1271]: info: Feb 11 09:58:04 music volumio[1271]: ---------------------------- MPD announces system playlist update Feb 11 09:58:04 music volumio[1271]: info: Ignoring MPD Status Update Feb 11 09:58:04 music volumio[1271]: info: Feb 11 09:58:04 music volumio[1271]: ---------------------------- MPD announces state update: player Feb 11 09:58:04 music volumio[1271]: info: ControllerMpd::getState Feb 11 09:58:04 music volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Feb 11 09:58:04 music volumio[1271]: info: ------------------------------ 1ms Feb 11 09:58:04 music volumio[1271]: info: CoreStateMachine::startPlaybackTimer Feb 11 09:58:04 music volumio[1271]: info: CorePlayQueue::getTrack 10 Feb 11 09:58:04 music volumio[1271]: info: CoreStateMachine::pushState Feb 11 09:58:04 music volumio[1271]: info: CorePlayQueue::getTrack 10 Feb 11 09:58:04 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 09:58:04 music volumio[1271]: info: CoreCommandRouter::volumioPushState Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:05 music volumio[1271]: info: sendMpdCommand status took 1044 milliseconds Feb 11 09:58:05 music volumio[1271]: verbose: ControllerMpd::parseState Feb 11 09:58:05 music volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 09:58:05 music volumio[1271]: info: Feb 11 09:58:05 music volumio[1271]: ---------------------------- MPD announces state update: player Feb 11 09:58:05 music volumio[1271]: info: ControllerMpd::getState Feb 11 09:58:05 music volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Feb 11 09:58:05 music volumio[1271]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 11 09:58:05 music volumio[1271]: verbose: ControllerMpd::parseTrackInfo Feb 11 09:58:05 music volumio[1271]: info: ControllerMpd::pushState Feb 11 09:58:05 music volumio[1271]: info: CoreCommandRouter::servicePushState Feb 11 09:58:05 music volumio[1271]: info: CorePlayQueue::getTrack 10 Feb 11 09:58:05 music volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":152,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"561 Kbps","isStreaming":false,"title":"Almost Fell","artist":"Nicolas Jaar","album":"Space Is Only Noise","uri":"USB/Nvme_500Go/Musiques/Nicolas Jaar/Space is Only Noise/Almost Fell.flac","trackType":"flac"} Feb 11 09:58:05 music volumio[1271]: verbose: CURRENT POSITION 10 Feb 11 09:58:05 music volumio[1271]: info: CoreStateMachine::syncState stateService play Feb 11 09:58:05 music volumio[1271]: info: CoreStateMachine::syncState currentStatus play Feb 11 09:58:05 music volumio[1271]: info: Received an update from plugin. extracting info from payload Feb 11 09:58:05 music volumio[1271]: info: CoreStateMachine::pushState Feb 11 09:58:05 music volumio[1271]: info: CorePlayQueue::getTrack 10 Feb 11 09:58:05 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 09:58:05 music volumio[1271]: info: CoreCommandRouter::volumioPushState Feb 11 09:58:05 music volumio[1271]: info: CoreStateMachine::pushState Feb 11 09:58:05 music volumio[1271]: info: CorePlayQueue::getTrack 10 Feb 11 09:58:05 music volumio[1271]: info: CoreCommandRouter::volumioPushState Feb 11 09:58:05 music volumio[1271]: info: ------------------------------ 1052ms Feb 11 09:58:05 music volumio[1271]: info: sendMpdCommand status took 7 milliseconds Feb 11 09:58:05 music volumio[1271]: verbose: ControllerMpd::parseState Feb 11 09:58:05 music volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:05 music volumio[1271]: info: sendMpdCommand playlistinfo took 8 milliseconds Feb 11 09:58:05 music volumio[1271]: verbose: ControllerMpd::parseTrackInfo Feb 11 09:58:05 music volumio[1271]: info: ControllerMpd::pushState Feb 11 09:58:05 music volumio[1271]: info: CoreCommandRouter::servicePushState Feb 11 09:58:05 music volumio[1271]: info: CorePlayQueue::getTrack 10 Feb 11 09:58:05 music volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":844,"duration":152,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"611 Kbps","isStreaming":false,"title":"Almost Fell","artist":"Nicolas Jaar","album":"Space Is Only Noise","uri":"USB/Nvme_500Go/Musiques/Nicolas Jaar/Space is Only Noise/Almost Fell.flac","trackType":"flac"} Feb 11 09:58:05 music volumio[1271]: verbose: CURRENT POSITION 10 Feb 11 09:58:05 music volumio[1271]: info: CoreStateMachine::syncState stateService play Feb 11 09:58:05 music volumio[1271]: info: CoreStateMachine::syncState currentStatus play Feb 11 09:58:05 music volumio[1271]: info: Received an update from plugin. extracting info from payload Feb 11 09:58:05 music volumio[1271]: info: CoreStateMachine::pushState Feb 11 09:58:05 music volumio[1271]: info: CorePlayQueue::getTrack 10 Feb 11 09:58:05 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 09:58:05 music volumio[1271]: info: CoreCommandRouter::volumioPushState Feb 11 09:58:05 music volumio[1271]: info: CoreStateMachine::pushState Feb 11 09:58:05 music volumio[1271]: info: CorePlayQueue::getTrack 10 Feb 11 09:58:05 music volumio[1271]: info: CoreCommandRouter::volumioPushState Feb 11 09:58:05 music volumio[1271]: info: ------------------------------ 26ms Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:05 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:07 music volumio5-onboarding[1929]: time=2026-02-11T09:58:07.822+01:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.1.75:64131 Feb 11 09:58:08 music volumio[1271]: verbose: New Socket.io Connection to 192.168.1.87 from 192.168.1.75 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 8 Feb 11 09:58:08 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 11 09:58:08 music volumio[1271]: info: CoreCommandRouter::volumioGetVisibleSources Feb 11 09:58:08 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 11 09:58:08 music volumio[1271]: info: CoreCommandRouter::volumioGetState Feb 11 09:58:08 music volumio[1271]: info: CorePlayQueue::getTrack 10 Feb 11 09:58:08 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 11 09:58:08 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 11 09:58:08 music volumio[1271]: info: Received Get System Info Feb 11 09:58:08 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 11 09:58:08 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 11 09:58:08 music volumio[1271]: info: Discovery: Getting this device information Feb 11 09:58:08 music volumio[1271]: info: CoreCommandRouter::volumioGetState Feb 11 09:58:08 music volumio[1271]: info: CorePlayQueue::getTrack 10 Feb 11 09:58:08 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 11 09:58:08 music volumio[1271]: info: CoreCommandRouter::volumioGetState Feb 11 09:58:08 music volumio[1271]: info: CorePlayQueue::getTrack 10 Feb 11 09:58:08 music volumio[1271]: info: Listing playlists Feb 11 09:58:08 music volumio[1271]: info: CoreCommandRouter::volumioGetQueue Feb 11 09:58:08 music volumio[1271]: info: CoreStateMachine::getQueue Feb 11 09:58:08 music volumio[1271]: info: CorePlayQueue::getQueue Feb 11 09:58:09 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 11 09:58:13 music volumio5-onboarding[1929]: time=2026-02-11T09:58:13.312+01:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.1.75:64131 Feb 11 09:58:13 music volumio5-onboarding[1929]: time=2026-02-11T09:58:13.312+01:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.1.75:64131 Feb 11 09:58:13 music volumio5-onboarding[1929]: time=2026-02-11T09:58:13.320+01:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.1.75:64134 Feb 11 09:58:19 music volumio[1271]: info: CoreCommandRouter::volumioPlay Feb 11 09:58:19 music volumio[1271]: info: CoreStateMachine::play index 8 Feb 11 09:58:19 music volumio[1271]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 09:58:19 music volumio[1271]: info: CoreStateMachine::stop Feb 11 09:58:19 music volumio[1271]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 09:58:19 music volumio[1271]: info: CoreStateMachine::stPlaybackTimer Feb 11 09:58:19 music volumio[1271]: info: CoreStateMachine::updateTrackBlock Feb 11 09:58:19 music volumio[1271]: info: CorePlayQueue::getTrackBlock Feb 11 09:58:19 music volumio[1271]: info: CoreStateMachine::pushState Feb 11 09:58:19 music volumio[1271]: info: CorePlayQueue::getTrack 10 Feb 11 09:58:19 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 09:58:19 music volumio[1271]: info: CoreCommandRouter::volumioPushState Feb 11 09:58:19 music volumio[1271]: info: CoreStateMachine::serviceStop Feb 11 09:58:19 music volumio[1271]: info: CorePlayQueue::getTrack 10 Feb 11 09:58:19 music volumio[1271]: info: CoreCommandRouter::serviceStop Feb 11 09:58:19 music volumio[1271]: info: ControllerMpd::stop Feb 11 09:58:19 music volumio[1271]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 09:58:19 music volumio5-onboarding[1929]: time=2026-02-11T09:58:19.105+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.75:64134 @ 0xc000300990" state=STATUS_STOPPED positionMs=0 volume=69 Feb 11 09:58:19 music volumio5-onboarding[1929]: time=2026-02-11T09:58:19.105+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.75:64134 @ 0xc000300990" id="mnt/USB/Nvme_500Go/Musiques/Nicolas Jaar/Space is Only Noise/Almost Fell.flac" title="Almost Fell" Feb 11 09:58:19 music volumio[1271]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:19 music volumio[1271]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:19 music volumio[1271]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:19 music volumio[1271]: info: Feb 11 09:58:19 music volumio[1271]: ---------------------------- MPD announces state update: player Feb 11 09:58:19 music volumio[1271]: info: sendMpdCommand stop took 20 milliseconds Feb 11 09:58:19 music volumio[1271]: info: ControllerMpd::getState Feb 11 09:58:19 music volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Feb 11 09:58:19 music volumio[1271]: info: CoreStateMachine::play index undefined Feb 11 09:58:19 music volumio[1271]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 09:58:19 music volumio[1271]: info: CorePlayQueue::getTrack 8 Feb 11 09:58:19 music volumio[1271]: info: CoreStateMachine::startPlaybackTimer Feb 11 09:58:19 music volumio[1271]: info: CorePlayQueue::getTrack 8 Feb 11 09:58:19 music volumio[1271]: verbose: ControllerMpd::clearAddPlayTracks USB/Nvme_500Go/Musiques/Indochine/01 - L'amour fou.flac Feb 11 09:58:19 music volumio[1271]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 09:58:19 music volumio[1271]: info: sendMpdCommand status took 3 milliseconds Feb 11 09:58:19 music volumio[1271]: info: sendMpdCommand stop took 2 milliseconds Feb 11 09:58:19 music volumio[1271]: verbose: ControllerMpd::parseState Feb 11 09:58:19 music volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 09:58:19 music volumio[1271]: verbose: ControllerMpd::sendMpdCommand clear Feb 11 09:58:19 music volumio[1271]: info: Feb 11 09:58:19 music volumio[1271]: ---------------------------- MPD announces system playlist update Feb 11 09:58:19 music volumio[1271]: info: Ignoring MPD Status Update Feb 11 09:58:19 music volumio[1271]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 11 09:58:19 music volumio[1271]: info: sendMpdCommand clear took 0 milliseconds Feb 11 09:58:19 music volumio[1271]: verbose: ControllerMpd::parseTrackInfo Feb 11 09:58:19 music volumio[1271]: verbose: ControllerMpd::sendMpdCommand add "USB/Nvme_500Go/Musiques/Indochine/01 - L'amour fou.flac" Feb 11 09:58:19 music volumio[1271]: info: ControllerMpd::pushState Feb 11 09:58:19 music volumio[1271]: info: CoreCommandRouter::servicePushState Feb 11 09:58:19 music volumio[1271]: info: CoreStateMachine::pushState Feb 11 09:58:19 music volumio[1271]: info: CorePlayQueue::getTrack 8 Feb 11 09:58:19 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 09:58:19 music volumio[1271]: info: CoreCommandRouter::volumioPushState Feb 11 09:58:19 music volumio[1271]: info: CorePlayQueue::getTrack 8 Feb 11 09:58:19 music volumio[1271]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Almost Fell","artist":"Nicolas Jaar","album":"Space Is Only Noise","uri":"USB/Nvme_500Go/Musiques/Nicolas Jaar/Space is Only Noise/Almost Fell.flac","trackType":"flac"} Feb 11 09:58:19 music volumio[1271]: verbose: CURRENT POSITION 8 Feb 11 09:58:19 music volumio[1271]: info: CoreStateMachine::syncState stateService stop Feb 11 09:58:19 music volumio[1271]: info: CoreStateMachine::syncState currentStatus stop Feb 11 09:58:19 music volumio[1271]: info: CoreStateMachine::pushState Feb 11 09:58:19 music volumio[1271]: info: CorePlayQueue::getTrack 8 Feb 11 09:58:19 music volumio[1271]: info: CoreCommandRouter::volumioPushState Feb 11 09:58:19 music volumio[1271]: info: No code Feb 11 09:58:19 music volumio[1271]: info: CoreStateMachine::pushState Feb 11 09:58:19 music volumio[1271]: info: CorePlayQueue::getTrack 8 Feb 11 09:58:19 music volumio[1271]: info: CoreCommandRouter::volumioPushState Feb 11 09:58:19 music volumio5-onboarding[1929]: time=2026-02-11T09:58:19.135+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.75:64134 @ 0xc000300990" state=STATUS_STOPPED positionMs=0 volume=69 Feb 11 09:58:19 music volumio5-onboarding[1929]: time=2026-02-11T09:58:19.135+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.75:64134 @ 0xc000300990" state=STATUS_STOPPED positionMs=0 volume=69 Feb 11 09:58:19 music volumio5-onboarding[1929]: time=2026-02-11T09:58:19.136+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.75:64134 @ 0xc000300990" state=STATUS_STOPPED positionMs=0 volume=69 Feb 11 09:58:19 music volumio5-onboarding[1929]: time=2026-02-11T09:58:19.136+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.75:64134 @ 0xc000300990" id="mnt/USB/Nvme_500Go/Musiques/Indochine/01 - L'amour fou.flac" title="L'amour fou" Feb 11 09:58:19 music volumio[1271]: info: ------------------------------ 12ms Feb 11 09:58:19 music volumio[1271]: error: updateQueue error: null Feb 11 09:58:19 music volumio[1271]: info: Feb 11 09:58:19 music volumio[1271]: ---------------------------- MPD announces system playlist update Feb 11 09:58:19 music volumio[1271]: info: Ignoring MPD Status Update Feb 11 09:58:19 music volumio[1271]: info: ------------------------------ 10ms Feb 11 09:58:19 music volumio[1271]: info: sendMpdCommand add "USB/Nvme_500Go/Musiques/Indochine/01 - L'amour fou.flac" took 9 milliseconds Feb 11 09:58:19 music volumio[1271]: verbose: ControllerMpd::sendMpdCommand play Feb 11 09:58:19 music volumio5-onboarding[1929]: time=2026-02-11T09:58:19.138+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.75:64134 @ 0xc000300990" id="mnt/USB/Nvme_500Go/Musiques/Indochine/01 - L'amour fou.flac" title="L'amour fou" Feb 11 09:58:19 music volumio5-onboarding[1929]: time=2026-02-11T09:58:19.138+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.75:64134 @ 0xc000300990" id="mnt/USB/Nvme_500Go/Musiques/Indochine/01 - L'amour fou.flac" title="L'amour fou" Feb 11 09:58:19 music volumio[1271]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:19 music volumio[1271]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:19 music volumio[1271]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:19 music volumio[1271]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:19 music volumio[1271]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:19 music volumio[1271]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:19 music volumio[1271]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:19 music volumio[1271]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:19 music volumio[1271]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:19 music volumio[1271]: info: ------------------------------ 7ms Feb 11 09:58:19 music volumio[1271]: info: sendMpdCommand play took 6 milliseconds Feb 11 09:58:19 music volumio[1271]: info: Feb 11 09:58:19 music volumio[1271]: ---------------------------- MPD announces state update: player Feb 11 09:58:19 music volumio[1271]: info: ControllerMpd::getState Feb 11 09:58:19 music volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Feb 11 09:58:19 music volumio[1271]: info: Feb 11 09:58:19 music volumio[1271]: ---------------------------- MPD announces state update: player Feb 11 09:58:19 music volumio[1271]: info: ControllerMpd::getState Feb 11 09:58:19 music volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Feb 11 09:58:19 music volumio[1271]: info: sendMpdCommand status took 2 milliseconds Feb 11 09:58:19 music volumio[1271]: verbose: ControllerMpd::parseState Feb 11 09:58:19 music volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 09:58:19 music volumio[1271]: info: sendMpdCommand status took 1 milliseconds Feb 11 09:58:19 music volumio[1271]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 11 09:58:19 music volumio[1271]: verbose: ControllerMpd::parseState Feb 11 09:58:19 music volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 09:58:19 music volumio[1271]: verbose: ControllerMpd::parseTrackInfo Feb 11 09:58:19 music volumio[1271]: info: ControllerMpd::pushState Feb 11 09:58:19 music volumio[1271]: info: CoreCommandRouter::servicePushState Feb 11 09:58:19 music volumio[1271]: info: CorePlayQueue::getTrack 8 Feb 11 09:58:19 music volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":287,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"L'amour fou","artist":"Indochine","album":"L'amour fou","uri":"USB/Nvme_500Go/Musiques/Indochine/01 - L'amour fou.flac","trackType":"flac"} Feb 11 09:58:19 music volumio[1271]: verbose: CURRENT POSITION 8 Feb 11 09:58:19 music volumio[1271]: info: CoreStateMachine::syncState stateService play Feb 11 09:58:19 music volumio[1271]: info: CoreStateMachine::syncState currentStatus stop Feb 11 09:58:19 music volumio[1271]: info: ------------------------------ 15ms Feb 11 09:58:19 music volumio[1271]: info: sendMpdCommand playlistinfo took 13 milliseconds Feb 11 09:58:19 music volumio[1271]: verbose: ControllerMpd::parseTrackInfo Feb 11 09:58:19 music volumio[1271]: info: ControllerMpd::pushState Feb 11 09:58:19 music volumio[1271]: info: CoreCommandRouter::servicePushState Feb 11 09:58:19 music volumio[1271]: info: CorePlayQueue::getTrack 8 Feb 11 09:58:19 music volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":287,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"L'amour fou","artist":"Indochine","album":"L'amour fou","uri":"USB/Nvme_500Go/Musiques/Indochine/01 - L'amour fou.flac","trackType":"flac"} Feb 11 09:58:19 music volumio[1271]: verbose: CURRENT POSITION 8 Feb 11 09:58:19 music volumio[1271]: info: CoreStateMachine::syncState stateService play Feb 11 09:58:19 music volumio[1271]: info: CoreStateMachine::syncState currentStatus play Feb 11 09:58:19 music volumio[1271]: info: Received an update from plugin. extracting info from payload Feb 11 09:58:19 music volumio[1271]: info: CoreStateMachine::pushState Feb 11 09:58:19 music volumio[1271]: info: CorePlayQueue::getTrack 8 Feb 11 09:58:19 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 09:58:19 music volumio[1271]: info: CoreCommandRouter::volumioPushState Feb 11 09:58:19 music volumio[1271]: info: CoreStateMachine::pushState Feb 11 09:58:19 music volumio[1271]: info: CorePlayQueue::getTrack 8 Feb 11 09:58:19 music volumio[1271]: info: CoreCommandRouter::volumioPushState Feb 11 09:58:19 music volumio5-onboarding[1929]: time=2026-02-11T09:58:19.212+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.75:64134 @ 0xc000300990" state=STATUS_PLAYING positionMs=0 volume=69 Feb 11 09:58:19 music volumio[1271]: info: ------------------------------ 41ms Feb 11 09:58:19 music volumio5-onboarding[1929]: time=2026-02-11T09:58:19.212+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.75:64134 @ 0xc000300990" state=STATUS_PLAYING positionMs=0 volume=69 Feb 11 09:58:19 music volumio5-onboarding[1929]: time=2026-02-11T09:58:19.215+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.75:64134 @ 0xc000300990" id="mnt/USB/Nvme_500Go/Musiques/Indochine/01 - L'amour fou.flac" title="L'amour fou" Feb 11 09:58:19 music volumio5-onboarding[1929]: time=2026-02-11T09:58:19.215+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.75:64134 @ 0xc000300990" id="mnt/USB/Nvme_500Go/Musiques/Indochine/01 - L'amour fou.flac" title="L'amour fou" Feb 11 09:58:22 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:22 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:22 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:22 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:22 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:22 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:22 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:22 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:22 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:22 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:22 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:22 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:22 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:23 music volumio[1271]: Upnp client error: Error: This socket has been ended by the other party Feb 11 09:58:31 music volumio[1271]: Upnp client error: Error: This socket has been ended by the other party Feb 11 09:58:33 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 11 09:58:33 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 11 09:58:41 music volumio[1271]: info: Enabling plugin ferrum_streaming_control_technology Feb 11 09:58:41 music volumio[1271]: info: Loading plugin "ferrum_streaming_control_technology"... Feb 11 09:58:59 music volumio[1271]: error: !!!! WARNING !!!! Feb 11 09:58:59 music volumio[1271]: 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 11 09:58:59 music volumio[1271]: Require stack: Feb 11 09:58:59 music volumio[1271]: - /data/plugins/user_interface/ferrum_streaming_control_technology/node_modules/@hemspzoo/fsct-lib/index.js Feb 11 09:58:59 music volumio[1271]: - /data/plugins/user_interface/ferrum_streaming_control_technology/index.js Feb 11 09:58:59 music volumio[1271]: - /volumio/app/pluginmanager.js Feb 11 09:58:59 music volumio[1271]: - /volumio/app/index.js Feb 11 09:58:59 music volumio[1271]: - /volumio/index.js Feb 11 09:58:59 music volumio[1271]: error: Stack trace: Error: Cannot find module '@hemspzoo/fsct-lib-linux-x64-gnu' Feb 11 09:58:59 music volumio[1271]: Require stack: Feb 11 09:58:59 music volumio[1271]: - /data/plugins/user_interface/ferrum_streaming_control_technology/node_modules/@hemspzoo/fsct-lib/index.js Feb 11 09:58:59 music volumio[1271]: - /data/plugins/user_interface/ferrum_streaming_control_technology/index.js Feb 11 09:58:59 music volumio[1271]: - /volumio/app/pluginmanager.js Feb 11 09:58:59 music volumio[1271]: - /volumio/app/index.js Feb 11 09:58:59 music volumio[1271]: - /volumio/index.js Feb 11 09:58:59 music volumio[1271]: at Module._resolveFilename (node:internal/modules/cjs/loader:1048:15) Feb 11 09:58:59 music volumio[1271]: at Module._load (node:internal/modules/cjs/loader:901:27) Feb 11 09:58:59 music volumio[1271]: at Module.require (node:internal/modules/cjs/loader:1115:19) Feb 11 09:58:59 music volumio[1271]: at require (node:internal/modules/helpers:130:18) Feb 11 09:58:59 music volumio[1271]: at Object. (/data/plugins/user_interface/ferrum_streaming_control_technology/node_modules/@hemspzoo/fsct-lib/index.js:190:31) Feb 11 09:58:59 music volumio[1271]: at Module._compile (node:internal/modules/cjs/loader:1233:14) Feb 11 09:58:59 music volumio[1271]: at Module._extensions..js (node:internal/modules/cjs/loader:1287:10) Feb 11 09:58:59 music volumio[1271]: at Module.load (node:internal/modules/cjs/loader:1091:32) Feb 11 09:58:59 music volumio[1271]: at Module._load (node:internal/modules/cjs/loader:938:12) Feb 11 09:58:59 music volumio[1271]: at Module.require (node:internal/modules/cjs/loader:1115:19) Feb 11 09:58:59 music volumio[1271]: at require (node:internal/modules/helpers:130:18) Feb 11 09:58:59 music volumio[1271]: at Object. (/data/plugins/user_interface/ferrum_streaming_control_technology/index.js:25:118) Feb 11 09:58:59 music volumio[1271]: at Module._compile (node:internal/modules/cjs/loader:1233:14) Feb 11 09:58:59 music volumio[1271]: at Module._extensions..js (node:internal/modules/cjs/loader:1287:10) Feb 11 09:58:59 music volumio[1271]: at Module.load (node:internal/modules/cjs/loader:1091:32) Feb 11 09:58:59 music volumio[1271]: at Module._load (node:internal/modules/cjs/loader:938:12) Feb 11 09:58:59 music volumio[1271]: error: !!!! WARNING !!!! Feb 11 09:58:59 music volumio[1271]: info: Done. Feb 11 09:58:59 music volumio[1271]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 11 09:58:59 music volumio[1271]: info: VolumeController::SetAlsaVolume59 Feb 11 09:58:59 music volumio[1271]: info: VolumeController::SetAlsaVolume50 Feb 11 09:58:59 music volumio[1271]: info: VolumeController::SetAlsaVolume32 Feb 11 09:58:59 music volumio[1271]: info: CoreStateMachine::pushState Feb 11 09:58:59 music volumio[1271]: info: CorePlayQueue::getTrack 8 Feb 11 09:58:59 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 09:58:59 music volumio[1271]: info: CoreCommandRouter::volumioPushState Feb 11 09:58:59 music volumio[1271]: info: CoreStateMachine::pushState Feb 11 09:58:59 music volumio[1271]: info: CorePlayQueue::getTrack 8 Feb 11 09:58:59 music volumio[1271]: info: CoreCommandRouter::volumioPushState Feb 11 09:58:59 music volumio[1271]: info: CoreStateMachine::pushState Feb 11 09:58:59 music volumio[1271]: info: CorePlayQueue::getTrack 8 Feb 11 09:58:59 music volumio[1271]: info: CoreCommandRouter::volumioPushState Feb 11 09:58:59 music volumio5-onboarding[1929]: time=2026-02-11T09:58:59.879+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.75:64134 @ 0xc000300990" state=STATUS_PLAYING positionMs=40006 volume=32 Feb 11 09:58:59 music volumio5-onboarding[1929]: time=2026-02-11T09:58:59.880+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.75:64134 @ 0xc000300990" id="mnt/USB/Nvme_500Go/Musiques/Indochine/01 - L'amour fou.flac" title="L'amour fou" Feb 11 09:58:59 music volumio5-onboarding[1929]: time=2026-02-11T09:58:59.880+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.75:64134 @ 0xc000300990" state=STATUS_PLAYING positionMs=40006 volume=32 Feb 11 09:58:59 music volumio5-onboarding[1929]: time=2026-02-11T09:58:59.881+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.75:64134 @ 0xc000300990" id="mnt/USB/Nvme_500Go/Musiques/Indochine/01 - L'amour fou.flac" title="L'amour fou" Feb 11 09:58:59 music volumio5-onboarding[1929]: time=2026-02-11T09:58:59.881+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.75:64134 @ 0xc000300990" state=STATUS_PLAYING positionMs=40006 volume=32 Feb 11 09:58:59 music volumio5-onboarding[1929]: time=2026-02-11T09:58:59.881+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.75:64134 @ 0xc000300990" id="mnt/USB/Nvme_500Go/Musiques/Indochine/01 - L'amour fou.flac" title="L'amour fou" Feb 11 09:58:59 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:59 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:59 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:59 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:59 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:59 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:59 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:59 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:59 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:59 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:59 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:59 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:59 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:59 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:59 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:59 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:59 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:58:59 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:58:59 music volumio[1271]: Upnp client error: Error: This socket has been ended by the other party Feb 11 09:59:01 music volumio[1271]: info: VolumeController::SetAlsaVolume48 Feb 11 09:59:01 music volumio[1271]: info: CoreStateMachine::pushState Feb 11 09:59:01 music volumio[1271]: info: CorePlayQueue::getTrack 8 Feb 11 09:59:01 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 09:59:01 music volumio[1271]: info: CoreCommandRouter::volumioPushState Feb 11 09:59:01 music volumio5-onboarding[1929]: time=2026-02-11T09:59:01.189+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.75:64134 @ 0xc000300990" state=STATUS_PLAYING positionMs=42020 volume=48 Feb 11 09:59:01 music volumio5-onboarding[1929]: time=2026-02-11T09:59:01.189+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.75:64134 @ 0xc000300990" id="mnt/USB/Nvme_500Go/Musiques/Indochine/01 - L'amour fou.flac" title="L'amour fou" Feb 11 09:59:01 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:59:01 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:59:01 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:59:01 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:59:01 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:59:01 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:59:06 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 11 09:59:06 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 11 09:59:10 music volumio[1271]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 11 09:59:29 music kernel: usb usb3-port4: disabled by hub (EMI?), re-enabling... Feb 11 09:59:29 music kernel: usb 3-4: USB disconnect, device number 7 Feb 11 09:59:29 music volumio[1271]: info: Feb 11 09:59:29 music volumio[1271]: ---------------------------- MPD announces state update: player Feb 11 09:59:29 music volumio[1271]: info: ControllerMpd::getState Feb 11 09:59:29 music volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Feb 11 09:59:29 music volumio[1271]: error: MPD returned error for command status: Failed to open audio output Feb 11 09:59:29 music volumio[1271]: error: ControllerMpd::pushError: TypeError: Cannot read properties of null (reading 'broadcastToastMessage') Feb 11 09:59:29 music volumio[1271]: info: ------------------------------ 8ms Feb 11 09:59:29 music volumio[1271]: info: Feb 11 09:59:29 music volumio[1271]: ---------------------------- USB Audio Device Detached Feb 11 09:59:29 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Feb 11 09:59:29 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 11 09:59:29 music volumio[1271]: error: API:pushError: TypeError: Cannot read properties of null (reading 'broadcastMessage') Feb 11 09:59:29 music kernel: usb 4-4: new full-speed USB device number 8 using ohci-pci Feb 11 09:59:29 music kernel: usb 4-4: New USB device found, idVendor=1a86, idProduct=7523, bcdDevice= 2.64 Feb 11 09:59:29 music kernel: usb 4-4: New USB device strings: Mfr=0, Product=2, SerialNumber=0 Feb 11 09:59:29 music kernel: usb 4-4: Product: USB Serial Feb 11 09:59:29 music kernel: ch341 4-4:1.0: ch341-uart converter detected Feb 11 09:59:29 music kernel: usb 4-4: ch341-uart converter now attached to ttyUSB0 Feb 11 09:59:34 music kernel: usb 4-4: USB disconnect, device number 8 Feb 11 09:59:34 music kernel: ch341-uart ttyUSB0: ch341-uart converter now disconnected from ttyUSB0 Feb 11 09:59:34 music kernel: ch341 4-4:1.0: device disconnected Feb 11 09:59:34 music kernel: usb 3-4: new high-speed USB device number 9 using ehci-pci Feb 11 09:59:34 music kernel: usb 3-4: New USB device found, idVendor=152a, idProduct=880c, bcdDevice= 3.16 Feb 11 09:59:34 music kernel: usb 3-4: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Feb 11 09:59:34 music kernel: usb 3-4: Product: LOXJIE AUDIO Feb 11 09:59:34 music kernel: usb 3-4: Manufacturer: LOXJIE Feb 11 09:59:35 music kernel: hid-generic 0003:152A:880C.0007: hiddev1,hidraw1: USB HID v1.10 Device [LOXJIE LOXJIE AUDIO] on usb-0000:00:06.1-4/input3 Feb 11 09:59:35 music volumio[1271]: info: Feb 11 09:59:35 music volumio[1271]: ---------------------------- USB Audio Device Attached Feb 11 09:59:35 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Feb 11 09:59:35 music volumio[1271]: error: API:pushError: TypeError: Cannot read properties of null (reading 'printToastMessage') Feb 11 09:59:39 music kernel: usb 3-4: USB disconnect, device number 9 Feb 11 09:59:39 music volumio[1271]: info: Feb 11 09:59:39 music volumio[1271]: ---------------------------- USB Audio Device Detached Feb 11 09:59:39 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Feb 11 09:59:39 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 11 09:59:39 music volumio[1271]: error: API:pushError: TypeError: Cannot read properties of null (reading 'broadcastMessage') Feb 11 09:59:39 music kernel: usb 3-4: new high-speed USB device number 10 using ehci-pci Feb 11 09:59:40 music kernel: usb 3-4: New USB device found, idVendor=152a, idProduct=880c, bcdDevice= 3.16 Feb 11 09:59:40 music kernel: usb 3-4: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Feb 11 09:59:40 music kernel: usb 3-4: Product: LOXJIE AUDIO Feb 11 09:59:40 music kernel: usb 3-4: Manufacturer: LOXJIE Feb 11 09:59:40 music kernel: usb 3-4: 1:1: cannot set freq 768000 (v2/v3): err -71 Feb 11 09:59:40 music kernel: usb 3-4: parse_audio_format_rates_v2v3(): unable to retrieve number of sample rates (clock 41) Feb 11 09:59:40 music kernel: usb 3-4: parse_audio_format_rates_v2v3(): unable to retrieve number of sample rates (clock 41) Feb 11 09:59:40 music kernel: usbhid 3-4:1.3: can't add hid device: -71 Feb 11 09:59:40 music kernel: usbhid 3-4:1.3: probe with driver usbhid failed with error -71 Feb 11 09:59:40 music kernel: usb 3-4: USB disconnect, device number 10 Feb 11 09:59:40 music (udev-worker)[19874]: controlC5: /usr/lib/udev/rules.d/78-sound-card.rules:5 Failed to write ATTR{/sys/devices/pci0000:00/0000:00:06.1/usb3/3-4/3-4:1.0/sound/card5/controlC5/../uevent}, ignoring: No such file or directory Feb 11 09:59:40 music volumio[1271]: info: Feb 11 09:59:40 music volumio[1271]: ---------------------------- USB Audio Device Attached Feb 11 09:59:40 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Feb 11 09:59:40 music volumio[1271]: error: API:pushError: TypeError: Cannot read properties of null (reading 'name') Feb 11 09:59:40 music volumio[1271]: info: Feb 11 09:59:40 music volumio[1271]: ---------------------------- USB Audio Device Detached Feb 11 09:59:40 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Feb 11 09:59:40 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 11 09:59:41 music volumio[1271]: error: API:pushError: TypeError: Cannot read properties of null (reading 'broadcastMessage') Feb 11 09:59:41 music kernel: usb 3-4: new high-speed USB device number 11 using ehci-pci Feb 11 09:59:41 music kernel: usb 3-4: New USB device found, idVendor=152a, idProduct=880c, bcdDevice= 3.16 Feb 11 09:59:41 music kernel: usb 3-4: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Feb 11 09:59:41 music kernel: usb 3-4: Product: LOXJIE AUDIO Feb 11 09:59:41 music kernel: usb 3-4: Manufacturer: LOXJIE Feb 11 09:59:41 music kernel: hid-generic 0003:152A:880C.0008: hiddev1,hidraw1: USB HID v1.10 Device [LOXJIE LOXJIE AUDIO] on usb-0000:00:06.1-4/input3 Feb 11 09:59:41 music volumio[1271]: info: Feb 11 09:59:41 music volumio[1271]: ---------------------------- USB Audio Device Attached Feb 11 09:59:41 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Feb 11 09:59:41 music volumio[1271]: error: API:pushError: TypeError: Cannot read properties of null (reading 'printToastMessage') Feb 11 09:59:45 music volumio[1271]: info: CoreCommandRouter::volumioPrevious Feb 11 09:59:45 music volumio[1271]: info: CoreStateMachine::previous Feb 11 09:59:45 music volumio[1271]: info: CorePlayQueue::getTrack 8 Feb 11 09:59:45 music volumio[1271]: info: ControllerMpd::seek Feb 11 09:59:45 music volumio[1271]: error: null Feb 11 09:59:45 music volumio[1271]: info: Feb 11 09:59:45 music volumio[1271]: ---------------------------- MPD announces state update: player Feb 11 09:59:45 music volumio[1271]: info: ControllerMpd::getState Feb 11 09:59:45 music volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Feb 11 09:59:45 music volumio[1271]: info: sendMpdCommand status took 1 milliseconds Feb 11 09:59:45 music volumio[1271]: verbose: ControllerMpd::parseState Feb 11 09:59:45 music volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 09:59:45 music volumio[1271]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 11 09:59:45 music volumio[1271]: verbose: ControllerMpd::parseTrackInfo Feb 11 09:59:45 music volumio[1271]: info: ControllerMpd::pushState Feb 11 09:59:45 music volumio[1271]: info: CoreCommandRouter::servicePushState Feb 11 09:59:45 music volumio[1271]: info: CorePlayQueue::getTrack 8 Feb 11 09:59:45 music volumio[1271]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":287,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1125 Kbps","isStreaming":false,"title":"L'amour fou","artist":"Indochine","album":"L'amour fou","uri":"USB/Nvme_500Go/Musiques/Indochine/01 - L'amour fou.flac","trackType":"flac"} Feb 11 09:59:45 music volumio[1271]: verbose: CURRENT POSITION 8 Feb 11 09:59:45 music volumio[1271]: info: CoreStateMachine::syncState stateService pause Feb 11 09:59:45 music volumio[1271]: info: CoreStateMachine::syncState currentStatus play Feb 11 09:59:45 music volumio[1271]: info: CoreStateMachine::pushState Feb 11 09:59:45 music volumio[1271]: info: CorePlayQueue::getTrack 8 Feb 11 09:59:45 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 09:59:45 music volumio[1271]: info: CoreCommandRouter::volumioPushState Feb 11 09:59:45 music volumio[1271]: error: ControllerMpd::pushError: TypeError: Cannot read properties of null (reading 'pushState') Feb 11 09:59:45 music volumio5-onboarding[1929]: time=2026-02-11T09:59:45.654+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.75:64134 @ 0xc000300990" state=STATUS_PLAYING positionMs=0 volume=48 Feb 11 09:59:45 music volumio[1271]: info: ------------------------------ 9ms Feb 11 09:59:45 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:59:45 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:59:45 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:59:45 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:59:45 music volumio[1271]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=false screensavertype=dpms Feb 11 09:59:45 music volumio[1271]: info: Display-configuration --- → No action taken Feb 11 09:59:45 music volumio5-onboarding[1929]: time=2026-02-11T09:59:45.655+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.75:64134 @ 0xc000300990" id="mnt/USB/Nvme_500Go/Musiques/Indochine/01 - L'amour fou.flac" title="L'amour fou" Feb 11 09:59:55 music volumio[1271]: info: CoreCommandRouter::volumioNext Feb 11 09:59:55 music volumio[1271]: info: CoreStateMachine::next Feb 11 09:59:55 music volumio[1271]: info: CoreStateMachine::stop Feb 11 09:59:55 music volumio[1271]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 09:59:55 music volumio[1271]: info: CoreStateMachine::stPlaybackTimer Feb 11 09:59:55 music volumio[1271]: info: CoreStateMachine::updateTrackBlock Feb 11 09:59:55 music volumio[1271]: info: CorePlayQueue::getTrackBlock Feb 11 09:59:55 music volumio[1271]: info: CoreStateMachine::pushState Feb 11 09:59:55 music volumio[1271]: info: CorePlayQueue::getTrack 8 Feb 11 09:59:55 music volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 09:59:55 music volumio[1271]: info: CoreCommandRouter::volumioPushState Feb 11 09:59:55 music volumio[1271]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 11 09:59:55 music volumio[1271]: TypeError: Cannot read properties of null (reading 'pushState') Feb 11 09:59:55 music volumio[1271]: at /volumio/app/index.js:326:32 Feb 11 09:59:55 music volumio[1271]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Feb 11 09:59:55 music volumio[1271]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Feb 11 09:59:55 music volumio[1271]: at CoreCommandRouter.volumioPushState (/volumio/app/index.js:324:13) Feb 11 09:59:55 music volumio[1271]: at CoreStateMachine.pushState (/volumio/app/statemachine.js:534:22) Feb 11 09:59:55 music volumio[1271]: at CoreStateMachine.stop (/volumio/app/statemachine.js:1247:12) Feb 11 09:59:55 music volumio[1271]: at CoreStateMachine.next (/volumio/app/statemachine.js:1180:12) Feb 11 09:59:55 music volumio[1271]: at CoreCommandRouter.volumioNext (/volumio/app/index.js:103:28) Feb 11 09:59:55 music volumio[1271]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:274:26) Feb 11 09:59:55 music volumio[1271]: at Socket.emit (node:events:514:28) Feb 11 09:59:55 music volumio[1271]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Feb 11 09:59:55 music volumio[1271]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Feb 11 09:59:55 music volumio[1271]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 11 09:59:56 music sudo[19990]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-11 09:58' Feb 11 09:59:56 music sudo[19990]: 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"