Aug 31 17:20:16 volumio-kali kernel: hwmon hwmon1: Undervoltage detected! Aug 31 17:20:23 volumio-kali kernel: hwmon hwmon1: Voltage normalised Aug 31 17:20:41 volumio-kali systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Aug 31 17:20:42 volumio-kali systemd[1]: setdatetime-helper.service: Deactivated successfully. Aug 31 17:20:42 volumio-kali systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Aug 31 17:20:42 volumio-kali systemd[1]: setdatetime-helper.service: Consumed 1.131s CPU time. Aug 31 17:20:50 volumio-kali kernel: hwmon hwmon1: Undervoltage detected! Aug 31 17:20:56 volumio-kali kernel: hwmon hwmon1: Voltage normalised Aug 31 17:20:58 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:20:58.200+02:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.1.4:49410 Aug 31 17:20:58 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:20:58.222+02:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.4:49410 @ 0x218e030" latency=5.684035ms timeout=10s Aug 31 17:20:58 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:20:58.232+02:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.1.4:49410 @ 0x218e030" latency=9.989857ms timeout=20s Aug 31 17:20:58 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:20:58.232+02:00 level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.1.4:49410 @ 0x218e030" Aug 31 17:20:58 volumio-kali volumio[1165]: info: Received Get System Info Aug 31 17:20:58 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 17:20:58 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 17:20:58 volumio-kali volumio[1165]: info: Discovery: Getting this device information Aug 31 17:20:58 volumio-kali volumio[1165]: info: CoreCommandRouter::volumioGetState Aug 31 17:20:58 volumio-kali volumio[1165]: info: CorePlayQueue::getTrack 0 Aug 31 17:20:58 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 17:20:58 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:20:58.237+02:00 level=INFO msg="emitting device name changed event" component=server peer="192.168.1.4:49410 @ 0x218e030" name="Volumio Kali" Aug 31 17:20:58 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:20:58.238+02:00 level=INFO msg="emitting device language changed event" component=server peer="192.168.1.4:49410 @ 0x218e030" language=it Aug 31 17:20:58 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Aug 31 17:20:58 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:20:58.241+02:00 level=INFO msg="emitting device timezone changed event" component=server peer="192.168.1.4:49410 @ 0x218e030" timezone=Europe/Berlin Aug 31 17:20:58 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:20:58.243+02:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.1.4:49410 @ 0x218e030" available=true connected=true macAddress=b8:27:eb:29:1f:07 ip4Address=192.168.1.6/24 ip6Address= Aug 31 17:20:58 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:20:58.244+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.4:49410 @ 0x218e030" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Aug 31 17:20:58 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:20:58.245+02:00 level=INFO msg="emitting device setup status changed event" component=server peer="192.168.1.4:49410 @ 0x218e030" setupComplete=true Aug 31 17:20:58 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Aug 31 17:20:58 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 31 17:20:58 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 17:20:58 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 31 17:20:58 volumio-kali volumio[1165]: amixer -c 0 info | grep "bcm2835 ALSA" Aug 31 17:20:58 volumio-kali volumio[1165]: amixer -c 1 info | grep "bcm2835 Headphones" Aug 31 17:20:58 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:20:58.362+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.4:49410 @ 0x218e030" latency=5.684035ms timeout=10s endpoint=http://pushupdates.volumio.org duration=136.521543ms Aug 31 17:20:58 volumio-kali volumio[1165]: Card sysdefault:1 'Headphones'/'bcm2835 Headphones' Aug 31 17:20:58 volumio-kali volumio[1165]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 2 Aug 31 17:20:58 volumio-kali volumio[1165]: /bin/sh: 1: /usr/local/bin/alsacap: not found Aug 31 17:20:58 volumio-kali volumio[1165]: {"cmd":"/usr/local/bin/alsacap -C 2","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 2\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)"} Aug 31 17:20:58 volumio-kali volumio[1165]: amixer -c 2 info | grep "vc4-hdmi" Aug 31 17:20:58 volumio-kali volumio[1165]: Card sysdefault:2 'vc4hdmi'/'vc4-hdmi' Aug 31 17:20:58 volumio-kali volumio[1165]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 3 Aug 31 17:20:58 volumio-kali volumio[1165]: /bin/sh: 1: /usr/local/bin/alsacap: not found Aug 31 17:20:58 volumio-kali volumio[1165]: {"cmd":"/usr/local/bin/alsacap -C 3","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 3\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)"} Aug 31 17:20:58 volumio-kali volumio[1165]: amixer -c 3 info | grep "BassFly-uHAT with I2S Mic" Aug 31 17:20:58 volumio-kali volumio[1165]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 3 Aug 31 17:20:58 volumio-kali volumio[1165]: /bin/sh: 1: /usr/local/bin/alsacap: not found Aug 31 17:20:58 volumio-kali volumio[1165]: {"cmd":"/usr/local/bin/alsacap -C 3","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 3\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)"} Aug 31 17:20:58 volumio-kali volumio[1165]: amixer -c 3 info | grep "snd_rpi_googlevoicehat_soundcar" Aug 31 17:20:58 volumio-kali volumio[1165]: Card sysdefault:3 'sndrpigooglevoi'/'snd_rpi_googlevoicehat_soundcard' Aug 31 17:20:58 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:20:58.493+02:00 level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.1.4:49410 @ 0x218e030" selectedOutputId=3 Aug 31 17:20:58 volumio-kali volumio[1165]: info: Received Get System Info Aug 31 17:20:58 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 17:20:58 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 17:20:58 volumio-kali volumio[1165]: info: Discovery: Getting this device information Aug 31 17:20:58 volumio-kali volumio[1165]: info: CoreCommandRouter::volumioGetState Aug 31 17:20:58 volumio-kali volumio[1165]: info: CorePlayQueue::getTrack 0 Aug 31 17:20:58 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 17:20:58 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:20:58.533+02:00 level=INFO msg="emitting software info changed event" component=server peer="192.168.1.4:49410 @ 0x218e030" currentVersion=4.119 latestVersion=4.119 Aug 31 17:20:58 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:20:58.534+02:00 level=INFO msg="emitting software update progress event" component=server peer="192.168.1.4:49410 @ 0x218e030" status=UPDATE_STATUS_NONE progress=0 Aug 31 17:20:58 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:20:58.534+02:00 level=INFO msg="emitting user changed event" component=server peer="192.168.1.4:49410 @ 0x218e030" userId= Aug 31 17:20:58 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:20:58.534+02:00 level=INFO msg="emitting music providers changed event" component=server peer="192.168.1.4:49410 @ 0x218e030" providers=3 Aug 31 17:20:58 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:20:58.535+02:00 level=INFO msg="emitting plugins changed event" component=server peer="192.168.1.4:49410 @ 0x218e030" plugins=71 Aug 31 17:20:58 volumio-kali volumio[1165]: info: CoreCommandRouter::volumioGetState Aug 31 17:20:58 volumio-kali volumio[1165]: info: CorePlayQueue::getTrack 0 Aug 31 17:20:58 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:20:58.540+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.4:49410 @ 0x218e030" state=STATUS_PLAYING positionMs=180846 volume=100 Aug 31 17:20:58 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:20:58.540+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.4:49410 @ 0x218e030" id="mnt/USB/Volume_m-sata/Danielle Nicole/(01) [Danielle Nicole] Crawl.flac" title="1 - Crawl" Aug 31 17:20:58 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:20:58.751+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.4:49410 @ 0x218e030" latency=5.684035ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=528.514682ms Aug 31 17:20:58 volumio-kali volumio[1165]: verbose: New Socket.io Connection to 192.168.1.6:3000 from 192.168.1.4 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Aug 31 17:20:58 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 17:20:58 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 17:20:58 volumio-kali volumio[1165]: info: Discovery: Getting this device information Aug 31 17:20:58 volumio-kali volumio[1165]: info: CoreCommandRouter::volumioGetState Aug 31 17:20:58 volumio-kali volumio[1165]: info: CorePlayQueue::getTrack 0 Aug 31 17:20:58 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 17:20:58 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:20:58.949+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.4:49410 @ 0x218e030" latency=5.684035ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=723.485941ms Aug 31 17:20:58 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:20:58.955+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.4:49410 @ 0x218e030" latency=5.684035ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=732.07067ms Aug 31 17:20:59 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:20:59.002+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.4:49410 @ 0x218e030" latency=5.684035ms timeout=10s endpoint=https://www.googleapis.com duration=776.114519ms Aug 31 17:20:59 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:20:59.027+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.4:49410 @ 0x218e030" latency=5.684035ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=803.551984ms Aug 31 17:20:59 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:20:59.032+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.4:49410 @ 0x218e030" latency=5.684035ms timeout=10s endpoint=https://securetoken.googleapis.com duration=808.931352ms Aug 31 17:20:59 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:20:59.115+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.4:49410 @ 0x218e030" latency=5.684035ms timeout=10s endpoint=https://functions.volumio.cloud duration=889.861873ms Aug 31 17:20:59 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:20:59.116+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.4:49410 @ 0x218e030" latency=5.684035ms timeout=10s endpoint=https://functions.volumio.cloud duration=892.834682ms Aug 31 17:20:59 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:20:59.274+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.4:49410 @ 0x218e030" latency=5.684035ms timeout=10s endpoint=https://database.volumio.cloud duration=1.047489898s Aug 31 17:20:59 volumio-kali volumio[1165]: verbose: New Socket.io Connection to 192.168.1.6 from 192.168.1.4 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: 6 Aug 31 17:20:59 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 31 17:20:59 volumio-kali volumio[1165]: info: CoreCommandRouter::volumioGetVisibleSources Aug 31 17:20:59 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 17:20:59 volumio-kali volumio[1165]: info: CoreCommandRouter::volumioGetState Aug 31 17:20:59 volumio-kali volumio[1165]: info: CorePlayQueue::getTrack 0 Aug 31 17:20:59 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 31 17:20:59 volumio-kali volumio[1165]: info: CoreCommandRouter::volumioGetQueue Aug 31 17:20:59 volumio-kali volumio[1165]: info: CoreStateMachine::getQueue Aug 31 17:20:59 volumio-kali volumio[1165]: info: CorePlayQueue::getQueue Aug 31 17:20:59 volumio-kali volumio[1165]: info: Listing playlists Aug 31 17:20:59 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 31 17:20:59 volumio-kali volumio[1165]: info: Received Get System Info Aug 31 17:20:59 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 17:20:59 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 17:20:59 volumio-kali volumio[1165]: info: Discovery: Getting this device information Aug 31 17:20:59 volumio-kali volumio[1165]: info: CoreCommandRouter::volumioGetState Aug 31 17:20:59 volumio-kali volumio[1165]: info: CorePlayQueue::getTrack 0 Aug 31 17:20:59 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 17:20:59 volumio-kali volumio[1165]: info: CoreCommandRouter::volumioGetState Aug 31 17:20:59 volumio-kali volumio[1165]: info: CorePlayQueue::getTrack 0 Aug 31 17:20:59 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 31 17:20:59 volumio-kali volumio[1165]: verbose: New Socket.io Connection to 192.168.1.6:3000 from 192.168.1.4 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Aug 31 17:20:59 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 17:20:59 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 17:20:59 volumio-kali volumio[1165]: info: Discovery: Getting this device information Aug 31 17:20:59 volumio-kali volumio[1165]: info: CoreCommandRouter::volumioGetState Aug 31 17:20:59 volumio-kali volumio[1165]: info: CorePlayQueue::getTrack 0 Aug 31 17:20:59 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 17:21:00 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:00.667+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.4:49410 @ 0x218e030" latency=5.684035ms timeout=10s endpoint=http://cddb.volumio.org duration=2.443222316s Aug 31 17:21:00 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:00.920+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.4:49410 @ 0x218e030" latency=5.684035ms timeout=10s endpoint=http://plugins.volumio.org duration=2.694768606s Aug 31 17:21:01 volumio-kali bluealsa[991]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_4E_80_66_B5_EA_6F, ...) Aug 31 17:21:01 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 17:21:01 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 17:21:01 volumio-kali volumio[1165]: info: Discovery: Getting this device information Aug 31 17:21:01 volumio-kali volumio[1165]: info: CoreCommandRouter::volumioGetState Aug 31 17:21:01 volumio-kali volumio[1165]: info: CorePlayQueue::getTrack 0 Aug 31 17:21:01 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 17:21:01 volumio-kali volumio[1165]: verbose: New Socket.io Connection to 192.168.1.6:3000 from 192.168.1.4 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Aug 31 17:21:01 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 31 17:21:01 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 31 17:21:01 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:01.284+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.4:49410 @ 0x218e030" latency=5.684035ms timeout=10s endpoint=https://google.com duration=3.060573655s Aug 31 17:21:01 volumio-kali volumio[1165]: verbose: New Socket.io Connection to 192.168.1.6:3000 from 192.168.1.4 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Aug 31 17:21:01 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 17:21:01 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 17:21:01 volumio-kali volumio[1165]: info: Discovery: Getting this device information Aug 31 17:21:01 volumio-kali volumio[1165]: info: CoreCommandRouter::volumioGetState Aug 31 17:21:01 volumio-kali volumio[1165]: info: CorePlayQueue::getTrack 0 Aug 31 17:21:01 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 17:21:02 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 31 17:21:02 volumio-kali volumio[1165]: info: CURURI: music-library/USB/Volume_m-sata/Climax Blues Band - Drastic Steps...plus (C-Five Records C5CD 573) Aug 31 17:21:03 volumio-kali volumio[1165]: info: Preload queue cleared Aug 31 17:21:03 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:03.694+02:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.1.4:49410 Aug 31 17:21:03 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:03.694+02:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.1.4:49410 Aug 31 17:21:03 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:03.700+02:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.1.4:49533 Aug 31 17:21:03 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:03.723+02:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.4:49533 @ 0x2078390" latency=10.886835ms timeout=10s Aug 31 17:21:03 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:03.724+02:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.1.4:49533 @ 0x2078390" latency=11.389958ms timeout=20s Aug 31 17:21:03 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:03.726+02:00 level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.1.4:49533 @ 0x2078390" Aug 31 17:21:03 volumio-kali volumio[1165]: info: Received Get System Info Aug 31 17:21:03 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 17:21:03 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 17:21:03 volumio-kali volumio[1165]: info: Discovery: Getting this device information Aug 31 17:21:03 volumio-kali volumio[1165]: info: CoreCommandRouter::volumioGetState Aug 31 17:21:03 volumio-kali volumio[1165]: info: CorePlayQueue::getTrack 0 Aug 31 17:21:03 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 17:21:03 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:03.731+02:00 level=INFO msg="emitting device name changed event" component=server peer="192.168.1.4:49533 @ 0x2078390" name="Volumio Kali" Aug 31 17:21:03 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:03.732+02:00 level=INFO msg="emitting device language changed event" component=server peer="192.168.1.4:49533 @ 0x2078390" language=it Aug 31 17:21:03 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Aug 31 17:21:03 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:03.735+02:00 level=INFO msg="emitting device timezone changed event" component=server peer="192.168.1.4:49533 @ 0x2078390" timezone=Europe/Berlin Aug 31 17:21:03 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:03.737+02:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.1.4:49533 @ 0x2078390" available=true connected=true macAddress=b8:27:eb:29:1f:07 ip4Address=192.168.1.6/24 ip6Address= Aug 31 17:21:03 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:03.739+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.4:49533 @ 0x2078390" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Aug 31 17:21:03 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:03.740+02:00 level=INFO msg="emitting device setup status changed event" component=server peer="192.168.1.4:49533 @ 0x2078390" setupComplete=true Aug 31 17:21:03 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Aug 31 17:21:03 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:03.751+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.4:49533 @ 0x2078390" latency=10.886835ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=27.943714ms Aug 31 17:21:03 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:03.769+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.4:49533 @ 0x2078390" latency=10.886835ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=44.584213ms Aug 31 17:21:03 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:03.778+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.4:49533 @ 0x2078390" latency=10.886835ms timeout=10s endpoint=http://pushupdates.volumio.org duration=54.234253ms Aug 31 17:21:03 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 31 17:21:03 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 17:21:03 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 31 17:21:03 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:03.780+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.4:49533 @ 0x2078390" latency=10.886835ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=55.142949ms Aug 31 17:21:03 volumio-kali volumio[1165]: amixer -c 0 info | grep "bcm2835 ALSA" Aug 31 17:21:03 volumio-kali volumio[1165]: amixer -c 1 info | grep "bcm2835 Headphones" Aug 31 17:21:03 volumio-kali volumio[1165]: Card sysdefault:1 'Headphones'/'bcm2835 Headphones' Aug 31 17:21:03 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:03.860+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.4:49533 @ 0x2078390" latency=10.886835ms timeout=10s endpoint=https://www.googleapis.com duration=136.343991ms Aug 31 17:21:03 volumio-kali volumio[1165]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 2 Aug 31 17:21:03 volumio-kali volumio[1165]: /bin/sh: 1: /usr/local/bin/alsacap: not found Aug 31 17:21:03 volumio-kali volumio[1165]: {"cmd":"/usr/local/bin/alsacap -C 2","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 2\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)"} Aug 31 17:21:03 volumio-kali volumio[1165]: amixer -c 2 info | grep "vc4-hdmi" Aug 31 17:21:03 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:03.882+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.4:49533 @ 0x2078390" latency=10.886835ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=158.959274ms Aug 31 17:21:03 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:03.884+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.4:49533 @ 0x2078390" latency=10.886835ms timeout=10s endpoint=https://securetoken.googleapis.com duration=158.893233ms Aug 31 17:21:03 volumio-kali volumio[1165]: Card sysdefault:2 'vc4hdmi'/'vc4-hdmi' Aug 31 17:21:03 volumio-kali volumio[1165]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 3 Aug 31 17:21:03 volumio-kali volumio[1165]: /bin/sh: 1: /usr/local/bin/alsacap: not found Aug 31 17:21:03 volumio-kali volumio[1165]: {"cmd":"/usr/local/bin/alsacap -C 3","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 3\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)"} Aug 31 17:21:03 volumio-kali volumio[1165]: amixer -c 3 info | grep "BassFly-uHAT with I2S Mic" Aug 31 17:21:03 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:03.904+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.4:49533 @ 0x2078390" latency=10.886835ms timeout=10s endpoint=https://database.volumio.cloud duration=180.550183ms Aug 31 17:21:03 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:03.904+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.4:49533 @ 0x2078390" latency=10.886835ms timeout=10s endpoint=https://functions.volumio.cloud duration=181.205078ms Aug 31 17:21:03 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:03.904+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.4:49533 @ 0x2078390" latency=10.886835ms timeout=10s endpoint=https://functions.volumio.cloud duration=179.40607ms Aug 31 17:21:03 volumio-kali volumio[1165]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 3 Aug 31 17:21:03 volumio-kali volumio[1165]: /bin/sh: 1: /usr/local/bin/alsacap: not found Aug 31 17:21:03 volumio-kali volumio[1165]: {"cmd":"/usr/local/bin/alsacap -C 3","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 3\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)"} Aug 31 17:21:03 volumio-kali volumio[1165]: amixer -c 3 info | grep "snd_rpi_googlevoicehat_soundcar" Aug 31 17:21:03 volumio-kali volumio[1165]: Card sysdefault:3 'sndrpigooglevoi'/'snd_rpi_googlevoicehat_soundcard' Aug 31 17:21:03 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:03.970+02:00 level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.1.4:49533 @ 0x2078390" selectedOutputId=3 Aug 31 17:21:03 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:03.983+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.4:49533 @ 0x2078390" latency=10.886835ms timeout=10s endpoint=http://cddb.volumio.org duration=259.921332ms Aug 31 17:21:04 volumio-kali volumio[1165]: info: Received Get System Info Aug 31 17:21:04 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 17:21:04 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 17:21:04 volumio-kali volumio[1165]: info: Discovery: Getting this device information Aug 31 17:21:04 volumio-kali volumio[1165]: info: CoreCommandRouter::volumioGetState Aug 31 17:21:04 volumio-kali volumio[1165]: info: CorePlayQueue::getTrack 0 Aug 31 17:21:04 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 17:21:04 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:04.009+02:00 level=INFO msg="emitting software info changed event" component=server peer="192.168.1.4:49533 @ 0x2078390" currentVersion=4.119 latestVersion=4.119 Aug 31 17:21:04 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:04.010+02:00 level=INFO msg="emitting software update progress event" component=server peer="192.168.1.4:49533 @ 0x2078390" status=UPDATE_STATUS_NONE progress=0 Aug 31 17:21:04 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:04.010+02:00 level=INFO msg="emitting user changed event" component=server peer="192.168.1.4:49533 @ 0x2078390" userId= Aug 31 17:21:04 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:04.010+02:00 level=INFO msg="emitting music providers changed event" component=server peer="192.168.1.4:49533 @ 0x2078390" providers=3 Aug 31 17:21:04 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:04.011+02:00 level=INFO msg="emitting plugins changed event" component=server peer="192.168.1.4:49533 @ 0x2078390" plugins=71 Aug 31 17:21:04 volumio-kali volumio[1165]: info: CoreCommandRouter::volumioGetState Aug 31 17:21:04 volumio-kali volumio[1165]: info: CorePlayQueue::getTrack 0 Aug 31 17:21:04 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:04.015+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.4:49533 @ 0x2078390" state=STATUS_PLAYING positionMs=186381 volume=100 Aug 31 17:21:04 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:04.015+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.4:49533 @ 0x2078390" id="mnt/USB/Volume_m-sata/Danielle Nicole/(01) [Danielle Nicole] Crawl.flac" title="1 - Crawl" Aug 31 17:21:04 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:04.189+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.4:49533 @ 0x2078390" latency=10.886835ms timeout=10s endpoint=http://plugins.volumio.org duration=465.611274ms Aug 31 17:21:04 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:04.225+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.4:49533 @ 0x2078390" latency=10.886835ms timeout=10s endpoint=https://google.com duration=500.986645ms Aug 31 17:21:08 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 31 17:21:08 volumio-kali volumio[1165]: info: CURURI: music-library/USB/Volume_m-sata/Climax Blues Band - Drastic Steps...plus (C-Five Records C5CD 573) Aug 31 17:21:08 volumio-kali volumio[1165]: info: Preload queue cleared Aug 31 17:21:13 volumio-kali volumio[1165]: info: Preload queue cleared Aug 31 17:21:13 volumio-kali volumio[1165]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 31 17:21:13 volumio-kali volumio[1165]: info: CoreStateMachine::ClearQueue Aug 31 17:21:13 volumio-kali volumio[1165]: info: CoreStateMachine::stop Aug 31 17:21:13 volumio-kali volumio[1165]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 17:21:13 volumio-kali volumio[1165]: info: CoreStateMachine::stPlaybackTimer Aug 31 17:21:13 volumio-kali volumio[1165]: info: CoreStateMachine::updateTrackBlock Aug 31 17:21:13 volumio-kali volumio[1165]: info: CorePlayQueue::getTrackBlock Aug 31 17:21:13 volumio-kali volumio[1165]: info: CoreStateMachine::pushState Aug 31 17:21:13 volumio-kali volumio[1165]: info: CorePlayQueue::getTrack 0 Aug 31 17:21:13 volumio-kali volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 17:21:13 volumio-kali volumio[1165]: info: CoreCommandRouter::volumioPushState Aug 31 17:21:13 volumio-kali volumio[1165]: info: CoreStateMachine::serviceStop Aug 31 17:21:13 volumio-kali volumio[1165]: info: CorePlayQueue::getTrack 0 Aug 31 17:21:13 volumio-kali volumio[1165]: info: CoreCommandRouter::serviceStop Aug 31 17:21:13 volumio-kali volumio[1165]: info: ControllerMpd::stop Aug 31 17:21:13 volumio-kali volumio[1165]: verbose: ControllerMpd::sendMpdCommand stop Aug 31 17:21:13 volumio-kali volumio[1165]: info: CorePlayQueue::clearPlayQueue Aug 31 17:21:13 volumio-kali volumio[1165]: info: CorePlayQueue::saveQueue Aug 31 17:21:13 volumio-kali volumio[1165]: info: CoreCommandRouter::volumioPushQueue Aug 31 17:21:13 volumio-kali volumio[1165]: info: CoreStateMachine::addQueueItems Aug 31 17:21:13 volumio-kali volumio[1165]: info: CorePlayQueue::addQueueItems Aug 31 17:21:13 volumio-kali volumio[1165]: info: Preload queue cleared Aug 31 17:21:13 volumio-kali volumio[1165]: info: Adding Item to queue: music-library/USB/Volume_m-sata/Climax Blues Band - Drastic Steps...plus (C-Five Records C5CD 573) Aug 31 17:21:13 volumio-kali volumio[1165]: info: Exploding uri music-library/USB/Volume_m-sata/Climax Blues Band - Drastic Steps...plus (C-Five Records C5CD 573) in service mpd Aug 31 17:21:13 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:13.179+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.4:49533 @ 0x2078390" state=STATUS_STOPPED positionMs=0 volume=100 Aug 31 17:21:13 volumio-kali volumio5-onboarding[1542]: time=2026-08-31T17:21:13.180+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.4:49533 @ 0x2078390" id="mnt/USB/Volume_m-sata/Danielle Nicole/(01) [Danielle Nicole] Crawl.flac" title="1 - Crawl" Aug 31 17:21:13 volumio-kali kernel: voicehat-codec voicehat-codec: Disabling audio amp... Aug 31 17:21:13 volumio-kali volumio[1165]: info: Aug 31 17:21:13 volumio-kali volumio[1165]: ---------------------------- MPD announces state update: player Aug 31 17:21:13 volumio-kali volumio[1165]: info: ALBUMART /albumart?cacheid=418&web=//large&path=%2Fmnt%2FUSB%2FVolume_m-sata%2FClimax%20Blues%20Band%20-%20Drastic%20Steps...plus%20(C-Five%20Records%20C5CD%20573)%2FClimax%20Bluesband%20-%20Drastic%20Steps...plus.ape&metadata=false Aug 31 17:21:13 volumio-kali volumio[1165]: info: URI /mnt/USB/Volume_m-sata/Climax Blues Band - Drastic Steps...plus (C-Five Records C5CD 573)/Climax Bluesband - Drastic Steps...plus.ape Aug 31 17:21:13 volumio-kali volumio[1165]: info: ALBUMART /albumart?cacheid=418&web=Climax%20Bluesband/Drastic%20Steps...plus/large&path=%2Fmnt%2FUSB%2FVolume_m-sata%2FClimax%20Blues%20Band%20-%20Drastic%20Steps...plus%20(C-Five%20Records%20C5CD%20573)%2FClimax%20Bluesband%20-%20Drastic%20Steps...plus.cue&metadata=false Aug 31 17:21:13 volumio-kali volumio[1165]: info: URI /mnt/USB/Volume_m-sata/Climax Blues Band - Drastic Steps...plus (C-Five Records C5CD 573)/Climax Bluesband - Drastic Steps...plus.cue Aug 31 17:21:13 volumio-kali volumio[1165]: info: ALBUMART /albumart?cacheid=418&web=Climax%20Bluesband/Drastic%20Steps...plus/large&path=%2Fmnt%2FUSB%2FVolume_m-sata%2FClimax%20Blues%20Band%20-%20Drastic%20Steps...plus%20(C-Five%20Records%20C5CD%20573)%2FClimax%20Bluesband%20-%20Drastic%20Steps...plus.cue&metadata=false Aug 31 17:21:13 volumio-kali volumio[1165]: info: URI /mnt/USB/Volume_m-sata/Climax Blues Band - Drastic Steps...plus (C-Five Records C5CD 573)/Climax Bluesband - Drastic Steps...plus.cue Aug 31 17:21:13 volumio-kali volumio[1165]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 17:21:13 volumio-kali volumio[1165]: Error: Unable to resolve or reject the same promise twice Aug 31 17:21:13 volumio-kali volumio[1165]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Aug 31 17:21:13 volumio-kali volumio[1165]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Aug 31 17:21:13 volumio-kali volumio[1165]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Aug 31 17:21:13 volumio-kali volumio[1165]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Aug 31 17:21:13 volumio-kali volumio[1165]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Aug 31 17:21:13 volumio-kali volumio[1165]: at Socket.emit (node:events:514:28) Aug 31 17:21:13 volumio-kali volumio[1165]: at addChunk (node:internal/streams/readable:343:12) Aug 31 17:21:13 volumio-kali volumio[1165]: at readableAddChunk (node:internal/streams/readable:312:11) Aug 31 17:21:13 volumio-kali volumio[1165]: at Readable.push (node:internal/streams/readable:253:10) Aug 31 17:21:13 volumio-kali volumio[1165]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Aug 31 17:21:13 volumio-kali volumio[1165]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 17:21:14 volumio-kali sudo[6726]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-31 17:20' Aug 31 17:21:14 volumio-kali sudo[6726]: 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"