Aug 29 15:04:09 volumio volumio5-onboarding[1611]: time=2026-08-29T15:04:09.011+08:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.2.209:64908,00:00:00:00:00:00%27 @ 0x209a120" latency=12.693933ms timeout=10s
Aug 29 15:04:09 volumio volumio5-onboarding[1611]: time=2026-08-29T15:04:09.626+08:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.2.209:64908,00:00:00:00:00:00%27 @ 0x209a120" latency=12.693933ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=613.695718ms
Aug 29 15:04:09 volumio volumio[2522]: verbose: New Socket.io Connection to 192.168.2.83 from 192.168.2.209 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_6_2 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 5
Aug 29 15:04:09 volumio volumio[2522]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Aug 29 15:04:09 volumio volumio5-onboarding[1611]: time=2026-08-29T15:04:09.687+08:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.2.209:64908,00:00:00:00:00:00%27 @ 0x209a120" latency=12.693933ms timeout=10s endpoint=https://functions.volumio.cloud duration=674.889381ms
Aug 29 15:04:09 volumio volumio5-onboarding[1611]: time=2026-08-29T15:04:09.688+08:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.2.209:64908,00:00:00:00:00:00%27 @ 0x209a120" latency=12.693933ms timeout=10s endpoint=https://functions.volumio.cloud duration=676.297899ms
Aug 29 15:04:09 volumio volumio[2522]: info: CoreCommandRouter::volumioGetVisibleSources
Aug 29 15:04:09 volumio volumio[2522]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 29 15:04:09 volumio volumio[2522]: info: CoreCommandRouter::volumioGetState
Aug 29 15:04:09 volumio volumio[2522]: info: CorePlayQueue::getTrack 125
Aug 29 15:04:09 volumio volumio[2522]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Aug 29 15:04:09 volumio volumio[2522]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Aug 29 15:04:09 volumio volumio[2522]: info: Received Get System Info
Aug 29 15:04:09 volumio volumio[2522]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 29 15:04:09 volumio volumio[2522]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 29 15:04:09 volumio volumio[2522]: info: Discovery: Getting this device information
Aug 29 15:04:09 volumio volumio[2522]: info: CoreCommandRouter::volumioGetState
Aug 29 15:04:09 volumio volumio[2522]: info: CorePlayQueue::getTrack 125
Aug 29 15:04:09 volumio volumio[2522]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 29 15:04:09 volumio volumio[2522]: info: CoreCommandRouter::volumioGetState
Aug 29 15:04:09 volumio volumio[2522]: info: CorePlayQueue::getTrack 125
Aug 29 15:04:09 volumio volumio[2522]: info: Listing playlists
Aug 29 15:04:09 volumio volumio[2522]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E7%8E%89%E7%BD%AE%E6%B5%A9%E4%BA%8C/%E9%85%92%E7%BA%A2%E8%89%B2%E7%9A%84%E5%BF%83/d9419819-66cb-4cef-8f0f-b15b36206f37.jpg'
Aug 29 15:04:09 volumio volumio5-onboarding[1611]: time=2026-08-29T15:04:09.888+08:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.2.209:64908,00:00:00:00:00:00%27 @ 0x209a120" latency=12.693933ms timeout=10s endpoint=http://cddb.volumio.org duration=876.509084ms
Aug 29 15:04:10 volumio volumio[2522]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Aug 29 15:04:10 volumio volumio5-onboarding[1611]: time=2026-08-29T15:04:10.116+08:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.2.209:64908,00:00:00:00:00:00%27 @ 0x209a120" latency=12.693933ms timeout=10s endpoint=http://pushupdates.volumio.org duration=1.103761112s
Aug 29 15:04:10 volumio volumio5-onboarding[1611]: time=2026-08-29T15:04:10.168+08:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.2.209:64908,00:00:00:00:00:00%27 @ 0x209a120" latency=12.693933ms timeout=10s endpoint=https://database.volumio.cloud duration=1.155430889s
Aug 29 15:04:10 volumio volumio5-onboarding[1611]: time=2026-08-29T15:04:10.441+08:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.2.209:64908,00:00:00:00:00:00%27 @ 0x209a120" latency=12.693933ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=1.427984011s
Aug 29 15:04:11 volumio volumio[2522]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 29 15:04:11 volumio volumio[2522]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 29 15:04:11 volumio volumio[2522]: info: Discovery: Getting this device information
Aug 29 15:04:11 volumio volumio[2522]: info: CoreCommandRouter::volumioGetState
Aug 29 15:04:11 volumio volumio[2522]: info: CorePlayQueue::getTrack 125
Aug 29 15:04:11 volumio volumio[2522]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 29 15:04:11 volumio volumio[2522]: verbose: New Socket.io Connection to 192.168.2.83:3000 from 192.168.2.209 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6
Aug 29 15:04:11 volumio volumio[2522]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Aug 29 15:04:11 volumio volumio[2522]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Aug 29 15:04:11 volumio volumio5-onboarding[1611]: time=2026-08-29T15:04:11.918+08:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.2.209:64908,00:00:00:00:00:00%27 @ 0x209a120" latency=12.693933ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=2.905725374s
Aug 29 15:04:19 volumio volumio5-onboarding[1611]: time=2026-08-29T15:04:19.012+08:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.2.209:64908,00:00:00:00:00:00%27 @ 0x209a120" latency=12.693933ms timeout=10s endpoint=https://google.com duration=10.000757094s error="Head \"https://google.com\": context deadline exceeded"
Aug 29 15:04:19 volumio volumio5-onboarding[1611]: time=2026-08-29T15:04:19.012+08:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.2.209:64908,00:00:00:00:00:00%27 @ 0x209a120" latency=12.693933ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=10.000740705s error="Head \"https://radio-directory.firebaseapp.com\": context deadline exceeded"
Aug 29 15:04:19 volumio volumio5-onboarding[1611]: time=2026-08-29T15:04:19.012+08:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.2.209:64908,00:00:00:00:00:00%27 @ 0x209a120" latency=12.693933ms timeout=10s endpoint=http://plugins.volumio.org duration=9.999763984s error="Head \"http://plugins.volumio.workers.dev/\": context deadline exceeded"
Aug 29 15:04:19 volumio volumio5-onboarding[1611]: time=2026-08-29T15:04:19.012+08:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.2.209:64908,00:00:00:00:00:00%27 @ 0x209a120" latency=12.693933ms timeout=10s endpoint=https://securetoken.googleapis.com duration=10.000756169s error="Head \"https://securetoken.googleapis.com\": context deadline exceeded"
Aug 29 15:04:19 volumio volumio5-onboarding[1611]: time=2026-08-29T15:04:19.012+08:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.2.209:64908,00:00:00:00:00:00%27 @ 0x209a120" latency=12.693933ms timeout=10s endpoint=https://www.googleapis.com duration=10.00080915s error="Head \"https://www.googleapis.com\": context deadline exceeded"
Aug 29 15:05:38 volumio volumio[2522]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 29 15:05:38 volumio volumio[2522]: Error: connect ETIMEDOUT 162.125.17.131:443
Aug 29 15:05:38 volumio volumio[2522]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) {
Aug 29 15:05:38 volumio volumio[2522]: errno: -110,
Aug 29 15:05:38 volumio volumio[2522]: code: 'ETIMEDOUT',
Aug 29 15:05:38 volumio volumio[2522]: syscall: 'connect',
Aug 29 15:05:38 volumio volumio[2522]: address: '162.125.17.131',
Aug 29 15:05:38 volumio volumio[2522]: port: 443
Aug 29 15:05:38 volumio volumio[2522]: }
Aug 29 15:05:38 volumio volumio[2522]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 29 15:05:38 volumio sudo[24999]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-29 15:04'
Aug 29 15:05:38 volumio sudo[24999]: 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"