Aug 26 08:23:00 primo-plus volumio5-onboarding[1938]: time=2026-08-26T08:23:00.444+02:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%5c,192.168.50.244:62421 @ 0x2cbcd50" latency=69.257265ms timeout=10s Aug 26 08:23:00 primo-plus volumio5-onboarding[1938]: time=2026-08-26T08:23:00.581+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%5c,192.168.50.244:62421 @ 0x2cbcd50" latency=69.257265ms timeout=10s endpoint=http://pushupdates.volumio.org duration=128.353724ms Aug 26 08:23:00 primo-plus volumio5-onboarding[1938]: time=2026-08-26T08:23:00.675+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%5c,192.168.50.244:62421 @ 0x2cbcd50" latency=69.257265ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=230.46455ms Aug 26 08:23:00 primo-plus volumio5-onboarding[1938]: time=2026-08-26T08:23:00.790+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%5c,192.168.50.244:62421 @ 0x2cbcd50" latency=69.257265ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=344.454351ms Aug 26 08:23:00 primo-plus volumio5-onboarding[1938]: time=2026-08-26T08:23:00.828+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%5c,192.168.50.244:62421 @ 0x2cbcd50" latency=69.257265ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=381.82962ms Aug 26 08:23:00 primo-plus volumio5-onboarding[1938]: time=2026-08-26T08:23:00.832+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%5c,192.168.50.244:62421 @ 0x2cbcd50" latency=69.257265ms timeout=10s endpoint=https://www.googleapis.com duration=379.12647ms Aug 26 08:23:00 primo-plus volumio5-onboarding[1938]: time=2026-08-26T08:23:00.883+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%5c,192.168.50.244:62421 @ 0x2cbcd50" latency=69.257265ms timeout=10s endpoint=https://securetoken.googleapis.com duration=428.875651ms Aug 26 08:23:00 primo-plus volumio5-onboarding[1938]: time=2026-08-26T08:23:00.981+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%5c,192.168.50.244:62421 @ 0x2cbcd50" latency=69.257265ms timeout=10s endpoint=https://google.com duration=529.897936ms Aug 26 08:23:01 primo-plus volumio5-onboarding[1938]: time=2026-08-26T08:23:01.038+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%5c,192.168.50.244:62421 @ 0x2cbcd50" latency=69.257265ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=583.455307ms Aug 26 08:23:01 primo-plus volumio5-onboarding[1938]: time=2026-08-26T08:23:01.039+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%5c,192.168.50.244:62421 @ 0x2cbcd50" latency=69.257265ms timeout=10s endpoint=https://functions.volumio.cloud duration=583.219125ms Aug 26 08:23:01 primo-plus volumio5-onboarding[1938]: time=2026-08-26T08:23:01.040+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%5c,192.168.50.244:62421 @ 0x2cbcd50" latency=69.257265ms timeout=10s endpoint=https://functions.volumio.cloud duration=590.178145ms Aug 26 08:23:01 primo-plus volumio5-onboarding[1938]: time=2026-08-26T08:23:01.289+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%5c,192.168.50.244:62421 @ 0x2cbcd50" latency=69.257265ms timeout=10s endpoint=https://database.volumio.cloud duration=840.146995ms Aug 26 08:23:01 primo-plus volumio[1178]: verbose: New Socket.io Connection to 192.168.50.182 from 192.168.50.244 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 10 Aug 26 08:23:01 primo-plus volumio[1178]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 26 08:23:01 primo-plus volumio[1178]: info: CoreCommandRouter::volumioGetVisibleSources Aug 26 08:23:01 primo-plus volumio[1178]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 26 08:23:01 primo-plus volumio[1178]: info: CoreCommandRouter::volumioGetState Aug 26 08:23:01 primo-plus volumio[1178]: info: CorePlayQueue::getTrack 1 Aug 26 08:23:01 primo-plus volumio[1178]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 26 08:23:01 primo-plus volumio[1178]: info: CoreCommandRouter::volumioGetQueue Aug 26 08:23:01 primo-plus volumio[1178]: info: CoreStateMachine::getQueue Aug 26 08:23:01 primo-plus volumio[1178]: info: CorePlayQueue::getQueue Aug 26 08:23:01 primo-plus volumio[1178]: info: Listing playlists Aug 26 08:23:01 primo-plus volumio[1178]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 26 08:23:01 primo-plus volumio[1178]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Aug 26 08:23:01 primo-plus volumio[1178]: info: CoreCommandRouter::executeOnPlugin: inputs , handleBrowseUri Aug 26 08:23:01 primo-plus volumio[1178]: info: Received Get System Info Aug 26 08:23:01 primo-plus volumio[1178]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 08:23:01 primo-plus volumio[1178]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 08:23:01 primo-plus volumio[1178]: info: Discovery: Getting this device information Aug 26 08:23:01 primo-plus volumio[1178]: info: CoreCommandRouter::volumioGetState Aug 26 08:23:01 primo-plus volumio[1178]: info: CorePlayQueue::getTrack 1 Aug 26 08:23:01 primo-plus volumio[1178]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 08:23:01 primo-plus volumio[1178]: info: CoreCommandRouter::volumioGetState Aug 26 08:23:01 primo-plus volumio[1178]: info: CorePlayQueue::getTrack 1 Aug 26 08:23:01 primo-plus volumio[1178]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 08:23:01 primo-plus volumio[1178]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 08:23:01 primo-plus volumio[1178]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 08:23:01 primo-plus volumio[1178]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 08:23:01 primo-plus volumio[1178]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 08:23:01 primo-plus volumio[1178]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 08:23:01 primo-plus volumio[1178]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 08:23:01 primo-plus volumio[1178]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 08:23:01 primo-plus volumio[1178]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 08:23:01 primo-plus volumio[1178]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 08:23:01 primo-plus volumio[1178]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 08:23:01 primo-plus volumio[1178]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 08:23:03 primo-plus volumio[1178]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 26 08:23:03 primo-plus volumio[1178]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 08:23:03 primo-plus volumio[1178]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 08:23:03 primo-plus volumio[1178]: info: Discovery: Getting this device information Aug 26 08:23:03 primo-plus volumio[1178]: info: CoreCommandRouter::volumioGetState Aug 26 08:23:03 primo-plus volumio[1178]: info: CorePlayQueue::getTrack 1 Aug 26 08:23:03 primo-plus volumio[1178]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 08:23:03 primo-plus volumio[1178]: verbose: New Socket.io Connection to 192.168.50.182:3000 from 192.168.50.244 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11 Aug 26 08:23:03 primo-plus volumio[1178]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 26 08:23:03 primo-plus volumio[1178]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 26 08:23:10 primo-plus volumio5-onboarding[1938]: time=2026-08-26T08:23:10.445+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%5c,192.168.50.244:62421 @ 0x2cbcd50" latency=69.257265ms timeout=10s endpoint=http://plugins.volumio.org duration=9.996308571s error="Head \"http://plugins.volumio.org\": context deadline exceeded" Aug 26 08:23:10 primo-plus volumio5-onboarding[1938]: time=2026-08-26T08:23:10.446+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%5c,192.168.50.244:62421 @ 0x2cbcd50" latency=69.257265ms timeout=10s endpoint=http://cddb.volumio.org duration=9.990597553s error="Head \"http://cddb.volumio.org\": context deadline exceeded" Aug 26 08:23:13 primo-plus volumio[1178]: Searching plugin music_service/qobuz Aug 26 08:23:13 primo-plus volumio[1178]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 26 08:23:14 primo-plus volumio[1178]: Searching plugin music_service/qobuz Aug 26 08:23:14 primo-plus volumio[1178]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 26 08:23:14 primo-plus volumio[1178]: info: searchQOBUZUri took 1254 milliseconds Aug 26 08:23:14 primo-plus volumio[1178]: info: All search sources collected, pushing search results Aug 26 08:23:15 primo-plus volumio[1178]: Searching plugin music_service/qobuz Aug 26 08:23:15 primo-plus volumio[1178]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 26 08:23:15 primo-plus volumio[1178]: info: searchQOBUZUri took 1528 milliseconds Aug 26 08:23:15 primo-plus volumio[1178]: info: All search sources collected, pushing search results Aug 26 08:23:16 primo-plus volumio[1178]: info: searchQOBUZUri took 992 milliseconds Aug 26 08:23:16 primo-plus volumio[1178]: info: All search sources collected, pushing search results Aug 26 08:23:17 primo-plus volumio[1178]: Searching plugin music_service/qobuz Aug 26 08:23:17 primo-plus volumio[1178]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 26 08:23:18 primo-plus volumio[1178]: info: searchQOBUZUri took 930 milliseconds Aug 26 08:23:18 primo-plus volumio[1178]: info: All search sources collected, pushing search results Aug 26 08:23:26 primo-plus volumio[1178]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Aug 26 08:23:28 primo-plus volumio[1178]: info: handleBrowseUri took 2284 milliseconds Aug 26 08:23:29 primo-plus volumio[1178]: info: Preload queue cleared Aug 26 08:23:29 primo-plus volumio[1178]: info: Executing endpoint getSimilarArtists Aug 26 08:23:29 primo-plus volumio[1178]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Aug 26 08:23:29 primo-plus volumio[1178]: info: Executing endpoint metavolumio Aug 26 08:23:29 primo-plus volumio[1178]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 26 08:23:31 primo-plus volumio[1178]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 08:23:31 primo-plus volumio[1178]: AggregateError Aug 26 08:23:31 primo-plus volumio[1178]: at internalConnectMultiple (node:net:1114:18) Aug 26 08:23:31 primo-plus volumio[1178]: at afterConnectMultiple (node:net:1667:5) { Aug 26 08:23:31 primo-plus volumio[1178]: code: 'ECONNREFUSED', Aug 26 08:23:31 primo-plus volumio[1178]: [errors]: [ Aug 26 08:23:31 primo-plus volumio[1178]: Error: connect ECONNREFUSED 158.69.209.125:443 Aug 26 08:23:31 primo-plus volumio[1178]: at createConnectionError (node:net:1634:14) Aug 26 08:23:31 primo-plus volumio[1178]: at afterConnectMultiple (node:net:1664:40) { Aug 26 08:23:31 primo-plus volumio[1178]: errno: -111, Aug 26 08:23:31 primo-plus volumio[1178]: code: 'ECONNREFUSED', Aug 26 08:23:31 primo-plus volumio[1178]: syscall: 'connect', Aug 26 08:23:31 primo-plus volumio[1178]: address: '158.69.209.125', Aug 26 08:23:31 primo-plus volumio[1178]: port: 443 Aug 26 08:23:31 primo-plus volumio[1178]: }, Aug 26 08:23:31 primo-plus volumio[1178]: Error: connect ECONNREFUSED 158.69.210.98:443 Aug 26 08:23:31 primo-plus volumio[1178]: at createConnectionError (node:net:1634:14) Aug 26 08:23:31 primo-plus volumio[1178]: at afterConnectMultiple (node:net:1664:40) { Aug 26 08:23:31 primo-plus volumio[1178]: errno: -111, Aug 26 08:23:31 primo-plus volumio[1178]: code: 'ECONNREFUSED', Aug 26 08:23:31 primo-plus volumio[1178]: syscall: 'connect', Aug 26 08:23:31 primo-plus volumio[1178]: address: '158.69.210.98', Aug 26 08:23:31 primo-plus volumio[1178]: port: 443 Aug 26 08:23:31 primo-plus volumio[1178]: } Aug 26 08:23:31 primo-plus volumio[1178]: ] Aug 26 08:23:31 primo-plus volumio[1178]: } Aug 26 08:23:31 primo-plus volumio[1178]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 08:23:31 primo-plus sudo[23978]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-26 08:22' Aug 26 08:23:31 primo-plus sudo[23978]: 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="ceea798be624bcca033d94ae449c2a749a9724f0" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="9938d7179e3b7c4e41f3e2d60c255985cff08fee" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="primoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed May 27 09:37:15 UTC 2026" VOLUMIO_VERSION="4.164" VOLUMIO_HARDWARE="cm4" VOLUMIO_DEVICENAME="CM4" VOLUMIO_VENDOR_MODEL="Volumio Primo Plus" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Primo Plus" VOLUMIO_HASH="c8e7083e83ff605518b1cfc23784b0e7"