Oct 13 20:34:01 volumio volumio[1357]: info: Received Get System Info
Oct 13 20:34:01 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 13 20:34:01 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 13 20:34:01 volumio volumio[1357]: info: Discovery: Getting this device information
Oct 13 20:34:01 volumio volumio[1357]: info: CoreCommandRouter::volumioGetState
Oct 13 20:34:01 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:34:01 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 13 20:34:01 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Oct 13 20:34:01 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Oct 13 20:34:02 volumio volumio5-onboarding[1972]: time=2026-10-13T20:34:02.936Z level=INFO msg="service successfully established" component=discovery/localnet
Oct 13 20:34:07 volumio volumio[1357]: info: CALLMETHOD: user_interface stylish_player configSavePlayerConfig [object Object]
Oct 13 20:34:07 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: stylish_player , configSavePlayerConfig
Oct 13 20:34:07 volumio volumio[1357]: info: Stylish Player: Broadcasted config update: {"playerType":"reelToReel","theme":"win95","showPlayerControls":true,"hideSeekHandle":false,"hideTrackTimes":false,"showRemainingTime":false,"albumArtMaxSpace":false,"albumArtAnimated":true,"showTrackPanel":false,"useCustomLayout":false,"vizType":"spectrum","spectrumOptions":"","peppyMeterFolder":"","peppyMeterModel":"random","peppySpectrumFolder":"","peppySpectrumModel":"random","backgroundColor":"","trackColor":"","artistColor":"","albumColor":"","streamInfoColor":"","buttonColor":"","buttonBgColor":"","barTrackColor":"","barTextColor":"","iconBtnColor":"","port":3339,"latitude":"","longitude":"","weatherApiKey":"","unitSystem":"metric","idleScreen":"analogClock","idleTimeout":5,"showWeatherInClock":true,"analogClockShowDate":true,"clockBackgroundColor":"","clockFrameColor":"","clockFaceColor":"","clockFontColor":"","weatherBackgroundColor":"","unsplashApiKey":"","fanartTvApiKey":"","displayFanartBackground":false,"fanartBackgroundGrayscale":false,"wallpaperUrl":"","wallpaperShowTime":true,"wallpaperShowSeconds":false,"wallpaperShowWeather":true,"slideshowInterval":30,"externalUrl":"","use24Hour":false,"layoutDesigner":{"layouts":[{"id":"66d182cb-6535-48cc-b9fe-397031eec210","name":"otis","width":1920,"height":1080,"isDefault":true,"rows":1,"cols":1,"rowFractions":[1],"colFractions":[1],"cells":[[{"id":"3db0bc86-c96a-4ded-bec0-3b4897f2d2a0","itemKey":null,"subdivisions":null,"colSpan":1,"rowSpan":1,"alignItems":"center","justifyContent":"center"}]],"fonts":{"title":{"family":"","size":""},"artist":{"family":"","size":""},"album":{"family":"","size":""},"bitrate":{"family":"","size":""},"progress":{"family":"","size":""},"volume":{"family":"","size":""}},"colors":{"backgroundColor":"","trackColor":"","artistColor":"","albumColor":"","streamInfoColor":"","buttonColor":"","buttonBgColor":"","barTrackColor":"","barTextColor":"","iconBtnColor":""},"player":{"displayFanartBackground":"","fanartBackgroundGrayscale":"","hideSeekHandle":"","hideTrackTimes":"","showRemainingTime":""}}]},"titleFontSize":"","titleFontName":"","albumFontSize":"","albumFontName":"","artistFontSize":"","artistFontName":"","bitrateFontSize":"","bitrateFontName":"","progressFontSize":"","progressFontName":"","volumeFontSize":"","volumeFontName":"","playerButtonSize":"","secondaryRowFontSize":"","language":"en"}
Oct 13 20:34:08 volumio volumio[1357]: info: Received Get System Info
Oct 13 20:34:08 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 13 20:34:08 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 13 20:34:08 volumio volumio[1357]: info: Discovery: Getting this device information
Oct 13 20:34:08 volumio volumio[1357]: info: CoreCommandRouter::volumioGetState
Oct 13 20:34:08 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:34:08 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 13 20:34:08 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Oct 13 20:34:08 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Oct 13 20:34:09 volumio volumio5-onboarding[1972]: time=2026-10-13T20:34:09.724Z level=INFO msg="service successfully established" component=discovery/localnet
Oct 13 20:34:12 volumio volumio[1357]: info: CoreCommandRouter::volumioGetState
Oct 13 20:34:12 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:34:12 volumio volumio[1357]: info: CoreCommandRouter::volumioGetQueue
Oct 13 20:34:12 volumio volumio[1357]: info: CoreStateMachine::getQueue
Oct 13 20:34:12 volumio volumio[1357]: info: CorePlayQueue::getQueue
Oct 13 20:34:12 volumio volumio[1357]: info: CoreCommandRouter::volumioGetState
Oct 13 20:34:12 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:34:12 volumio volumio[1357]: info: CoreCommandRouter::volumioGetQueue
Oct 13 20:34:12 volumio volumio[1357]: info: CoreStateMachine::getQueue
Oct 13 20:34:12 volumio volumio[1357]: info: CorePlayQueue::getQueue
Oct 13 20:34:12 volumio volumio[1357]: info: CoreCommandRouter::volumioGetState
Oct 13 20:34:12 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:34:12 volumio volumio[1357]: info: CoreCommandRouter::volumioGetState
Oct 13 20:34:12 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:34:12 volumio volumio[1357]: info: CoreCommandRouter::volumioGetQueue
Oct 13 20:34:12 volumio volumio[1357]: info: CoreStateMachine::getQueue
Oct 13 20:34:12 volumio volumio[1357]: info: CorePlayQueue::getQueue
Oct 13 20:34:14 volumio volumio[1357]: info: Received Get System Info
Oct 13 20:34:14 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 13 20:34:14 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 13 20:34:14 volumio volumio[1357]: info: Discovery: Getting this device information
Oct 13 20:34:14 volumio volumio[1357]: info: CoreCommandRouter::volumioGetState
Oct 13 20:34:14 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:34:14 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 13 20:34:14 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Oct 13 20:34:14 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Oct 13 20:34:15 volumio volumio[1357]: info: CoreCommandRouter::volumioPlay
Oct 13 20:34:15 volumio volumio[1357]: info: CoreStateMachine::play index undefined
Oct 13 20:34:15 volumio volumio[1357]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 13 20:34:15 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:34:15 volumio volumio[1357]: info: CoreStateMachine::startPlaybackTimer
Oct 13 20:34:15 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:34:15 volumio volumio[1357]: verbose: ControllerMpd::clearAddPlayTracks USB/1.42.6-25556/Music/Arcade Fire/Arcade Fire, The - 2001 Demos/01 Winter For A Year.mp3
Oct 13 20:34:15 volumio volumio[1357]: verbose: ControllerMpd::sendMpdCommand stop
Oct 13 20:34:15 volumio volumio[1357]: info: sendMpdCommand stop took 1 milliseconds
Oct 13 20:34:15 volumio volumio[1357]: verbose: ControllerMpd::sendMpdCommand clear
Oct 13 20:34:15 volumio volumio[1357]: info: sendMpdCommand clear took 1 milliseconds
Oct 13 20:34:15 volumio volumio[1357]: verbose: ControllerMpd::sendMpdCommand add "USB/1.42.6-25556/Music/Arcade Fire/Arcade Fire, The - 2001 Demos/01 Winter For A Year.mp3"
Oct 13 20:34:15 volumio volumio[1357]: info:
Oct 13 20:34:15 volumio volumio[1357]: ---------------------------- MPD announces system playlist update
Oct 13 20:34:15 volumio volumio[1357]: info: Ignoring MPD Status Update
Oct 13 20:34:15 volumio volumio[1357]: info: sendMpdCommand add "USB/1.42.6-25556/Music/Arcade Fire/Arcade Fire, The - 2001 Demos/01 Winter For A Year.mp3" took 2 milliseconds
Oct 13 20:34:15 volumio volumio[1357]: verbose: ControllerMpd::sendMpdCommand play
Oct 13 20:34:15 volumio volumio[1357]: info:
Oct 13 20:34:15 volumio volumio[1357]: ---------------------------- MPD announces system playlist update
Oct 13 20:34:15 volumio volumio[1357]: info: Ignoring MPD Status Update
Oct 13 20:34:15 volumio volumio[1357]: info:
Oct 13 20:34:15 volumio volumio[1357]: ---------------------------- MPD announces system playlist update
Oct 13 20:34:15 volumio volumio[1357]: info: Ignoring MPD Status Update
Oct 13 20:34:15 volumio volumio[1357]: info: ------------------------------ 4ms
Oct 13 20:34:15 volumio volumio[1357]: info: sendMpdCommand play took 3 milliseconds
Oct 13 20:34:15 volumio volumio[1357]: info: ------------------------------ 3ms
Oct 13 20:34:15 volumio volumio[1357]: info:
Oct 13 20:34:15 volumio volumio[1357]: ---------------------------- MPD announces system playlist update
Oct 13 20:34:15 volumio volumio[1357]: info: Ignoring MPD Status Update
Oct 13 20:34:15 volumio volumio[1357]: info: ------------------------------ 2ms
Oct 13 20:34:15 volumio volumio[1357]: info: ------------------------------ 2ms
Oct 13 20:34:15 volumio volumio5-onboarding[1972]: time=2026-10-13T20:34:15.716Z level=INFO msg="service successfully established" component=discovery/localnet
Oct 13 20:34:15 volumio volumio[1357]: info:
Oct 13 20:34:15 volumio volumio[1357]: ---------------------------- MPD announces state update: player
Oct 13 20:34:15 volumio volumio[1357]: info: ControllerMpd::getState
Oct 13 20:34:15 volumio volumio[1357]: verbose: ControllerMpd::sendMpdCommand status
Oct 13 20:34:15 volumio volumio[1357]: info:
Oct 13 20:34:15 volumio volumio[1357]: ---------------------------- MPD announces state update: player
Oct 13 20:34:15 volumio volumio[1357]: info: ControllerMpd::getState
Oct 13 20:34:15 volumio volumio[1357]: verbose: ControllerMpd::sendMpdCommand status
Oct 13 20:34:15 volumio volumio[1357]: info:
Oct 13 20:34:15 volumio volumio[1357]: ---------------------------- MPD announces state update: player
Oct 13 20:34:15 volumio volumio[1357]: info: sendMpdCommand status took 51 milliseconds
Oct 13 20:34:15 volumio volumio[1357]: info: sendMpdCommand status took 51 milliseconds
Oct 13 20:34:15 volumio volumio[1357]: info: ControllerMpd::getState
Oct 13 20:34:15 volumio volumio[1357]: verbose: ControllerMpd::sendMpdCommand status
Oct 13 20:34:15 volumio volumio[1357]: verbose: ControllerMpd::parseState
Oct 13 20:34:15 volumio volumio[1357]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 13 20:34:15 volumio volumio[1357]: verbose: ControllerMpd::parseState
Oct 13 20:34:15 volumio volumio[1357]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 13 20:34:15 volumio volumio[1357]: info:
Oct 13 20:34:15 volumio volumio[1357]: ---------------------------- MPD announces state update: player
Oct 13 20:34:15 volumio volumio[1357]: info: ControllerMpd::getState
Oct 13 20:34:15 volumio volumio[1357]: verbose: ControllerMpd::sendMpdCommand status
Oct 13 20:34:15 volumio volumio[1357]: info: sendMpdCommand status took 2 milliseconds
Oct 13 20:34:15 volumio volumio[1357]: info: sendMpdCommand playlistinfo took 1 milliseconds
Oct 13 20:34:15 volumio volumio[1357]: info: sendMpdCommand playlistinfo took 1 milliseconds
Oct 13 20:34:15 volumio volumio[1357]: verbose: ControllerMpd::parseState
Oct 13 20:34:15 volumio volumio[1357]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 13 20:34:15 volumio volumio[1357]: verbose: ControllerMpd::parseTrackInfo
Oct 13 20:34:15 volumio volumio[1357]: verbose: ControllerMpd::parseTrackInfo
Oct 13 20:34:15 volumio volumio[1357]: info: ControllerMpd::pushState
Oct 13 20:34:15 volumio volumio[1357]: info: CoreCommandRouter::servicePushState
Oct 13 20:34:15 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:34:15 volumio volumio[1357]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":292,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Winter For A Year","artist":"Arcade Fire","album":"2001 Demos","uri":"USB/1.42.6-25556/Music/Arcade Fire/Arcade Fire, The - 2001 Demos/01 Winter For A Year.mp3","trackType":"mp3"}
Oct 13 20:34:15 volumio volumio[1357]: verbose: CURRENT POSITION 0
Oct 13 20:34:15 volumio volumio[1357]: info: CoreStateMachine::syncState stateService play
Oct 13 20:34:15 volumio volumio[1357]: info: CoreStateMachine::syncState currentStatus stop
Oct 13 20:34:15 volumio volumio[1357]: info: ControllerMpd::pushState
Oct 13 20:34:15 volumio volumio[1357]: info: CoreCommandRouter::servicePushState
Oct 13 20:34:15 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:34:15 volumio volumio[1357]: verbose: STATE SERVICE {"status":"play","position":0,"seek":661,"duration":292,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Winter For A Year","artist":"Arcade Fire","album":"2001 Demos","uri":"USB/1.42.6-25556/Music/Arcade Fire/Arcade Fire, The - 2001 Demos/01 Winter For A Year.mp3","trackType":"mp3"}
Oct 13 20:34:15 volumio volumio[1357]: verbose: CURRENT POSITION 0
Oct 13 20:34:15 volumio volumio[1357]: info: CoreStateMachine::syncState stateService play
Oct 13 20:34:15 volumio volumio[1357]: info: CoreStateMachine::syncState currentStatus play
Oct 13 20:34:15 volumio volumio[1357]: info: Received an update from plugin. extracting info from payload
Oct 13 20:34:15 volumio volumio[1357]: info: CoreStateMachine::pushState
Oct 13 20:34:15 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:34:15 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 13 20:34:15 volumio volumio[1357]: info: CoreCommandRouter::volumioPushState
Oct 13 20:34:15 volumio volumio[1357]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false
Oct 13 20:34:15 volumio volumio[1357]: info: CoreStateMachine::pushState
Oct 13 20:34:15 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:34:15 volumio volumio[1357]: info: CoreCommandRouter::volumioPushState
Oct 13 20:34:15 volumio volumio[1357]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false
Oct 13 20:34:15 volumio volumio[1357]: info: ------------------------------ 60ms
Oct 13 20:34:15 volumio volumio[1357]: info: ------------------------------ 66ms
Oct 13 20:34:15 volumio volumio[1357]: info: sendMpdCommand status took 13 milliseconds
Oct 13 20:34:15 volumio volumio[1357]: info: sendMpdCommand playlistinfo took 13 milliseconds
Oct 13 20:34:15 volumio volumio[1357]: verbose: ControllerMpd::parseState
Oct 13 20:34:15 volumio volumio[1357]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 13 20:34:15 volumio volumio[1357]: verbose: ControllerMpd::parseTrackInfo
Oct 13 20:34:15 volumio volumio[1357]: info: ControllerMpd::pushState
Oct 13 20:34:15 volumio volumio[1357]: info: CoreCommandRouter::servicePushState
Oct 13 20:34:15 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:34:15 volumio volumio[1357]: verbose: STATE SERVICE {"status":"play","position":0,"seek":661,"duration":292,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Winter For A Year","artist":"Arcade Fire","album":"2001 Demos","uri":"USB/1.42.6-25556/Music/Arcade Fire/Arcade Fire, The - 2001 Demos/01 Winter For A Year.mp3","trackType":"mp3"}
Oct 13 20:34:15 volumio volumio[1357]: verbose: CURRENT POSITION 0
Oct 13 20:34:15 volumio volumio[1357]: info: CoreStateMachine::syncState stateService play
Oct 13 20:34:15 volumio volumio[1357]: info: CoreStateMachine::syncState currentStatus play
Oct 13 20:34:15 volumio volumio[1357]: info: Received an update from plugin. extracting info from payload
Oct 13 20:34:15 volumio volumio[1357]: info: CoreStateMachine::pushState
Oct 13 20:34:15 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:34:15 volumio volumio[1357]: info: CoreCommandRouter::volumioPushState
Oct 13 20:34:15 volumio volumio[1357]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false
Oct 13 20:34:15 volumio volumio[1357]: info: CoreStateMachine::pushState
Oct 13 20:34:15 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:34:15 volumio volumio[1357]: info: CoreCommandRouter::volumioPushState
Oct 13 20:34:15 volumio volumio[1357]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false
Oct 13 20:34:15 volumio volumio[1357]: info: ------------------------------ 31ms
Oct 13 20:34:15 volumio volumio[1357]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms
Oct 13 20:34:15 volumio volumio[1357]: info: Display-configuration --- → Wakeup triggered
Oct 13 20:34:15 volumio volumio[1357]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms
Oct 13 20:34:15 volumio volumio[1357]: info: Display-configuration --- → Wakeup triggered
Oct 13 20:34:15 volumio volumio[1357]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms
Oct 13 20:34:15 volumio volumio[1357]: info: Display-configuration --- → Wakeup triggered
Oct 13 20:34:15 volumio volumio[1357]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms
Oct 13 20:34:15 volumio volumio[1357]: info: Display-configuration --- → Wakeup triggered
Oct 13 20:34:15 volumio volumio[1357]: info: sendMpdCommand playlistinfo took 80 milliseconds
Oct 13 20:34:15 volumio volumio[1357]: verbose: ControllerMpd::parseTrackInfo
Oct 13 20:34:15 volumio volumio[1357]: info: ControllerMpd::pushState
Oct 13 20:34:15 volumio volumio[1357]: info: CoreCommandRouter::servicePushState
Oct 13 20:34:15 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:34:15 volumio volumio[1357]: verbose: STATE SERVICE {"status":"play","position":0,"seek":661,"duration":292,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Winter For A Year","artist":"Arcade Fire","album":"2001 Demos","uri":"USB/1.42.6-25556/Music/Arcade Fire/Arcade Fire, The - 2001 Demos/01 Winter For A Year.mp3","trackType":"mp3"}
Oct 13 20:34:15 volumio volumio[1357]: verbose: CURRENT POSITION 0
Oct 13 20:34:15 volumio volumio[1357]: info: CoreStateMachine::syncState stateService play
Oct 13 20:34:15 volumio volumio[1357]: info: CoreStateMachine::syncState currentStatus play
Oct 13 20:34:15 volumio volumio[1357]: info: Received an update from plugin. extracting info from payload
Oct 13 20:34:15 volumio volumio[1357]: info: CoreStateMachine::pushState
Oct 13 20:34:15 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:34:15 volumio volumio[1357]: info: CoreCommandRouter::volumioPushState
Oct 13 20:34:15 volumio volumio[1357]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false
Oct 13 20:34:15 volumio volumio[1357]: info: CoreStateMachine::pushState
Oct 13 20:34:15 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:34:15 volumio volumio[1357]: info: CoreCommandRouter::volumioPushState
Oct 13 20:34:15 volumio volumio[1357]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false
Oct 13 20:34:15 volumio volumio[1357]: info: ------------------------------ 109ms
Oct 13 20:34:15 volumio volumio[1357]: info: Stylish Player: FFmpeg exited with code 255. Restarting...
Oct 13 20:34:15 volumio volumio[1357]: info: Stylish Player: No stream clients — draining FIFO to keep ALSA unblocked
Oct 13 20:34:15 volumio volumio[1357]: error: Display-configuration --- wakeupScreen: DPMS command failed: Command failed: /usr/bin/xset -display :0 -dpms
Oct 13 20:34:15 volumio volumio[1357]: Invalid MIT-MAGIC-COOKIE-1 key
Oct 13 20:34:15 volumio volumio[1357]: /usr/bin/xset: unable to open display ":0"
Oct 13 20:34:15 volumio volumio[1357]: error: Display-configuration --- wakeupScreen: DPMS command failed: Command failed: /usr/bin/xset -display :0 -dpms
Oct 13 20:34:15 volumio volumio[1357]: Invalid MIT-MAGIC-COOKIE-1 key
Oct 13 20:34:15 volumio volumio[1357]: /usr/bin/xset: unable to open display ":0"
Oct 13 20:34:15 volumio volumio[1357]: error: Display-configuration --- wakeupScreen: DPMS command failed: Command failed: /usr/bin/xset -display :0 -dpms
Oct 13 20:34:15 volumio volumio[1357]: Invalid MIT-MAGIC-COOKIE-1 key
Oct 13 20:34:15 volumio volumio[1357]: /usr/bin/xset: unable to open display ":0"
Oct 13 20:34:15 volumio volumio[1357]: error: Display-configuration --- wakeupScreen: DPMS command failed: Command failed: /usr/bin/xset -display :0 -dpms
Oct 13 20:34:15 volumio volumio[1357]: Invalid MIT-MAGIC-COOKIE-1 key
Oct 13 20:34:15 volumio volumio[1357]: /usr/bin/xset: unable to open display ":0"
Oct 13 20:34:15 volumio volumio[1357]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms
Oct 13 20:34:15 volumio volumio[1357]: info: Display-configuration --- → Wakeup triggered
Oct 13 20:34:15 volumio volumio[1357]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms
Oct 13 20:34:15 volumio volumio[1357]: info: Display-configuration --- → Wakeup triggered
Oct 13 20:34:15 volumio volumio[1357]: error: Display-configuration --- wakeupScreen: DPMS command failed: Command failed: /usr/bin/xset -display :0 -dpms
Oct 13 20:34:15 volumio volumio[1357]: Invalid MIT-MAGIC-COOKIE-1 key
Oct 13 20:34:15 volumio volumio[1357]: /usr/bin/xset: unable to open display ":0"
Oct 13 20:34:15 volumio volumio[1357]: error: Display-configuration --- wakeupScreen: DPMS command failed: Command failed: /usr/bin/xset -display :0 -dpms
Oct 13 20:34:15 volumio volumio[1357]: Invalid MIT-MAGIC-COOKIE-1 key
Oct 13 20:34:15 volumio volumio[1357]: /usr/bin/xset: unable to open display ":0"
Oct 13 20:34:16 volumio volumio[1357]: info: Stylish Player: Stream client connected for /
Oct 13 20:34:16 volumio volumio[1357]: info: Stylish Player: Stopping FIFO drain
Oct 13 20:34:16 volumio volumio[1357]: info: Stylish Player: Starting FFmpeg — fmt=s16le inputRate=44100 → output 44100 Hz MP3
Oct 13 20:34:37 volumio volumio[1357]: info: Received Get System Info
Oct 13 20:34:37 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 13 20:34:37 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 13 20:34:37 volumio volumio[1357]: info: Discovery: Getting this device information
Oct 13 20:34:37 volumio volumio[1357]: info: CoreCommandRouter::volumioGetState
Oct 13 20:34:37 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:34:37 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 13 20:34:37 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Oct 13 20:34:37 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Oct 13 20:34:38 volumio volumio5-onboarding[1972]: time=2026-10-13T20:34:38.045Z level=INFO msg="service successfully established" component=discovery/localnet
Oct 13 20:34:44 volumio volumio[1357]: info: Received Get System Info
Oct 13 20:34:44 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 13 20:34:44 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 13 20:34:44 volumio volumio[1357]: info: Discovery: Getting this device information
Oct 13 20:34:44 volumio volumio[1357]: info: CoreCommandRouter::volumioGetState
Oct 13 20:34:44 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:34:44 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 13 20:34:44 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Oct 13 20:34:44 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Oct 13 20:34:45 volumio volumio5-onboarding[1972]: time=2026-10-13T20:34:45.046Z level=INFO msg="service successfully established" component=discovery/localnet
Oct 13 20:34:50 volumio volumio[1357]: info: Received Get System Info
Oct 13 20:34:50 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 13 20:34:50 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 13 20:34:50 volumio volumio[1357]: info: Discovery: Getting this device information
Oct 13 20:34:50 volumio volumio[1357]: info: CoreCommandRouter::volumioGetState
Oct 13 20:34:50 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:34:50 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 13 20:34:50 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Oct 13 20:34:50 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Oct 13 20:34:51 volumio volumio5-onboarding[1972]: time=2026-10-13T20:34:51.056Z level=INFO msg="service successfully established" component=discovery/localnet
Oct 13 20:34:59 volumio volumio[1357]: info: Received Get System Info
Oct 13 20:34:59 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 13 20:34:59 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 13 20:34:59 volumio volumio[1357]: info: Discovery: Getting this device information
Oct 13 20:34:59 volumio volumio[1357]: info: CoreCommandRouter::volumioGetState
Oct 13 20:34:59 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:34:59 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 13 20:34:59 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Oct 13 20:34:59 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Oct 13 20:35:00 volumio volumio5-onboarding[1972]: time=2026-10-13T20:35:00.114Z level=INFO msg="service successfully established" component=discovery/localnet
Oct 13 20:35:05 volumio volumio[1357]: info: Received Get System Info
Oct 13 20:35:05 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 13 20:35:05 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 13 20:35:05 volumio volumio[1357]: info: Discovery: Getting this device information
Oct 13 20:35:05 volumio volumio[1357]: info: CoreCommandRouter::volumioGetState
Oct 13 20:35:05 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:35:05 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 13 20:35:05 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Oct 13 20:35:05 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Oct 13 20:35:06 volumio volumio5-onboarding[1972]: time=2026-10-13T20:35:06.363Z level=INFO msg="service successfully established" component=discovery/localnet
Oct 13 20:35:07 volumio volumio[1357]: info: CALLMETHOD: user_interface stylish_player configSavePlayerConfig [object Object]
Oct 13 20:35:07 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: stylish_player , configSavePlayerConfig
Oct 13 20:35:07 volumio volumio[1357]: info: Stylish Player: Broadcasted config update: {"playerType":"reelToReel","theme":"casio","showPlayerControls":true,"hideSeekHandle":false,"hideTrackTimes":true,"showRemainingTime":false,"albumArtMaxSpace":false,"albumArtAnimated":true,"showTrackPanel":true,"useCustomLayout":false,"vizType":"peppyMeter","spectrumOptions":"","peppyMeterFolder":"","peppyMeterModel":"random","peppySpectrumFolder":"","peppySpectrumModel":"random","backgroundColor":"","trackColor":"","artistColor":"","albumColor":"","streamInfoColor":"","buttonColor":"","buttonBgColor":"","barTrackColor":"","barTextColor":"","iconBtnColor":"","port":3339,"latitude":"","longitude":"","weatherApiKey":"","unitSystem":"metric","idleScreen":"analogClock","idleTimeout":5,"showWeatherInClock":true,"analogClockShowDate":true,"clockBackgroundColor":"","clockFrameColor":"","clockFaceColor":"","clockFontColor":"","weatherBackgroundColor":"","unsplashApiKey":"","fanartTvApiKey":"","displayFanartBackground":false,"fanartBackgroundGrayscale":false,"wallpaperUrl":"","wallpaperShowTime":true,"wallpaperShowSeconds":false,"wallpaperShowWeather":true,"slideshowInterval":30,"externalUrl":"","use24Hour":false,"layoutDesigner":{"layouts":[{"id":"66d182cb-6535-48cc-b9fe-397031eec210","name":"otis","width":1920,"height":1080,"isDefault":true,"rows":1,"cols":1,"rowFractions":[1],"colFractions":[1],"cells":[[{"id":"3db0bc86-c96a-4ded-bec0-3b4897f2d2a0","itemKey":null,"subdivisions":null,"colSpan":1,"rowSpan":1,"alignItems":"center","justifyContent":"center"}]],"fonts":{"title":{"family":"","size":""},"artist":{"family":"","size":""},"album":{"family":"","size":""},"bitrate":{"family":"","size":""},"progress":{"family":"","size":""},"volume":{"family":"","size":""}},"colors":{"backgroundColor":"","trackColor":"","artistColor":"","albumColor":"","streamInfoColor":"","buttonColor":"","buttonBgColor":"","barTrackColor":"","barTextColor":"","iconBtnColor":""},"player":{"displayFanartBackground":"","fanartBackgroundGrayscale":"","hideSeekHandle":"","hideTrackTimes":"","showRemainingTime":""}}]},"titleFontSize":"","titleFontName":"","albumFontSize":"","albumFontName":"","artistFontSize":"","artistFontName":"","bitrateFontSize":"","bitrateFontName":"","progressFontSize":"","progressFontName":"","volumeFontSize":"","volumeFontName":"","playerButtonSize":"","secondaryRowFontSize":"","language":"en"}
Oct 13 20:35:14 volumio volumio[1357]: info: Received Get System Info
Oct 13 20:35:14 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 13 20:35:14 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 13 20:35:14 volumio volumio[1357]: info: Discovery: Getting this device information
Oct 13 20:35:14 volumio volumio[1357]: info: CoreCommandRouter::volumioGetState
Oct 13 20:35:14 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:35:14 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 13 20:35:14 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Oct 13 20:35:14 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Oct 13 20:35:15 volumio volumio5-onboarding[1972]: time=2026-10-13T20:35:15.392Z level=INFO msg="service successfully established" component=discovery/localnet
Oct 13 20:35:17 volumio volumio[1357]: info: CoreCommandRouter::volumioGetState
Oct 13 20:35:17 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:35:17 volumio volumio[1357]: info: CoreCommandRouter::volumioGetQueue
Oct 13 20:35:17 volumio volumio[1357]: info: CoreStateMachine::getQueue
Oct 13 20:35:17 volumio volumio[1357]: info: CorePlayQueue::getQueue
Oct 13 20:35:17 volumio volumio[1357]: info: CoreCommandRouter::volumioGetState
Oct 13 20:35:17 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:35:17 volumio volumio[1357]: info: CoreCommandRouter::volumioGetQueue
Oct 13 20:35:17 volumio volumio[1357]: info: CoreStateMachine::getQueue
Oct 13 20:35:17 volumio volumio[1357]: info: CorePlayQueue::getQueue
Oct 13 20:35:17 volumio volumio[1357]: info: CoreCommandRouter::volumioGetState
Oct 13 20:35:17 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:35:17 volumio volumio[1357]: info: CoreCommandRouter::volumioGetState
Oct 13 20:35:17 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:35:17 volumio volumio[1357]: info: CoreCommandRouter::volumioGetQueue
Oct 13 20:35:17 volumio volumio[1357]: info: CoreStateMachine::getQueue
Oct 13 20:35:17 volumio volumio[1357]: info: CorePlayQueue::getQueue
Oct 13 20:35:17 volumio volumio[1357]: info: CoreCommandRouter::volumioGetVisibleSources
Oct 13 20:35:17 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 13 20:35:17 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Oct 13 20:35:17 volumio volumio[1357]: info: CURURI: playlists
Oct 13 20:35:17 volumio volumio[1357]: info: Listing playlists
Oct 13 20:35:25 volumio volumio[1357]: info: Received Get System Info
Oct 13 20:35:25 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 13 20:35:25 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 13 20:35:25 volumio volumio[1357]: info: Discovery: Getting this device information
Oct 13 20:35:25 volumio volumio[1357]: info: CoreCommandRouter::volumioGetState
Oct 13 20:35:25 volumio volumio[1357]: info: CorePlayQueue::getTrack 0
Oct 13 20:35:25 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 13 20:35:25 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Oct 13 20:35:25 volumio volumio[1357]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Oct 13 20:35:26 volumio volumio5-onboarding[1972]: time=2026-10-13T20:35:26.161Z level=INFO msg="service successfully established" component=discovery/localnet
Oct 13 20:35:35 volumio volumio[1357]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 13 20:35:35 volumio volumio[1357]: Error: read ETIMEDOUT
Oct 13 20:35:35 volumio volumio[1357]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:217:20) {
Oct 13 20:35:35 volumio volumio[1357]: errno: -110,
Oct 13 20:35:35 volumio volumio[1357]: code: 'ETIMEDOUT',
Oct 13 20:35:35 volumio volumio[1357]: syscall: 'read'
Oct 13 20:35:35 volumio volumio[1357]: }
Oct 13 20:35:35 volumio volumio[1357]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 13 20:35:36 volumio sudo[7824]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-13 20:34'
Oct 13 20:35:36 volumio sudo[7824]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Debian GNU/Linux 12 (bookworm)"
NAME="Debian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026"
VOLUMIO_VERSION="4.119"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"