Oct 12 14:57:16 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:57:16.276+02:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=87.646579ms timeout=10s Oct 12 14:57:16 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:57:16.360+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=87.646579ms timeout=10s endpoint=http://pushupdates.volumio.org duration=81.92816ms Oct 12 14:57:16 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:57:16.472+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=87.646579ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=193.522037ms Oct 12 14:57:16 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:57:16.556+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=87.646579ms timeout=10s endpoint=https://securetoken.googleapis.com duration=277.062277ms Oct 12 14:57:16 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:57:16.565+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=87.646579ms timeout=10s endpoint=https://www.googleapis.com duration=286.110643ms Oct 12 14:57:16 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:57:16.639+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=87.646579ms timeout=10s endpoint=https://functions.volumio.cloud duration=359.166426ms Oct 12 14:57:16 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:57:16.642+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=87.646579ms timeout=10s endpoint=https://functions.volumio.cloud duration=363.850375ms Oct 12 14:57:16 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:57:16.736+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=87.646579ms timeout=10s endpoint=http://cddb.volumio.org duration=458.332986ms error="Head \"http://gnudb.gnudb.org/~cddb/cddb.cgi/\": EOF" Oct 12 14:57:16 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:57:16.752+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=87.646579ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=473.948943ms Oct 12 14:57:16 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:57:16.833+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=87.646579ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=554.924292ms Oct 12 14:57:16 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:57:16.896+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=87.646579ms timeout=10s endpoint=https://google.com duration=617.59994ms Oct 12 14:57:16 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:57:16.931+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=87.646579ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=651.297473ms Oct 12 14:57:16 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:57:16.937+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=87.646579ms timeout=10s endpoint=https://database.volumio.cloud duration=657.649022ms Oct 12 14:57:17 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:57:17.034+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=87.646579ms timeout=10s endpoint=http://plugins.volumio.org duration=755.824595ms Oct 12 14:57:17 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 14:57:17 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 14:57:17 volumiouz volumio[1137]: info: Discovery: Getting this device information Oct 12 14:57:17 volumiouz volumio[1137]: info: CoreCommandRouter::volumioGetState Oct 12 14:57:17 volumiouz volumio[1137]: info: CorePlayQueue::getTrack 18 Oct 12 14:57:17 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 14:57:17 volumiouz volumio[1137]: verbose: New Socket.io Connection to 192.168.188.179:3000 from 192.168.188.131 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Oct 12 14:57:17 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 12 14:57:17 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 12 14:57:24 volumiouz volumio[1137]: Searching plugin music_service/mpd Oct 12 14:57:24 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: mpd , search Oct 12 14:57:28 volumiouz volumio[1137]: info: All search sources collected, pushing search results Oct 12 14:57:34 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:57:34.909+02:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=82.559809ms timeout=10s Oct 12 14:57:34 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:57:34.919+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=82.559809ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=9.477583ms Oct 12 14:57:34 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:57:34.934+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=82.559809ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=23.809219ms Oct 12 14:57:34 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:57:34.941+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=82.559809ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=31.219933ms Oct 12 14:57:34 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:57:34.945+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=82.559809ms timeout=10s endpoint=http://pushupdates.volumio.org duration=34.298624ms Oct 12 14:57:35 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:57:35.019+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=82.559809ms timeout=10s endpoint=https://www.googleapis.com duration=108.929661ms Oct 12 14:57:35 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 14:57:35 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 14:57:35 volumiouz volumio[1137]: info: Discovery: Getting this device information Oct 12 14:57:35 volumiouz volumio[1137]: info: CoreCommandRouter::volumioGetState Oct 12 14:57:35 volumiouz volumio[1137]: info: CorePlayQueue::getTrack 18 Oct 12 14:57:35 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 14:57:35 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:57:35.044+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=82.559809ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=134.2582ms Oct 12 14:57:35 volumiouz volumio[1137]: verbose: New Socket.io Connection to 192.168.188.179:3000 from 192.168.188.131 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Oct 12 14:57:35 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 12 14:57:35 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 12 14:57:35 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:57:35.067+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=82.559809ms timeout=10s endpoint=https://database.volumio.cloud duration=156.304142ms Oct 12 14:57:35 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:57:35.069+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=82.559809ms timeout=10s endpoint=https://functions.volumio.cloud duration=159.609031ms Oct 12 14:57:35 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:57:35.069+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=82.559809ms timeout=10s endpoint=https://functions.volumio.cloud duration=159.460386ms Oct 12 14:57:35 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:57:35.234+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=82.559809ms timeout=10s endpoint=https://securetoken.googleapis.com duration=323.781801ms Oct 12 14:57:35 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:57:35.240+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=82.559809ms timeout=10s endpoint=https://google.com duration=330.299131ms Oct 12 14:57:35 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:57:35.323+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=82.559809ms timeout=10s endpoint=http://cddb.volumio.org duration=413.981919ms error="Head \"http://gnudb.gnudb.org/~cddb/cddb.cgi/\": EOF" Oct 12 14:57:35 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:57:35.471+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=82.559809ms timeout=10s endpoint=http://plugins.volumio.org duration=560.578166ms Oct 12 14:57:38 volumiouz volumio[1137]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 14:57:38 volumiouz volumio[1137]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 14:57:38 volumiouz volumio[1137]: info: Retrieving Cloud Streaming UI Oct 12 14:57:38 volumiouz volumio[1137]: info: Getting Tidal Cloud Configuration Oct 12 14:57:38 volumiouz volumio[1137]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 14:57:38 volumiouz volumio[1137]: info: Getting Qobuz Cloud Configuration Oct 12 14:57:38 volumiouz volumio[1137]: info: Asking plugin for UI Config Oct 12 14:57:38 volumiouz volumio[1137]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 14:57:38 volumiouz volumio[1137]: info: Getting Spotify Cloud Configuration Oct 12 14:57:38 volumiouz volumio[1137]: info: Asking plugin for UI Config Oct 12 14:57:38 volumiouz volumio[1137]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 14:57:38 volumiouz volumio[1137]: info: Saving Spotify Acccount Oct 12 14:57:38 volumiouz volumio[1137]: info: Got Tidal Cloud Configuration Oct 12 14:57:38 volumiouz volumio[1137]: info: Got it Oct 12 14:57:38 volumiouz volumio[1137]: info: Got it Oct 12 14:57:38 volumiouz volumio[1137]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 12 14:57:39 volumiouz volumio[1137]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 14:57:39 volumiouz volumio[1137]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Oct 12 14:57:39 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 12 14:57:39 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 12 14:57:39 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 12 14:57:39 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 12 14:57:39 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 14:57:39 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 14:57:39 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 14:57:39 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 14:57:39 volumiouz volumio[1137]: info: CoreCommandRouter::volumioGetBrowseSources Oct 12 14:57:39 volumiouz volumio[1137]: info: CoreCommandRouter::volumioGetBrowseSources Oct 12 14:57:39 volumiouz volumio[1137]: info: CoreCommandRouter::volumioGetBrowseSources Oct 12 14:57:39 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 12 14:57:39 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 12 14:57:43 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 12 14:57:45 volumiouz volumio[1137]: info: CALLMETHOD: miscellanea albumart clearAlbumartCache Oct 12 14:57:45 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: albumart , clearAlbumartCache Oct 12 14:57:46 volumiouz volumio[1137]: info: CALLMETHOD: miscellanea albumart clearAlbumartCache Oct 12 14:57:46 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: albumart , clearAlbumartCache Oct 12 14:57:47 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 12 14:57:47 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: mpd , rebuildAlbumCache Oct 12 14:57:47 volumiouz volumio[1137]: info: Rebuild Album cache Oct 12 14:57:47 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: mpd , rebuildAlbumCache Oct 12 14:57:47 volumiouz volumio[1137]: info: Rebuild Album cache Oct 12 14:57:50 volumiouz volumio[1137]: info: CALLMETHOD: miscellanea albumart clearAlbumartCache Oct 12 14:57:50 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: albumart , clearAlbumartCache Oct 12 14:57:51 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: mpd , rebuildAlbumCache Oct 12 14:57:51 volumiouz volumio[1137]: info: Rebuild Album cache Oct 12 14:57:51 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 12 14:57:54 volumiouz volumio[1137]: info: CALLMETHOD: miscellanea albumart clearAlbumartCache Oct 12 14:57:54 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: albumart , clearAlbumartCache Oct 12 14:57:56 volumiouz volumio[1137]: Cannot compose Albumart path Oct 12 14:57:56 volumiouz volumio[1137]: Cannot compose Albumart path Oct 12 14:57:57 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 12 14:57:57 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: mpd , rebuildAlbumCache Oct 12 14:57:57 volumiouz volumio[1137]: info: Rebuild Album cache Oct 12 14:57:59 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 12 14:58:03 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 12 14:58:05 volumiouz volumio[1137]: Cannot compose Albumart path Oct 12 14:58:05 volumiouz volumio[1137]: Cannot compose Albumart path Oct 12 14:58:07 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 12 14:58:07 volumiouz volumio[1137]: info: CALLMETHOD: miscellanea albumart clearAlbumartCache Oct 12 14:58:07 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: albumart , clearAlbumartCache Oct 12 14:58:07 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: mpd , rebuildAlbumCache Oct 12 14:58:07 volumiouz volumio[1137]: info: Rebuild Album cache Oct 12 14:58:10 volumiouz volumio[1137]: info: CALLMETHOD: miscellanea albumart clearAlbumartCache Oct 12 14:58:10 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: albumart , clearAlbumartCache Oct 12 14:58:11 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: mpd , rebuildAlbumCache Oct 12 14:58:11 volumiouz volumio[1137]: info: Rebuild Album cache Oct 12 14:58:11 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 12 14:58:11 volumiouz volumio[1137]: info: CALLMETHOD: miscellanea albumart saveAlbumartOptions [object Object] Oct 12 14:58:11 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: albumart , saveAlbumartOptions Oct 12 14:58:14 volumiouz volumio[1137]: Cannot compose Albumart path Oct 12 14:58:14 volumiouz volumio[1137]: Cannot compose Albumart path Oct 12 14:58:15 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:58:15.535+02:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=83.28454ms timeout=10s Oct 12 14:58:15 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:58:15.544+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=83.28454ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=8.43946ms Oct 12 14:58:15 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:58:15.561+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=83.28454ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=23.55776ms Oct 12 14:58:15 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:58:15.568+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=83.28454ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=30.892848ms Oct 12 14:58:15 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:58:15.572+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=83.28454ms timeout=10s endpoint=http://pushupdates.volumio.org duration=34.256746ms Oct 12 14:58:15 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 12 14:58:15 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:58:15.646+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=83.28454ms timeout=10s endpoint=https://www.googleapis.com duration=109.075747ms Oct 12 14:58:15 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:58:15.670+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=83.28454ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=132.694183ms Oct 12 14:58:15 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:58:15.685+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=83.28454ms timeout=10s endpoint=https://database.volumio.cloud duration=147.622431ms Oct 12 14:58:15 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:58:15.693+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=83.28454ms timeout=10s endpoint=https://functions.volumio.cloud duration=155.131477ms Oct 12 14:58:15 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:58:15.694+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=83.28454ms timeout=10s endpoint=https://functions.volumio.cloud duration=158.128085ms Oct 12 14:58:15 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:58:15.699+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=83.28454ms timeout=10s endpoint=https://securetoken.googleapis.com duration=161.548963ms Oct 12 14:58:15 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:58:15.894+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=83.28454ms timeout=10s endpoint=https://google.com duration=358.26019ms Oct 12 14:58:15 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:58:15.984+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=83.28454ms timeout=10s endpoint=http://cddb.volumio.org duration=447.012128ms error="Head \"http://gnudb.gnudb.org/~cddb/cddb.cgi/\": EOF" Oct 12 14:58:16 volumiouz volumio5-onboarding[1430]: time=2026-10-12T14:58:16.096+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.188.131:44296,00:00:00:00:00:00%01 @ 0x3000c00" latency=83.28454ms timeout=10s endpoint=http://plugins.volumio.org duration=557.417038ms Oct 12 14:58:16 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 14:58:16 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 14:58:16 volumiouz volumio[1137]: info: Discovery: Getting this device information Oct 12 14:58:16 volumiouz volumio[1137]: info: CoreCommandRouter::volumioGetState Oct 12 14:58:16 volumiouz volumio[1137]: info: CorePlayQueue::getTrack 18 Oct 12 14:58:16 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 14:58:16 volumiouz volumio[1137]: verbose: New Socket.io Connection to 192.168.188.179:3000 from 192.168.188.131 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Oct 12 14:58:16 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 12 14:58:16 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 12 14:58:23 volumiouz volumio[1137]: Cannot compose Albumart path Oct 12 14:58:23 volumiouz volumio[1137]: Cannot compose Albumart path Oct 12 14:58:23 volumiouz volumio[1137]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 14:58:23 volumiouz volumio[1137]: info: CURURI: artists:// Oct 12 14:58:31 volumiouz volumio[1137]: Cannot compose Albumart path Oct 12 14:58:31 volumiouz volumio[1137]: Cannot compose Albumart path Oct 12 14:58:39 volumiouz volumio[1137]: Cannot compose Albumart path Oct 12 14:58:39 volumiouz volumio[1137]: Cannot compose Albumart path Oct 12 14:58:39 volumiouz volumio[1137]: info: Preload queue cleared Oct 12 14:58:50 volumiouz volumio[1137]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 14:58:50 volumiouz volumio[1137]: TypeError: Cannot read properties of null (reading 'slice') Oct 12 14:58:50 volumiouz volumio[1137]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Oct 12 14:58:50 volumiouz volumio[1137]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Oct 12 14:58:50 volumiouz volumio[1137]: at Object.onceWrapper (node:events:629:26) Oct 12 14:58:50 volumiouz volumio[1137]: at ClientRequest.emit (node:events:514:28) Oct 12 14:58:50 volumiouz volumio[1137]: at HTTPParser.parserOnIncomingClient [as onIncoming] (node:_http_client:693:27) Oct 12 14:58:50 volumiouz volumio[1137]: at HTTPParser.parserOnHeadersComplete (node:_http_common:119:17) Oct 12 14:58:50 volumiouz volumio[1137]: at TLSSocket.socketOnData (node:_http_client:535:22) Oct 12 14:58:50 volumiouz volumio[1137]: at TLSSocket.emit (node:events:514:28) Oct 12 14:58:50 volumiouz volumio[1137]: at addChunk (node:internal/streams/readable:343:12) Oct 12 14:58:50 volumiouz volumio[1137]: at readableAddChunk (node:internal/streams/readable:316:9) Oct 12 14:58:50 volumiouz volumio[1137]: at Readable.push (node:internal/streams/readable:253:10) Oct 12 14:58:50 volumiouz volumio[1137]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:190:23) Oct 12 14:58:50 volumiouz volumio[1137]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 14:58:52 volumiouz sudo[8412]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-12 14:57' Oct 12 14:58:52 volumiouz sudo[8412]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"