Apr 03 08:26:31 volumio-gt volumio5-onboarding[2124]: time=2026-04-03T08:26:31.916+02:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.178.44:59716 Apr 03 08:26:32 volumio-gt volumio5-onboarding[2124]: time=2026-04-03T08:26:32.062+02:00 level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.178.44:59716 @ 0xc0003345d0" latency=-773.1372ms platform=PLATFORM_ANDROID version=5.260209.0 Apr 03 08:26:32 volumio-gt volumio5-onboarding[2124]: time=2026-04-03T08:26:32.064+02:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.178.44:59716 @ 0xc0003345d0" latency=-773.01191ms timeout=10s Apr 03 08:26:32 volumio-gt volumio5-onboarding[2124]: time=2026-04-03T08:26:32.064+02:00 level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.178.44:59716 @ 0xc0003345d0" Apr 03 08:26:32 volumio-gt volumio[1382]: info: Received Get System Info Apr 03 08:26:32 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 08:26:32 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 08:26:32 volumio-gt volumio[1382]: info: Discovery: Getting this device information Apr 03 08:26:32 volumio-gt volumio[1382]: info: CoreCommandRouter::volumioGetState Apr 03 08:26:32 volumio-gt volumio[1382]: info: CorePlayQueue::getTrack 0 Apr 03 08:26:32 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 08:26:32 volumio-gt volumio5-onboarding[2124]: time=2026-04-03T08:26:32.067+02:00 level=INFO msg="emitting device name changed event" component=server peer="192.168.178.44:59716 @ 0xc0003345d0" name="Volumio GT" Apr 03 08:26:32 volumio-gt volumio5-onboarding[2124]: time=2026-04-03T08:26:32.067+02:00 level=INFO msg="emitting device language changed event" component=server peer="192.168.178.44:59716 @ 0xc0003345d0" language=en Apr 03 08:26:32 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Apr 03 08:26:32 volumio-gt volumio5-onboarding[2124]: time=2026-04-03T08:26:32.069+02:00 level=INFO msg="emitting device timezone changed event" component=server peer="192.168.178.44:59716 @ 0xc0003345d0" timezone=Europe/Berlin Apr 03 08:26:32 volumio-gt volumio5-onboarding[2124]: time=2026-04-03T08:26:32.070+02:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.178.44:59716 @ 0xc0003345d0" available=true connected=true macAddress=00:01:c0:21:37:95 ip4Address=192.168.178.45/24 ip6Address= Apr 03 08:26:32 volumio-gt volumio5-onboarding[2124]: time=2026-04-03T08:26:32.070+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.178.44:59716 @ 0xc0003345d0" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Apr 03 08:26:32 volumio-gt volumio5-onboarding[2124]: time=2026-04-03T08:26:32.071+02:00 level=INFO msg="emitting device setup status changed event" component=server peer="192.168.178.44:59716 @ 0xc0003345d0" setupComplete=true Apr 03 08:26:32 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Apr 03 08:26:32 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 03 08:26:32 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 08:26:32 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 03 08:26:32 volumio-gt volumio[1382]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 0 -D 1 Apr 03 08:26:32 volumio-gt volumio[1382]: /bin/sh: 1: /usr/local/bin/alsacap: not found Apr 03 08:26:32 volumio-gt volumio[1382]: {"cmd":"/usr/local/bin/alsacap -C 0 -D 1","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 0 -D 1\n/bin/sh: 1: /usr/local/bin/alsacap: not found\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)"} Apr 03 08:26:32 volumio-gt volumio[1382]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 0 -D 0 Apr 03 08:26:32 volumio-gt volumio[1382]: /bin/sh: 1: /usr/local/bin/alsacap: not found Apr 03 08:26:32 volumio-gt volumio[1382]: {"cmd":"/usr/local/bin/alsacap -C 0 -D 0","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 0 -D 0\n/bin/sh: 1: /usr/local/bin/alsacap: not found\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)"} Apr 03 08:26:32 volumio-gt volumio[1382]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 5 Apr 03 08:26:32 volumio-gt volumio[1382]: /bin/sh: 1: /usr/local/bin/alsacap: not found Apr 03 08:26:32 volumio-gt volumio[1382]: {"cmd":"/usr/local/bin/alsacap -C 5","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 5\n/bin/sh: 1: /usr/local/bin/alsacap: not found\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)"} Apr 03 08:26:32 volumio-gt volumio[1382]: amixer -c 5 info | grep "Volumio Preciso" Apr 03 08:26:32 volumio-gt volumio[1382]: Card sysdefault:5 'Preciso'/'Volumio srl Volumio Preciso at usb-0000:00:15.0-5, high speed' Apr 03 08:26:32 volumio-gt volumio[1382]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 5 Apr 03 08:26:32 volumio-gt volumio[1382]: /bin/sh: 1: /usr/local/bin/alsacap: not found Apr 03 08:26:32 volumio-gt volumio[1382]: {"cmd":"/usr/local/bin/alsacap -C 5","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 5\n/bin/sh: 1: /usr/local/bin/alsacap: not found\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)"} Apr 03 08:26:32 volumio-gt volumio[1382]: amixer -c 5 info | grep "Volumio Preciso" Apr 03 08:26:32 volumio-gt volumio[1382]: Card sysdefault:5 'Preciso'/'Volumio srl Volumio Preciso at usb-0000:00:15.0-5, high speed' Apr 03 08:26:32 volumio-gt volumio5-onboarding[2124]: time=2026-04-03T08:26:32.152+02:00 level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.178.44:59716 @ 0xc0003345d0" selectedOutputId=5 Apr 03 08:26:32 volumio-gt volumio[1382]: info: CoreCommandRouter::volumioGetState Apr 03 08:26:32 volumio-gt volumio[1382]: info: CorePlayQueue::getTrack 0 Apr 03 08:26:32 volumio-gt volumio5-onboarding[2124]: time=2026-04-03T08:26:32.174+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.44:59716 @ 0xc0003345d0" state=STATUS_STOPPED positionMs=251 volume=100 Apr 03 08:26:32 volumio-gt volumio5-onboarding[2124]: time=2026-04-03T08:26:32.174+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.44:59716 @ 0xc0003345d0" id="mnt/NAS/NAS/DSD/My Rips/Mark Knopfler 'Shangri-La' (2004)/01. 5_15 a.m..dsf" title="5:15 a.m." Apr 03 08:26:32 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 08:26:32 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 08:26:32 volumio-gt volumio[1382]: info: Discovery: Getting this device information Apr 03 08:26:32 volumio-gt volumio[1382]: info: CoreCommandRouter::volumioGetState Apr 03 08:26:32 volumio-gt volumio[1382]: info: CorePlayQueue::getTrack 0 Apr 03 08:26:32 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 08:26:32 volumio-gt volumio[1382]: verbose: New Socket.io Connection to 192.168.178.45:3000 from 192.168.178.44 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Apr 03 08:26:32 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 03 08:26:32 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 03 08:26:33 volumio-gt volumio5-onboarding[2124]: time=2026-04-03T08:26:33.969+02:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.178.44:59716 @ 0xc0003345d0" latency=-737.098635ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Apr 03 08:26:35 volumio-gt sudo[2155237]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 03 08:26:35 volumio-gt sudo[2155237]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 08:26:35 volumio-gt sudo[2155237]: pam_unix(sudo:session): session closed for user root Apr 03 08:26:35 volumio-gt sudo[2155239]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 08:26:35 volumio-gt sudo[2155239]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 08:26:35 volumio-gt sudo[2155239]: pam_unix(sudo:session): session closed for user root Apr 03 08:26:35 volumio-gt volumio[1382]: verbose: New Socket.io Connection to 192.168.178.45 from 192.168.178.44 UA: Mozilla/5.0 (Linux; Android 15; 23073RPBFG Build/AQ3A.240829.003; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.164 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Apr 03 08:26:35 volumio-gt sudo[2155244]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 03 08:26:35 volumio-gt sudo[2155244]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 08:26:35 volumio-gt sudo[2155244]: pam_unix(sudo:session): session closed for user root Apr 03 08:26:35 volumio-gt sudo[2155246]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 08:26:35 volumio-gt sudo[2155246]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 08:26:35 volumio-gt sudo[2155246]: pam_unix(sudo:session): session closed for user root Apr 03 08:26:35 volumio-gt volumio[1382]: verbose: New Socket.io Connection to 192.168.178.45 from 192.168.178.44 UA: Mozilla/5.0 (Linux; Android 15; 23073RPBFG Build/AQ3A.240829.003; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.164 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Apr 03 08:26:36 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 03 08:26:36 volumio-gt volumio[1382]: info: CoreCommandRouter::volumioGetVisibleSources Apr 03 08:26:36 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 03 08:26:36 volumio-gt volumio[1382]: info: CoreCommandRouter::volumioGetState Apr 03 08:26:36 volumio-gt volumio[1382]: info: CorePlayQueue::getTrack 0 Apr 03 08:26:36 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 03 08:26:36 volumio-gt volumio[1382]: info: CoreCommandRouter::volumioGetQueue Apr 03 08:26:36 volumio-gt volumio[1382]: info: CoreStateMachine::getQueue Apr 03 08:26:36 volumio-gt volumio[1382]: info: CorePlayQueue::getQueue Apr 03 08:26:36 volumio-gt volumio[1382]: info: Listing playlists Apr 03 08:26:36 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 03 08:26:36 volumio-gt volumio[1382]: info: Received Get System Info Apr 03 08:26:36 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 08:26:36 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 08:26:36 volumio-gt volumio[1382]: info: Discovery: Getting this device information Apr 03 08:26:36 volumio-gt volumio[1382]: info: CoreCommandRouter::volumioGetState Apr 03 08:26:36 volumio-gt volumio[1382]: info: CorePlayQueue::getTrack 0 Apr 03 08:26:36 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 08:26:36 volumio-gt volumio[1382]: info: CoreCommandRouter::volumioGetState Apr 03 08:26:36 volumio-gt volumio[1382]: info: CorePlayQueue::getTrack 0 Apr 03 08:26:36 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 03 08:26:36 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 03 08:26:36 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 03 08:26:37 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 03 08:26:37 volumio-gt volumio[1382]: info: Received Get System Info Apr 03 08:26:37 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 08:26:37 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 08:26:37 volumio-gt volumio[1382]: info: Discovery: Getting this device information Apr 03 08:26:37 volumio-gt volumio[1382]: info: CoreCommandRouter::volumioGetState Apr 03 08:26:37 volumio-gt volumio[1382]: info: CorePlayQueue::getTrack 0 Apr 03 08:26:37 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 08:26:38 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Apr 03 08:26:42 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Apr 03 08:26:42 volumio-gt volumio[1382]: info: Preload queue cleared Apr 03 08:26:45 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Apr 03 08:26:45 volumio-gt volumio[1382]: info: Preload queue cleared Apr 03 08:26:45 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 03 08:26:49 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Apr 03 08:26:49 volumio-gt volumio[1382]: info: Preload queue cleared Apr 03 08:26:54 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 03 08:26:54 volumio-gt volumio[1382]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 03 08:26:54 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 03 08:26:54 volumio-gt volumio[1382]: info: Received Get System Version Apr 03 08:26:54 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 03 08:26:54 volumio-gt volumio[1382]: info: Received Get System Info Apr 03 08:26:54 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 08:26:54 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 08:26:54 volumio-gt volumio[1382]: info: Discovery: Getting this device information Apr 03 08:26:54 volumio-gt volumio[1382]: info: CoreCommandRouter::volumioGetState Apr 03 08:26:54 volumio-gt volumio[1382]: info: CorePlayQueue::getTrack 0 Apr 03 08:26:54 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 08:27:01 volumio-gt volumio[1382]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Apr 03 08:27:01 volumio-gt volumio[1382]: info: READ Apr 03 08:27:01 volumio-gt volumio[1382]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 03 08:27:01 volumio-gt volumio[1382]: Error Apr 03 08:27:01 volumio-gt volumio[1382]: at /volumio/app/plugins/music_service/webradio/index.js:286:31 Apr 03 08:27:01 volumio-gt volumio[1382]: at Request.handleRequestResponse [as _callback] (/volumio/node_modules/unirest/index.js:444:15) Apr 03 08:27:01 volumio-gt volumio[1382]: at self.callback (/volumio/node_modules/request/request.js:185:22) Apr 03 08:27:01 volumio-gt volumio[1382]: at Request.emit (node:events:514:28) Apr 03 08:27:01 volumio-gt volumio[1382]: at Request.onRequestError (/volumio/node_modules/request/request.js:877:8) Apr 03 08:27:01 volumio-gt volumio[1382]: at ClientRequest.emit (node:events:514:28) Apr 03 08:27:01 volumio-gt volumio[1382]: at Socket.socketErrorListener (node:_http_client:495:9) Apr 03 08:27:01 volumio-gt volumio[1382]: at Socket.emit (node:events:514:28) Apr 03 08:27:01 volumio-gt volumio[1382]: at emitErrorNT (node:internal/streams/destroy:151:8) Apr 03 08:27:01 volumio-gt volumio[1382]: at emitErrorCloseNT (node:internal/streams/destroy:116:3) Apr 03 08:27:01 volumio-gt volumio[1382]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) Apr 03 08:27:01 volumio-gt volumio[1382]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 03 08:27:01 volumio-gt sudo[2155381]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-03 08:26' Apr 03 08:27:01 volumio-gt sudo[2155381]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"