-- Logs begin at Thu 2019-02-14 13:11:58 MSK, end at Sun 2026-02-08 12:17:13 MSK. -- Feb 08 12:16:18 primo volumio5-onboarding[12966]: failed to bootstrap state: failed to get music providers: could not get available plugins: could not get available plugins: context deadline exceeded Feb 08 12:16:18 primo systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Feb 08 12:16:18 primo systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Feb 08 12:16:18 primo systemd[1]: volumio5-onboarding.service: Service RestartSec=100ms expired, scheduling restart. Feb 08 12:16:18 primo systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 357. Feb 08 12:16:18 primo systemd[1]: Stopped Volumio5 Onboarding Server. Feb 08 12:16:18 primo systemd[1]: Started Volumio5 Onboarding Server. Feb 08 12:16:18 primo volumio5-onboarding[13109]: time=2026-02-08T12:16:18.361+03:00 level=INFO msg="running volumio5-device-gateway" version=5bca5789+CHANGES buildDate=2025-12-11T14:07:23Z Feb 08 12:16:18 primo volumio[3119]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Feb 08 12:16:18 primo volumio[3119]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Feb 08 12:16:18 primo volumio5-onboarding[13109]: time=2026-02-08T12:16:18.413+03:00 level=INFO msg="listening for BLE messages" address=B8:2D:28:29:82:8D%00 Feb 08 12:16:18 primo volumio5-onboarding[13109]: time=2026-02-08T12:16:18.414+03:00 level=INFO msg="listening for WebSocket messages" address=[::]:7331 Feb 08 12:16:18 primo volumio[3119]: info: Received Get System Info Feb 08 12:16:18 primo volumio[3119]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 12:16:18 primo volumio[3119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 12:16:18 primo volumio[3119]: info: Discovery: Getting this device information Feb 08 12:16:18 primo volumio[3119]: info: CoreCommandRouter::volumioGetState Feb 08 12:16:18 primo volumio[3119]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 12:16:18 primo volumio[3119]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 08 12:16:18 primo volumio[3119]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 08 12:16:18 primo volumio5-onboarding[13109]: time=2026-02-08T12:16:18.426+03:00 level=INFO msg="BLE descriptor updated" deviceId=5caac58d64be6db5186fdaf1deb5d9a3 deviceName=Primo deviceModel=0x2426d18 Feb 08 12:16:18 primo volumio5-onboarding[13109]: time=2026-02-08T12:16:18.426+03:00 level=INFO msg="mDNS descriptor updated" deviceId=5caac58d64be6db5186fdaf1deb5d9a3 deviceName=Primo deviceModel=0x2426d18 Feb 08 12:16:18 primo volumio5-onboarding[13109]: time=2026-02-08T12:16:18.448+03:00 level=INFO msg="bootstrapping state" hasInternet=true Feb 08 12:16:18 primo volumio[3119]: info: Received Get System Info Feb 08 12:16:18 primo volumio[3119]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 12:16:18 primo volumio[3119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 12:16:18 primo volumio[3119]: info: Discovery: Getting this device information Feb 08 12:16:18 primo volumio[3119]: info: CoreCommandRouter::volumioGetState Feb 08 12:16:18 primo volumio[3119]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 12:16:18 primo volumio-remote-updater[12696]: No test mode Feb 08 12:16:18 primo volumio-remote-updater[12696]: No alpha test mode Feb 08 12:16:18 primo volumio[3119]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 08 12:16:18 primo volumio[3119]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 08 12:16:18 primo volumio[3119]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 08 12:16:18 primo volumio[3119]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 08 12:16:18 primo volumio[3119]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 08 12:16:29 primo volumio[3119]: error: Cannot download Available plugins list: Error: ESOCKETTIMEDOUT Feb 08 12:16:48 primo volumio5-onboarding[13109]: failed to bootstrap state: failed to get music providers: could not get available plugins: could not get available plugins: context deadline exceeded Feb 08 12:16:48 primo systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Feb 08 12:16:48 primo systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Feb 08 12:16:48 primo systemd[1]: volumio5-onboarding.service: Service RestartSec=100ms expired, scheduling restart. Feb 08 12:16:48 primo systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 358. Feb 08 12:16:48 primo systemd[1]: Stopped Volumio5 Onboarding Server. Feb 08 12:16:48 primo systemd[1]: Started Volumio5 Onboarding Server. Feb 08 12:16:48 primo volumio5-onboarding[13279]: time=2026-02-08T12:16:48.611+03:00 level=INFO msg="running volumio5-device-gateway" version=5bca5789+CHANGES buildDate=2025-12-11T14:07:23Z Feb 08 12:16:48 primo volumio[3119]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Feb 08 12:16:48 primo volumio[3119]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Feb 08 12:16:48 primo volumio5-onboarding[13279]: time=2026-02-08T12:16:48.657+03:00 level=INFO msg="listening for BLE messages" address=B8:2D:28:29:82:8D%00 Feb 08 12:16:48 primo volumio5-onboarding[13279]: time=2026-02-08T12:16:48.658+03:00 level=INFO msg="listening for WebSocket messages" address=[::]:7331 Feb 08 12:16:48 primo volumio[3119]: info: Received Get System Info Feb 08 12:16:48 primo volumio[3119]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 12:16:48 primo volumio[3119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 12:16:48 primo volumio[3119]: info: Discovery: Getting this device information Feb 08 12:16:48 primo volumio[3119]: info: CoreCommandRouter::volumioGetState Feb 08 12:16:48 primo volumio[3119]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 12:16:48 primo volumio[3119]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 08 12:16:48 primo volumio[3119]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 08 12:16:48 primo volumio5-onboarding[13279]: time=2026-02-08T12:16:48.670+03:00 level=INFO msg="BLE descriptor updated" deviceId=5caac58d64be6db5186fdaf1deb5d9a3 deviceName=Primo deviceModel=0x1a80360 Feb 08 12:16:48 primo volumio5-onboarding[13279]: time=2026-02-08T12:16:48.670+03:00 level=INFO msg="mDNS descriptor updated" deviceId=5caac58d64be6db5186fdaf1deb5d9a3 deviceName=Primo deviceModel=0x1a80360 Feb 08 12:16:48 primo volumio5-onboarding[13279]: time=2026-02-08T12:16:48.692+03:00 level=INFO msg="bootstrapping state" hasInternet=true Feb 08 12:16:48 primo volumio[3119]: info: Received Get System Info Feb 08 12:16:48 primo volumio[3119]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 12:16:48 primo volumio[3119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 12:16:48 primo volumio[3119]: info: Discovery: Getting this device information Feb 08 12:16:48 primo volumio[3119]: info: CoreCommandRouter::volumioGetState Feb 08 12:16:48 primo volumio[3119]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 12:16:48 primo volumio-remote-updater[12696]: No test mode Feb 08 12:16:48 primo volumio-remote-updater[12696]: No alpha test mode Feb 08 12:16:48 primo volumio[3119]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 08 12:16:48 primo volumio[3119]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 08 12:16:48 primo volumio[3119]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 08 12:16:48 primo volumio[3119]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 08 12:16:48 primo volumio[3119]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 08 12:16:59 primo volumio[3119]: error: Cannot download Available plugins list: Error: ESOCKETTIMEDOUT Feb 08 12:17:12 primo volumio[3119]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 08 12:17:12 primo volumio[3119]: Error: connect ETIMEDOUT 23.73.2.88:443 Feb 08 12:17:12 primo volumio[3119]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Feb 08 12:17:12 primo volumio[3119]: errno: -110, Feb 08 12:17:12 primo volumio[3119]: code: 'ETIMEDOUT', Feb 08 12:17:12 primo volumio[3119]: syscall: 'connect', Feb 08 12:17:12 primo volumio[3119]: address: '23.73.2.88', Feb 08 12:17:12 primo volumio[3119]: port: 443 Feb 08 12:17:12 primo volumio[3119]: } Feb 08 12:17:12 primo volumio[3119]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 08 12:17:13 primo sudo[13404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-08 12:16 Feb 08 12:17:13 primo sudo[13404]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="2f25e1a98e53e2dbc4f3878604e250b0379f3ea4" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="primo2rev2" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 07:52:21 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Primo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Primo" VOLUMIO_HASH="060c5b31331b90c840ee52059a8e3db0"