-- Logs begin at Sun 2026-10-11 03:15:27 CEST, end at Fri 2026-10-16 15:01:16 CEST. -- Oct 16 15:00:00 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:00.189+02:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.178.78:56640 Oct 16 15:00:00 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:00.189+02:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.178.78:35948 Oct 16 15:00:00 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:00.470+02:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-37.917586ms timeout=20s Oct 16 15:00:00 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:00.471+02:00 level=INFO msg="emitting device capabilities changed event" component=server peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" Oct 16 15:00:00 volumio volumio[1113]: info: Received Get System Info Oct 16 15:00:00 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 15:00:00 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 15:00:00 volumio volumio[1113]: info: Discovery: Getting this device information Oct 16 15:00:00 volumio volumio[1113]: info: CoreCommandRouter::volumioGetState Oct 16 15:00:00 volumio volumio[1113]: info: CorePlayQueue::getTrack 3 Oct 16 15:00:00 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 15:00:00 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:00.475+02:00 level=INFO msg="emitting device name changed event" component=server peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" name=Volumio Oct 16 15:00:00 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:00.476+02:00 level=INFO msg="emitting device language changed event" component=server peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" language=de Oct 16 15:00:00 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Oct 16 15:00:00 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:00.478+02:00 level=INFO msg="emitting device timezone changed event" component=server peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" timezone=Europe/Berlin Oct 16 15:00:00 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:00.482+02:00 level=INFO msg="emitting ethernet info changed event" component=server peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" available=true connected=true macAddress=d8:3a:dd:48:66:95 ip4Address=192.168.178.38/24 ip6Address= Oct 16 15:00:00 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:00.485+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" available=true connected=true macAddress=d8:3a:dd:48:66:96 ip4Address=192.168.178.52/24 ip6Address= ssid=Funkstreife7520 Oct 16 15:00:00 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:00.485+02:00 level=INFO msg="emitting device setup status changed event" component=server peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" setupComplete=true Oct 16 15:00:00 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Oct 16 15:00:00 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:00.501+02:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-15.91982ms timeout=10s Oct 16 15:00:00 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 16 15:00:00 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 15:00:00 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 16 15:00:00 volumio volumio[1113]: amixer -c 0 info | grep "bcm2835 ALSA" Oct 16 15:00:00 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:00.637+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-15.91982ms timeout=10s endpoint=http://pushupdates.volumio.org duration=135.875836ms Oct 16 15:00:00 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:00.638+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-15.91982ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=136.8011ms Oct 16 15:00:00 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:00.638+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-15.91982ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=136.724509ms Oct 16 15:00:00 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:00.638+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-15.91982ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=137.423313ms Oct 16 15:00:00 volumio volumio[1113]: amixer -c 1 info | grep "bcm2835 Headphones" Oct 16 15:00:00 volumio volumio[1113]: Card hw:1 'Headphones'/'bcm2835 Headphones' Oct 16 15:00:00 volumio volumio[1113]: amixer -c 2 info | grep "snd_rpi_hifiberry_dacplus" Oct 16 15:00:00 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:00.725+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-15.91982ms timeout=10s endpoint=https://www.googleapis.com duration=223.382012ms Oct 16 15:00:00 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:00.742+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-15.91982ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=240.002916ms Oct 16 15:00:00 volumio volumio[1113]: Card hw:2 'sndrpihifiberry'/'snd_rpi_hifiberry_dacplus' Oct 16 15:00:00 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 16 15:00:00 volumio volumio[1113]: info: CURURI: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021 Oct 16 15:00:00 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 16 15:00:00 volumio volumio[1113]: info: CURURI: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021 Oct 16 15:00:00 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:00.760+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-15.91982ms timeout=10s endpoint=https://securetoken.googleapis.com duration=258.833769ms Oct 16 15:00:00 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:00.800+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-15.91982ms timeout=10s endpoint=https://google.com duration=299.083511ms Oct 16 15:00:00 volumio volumio[1113]: amixer -c 2 info | grep "HiFiBerry DAC2 Pro" Oct 16 15:00:00 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:00.845+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-15.91982ms timeout=10s endpoint=https://database.volumio.cloud duration=343.616949ms Oct 16 15:00:00 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:00.849+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-15.91982ms timeout=10s endpoint=https://functions.volumio.cloud duration=347.498614ms Oct 16 15:00:00 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:00.868+02:00 level=INFO msg="emitting audio outputs changed event" component=server peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" selectedOutputId=2 Oct 16 15:00:00 volumio volumio[1113]: info: Preload queue cleared Oct 16 15:00:00 volumio volumio[1113]: info: Preloading song: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/01-adele-strangers_by_nature-cff1d3.flac Oct 16 15:00:00 volumio volumio[1113]: info: Preloading song: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/02-adele-easy_on_me-6b8df7.flac Oct 16 15:00:00 volumio volumio[1113]: info: Preloading song: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/03-adele-my_little_love-650e4a.flac Oct 16 15:00:00 volumio volumio[1113]: info: Preloading song: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/04-adele-cry_your_heart_out-c7a6cf.flac Oct 16 15:00:00 volumio volumio[1113]: info: Preloading song: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/05-adele-oh_my_god-5257ce.flac Oct 16 15:00:00 volumio volumio[1113]: info: Preloading song: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/06-adele-can_i_get_it-f9eb31.flac Oct 16 15:00:00 volumio volumio[1113]: info: Preloading song: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/07-adele-i_drink_wine-c6f4fc.flac Oct 16 15:00:00 volumio volumio[1113]: info: Preloading song: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/08-adele-all_night_parking_(with_erroll_garner)_interlude-b4cf34.flac Oct 16 15:00:00 volumio volumio[1113]: info: Preloading song: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/09-adele-woman_like_me-969cb4.flac Oct 16 15:00:00 volumio volumio[1113]: info: Preloading song: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/10-adele-hold_on-2ae4fb.flac Oct 16 15:00:00 volumio volumio[1113]: info: Preloading song: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/11-adele-to_be_loved-3ff20a.flac Oct 16 15:00:00 volumio volumio[1113]: info: Preloading song: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/12-adele-love_is_a_game-e4d3dc.flac Oct 16 15:00:00 volumio volumio[1113]: info: Preloading song: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/00-adele-30-16bit-webflac-2021.m3u Oct 16 15:00:00 volumio volumio[1113]: info: Preload queue cleared Oct 16 15:00:00 volumio volumio[1113]: info: Preloading song: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/01-adele-strangers_by_nature-cff1d3.flac Oct 16 15:00:00 volumio volumio[1113]: info: Preloading song: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/02-adele-easy_on_me-6b8df7.flac Oct 16 15:00:00 volumio volumio[1113]: info: Preloading song: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/03-adele-my_little_love-650e4a.flac Oct 16 15:00:00 volumio volumio[1113]: info: Preloading song: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/04-adele-cry_your_heart_out-c7a6cf.flac Oct 16 15:00:00 volumio volumio[1113]: info: Preloading song: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/05-adele-oh_my_god-5257ce.flac Oct 16 15:00:00 volumio volumio[1113]: info: Preloading song: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/06-adele-can_i_get_it-f9eb31.flac Oct 16 15:00:00 volumio volumio[1113]: info: Preloading song: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/07-adele-i_drink_wine-c6f4fc.flac Oct 16 15:00:00 volumio volumio[1113]: info: Preloading song: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/08-adele-all_night_parking_(with_erroll_garner)_interlude-b4cf34.flac Oct 16 15:00:00 volumio volumio[1113]: info: Preloading song: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/09-adele-woman_like_me-969cb4.flac Oct 16 15:00:00 volumio volumio[1113]: info: Preloading song: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/10-adele-hold_on-2ae4fb.flac Oct 16 15:00:00 volumio volumio[1113]: info: Preloading song: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/11-adele-to_be_loved-3ff20a.flac Oct 16 15:00:00 volumio volumio[1113]: info: Preloading song: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/12-adele-love_is_a_game-e4d3dc.flac Oct 16 15:00:00 volumio volumio[1113]: info: Preloading song: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/00-adele-30-16bit-webflac-2021.m3u Oct 16 15:00:00 volumio volumio[1113]: info: Exploding uri music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/01-adele-strangers_by_nature-cff1d3.flac in service mpd Oct 16 15:00:00 volumio volumio[1113]: info: ALBUMART /albumart?cacheid=257&web=Adele/30/medium&path=%2Fmnt%2FUSB%2FWD_MY_BOOK%2FAdele%20-%2030%20-%202021%2F01-adele-strangers_by_nature-cff1d3.flac&metadata=false Oct 16 15:00:00 volumio volumio[1113]: info: URI /mnt/USB/WD_MY_BOOK/Adele - 30 - 2021/01-adele-strangers_by_nature-cff1d3.flac Oct 16 15:00:01 volumio volumio[1113]: info: Received Get System Info Oct 16 15:00:01 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 15:00:01 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 15:00:01 volumio volumio[1113]: info: Discovery: Getting this device information Oct 16 15:00:01 volumio volumio[1113]: info: CoreCommandRouter::volumioGetState Oct 16 15:00:01 volumio volumio[1113]: info: CorePlayQueue::getTrack 3 Oct 16 15:00:01 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 15:00:01 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:01.008+02:00 level=INFO msg="emitting software info changed event" component=server peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" currentVersion=3.912 latestVersion=3.912 Oct 16 15:00:01 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:01.008+02:00 level=INFO msg="emitting software update progress event" component=server peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" status=UPDATE_STATUS_NONE progress=0 Oct 16 15:00:01 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:01.008+02:00 level=INFO msg="emitting user changed event" component=server peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" userId= Oct 16 15:00:01 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:01.008+02:00 level=INFO msg="emitting music providers changed event" component=server peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" providers=3 Oct 16 15:00:01 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 15:00:01 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:01.017+02:00 level=INFO msg="emitting plugins changed event" component=server peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" plugins=0 Oct 16 15:00:01 volumio volumio[1113]: info: CoreCommandRouter::volumioGetState Oct 16 15:00:01 volumio volumio[1113]: info: CorePlayQueue::getTrack 3 Oct 16 15:00:01 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:01.020+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" state=STATUS_PLAYING positionMs=183749 volume=28 Oct 16 15:00:01 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:01.020+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" id="mnt/USB/WD_MY_BOOK/Adoro - Für Immer Und Dich/04 - Adoro - Ich bin ich (Wir sind wir).mp3" title="4 - Ich bin ich (Wir sind wir)" Oct 16 15:00:01 volumio volumio[1113]: info: Exploding uri music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/02-adele-easy_on_me-6b8df7.flac in service mpd Oct 16 15:00:01 volumio volumio[1113]: info: ALBUMART /albumart?cacheid=257&web=Adele/30/medium&path=%2Fmnt%2FUSB%2FWD_MY_BOOK%2FAdele%20-%2030%20-%202021%2F02-adele-easy_on_me-6b8df7.flac&metadata=false Oct 16 15:00:01 volumio volumio[1113]: info: URI /mnt/USB/WD_MY_BOOK/Adele - 30 - 2021/02-adele-easy_on_me-6b8df7.flac Oct 16 15:00:01 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:01.044+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-15.91982ms timeout=10s endpoint=http://plugins.volumio.org duration=542.736632ms Oct 16 15:00:01 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:01.048+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-15.91982ms timeout=10s endpoint=http://cddb.volumio.org duration=546.743907ms error="Head \"http://gnudb.gnudb.org/~cddb/cddb.cgi/\": EOF" Oct 16 15:00:01 volumio volumio[1113]: info: Exploding uri music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/03-adele-my_little_love-650e4a.flac in service mpd Oct 16 15:00:01 volumio volumio[1113]: info: ALBUMART /albumart?cacheid=257&web=Adele/30/medium&path=%2Fmnt%2FUSB%2FWD_MY_BOOK%2FAdele%20-%2030%20-%202021%2F03-adele-my_little_love-650e4a.flac&metadata=false Oct 16 15:00:01 volumio volumio[1113]: info: URI /mnt/USB/WD_MY_BOOK/Adele - 30 - 2021/03-adele-my_little_love-650e4a.flac Oct 16 15:00:01 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:01.099+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-15.91982ms timeout=10s endpoint=https://functions.volumio.cloud duration=596.817856ms Oct 16 15:00:01 volumio volumio[1113]: info: Exploding uri music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/04-adele-cry_your_heart_out-c7a6cf.flac in service mpd Oct 16 15:00:01 volumio volumio[1113]: info: ALBUMART /albumart?cacheid=257&web=Adele/30/medium&path=%2Fmnt%2FUSB%2FWD_MY_BOOK%2FAdele%20-%2030%20-%202021%2F04-adele-cry_your_heart_out-c7a6cf.flac&metadata=false Oct 16 15:00:01 volumio volumio[1113]: info: URI /mnt/USB/WD_MY_BOOK/Adele - 30 - 2021/04-adele-cry_your_heart_out-c7a6cf.flac Oct 16 15:00:01 volumio volumio[1113]: info: Exploding uri music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/05-adele-oh_my_god-5257ce.flac in service mpd Oct 16 15:00:01 volumio volumio[1113]: info: ALBUMART /albumart?cacheid=257&web=Adele/30/medium&path=%2Fmnt%2FUSB%2FWD_MY_BOOK%2FAdele%20-%2030%20-%202021%2F05-adele-oh_my_god-5257ce.flac&metadata=false Oct 16 15:00:01 volumio volumio[1113]: info: URI /mnt/USB/WD_MY_BOOK/Adele - 30 - 2021/05-adele-oh_my_god-5257ce.flac Oct 16 15:00:01 volumio volumio[1113]: info: Exploding uri music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/06-adele-can_i_get_it-f9eb31.flac in service mpd Oct 16 15:00:01 volumio volumio[1113]: info: ALBUMART /albumart?cacheid=257&web=Adele/30/medium&path=%2Fmnt%2FUSB%2FWD_MY_BOOK%2FAdele%20-%2030%20-%202021%2F06-adele-can_i_get_it-f9eb31.flac&metadata=false Oct 16 15:00:01 volumio volumio[1113]: info: URI /mnt/USB/WD_MY_BOOK/Adele - 30 - 2021/06-adele-can_i_get_it-f9eb31.flac Oct 16 15:00:01 volumio volumio[1113]: info: Exploding uri music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/07-adele-i_drink_wine-c6f4fc.flac in service mpd Oct 16 15:00:01 volumio volumio[1113]: info: ALBUMART /albumart?cacheid=257&web=Adele/30/medium&path=%2Fmnt%2FUSB%2FWD_MY_BOOK%2FAdele%20-%2030%20-%202021%2F07-adele-i_drink_wine-c6f4fc.flac&metadata=false Oct 16 15:00:01 volumio volumio[1113]: info: URI /mnt/USB/WD_MY_BOOK/Adele - 30 - 2021/07-adele-i_drink_wine-c6f4fc.flac Oct 16 15:00:01 volumio volumio[1113]: info: Exploding uri music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/08-adele-all_night_parking_(with_erroll_garner)_interlude-b4cf34.flac in service mpd Oct 16 15:00:01 volumio volumio[1113]: info: ALBUMART /albumart?cacheid=257&web=Adele/30/medium&path=%2Fmnt%2FUSB%2FWD_MY_BOOK%2FAdele%20-%2030%20-%202021%2F08-adele-all_night_parking_(with_erroll_garner)_interlude-b4cf34.flac&metadata=false Oct 16 15:00:01 volumio volumio[1113]: info: URI /mnt/USB/WD_MY_BOOK/Adele - 30 - 2021/08-adele-all_night_parking_(with_erroll_garner)_interlude-b4cf34.flac Oct 16 15:00:01 volumio volumio[1113]: info: Exploding uri music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/09-adele-woman_like_me-969cb4.flac in service mpd Oct 16 15:00:01 volumio volumio[1113]: info: ALBUMART /albumart?cacheid=257&web=Adele/30/medium&path=%2Fmnt%2FUSB%2FWD_MY_BOOK%2FAdele%20-%2030%20-%202021%2F09-adele-woman_like_me-969cb4.flac&metadata=false Oct 16 15:00:01 volumio volumio[1113]: info: URI /mnt/USB/WD_MY_BOOK/Adele - 30 - 2021/09-adele-woman_like_me-969cb4.flac Oct 16 15:00:01 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:01.400+02:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.178.78:39162 Oct 16 15:00:01 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:01.400+02:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.178.78:38630 Oct 16 15:00:01 volumio volumio[1113]: info: Exploding uri music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/10-adele-hold_on-2ae4fb.flac in service mpd Oct 16 15:00:01 volumio volumio[1113]: info: ALBUMART /albumart?cacheid=257&web=Adele/30/medium&path=%2Fmnt%2FUSB%2FWD_MY_BOOK%2FAdele%20-%2030%20-%202021%2F10-adele-hold_on-2ae4fb.flac&metadata=false Oct 16 15:00:01 volumio volumio[1113]: info: URI /mnt/USB/WD_MY_BOOK/Adele - 30 - 2021/10-adele-hold_on-2ae4fb.flac Oct 16 15:00:01 volumio volumio[1113]: info: Exploding uri music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/11-adele-to_be_loved-3ff20a.flac in service mpd Oct 16 15:00:01 volumio volumio[1113]: info: ALBUMART /albumart?cacheid=257&web=Adele/30/medium&path=%2Fmnt%2FUSB%2FWD_MY_BOOK%2FAdele%20-%2030%20-%202021%2F11-adele-to_be_loved-3ff20a.flac&metadata=false Oct 16 15:00:01 volumio volumio[1113]: info: URI /mnt/USB/WD_MY_BOOK/Adele - 30 - 2021/11-adele-to_be_loved-3ff20a.flac Oct 16 15:00:01 volumio volumio[1113]: info: Exploding uri music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/12-adele-love_is_a_game-e4d3dc.flac in service mpd Oct 16 15:00:01 volumio volumio[1113]: info: ALBUMART /albumart?cacheid=257&web=Adele/30/medium&path=%2Fmnt%2FUSB%2FWD_MY_BOOK%2FAdele%20-%2030%20-%202021%2F12-adele-love_is_a_game-e4d3dc.flac&metadata=false Oct 16 15:00:01 volumio volumio[1113]: info: URI /mnt/USB/WD_MY_BOOK/Adele - 30 - 2021/12-adele-love_is_a_game-e4d3dc.flac Oct 16 15:00:01 volumio volumio[1113]: info: Exploding uri music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/00-adele-30-16bit-webflac-2021.m3u in service mpd Oct 16 15:00:13 volumio volumio[1113]: info: Preload queue cleared Oct 16 15:00:13 volumio volumio[1113]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 16 15:00:13 volumio volumio[1113]: info: CoreStateMachine::ClearQueue Oct 16 15:00:13 volumio volumio[1113]: info: CoreStateMachine::stop Oct 16 15:00:13 volumio volumio[1113]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 15:00:13 volumio volumio[1113]: info: CoreStateMachine::stPlaybackTimer Oct 16 15:00:13 volumio volumio[1113]: info: CoreStateMachine::updateTrackBlock Oct 16 15:00:13 volumio volumio[1113]: info: CorePlayQueue::getTrackBlock Oct 16 15:00:13 volumio volumio[1113]: info: CoreStateMachine::pushState Oct 16 15:00:13 volumio volumio[1113]: info: CorePlayQueue::getTrack 3 Oct 16 15:00:13 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 15:00:13 volumio volumio[1113]: info: CoreCommandRouter::volumioPushState Oct 16 15:00:13 volumio volumio[1113]: info: CoreStateMachine::serviceStop Oct 16 15:00:13 volumio volumio[1113]: info: CorePlayQueue::getTrack 3 Oct 16 15:00:13 volumio volumio[1113]: info: CoreCommandRouter::serviceStop Oct 16 15:00:13 volumio volumio[1113]: info: ControllerMpd::stop Oct 16 15:00:13 volumio volumio[1113]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 15:00:13 volumio volumio[1113]: info: CorePlayQueue::clearPlayQueue Oct 16 15:00:13 volumio volumio[1113]: info: CorePlayQueue::saveQueue Oct 16 15:00:13 volumio volumio[1113]: info: CoreCommandRouter::volumioPushQueue Oct 16 15:00:13 volumio volumio[1113]: info: CoreStateMachine::addQueueItems Oct 16 15:00:13 volumio volumio[1113]: info: CorePlayQueue::addQueueItems Oct 16 15:00:13 volumio volumio[1113]: info: Preload queue cleared Oct 16 15:00:13 volumio volumio[1113]: info: Adding Item to queue: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/01-adele-strangers_by_nature-cff1d3.flac Oct 16 15:00:13 volumio volumio[1113]: info: Using cached record of: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/01-adele-strangers_by_nature-cff1d3.flac Oct 16 15:00:13 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:13.825+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" state=STATUS_STOPPED positionMs=0 volume=28 Oct 16 15:00:13 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:13.825+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" id="mnt/USB/WD_MY_BOOK/Adoro - Für Immer Und Dich/04 - Adoro - Ich bin ich (Wir sind wir).mp3" title="4 - Ich bin ich (Wir sind wir)" Oct 16 15:00:13 volumio volumio[1113]: info: CoreCommandRouter::volumioPushQueue Oct 16 15:00:13 volumio volumio[1113]: info: CorePlayQueue::saveQueue Oct 16 15:00:13 volumio volumio[1113]: info: CoreStateMachine::updateTrackBlock Oct 16 15:00:13 volumio volumio[1113]: info: CorePlayQueue::getTrackBlock Oct 16 15:00:13 volumio volumio[1113]: info: CoreCommandRouter::volumioPlay Oct 16 15:00:13 volumio volumio[1113]: info: CoreStateMachine::play index 0 Oct 16 15:00:13 volumio volumio[1113]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 15:00:13 volumio volumio[1113]: info: CoreStateMachine::addQueueItems Oct 16 15:00:13 volumio volumio[1113]: info: CorePlayQueue::addQueueItems Oct 16 15:00:13 volumio volumio[1113]: info: Preload queue cleared Oct 16 15:00:13 volumio volumio[1113]: info: Adding Item to queue: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/02-adele-easy_on_me-6b8df7.flac Oct 16 15:00:13 volumio volumio[1113]: info: Using cached record of: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/02-adele-easy_on_me-6b8df7.flac Oct 16 15:00:13 volumio volumio[1113]: info: Adding Item to queue: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/03-adele-my_little_love-650e4a.flac Oct 16 15:00:13 volumio volumio[1113]: info: Using cached record of: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/03-adele-my_little_love-650e4a.flac Oct 16 15:00:13 volumio volumio[1113]: info: Adding Item to queue: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/04-adele-cry_your_heart_out-c7a6cf.flac Oct 16 15:00:13 volumio volumio[1113]: info: Using cached record of: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/04-adele-cry_your_heart_out-c7a6cf.flac Oct 16 15:00:13 volumio volumio[1113]: info: Adding Item to queue: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/05-adele-oh_my_god-5257ce.flac Oct 16 15:00:13 volumio volumio[1113]: info: Using cached record of: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/05-adele-oh_my_god-5257ce.flac Oct 16 15:00:13 volumio volumio[1113]: info: Adding Item to queue: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/06-adele-can_i_get_it-f9eb31.flac Oct 16 15:00:13 volumio volumio[1113]: info: Using cached record of: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/06-adele-can_i_get_it-f9eb31.flac Oct 16 15:00:13 volumio volumio[1113]: info: Adding Item to queue: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/07-adele-i_drink_wine-c6f4fc.flac Oct 16 15:00:13 volumio volumio[1113]: info: Using cached record of: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/07-adele-i_drink_wine-c6f4fc.flac Oct 16 15:00:13 volumio volumio[1113]: info: Adding Item to queue: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/08-adele-all_night_parking_(with_erroll_garner)_interlude-b4cf34.flac Oct 16 15:00:13 volumio volumio[1113]: info: Using cached record of: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/08-adele-all_night_parking_(with_erroll_garner)_interlude-b4cf34.flac Oct 16 15:00:13 volumio volumio[1113]: info: Adding Item to queue: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/09-adele-woman_like_me-969cb4.flac Oct 16 15:00:13 volumio volumio[1113]: info: Using cached record of: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/09-adele-woman_like_me-969cb4.flac Oct 16 15:00:13 volumio volumio[1113]: info: Adding Item to queue: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/10-adele-hold_on-2ae4fb.flac Oct 16 15:00:13 volumio volumio[1113]: info: Using cached record of: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/10-adele-hold_on-2ae4fb.flac Oct 16 15:00:13 volumio volumio[1113]: info: Adding Item to queue: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/11-adele-to_be_loved-3ff20a.flac Oct 16 15:00:13 volumio volumio[1113]: info: Using cached record of: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/11-adele-to_be_loved-3ff20a.flac Oct 16 15:00:13 volumio volumio[1113]: info: Adding Item to queue: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/12-adele-love_is_a_game-e4d3dc.flac Oct 16 15:00:13 volumio volumio[1113]: info: Using cached record of: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/12-adele-love_is_a_game-e4d3dc.flac Oct 16 15:00:13 volumio volumio[1113]: info: Adding Item to queue: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/00-adele-30-16bit-webflac-2021.m3u Oct 16 15:00:13 volumio volumio[1113]: info: Using cached record of: music-library/USB/WD_MY_BOOK/Adele - 30 - 2021/00-adele-30-16bit-webflac-2021.m3u Oct 16 15:00:13 volumio volumio[1113]: info: CoreStateMachine::stop Oct 16 15:00:13 volumio volumio[1113]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 15:00:13 volumio volumio[1113]: info: CoreCommandRouter::volumioPushQueue Oct 16 15:00:13 volumio volumio[1113]: info: CorePlayQueue::saveQueue Oct 16 15:00:13 volumio volumio[1113]: info: CoreStateMachine::play index undefined Oct 16 15:00:13 volumio volumio[1113]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 15:00:13 volumio volumio[1113]: info: CoreStateMachine::updateTrackBlock Oct 16 15:00:13 volumio volumio[1113]: info: CorePlayQueue::getTrackBlock Oct 16 15:00:13 volumio volumio[1113]: info: CorePlayQueue::getTrack 0 Oct 16 15:00:13 volumio volumio[1113]: info: CoreStateMachine::startPlaybackTimer Oct 16 15:00:13 volumio volumio[1113]: info: CorePlayQueue::getTrack 0 Oct 16 15:00:13 volumio volumio[1113]: verbose: ControllerMpd::clearAddPlayTracks USB/WD_MY_BOOK/Adele - 30 - 2021/01-adele-strangers_by_nature-cff1d3.flac Oct 16 15:00:13 volumio volumio[1113]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 15:00:13 volumio volumio[1113]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 16 15:00:13 volumio volumio[1113]: info: PeppySpectrum ---peppyspectrum status stop Oct 16 15:00:13 volumio sudo[18424]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 16 15:00:13 volumio sudo[18424]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 15:00:13 volumio systemd[1]: Stopping peppymeterbasic Daemon... Oct 16 15:00:13 volumio systemd[1]: peppymeterbasic.service: Main process exited, code=killed, status=15/TERM Oct 16 15:00:13 volumio volumio[1113]: info: [ASDebug] CurState: stop PrevState: play Oct 16 15:00:13 volumio volumio[1113]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Oct 16 15:00:13 volumio sudo[18427]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Oct 16 15:00:13 volumio sudo[18427]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 15:00:13 volumio volumio[1113]: SPOTIFY: RECEIVED VOLUMIO VOLUME 28 Oct 16 15:00:13 volumio volumio[1113]: info: Oct 16 15:00:13 volumio volumio[1113]: ---------------------------- MPD announces state update: player Oct 16 15:00:13 volumio volumio[1113]: info: sendMpdCommand stop took 140 milliseconds Oct 16 15:00:13 volumio volumio[1113]: info: ControllerMpd::getState Oct 16 15:00:13 volumio volumio[1113]: verbose: ControllerMpd::sendMpdCommand status Oct 16 15:00:13 volumio volumio[1113]: info: sendMpdCommand stop took 101 milliseconds Oct 16 15:00:13 volumio volumio[1113]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 15:00:13 volumio volumio[1113]: info: Oct 16 15:00:13 volumio volumio[1113]: ---------------------------- MPD announces system playlist update Oct 16 15:00:13 volumio volumio[1113]: info: Ignoring MPD Status Update Oct 16 15:00:13 volumio volumio[1113]: info: sendMpdCommand status took 3 milliseconds Oct 16 15:00:13 volumio volumio[1113]: info: sendMpdCommand clear took 3 milliseconds Oct 16 15:00:13 volumio volumio[1113]: verbose: ControllerMpd::parseState Oct 16 15:00:13 volumio volumio[1113]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 15:00:13 volumio volumio[1113]: verbose: ControllerMpd::sendMpdCommand add "USB/WD_MY_BOOK/Adele - 30 - 2021/01-adele-strangers_by_nature-cff1d3.flac" Oct 16 15:00:13 volumio systemd[1]: Stopping peppyspectrum Daemon... Oct 16 15:00:13 volumio systemd[1]: peppyspectrum.service: Main process exited, code=killed, status=15/TERM Oct 16 15:00:14 volumio volumio[1113]: error: updateQueue error: null Oct 16 15:00:14 volumio volumio[1113]: info: Oct 16 15:00:14 volumio volumio[1113]: ---------------------------- MPD announces system playlist update Oct 16 15:00:14 volumio volumio[1113]: info: Ignoring MPD Status Update Oct 16 15:00:14 volumio volumio[1113]: info: ------------------------------ 45ms Oct 16 15:00:14 volumio volumio[1113]: info: sendMpdCommand playlistinfo took 44 milliseconds Oct 16 15:00:14 volumio volumio[1113]: info: sendMpdCommand add "USB/WD_MY_BOOK/Adele - 30 - 2021/01-adele-strangers_by_nature-cff1d3.flac" took 44 milliseconds Oct 16 15:00:14 volumio volumio[1113]: verbose: ControllerMpd::parseTrackInfo Oct 16 15:00:14 volumio volumio[1113]: verbose: ControllerMpd::sendMpdCommand play Oct 16 15:00:14 volumio volumio[1113]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 16 15:00:14 volumio volumio[1113]: info: ------------------------------ 52ms Oct 16 15:00:14 volumio volumio[1113]: info: ------------------------------ 6ms Oct 16 15:00:14 volumio volumio[1113]: info: sendMpdCommand play took 5 milliseconds Oct 16 15:00:14 volumio systemd[1]: peppyspectrum.service: Succeeded. Oct 16 15:00:14 volumio systemd[1]: Stopped peppyspectrum Daemon. Oct 16 15:00:14 volumio volumio[1113]: info: Oct 16 15:00:14 volumio volumio[1113]: ---------------------------- MPD announces state update: player Oct 16 15:00:14 volumio volumio[1113]: info: ControllerMpd::getState Oct 16 15:00:14 volumio volumio[1113]: verbose: ControllerMpd::sendMpdCommand status Oct 16 15:00:14 volumio volumio[1113]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Oct 16 15:00:14 volumio volumio[1113]: info: FusionDsp - ---- read samplerate from file: 44100 Oct 16 15:00:14 volumio volumio[1113]: info: FusionDsp - If filter freq >samplerate/2 then disable it Oct 16 15:00:14 volumio volumio[1113]: info: FusionDsp - Nulleq applied Oct 16 15:00:14 volumio systemd[1]: peppymeterbasic.service: Succeeded. Oct 16 15:00:14 volumio systemd[1]: Stopped peppymeterbasic Daemon. Oct 16 15:00:14 volumio sudo[18427]: pam_unix(sudo:session): session closed for user root Oct 16 15:00:14 volumio volumio[1113]: info: touch_display: Setting screensaver timeout to 120 seconds. Oct 16 15:00:14 volumio volumio[1113]: info: Oct 16 15:00:14 volumio volumio[1113]: ---------------------------- MPD announces state update: player Oct 16 15:00:14 volumio volumio[1113]: info: ControllerMpd::getState Oct 16 15:00:14 volumio volumio[1113]: verbose: ControllerMpd::sendMpdCommand status Oct 16 15:00:14 volumio volumio[1113]: info: sendMpdCommand status took 11 milliseconds Oct 16 15:00:14 volumio volumio[1113]: verbose: ControllerMpd::parseState Oct 16 15:00:14 volumio volumio[1113]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 15:00:14 volumio volumio[1113]: info: peppyspectrum Daemon Stop Oct 16 15:00:14 volumio volumio[1113]: info: sendMpdCommand status took 4 milliseconds Oct 16 15:00:14 volumio volumio[1113]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 16 15:00:14 volumio volumio[1113]: verbose: ControllerMpd::parseState Oct 16 15:00:14 volumio volumio[1113]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 15:00:14 volumio volumio[1113]: verbose: ControllerMpd::parseTrackInfo Oct 16 15:00:14 volumio volumio[1113]: info: ControllerMpd::pushState Oct 16 15:00:14 volumio volumio[1113]: info: CoreCommandRouter::servicePushState Oct 16 15:00:14 volumio volumio[1113]: info: CorePlayQueue::getTrack 0 Oct 16 15:00:14 volumio volumio[1113]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":182,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"301 Kbps","isStreaming":false,"title":"Strangers By Nature","artist":"Adele","album":"30","uri":"USB/WD_MY_BOOK/Adele - 30 - 2021/01-adele-strangers_by_nature-cff1d3.flac","trackType":"flac"} Oct 16 15:00:14 volumio volumio[1113]: verbose: CURRENT POSITION 0 Oct 16 15:00:14 volumio volumio[1113]: info: CoreStateMachine::syncState stateService play Oct 16 15:00:14 volumio volumio[1113]: info: CoreStateMachine::syncState currentStatus stop Oct 16 15:00:14 volumio volumio[1113]: info: ------------------------------ 18ms Oct 16 15:00:14 volumio sudo[18424]: pam_unix(sudo:session): session closed for user root Oct 16 15:00:14 volumio volumio[1113]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 16 15:00:14 volumio volumio[1113]: verbose: ControllerMpd::parseTrackInfo Oct 16 15:00:14 volumio volumio[1113]: info: ControllerMpd::pushState Oct 16 15:00:14 volumio volumio[1113]: info: CoreCommandRouter::servicePushState Oct 16 15:00:14 volumio volumio[1113]: info: CorePlayQueue::getTrack 0 Oct 16 15:00:14 volumio volumio[1113]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":182,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"285 Kbps","isStreaming":false,"title":"Strangers By Nature","artist":"Adele","album":"30","uri":"USB/WD_MY_BOOK/Adele - 30 - 2021/01-adele-strangers_by_nature-cff1d3.flac","trackType":"flac"} Oct 16 15:00:14 volumio volumio[1113]: verbose: CURRENT POSITION 0 Oct 16 15:00:14 volumio volumio[1113]: info: CoreStateMachine::syncState stateService play Oct 16 15:00:14 volumio volumio[1113]: info: CoreStateMachine::syncState currentStatus play Oct 16 15:00:14 volumio volumio[1113]: info: Received an update from plugin. extracting info from payload Oct 16 15:00:14 volumio volumio[1113]: info: CoreStateMachine::pushState Oct 16 15:00:14 volumio volumio[1113]: info: CorePlayQueue::getTrack 0 Oct 16 15:00:14 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 15:00:14 volumio volumio[1113]: info: CoreCommandRouter::volumioPushState Oct 16 15:00:14 volumio volumio[1113]: info: CoreStateMachine::pushState Oct 16 15:00:14 volumio volumio[1113]: info: CorePlayQueue::getTrack 0 Oct 16 15:00:14 volumio volumio[1113]: info: CoreCommandRouter::volumioPushState Oct 16 15:00:14 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:14.098+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" state=STATUS_PLAYING positionMs=960 volume=28 Oct 16 15:00:14 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:14.098+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" id="mnt/USB/WD_MY_BOOK/Adele - 30 - 2021/01-adele-strangers_by_nature-cff1d3.flac" title="1 - Strangers By Nature" Oct 16 15:00:14 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:14.099+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" state=STATUS_PLAYING positionMs=960 volume=28 Oct 16 15:00:14 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:14.099+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" id="mnt/USB/WD_MY_BOOK/Adele - 30 - 2021/01-adele-strangers_by_nature-cff1d3.flac" title="1 - Strangers By Nature" Oct 16 15:00:14 volumio volumio[1113]: info: ------------------------------ 24ms Oct 16 15:00:14 volumio volumio[1113]: info: FusionDsp - {"Reload":{"result":"Ok"}} Oct 16 15:00:14 volumio volumio[1113]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 16 15:00:14 volumio volumio[1113]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 16 15:00:14 volumio sudo[18436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 16 15:00:14 volumio sudo[18436]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 15:00:14 volumio volumio[1113]: info: PeppySpectrum ---peppyspectrum status play Oct 16 15:00:14 volumio sudo[18440]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 16 15:00:14 volumio sudo[18440]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 15:00:14 volumio systemd[1]: Started peppymeterbasic Daemon. Oct 16 15:00:14 volumio volumio[1113]: info: PeppySpectrum ---peppyspectrum status play Oct 16 15:00:14 volumio sudo[18436]: pam_unix(sudo:session): session closed for user root Oct 16 15:00:14 volumio sudo[18443]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 16 15:00:14 volumio sudo[18443]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 15:00:14 volumio sudo[18440]: pam_unix(sudo:session): session closed for user root Oct 16 15:00:14 volumio systemd[1]: Started peppyspectrum Daemon. Oct 16 15:00:14 volumio volumio[1113]: info: [ASDebug] CurState: play PrevState: play Oct 16 15:00:14 volumio volumio[1113]: info: [ASDebug] CurState: play PrevState: play Oct 16 15:00:14 volumio volumio[1113]: SPOTIFY: RECEIVED VOLUMIO VOLUME 28 Oct 16 15:00:14 volumio volumio[1113]: SPOTIFY: RECEIVED VOLUMIO VOLUME 28 Oct 16 15:00:14 volumio volumio[1113]: info: peppymeterbasic Daemon Stop Oct 16 15:00:14 volumio sudo[18443]: pam_unix(sudo:session): session closed for user root Oct 16 15:00:14 volumio sudo[18447]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 16 15:00:14 volumio sudo[18447]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 15:00:14 volumio volumio[1113]: info: peppymeterbasic Daemon Started Oct 16 15:00:14 volumio sudo[18447]: pam_unix(sudo:session): session closed for user root Oct 16 15:00:14 volumio volumio[1113]: info: peppyspectrum Daemon Started Oct 16 15:00:14 volumio volumio[1113]: info: peppyspectrum Daemon Started Oct 16 15:00:15 volumio volumio[18448]: libpng warning: iCCP: known incorrect sRGB profile Oct 16 15:00:15 volumio volumio[18448]: libpng warning: iCCP: known incorrect sRGB profile Oct 16 15:00:15 volumio volumio[18448]: libpng warning: iCCP: known incorrect sRGB profile Oct 16 15:00:15 volumio volumio[18448]: libpng warning: iCCP: known incorrect sRGB profile Oct 16 15:00:15 volumio volumio[18448]: libpng warning: iCCP: known incorrect sRGB profile Oct 16 15:00:15 volumio volumio[18448]: libpng warning: iCCP: known incorrect sRGB profile Oct 16 15:00:15 volumio volumio[18448]: libpng warning: iCCP: known incorrect sRGB profile Oct 16 15:00:15 volumio volumio[18439]: libpng warning: iCCP: known incorrect sRGB profile Oct 16 15:00:15 volumio volumio[18439]: libpng warning: iCCP: known incorrect sRGB profile Oct 16 15:00:17 volumio kernel: bcmgenet fd580000.ethernet eth0: NETDEV WATCHDOG: CPU: 2: transmit queue 0 timed out 2650 ms Oct 16 15:00:33 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:33.061+02:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-40.108657ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Oct 16 15:00:33 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:33.125+02:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-35.848658ms timeout=10s Oct 16 15:00:33 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:33.138+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-35.848658ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=13.241472ms Oct 16 15:00:33 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:33.141+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-35.848658ms timeout=10s endpoint=http://pushupdates.volumio.org duration=15.513179ms Oct 16 15:00:33 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:33.143+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-35.848658ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=17.649463ms Oct 16 15:00:33 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:33.157+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-35.848658ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=32.418598ms Oct 16 15:00:33 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:33.224+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-35.848658ms timeout=10s endpoint=https://google.com duration=98.781122ms Oct 16 15:00:33 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:33.250+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-35.848658ms timeout=10s endpoint=https://www.googleapis.com duration=124.919313ms Oct 16 15:00:33 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:33.250+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-35.848658ms timeout=10s endpoint=http://cddb.volumio.org duration=125.000237ms error="Head \"http://gnudb.gnudb.org/~cddb/cddb.cgi/\": EOF" Oct 16 15:00:33 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:33.251+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-35.848658ms timeout=10s endpoint=https://securetoken.googleapis.com duration=125.749133ms Oct 16 15:00:33 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:33.257+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-35.848658ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=131.952987ms Oct 16 15:00:33 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:33.386+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-35.848658ms timeout=10s endpoint=http://plugins.volumio.org duration=260.667707ms Oct 16 15:00:33 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:33.386+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-35.848658ms timeout=10s endpoint=https://database.volumio.cloud duration=260.615281ms Oct 16 15:00:33 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:33.386+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-35.848658ms timeout=10s endpoint=https://functions.volumio.cloud duration=260.52795ms Oct 16 15:00:33 volumio volumio5-onboarding[11813]: time=2026-10-16T15:00:33.386+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%07,192.168.178.78:35948,192.168.178.78:56640 @ 0x36ea1e0" latency=-35.848658ms timeout=10s endpoint=https://functions.volumio.cloud duration=260.622874ms Oct 16 15:00:33 volumio sudo[18529]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 16 15:00:33 volumio sudo[18529]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 15:00:33 volumio sudo[18529]: pam_unix(sudo:session): session closed for user root Oct 16 15:00:33 volumio sudo[18532]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 15:00:33 volumio sudo[18532]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 15:00:33 volumio sudo[18532]: pam_unix(sudo:session): session closed for user root Oct 16 15:00:33 volumio volumio[1113]: verbose: New Socket.io Connection to 192.168.178.38 from 192.168.178.78 UA: Mozilla/5.0 (Linux; Android 16; SM-S731B Build/BP4A.251205.006; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/155.0.8059.43 Mobile Safari/537.36 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 14 Oct 16 15:00:34 volumio volumio[1113]: info: CoreCommandRouter::volumioGetVisibleSources Oct 16 15:00:34 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 15:00:34 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 16 15:00:34 volumio volumio[1113]: info: CoreCommandRouter::volumioGetState Oct 16 15:00:34 volumio volumio[1113]: info: CorePlayQueue::getTrack 0 Oct 16 15:00:34 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 16 15:00:34 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 16 15:00:34 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 16 15:00:34 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 16 15:00:34 volumio sudo[18535]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 16 15:00:34 volumio sudo[18535]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 15:00:34 volumio sudo[18535]: pam_unix(sudo:session): session closed for user root Oct 16 15:00:34 volumio sudo[18538]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 15:00:34 volumio sudo[18538]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 15:00:34 volumio sudo[18538]: pam_unix(sudo:session): session closed for user root Oct 16 15:00:34 volumio volumio[1113]: verbose: New Socket.io Connection to 192.168.178.38 from 192.168.178.78 UA: Mozilla/5.0 (Linux; Android 16; SM-S731B Build/BP4A.251205.006; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/155.0.8059.43 Mobile Safari/537.36 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 15 Oct 16 15:00:34 volumio volumio[1113]: info: CoreCommandRouter::volumioGetState Oct 16 15:00:34 volumio volumio[1113]: info: CorePlayQueue::getTrack 0 Oct 16 15:00:34 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 16 15:00:34 volumio volumio[1113]: info: Listing playlists Oct 16 15:00:34 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 16 15:00:34 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 16 15:00:34 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 16 15:00:34 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 16 15:00:35 volumio volumio[18439]: libpng warning: iCCP: known incorrect sRGB profile Oct 16 15:00:40 volumio volumio[1113]: info: CoreCommandRouter::volumioGetVisibleSources Oct 16 15:00:40 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 15:00:40 volumio volumio[1113]: info: CoreCommandRouter::volumioGetQueue Oct 16 15:00:40 volumio volumio[1113]: info: CoreStateMachine::getQueue Oct 16 15:00:40 volumio volumio[1113]: info: CorePlayQueue::getQueue Oct 16 15:00:52 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 16 15:00:52 volumio volumio[1113]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 16 15:00:52 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 16 15:00:52 volumio volumio[1113]: info: Received Get System Version Oct 16 15:00:52 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 15:00:52 volumio volumio[1113]: info: Received Get System Info Oct 16 15:00:52 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 15:00:52 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 15:00:52 volumio volumio[1113]: info: Discovery: Getting this device information Oct 16 15:00:52 volumio volumio[1113]: info: CoreCommandRouter::volumioGetState Oct 16 15:00:52 volumio volumio[1113]: info: CorePlayQueue::getTrack 0 Oct 16 15:00:52 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 15:00:52 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 16 15:00:52 volumio volumio[1113]: info: CURURI: genres:// Oct 16 15:00:53 volumio volumio[1113]: info: Preload queue cleared Oct 16 15:00:53 volumio volumio[1113]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Oct 16 15:00:55 volumio volumio[18439]: libpng warning: iCCP: known incorrect sRGB profile Oct 16 15:01:05 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 16 15:01:05 volumio volumio[1113]: info: CURURI: genres://80's%20Pop Oct 16 15:01:05 volumio volumio[1113]: info: Preload queue cleared Oct 16 15:01:05 volumio volumio[1113]: info: Preload queue cleared Oct 16 15:01:14 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 15:01:14 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 15:01:14 volumio volumio[1113]: info: Discovery: Getting this device information Oct 16 15:01:14 volumio volumio[1113]: info: CoreCommandRouter::volumioGetState Oct 16 15:01:14 volumio volumio[1113]: info: CorePlayQueue::getTrack 0 Oct 16 15:01:14 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 15:01:14 volumio volumio[1113]: verbose: New Socket.io Connection to 192.168.178.38:3000 from 192.168.178.78 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 15 Oct 16 15:01:14 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 16 15:01:14 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 16 15:01:14 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 15:01:14 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 15:01:14 volumio volumio[1113]: info: Discovery: Getting this device information Oct 16 15:01:14 volumio volumio[1113]: info: CoreCommandRouter::volumioGetState Oct 16 15:01:14 volumio volumio[1113]: info: CorePlayQueue::getTrack 0 Oct 16 15:01:14 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 15:01:14 volumio volumio[1113]: verbose: New Socket.io Connection to 192.168.178.52:3000 from 192.168.178.78 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 15 Oct 16 15:01:14 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 16 15:01:14 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 16 15:01:15 volumio volumio[1113]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 16 15:01:15 volumio volumio[1113]: info: CURURI: genres://80's%20Pop/Michael%20Jackson/So80s%20(So%20Eighties)%20Pres.%20Formel%20Eins%20Curated%20By%20Blank%20%26%20Jones%20(CD%201%2F3) Oct 16 15:01:15 volumio volumio[1113]: info: Preload queue cleared Oct 16 15:01:15 volumio volumio[1113]: info: Preloading song: music-library/USB/WD_MY_BOOK/VA - Formel Eins (1983 - 2019 )/VA - Formel Eins (2013) - So80s So Eighties Pres. Curated By Blank and Jones - 2013/101-michael_jackson-billie_jean_(album_version).mp3 Oct 16 15:01:15 volumio volumio[1113]: info: Exploding uri music-library/USB/WD_MY_BOOK/VA - Formel Eins (1983 - 2019 )/VA - Formel Eins (2013) - So80s So Eighties Pres. Curated By Blank and Jones - 2013/101-michael_jackson-billie_jean_(album_version).mp3 in service mpd Oct 16 15:01:15 volumio volumio[1113]: info: ALBUMART /albumart?cacheid=257&web=Michael%20Jackson/So80s%20(So%20Eighties)%20Pres.%20Formel%20Eins%20Curated%20By%20Blank%20%26%20Jones%20(CD%201%2F3)/medium&path=%2Fmnt%2FUSB%2FWD_MY_BOOK%2FVA%20-%20Formel%20Eins%20(1983%20-%202019%20)%2FVA%20-%20Formel%20Eins%20(2013)%20-%20So80s%20So%20Eighties%20Pres.%20Curated%20By%20Blank%20and%20Jones%20-%202013%2F101-michael_jackson-billie_jean_(album_version).mp3&metadata=false Oct 16 15:01:15 volumio volumio[1113]: info: URI /mnt/USB/WD_MY_BOOK/VA - Formel Eins (1983 - 2019 )/VA - Formel Eins (2013) - So80s So Eighties Pres. Curated By Blank and Jones - 2013/101-michael_jackson-billie_jean_(album_version).mp3 Oct 16 15:01:15 volumio volumio[18439]: libpng warning: iCCP: known incorrect sRGB profile Oct 16 15:01:16 volumio volumio[1113]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 15:01:16 volumio volumio[1113]: TypeError: Cannot read property 'slice' of null Oct 16 15:01:16 volumio volumio[1113]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Oct 16 15:01:16 volumio volumio[1113]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Oct 16 15:01:16 volumio volumio[1113]: at Object.onceWrapper (events.js:422:26) Oct 16 15:01:16 volumio volumio[1113]: at ClientRequest.emit (events.js:315:20) Oct 16 15:01:16 volumio volumio[1113]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27) Oct 16 15:01:16 volumio volumio[1113]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17) Oct 16 15:01:16 volumio volumio[1113]: at TLSSocket.socketOnData (_http_client.js:509:22) Oct 16 15:01:16 volumio volumio[1113]: at TLSSocket.emit (events.js:315:20) Oct 16 15:01:16 volumio volumio[1113]: at addChunk (internal/streams/readable.js:309:12) Oct 16 15:01:16 volumio volumio[1113]: at readableAddChunk (internal/streams/readable.js:284:9) Oct 16 15:01:16 volumio volumio[1113]: at TLSSocket.Readable.push (internal/streams/readable.js:223:10) Oct 16 15:01:16 volumio volumio[1113]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Oct 16 15:01:16 volumio volumio[1113]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 15:01:16 volumio sudo[18625]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-10-16 15:00 Oct 16 15:01:16 volumio sudo[18625]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"