Aug 27 13:52:12 volumio systemd[1]: mpd.service: State 'stop-sigterm' timed out. Killing. Aug 27 13:52:12 volumio systemd[1]: mpd.service: Killing process 6451 (mpd) with signal SIGKILL. Aug 27 13:52:12 volumio systemd[1]: mpd.service: Killing process 9079 (update) with signal SIGKILL. Aug 27 13:52:54 volumio sshd[9801]: Accepted publickey for volumio from 192.168.1.15 port 50029 ssh2: RSA SHA256:Utu+1e4MHQI4gV+IE1eFMgJExWXHhu8KQzBz2PofLU0 Aug 27 13:52:54 volumio sshd[9801]: pam_unix(sshd:session): session opened for user volumio(uid=1000) by (uid=0) Aug 27 13:52:54 volumio systemd-logind[797]: New session 3 of user volumio. Aug 27 13:52:54 volumio systemd[1]: Started session-3.scope - Session 3 of User volumio. Aug 27 13:52:54 volumio sshd[9801]: pam_env(sshd:session): deprecated reading of user environment enabled Aug 27 13:53:11 volumio ntpd[1417]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Aug 27 13:53:11 volumio ntpd[1417]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Aug 27 13:53:11 volumio ntpd[1417]: DNS: Pool skipping: 103.221.223.143 Aug 27 13:53:11 volumio ntpd[1417]: DNS: Pool skipping: 160.22.74.161 Aug 27 13:53:11 volumio ntpd[1417]: DNS: Pool taking: 45.252.250.189 Aug 27 13:53:11 volumio ntpd[1417]: DNS: Pool taking: 115.165.161.155 Aug 27 13:53:11 volumio ntpd[1417]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 Aug 27 13:53:12 volumio ntpd[1417]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Aug 27 13:53:12 volumio ntpd[1417]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Aug 27 13:53:12 volumio ntpd[1417]: DNS: Pool skipping: 160.22.74.161 Aug 27 13:53:12 volumio ntpd[1417]: DNS: Pool skipping: 45.252.250.189 Aug 27 13:53:12 volumio ntpd[1417]: DNS: Pool skipping: 103.184.124.254 Aug 27 13:53:12 volumio ntpd[1417]: DNS: Pool skipping: 103.221.223.143 Aug 27 13:53:12 volumio ntpd[1417]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 Aug 27 13:53:13 volumio ntpd[1417]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Aug 27 13:53:13 volumio ntpd[1417]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Aug 27 13:53:13 volumio ntpd[1417]: DNS: Pool skipping: 103.221.223.143 Aug 27 13:53:13 volumio ntpd[1417]: DNS: Pool skipping: 160.22.74.161 Aug 27 13:53:13 volumio ntpd[1417]: DNS: Pool skipping: 45.252.250.189 Aug 27 13:53:13 volumio ntpd[1417]: DNS: Pool skipping: 115.165.161.155 Aug 27 13:53:13 volumio ntpd[1417]: DNS: Pool skipping: 2001:df4:bac0::e35b:f223 Aug 27 13:53:13 volumio ntpd[1417]: DNS: Pool taking: 2401:5b60:0:2::21 Aug 27 13:53:13 volumio ntpd[1417]: DNS: Pool skipping: 2001:df7:c600:13:f816:3eff:fe1d:b3b5 Aug 27 13:53:13 volumio ntpd[1417]: DNS: Pool taking: 2400:e920:0:5::14 Aug 27 13:53:13 volumio ntpd[1417]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 Aug 27 13:53:13 volumio sshd[7078]: Received disconnect from 192.168.1.15 port 59322:11: disconnected by user Aug 27 13:53:13 volumio sshd[7078]: Disconnected from user volumio 192.168.1.15 port 59322 Aug 27 13:53:13 volumio sshd[7047]: pam_unix(sshd:session): session closed for user volumio Aug 27 13:53:13 volumio systemd-logind[797]: Session 1 logged out. Waiting for processes to exit. Aug 27 13:53:15 volumio ntpd[1417]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Aug 27 13:53:15 volumio ntpd[1417]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Aug 27 13:53:15 volumio ntpd[1417]: DNS: Pool skipping: 103.184.124.254 Aug 27 13:53:15 volumio ntpd[1417]: DNS: Pool skipping: 45.252.250.189 Aug 27 13:53:15 volumio ntpd[1417]: DNS: Pool skipping: 160.22.74.161 Aug 27 13:53:15 volumio ntpd[1417]: DNS: Pool skipping: 103.221.223.143 Aug 27 13:53:15 volumio ntpd[1417]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 Aug 27 13:53:20 volumio volumio[9248]: error: Upnp client error: Error: connect ETIMEDOUT 127.0.0.1:6600 Aug 27 13:53:20 volumio volumio[9248]: error: Upnp client error: Error: connect ETIMEDOUT 127.0.0.1:6600 Aug 27 13:53:23 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:23.789+07:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.340000694s timeout=10s Aug 27 13:53:23 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 27 13:53:23 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 27 13:53:23 volumio volumio[9248]: info: Discovery: Getting this device information Aug 27 13:53:23 volumio volumio[9248]: info: CoreCommandRouter::volumioGetState Aug 27 13:53:23 volumio volumio[9248]: info: CorePlayQueue::getTrack 0 Aug 27 13:53:23 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 27 13:53:23 volumio volumio[9248]: verbose: New Socket.io Connection to 192.168.1.20:3000 from 192.168.1.2 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Aug 27 13:53:23 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 27 13:53:23 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 27 13:53:24 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:24.050+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.340000694s timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=261.679074ms Aug 27 13:53:24 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:24.141+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.340000694s timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=352.014648ms Aug 27 13:53:24 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:24.235+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.340000694s timeout=10s endpoint=https://www.googleapis.com duration=444.197444ms Aug 27 13:53:24 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:24.259+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.340000694s timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=469.792482ms Aug 27 13:53:24 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:24.304+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.340000694s timeout=10s endpoint=https://securetoken.googleapis.com duration=513.986537ms Aug 27 13:53:24 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:24.327+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.340000694s timeout=10s endpoint=http://pushupdates.volumio.org duration=537.450944ms Aug 27 13:53:24 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:24.343+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.340000694s timeout=10s endpoint=https://google.com duration=552.697611ms Aug 27 13:53:24 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:24.395+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.340000694s timeout=10s endpoint=https://functions.volumio.cloud duration=604.96811ms Aug 27 13:53:24 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:24.398+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.340000694s timeout=10s endpoint=https://functions.volumio.cloud duration=609.566537ms Aug 27 13:53:24 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:24.510+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.340000694s timeout=10s endpoint=https://database.volumio.cloud duration=720.043462ms Aug 27 13:53:24 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:24.517+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.340000694s timeout=10s endpoint=https://myvolumio.firebaseio.com duration=727.631185ms Aug 27 13:53:24 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:24.727+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.340000694s timeout=10s endpoint=http://plugins.volumio.org duration=936.70763ms Aug 27 13:53:25 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:25.527+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.340000694s timeout=10s endpoint=http://cddb.volumio.org duration=1.736921017s Aug 27 13:53:26 volumio volumio[9248]: error: Upnp client error: Error: connect ETIMEDOUT 127.0.0.1:6600 Aug 27 13:53:26 volumio volumio[9248]: error: Upnp client error: Error: connect ETIMEDOUT 127.0.0.1:6600 Aug 27 13:53:29 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:29.912+07:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.347025086s timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Aug 27 13:53:29 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:29.933+07:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346918901s timeout=10s Aug 27 13:53:29 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:29.973+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346918901s timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=38.98163ms Aug 27 13:53:29 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:29.987+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346918901s timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=53.56674ms Aug 27 13:53:29 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:29.988+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346918901s timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=54.141722ms Aug 27 13:53:30 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:30.060+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346918901s timeout=10s endpoint=https://google.com duration=126.50237ms Aug 27 13:53:30 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:30.089+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346918901s timeout=10s endpoint=https://www.googleapis.com duration=155.535314ms Aug 27 13:53:30 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:30.159+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346918901s timeout=10s endpoint=http://pushupdates.volumio.org duration=224.548296ms Aug 27 13:53:30 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:30.172+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346918901s timeout=10s endpoint=https://functions.volumio.cloud duration=237.159778ms Aug 27 13:53:30 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:30.173+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346918901s timeout=10s endpoint=https://functions.volumio.cloud duration=238.990111ms Aug 27 13:53:30 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:30.185+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346918901s timeout=10s endpoint=https://securetoken.googleapis.com duration=250.851388ms Aug 27 13:53:30 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:30.201+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346918901s timeout=10s endpoint=https://database.volumio.cloud duration=266.350259ms Aug 27 13:53:30 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:30.208+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346918901s timeout=10s endpoint=https://myvolumio.firebaseio.com duration=274.214982ms Aug 27 13:53:30 volumio sudo[9881]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 27 13:53:30 volumio sudo[9881]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 27 13:53:30 volumio sudo[9881]: pam_unix(sudo:session): session closed for user root Aug 27 13:53:30 volumio sudo[9883]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 27 13:53:30 volumio sudo[9883]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 27 13:53:30 volumio sudo[9883]: pam_unix(sudo:session): session closed for user root Aug 27 13:53:30 volumio volumio[9248]: verbose: New Socket.io Connection to 192.168.1.20 from 192.168.1.2 UA: Mozilla/5.0 (Linux; Android 16; 23127PN0CC Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/151.0.7922.199 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Aug 27 13:53:30 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:30.402+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346918901s timeout=10s endpoint=http://plugins.volumio.org duration=467.501444ms Aug 27 13:53:30 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:30.411+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346918901s timeout=10s endpoint=http://cddb.volumio.org duration=476.628185ms Aug 27 13:53:30 volumio sudo[9887]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 27 13:53:30 volumio sudo[9887]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 27 13:53:30 volumio sudo[9889]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 27 13:53:30 volumio sudo[9889]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 27 13:53:30 volumio sudo[9887]: pam_unix(sudo:session): session closed for user root Aug 27 13:53:30 volumio sudo[9889]: pam_unix(sudo:session): session closed for user root Aug 27 13:53:30 volumio volumio[9248]: verbose: New Socket.io Connection to 192.168.1.20 from 192.168.1.2 UA: Mozilla/5.0 (Linux; Android 16; 23127PN0CC Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/151.0.7922.199 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Aug 27 13:53:30 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 27 13:53:30 volumio volumio[9248]: info: CoreCommandRouter::volumioGetVisibleSources Aug 27 13:53:30 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 27 13:53:30 volumio volumio[9248]: info: CoreCommandRouter::volumioGetState Aug 27 13:53:30 volumio volumio[9248]: info: CorePlayQueue::getTrack 0 Aug 27 13:53:30 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 27 13:53:30 volumio volumio[9248]: info: CoreCommandRouter::volumioGetQueue Aug 27 13:53:30 volumio volumio[9248]: info: CoreStateMachine::getQueue Aug 27 13:53:30 volumio volumio[9248]: info: CorePlayQueue::getQueue Aug 27 13:53:30 volumio volumio[9248]: info: Listing playlists Aug 27 13:53:30 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 27 13:53:30 volumio volumio[9248]: info: Received Get System Info Aug 27 13:53:30 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 27 13:53:30 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 27 13:53:30 volumio volumio[9248]: info: Discovery: Getting this device information Aug 27 13:53:30 volumio volumio[9248]: info: CoreCommandRouter::volumioGetState Aug 27 13:53:30 volumio volumio[9248]: info: CorePlayQueue::getTrack 0 Aug 27 13:53:30 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 27 13:53:30 volumio volumio[9248]: info: CoreCommandRouter::volumioGetState Aug 27 13:53:30 volumio volumio[9248]: info: CorePlayQueue::getTrack 0 Aug 27 13:53:30 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 27 13:53:30 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 27 13:53:30 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 27 13:53:31 volumio volumio[9248]: error: Upnp client error: Error: connect ETIMEDOUT 127.0.0.1:6600 Aug 27 13:53:32 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 27 13:53:32 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 27 13:53:32 volumio volumio[9248]: info: Received Get System Info Aug 27 13:53:32 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 27 13:53:32 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 27 13:53:32 volumio volumio[9248]: info: Discovery: Getting this device information Aug 27 13:53:32 volumio volumio[9248]: info: CoreCommandRouter::volumioGetState Aug 27 13:53:32 volumio volumio[9248]: info: CorePlayQueue::getTrack 0 Aug 27 13:53:32 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 27 13:53:33 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:33.958+07:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346880848s timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Aug 27 13:53:33 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:33.977+07:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346891626s timeout=10s Aug 27 13:53:34 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:34.017+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346891626s timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=40.202222ms Aug 27 13:53:34 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:34.030+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346891626s timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=53.508092ms Aug 27 13:53:34 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:34.031+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346891626s timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=54.15063ms Aug 27 13:53:34 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:34.105+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346891626s timeout=10s endpoint=https://google.com duration=128.101241ms Aug 27 13:53:34 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:34.132+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346891626s timeout=10s endpoint=https://www.googleapis.com duration=155.492315ms Aug 27 13:53:34 volumio sudo[9893]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 27 13:53:34 volumio sudo[9893]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 27 13:53:34 volumio sudo[9893]: pam_unix(sudo:session): session closed for user root Aug 27 13:53:34 volumio sudo[9895]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 27 13:53:34 volumio sudo[9895]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 27 13:53:34 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:34.199+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346891626s timeout=10s endpoint=http://pushupdates.volumio.org duration=222.083685ms Aug 27 13:53:34 volumio sudo[9895]: pam_unix(sudo:session): session closed for user root Aug 27 13:53:34 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:34.208+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346891626s timeout=10s endpoint=https://functions.volumio.cloud duration=231.014519ms Aug 27 13:53:34 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:34.209+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346891626s timeout=10s endpoint=https://functions.volumio.cloud duration=231.977593ms Aug 27 13:53:34 volumio volumio[9248]: verbose: New Socket.io Connection to 192.168.1.20 from 192.168.1.2 UA: Mozilla/5.0 (Linux; Android 16; 23127PN0CC Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/151.0.7922.199 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Aug 27 13:53:34 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:34.231+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346891626s timeout=10s endpoint=https://securetoken.googleapis.com duration=254.064185ms Aug 27 13:53:34 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:34.243+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346891626s timeout=10s endpoint=https://database.volumio.cloud duration=265.592519ms Aug 27 13:53:34 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:34.252+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346891626s timeout=10s endpoint=https://myvolumio.firebaseio.com duration=274.835852ms Aug 27 13:53:34 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 27 13:53:34 volumio volumio[9248]: info: Received Get System Info Aug 27 13:53:34 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 27 13:53:34 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 27 13:53:34 volumio volumio[9248]: info: Discovery: Getting this device information Aug 27 13:53:34 volumio volumio[9248]: info: CoreCommandRouter::volumioGetState Aug 27 13:53:34 volumio volumio[9248]: info: CorePlayQueue::getTrack 0 Aug 27 13:53:34 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 27 13:53:34 volumio sudo[9899]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 27 13:53:34 volumio sudo[9899]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 27 13:53:34 volumio sudo[9899]: pam_unix(sudo:session): session closed for user root Aug 27 13:53:34 volumio sudo[9901]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 27 13:53:34 volumio sudo[9901]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 27 13:53:34 volumio sudo[9901]: pam_unix(sudo:session): session closed for user root Aug 27 13:53:34 volumio volumio[9248]: verbose: New Socket.io Connection to 192.168.1.20 from 192.168.1.2 UA: Mozilla/5.0 (Linux; Android 16; 23127PN0CC Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/151.0.7922.199 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Aug 27 13:53:34 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:34.411+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346891626s timeout=10s endpoint=http://plugins.volumio.org duration=434.094759ms Aug 27 13:53:34 volumio volumio5-onboarding[1632]: time=2026-08-27T13:53:34.454+07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.2:53020 @ 0x35f7290" latency=-19.346891626s timeout=10s endpoint=http://cddb.volumio.org duration=476.7145ms Aug 27 13:53:34 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 27 13:53:34 volumio volumio[9248]: info: CoreCommandRouter::volumioGetVisibleSources Aug 27 13:53:34 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 27 13:53:34 volumio volumio[9248]: info: CoreCommandRouter::volumioGetState Aug 27 13:53:34 volumio volumio[9248]: info: CorePlayQueue::getTrack 0 Aug 27 13:53:34 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 27 13:53:34 volumio volumio[9248]: info: CoreCommandRouter::volumioGetQueue Aug 27 13:53:34 volumio volumio[9248]: info: CoreStateMachine::getQueue Aug 27 13:53:34 volumio volumio[9248]: info: CorePlayQueue::getQueue Aug 27 13:53:34 volumio volumio[9248]: info: Listing playlists Aug 27 13:53:34 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 27 13:53:34 volumio volumio[9248]: info: Received Get System Info Aug 27 13:53:34 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 27 13:53:34 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 27 13:53:34 volumio volumio[9248]: info: Discovery: Getting this device information Aug 27 13:53:34 volumio volumio[9248]: info: CoreCommandRouter::volumioGetState Aug 27 13:53:34 volumio volumio[9248]: info: CorePlayQueue::getTrack 0 Aug 27 13:53:34 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 27 13:53:34 volumio volumio[9248]: info: CoreCommandRouter::volumioGetState Aug 27 13:53:34 volumio volumio[9248]: info: CorePlayQueue::getTrack 0 Aug 27 13:53:34 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 27 13:53:34 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 27 13:53:34 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 27 13:53:36 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 27 13:53:36 volumio volumio[9248]: error: Upnp client error: Error: connect ETIMEDOUT 127.0.0.1:6600 Aug 27 13:53:36 volumio volumio[9248]: error: Upnp client error: Error: connect ETIMEDOUT 127.0.0.1:6600 Aug 27 13:53:36 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 27 13:53:36 volumio volumio[9248]: info: Received Get System Info Aug 27 13:53:36 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 27 13:53:36 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 27 13:53:36 volumio volumio[9248]: info: Discovery: Getting this device information Aug 27 13:53:36 volumio volumio[9248]: info: CoreCommandRouter::volumioGetState Aug 27 13:53:36 volumio volumio[9248]: info: CorePlayQueue::getTrack 0 Aug 27 13:53:36 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 27 13:53:36 volumio volumio[9248]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 27 13:53:36 volumio volumio[9248]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 27 13:53:36 volumio volumio[9248]: info: Retrieving Cloud Streaming UI Aug 27 13:53:37 volumio volumio[9248]: info: Getting Tidal Cloud Configuration Aug 27 13:53:37 volumio volumio[9248]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 27 13:53:37 volumio volumio[9248]: info: Getting Qobuz Cloud Configuration Aug 27 13:53:37 volumio volumio[9248]: info: Asking plugin for UI Config Aug 27 13:53:37 volumio volumio[9248]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 27 13:53:37 volumio volumio[9248]: info: Getting Spotify Cloud Configuration Aug 27 13:53:37 volumio volumio[9248]: info: Asking plugin for UI Config Aug 27 13:53:37 volumio volumio[9248]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 27 13:53:37 volumio volumio[9248]: info: Saving Spotify Acccount Aug 27 13:53:37 volumio volumio[9248]: info: Got Tidal Cloud Configuration Aug 27 13:53:37 volumio volumio[9248]: info: Got it Aug 27 13:53:37 volumio volumio[9248]: info: Got it Aug 27 13:53:37 volumio volumio[9248]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Aug 27 13:53:37 volumio volumio[9248]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 27 13:53:37 volumio volumio[9248]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Aug 27 13:53:37 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 27 13:53:37 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 27 13:53:37 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 27 13:53:37 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 27 13:53:37 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 27 13:53:37 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 27 13:53:37 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 27 13:53:37 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 27 13:53:37 volumio volumio[9248]: info: CoreCommandRouter::volumioGetBrowseSources Aug 27 13:53:37 volumio volumio[9248]: info: CoreCommandRouter::volumioGetBrowseSources Aug 27 13:53:37 volumio volumio[9248]: info: CoreCommandRouter::volumioGetBrowseSources Aug 27 13:53:37 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 27 13:53:37 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Aug 27 13:53:37 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 27 13:53:37 volumio volumio[9248]: info: Received Get System Info Aug 27 13:53:37 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 27 13:53:37 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 27 13:53:37 volumio volumio[9248]: info: Discovery: Getting this device information Aug 27 13:53:37 volumio volumio[9248]: info: CoreCommandRouter::volumioGetState Aug 27 13:53:37 volumio volumio[9248]: info: CorePlayQueue::getTrack 0 Aug 27 13:53:37 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 27 13:53:38 volumio volumio[9248]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Aug 27 13:53:38 volumio volumio[9248]: verbose: ControllerMpd::sendMpdCommand update Aug 27 13:53:38 volumio volumio[9248]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 27 13:53:38 volumio volumio[9248]: TypeError: Cannot read properties of undefined (reading 'then') Aug 27 13:53:38 volumio volumio[9248]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:332:6) Aug 27 13:53:38 volumio volumio[9248]: at ControllerMpd.updateDb (/volumio/app/plugins/music_service/mpd/index.js:1912:15) Aug 27 13:53:38 volumio volumio[9248]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Aug 27 13:53:38 volumio volumio[9248]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1102:26) Aug 27 13:53:38 volumio volumio[9248]: at Socket.emit (node:events:514:28) Aug 27 13:53:38 volumio volumio[9248]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Aug 27 13:53:38 volumio volumio[9248]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Aug 27 13:53:38 volumio volumio[9248]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 27 13:53:38 volumio sudo[9920]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-27 13:52' Aug 27 13:53:38 volumio sudo[9920]: 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"