Feb 18 09:23:06 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 10.
Feb 18 09:23:06 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 18 09:23:06 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 18 09:23:06 volumio upmpdcli[2292]: Could not open config: /tmp/upmpdcli.conf
Feb 18 09:23:06 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 09:23:06 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Feb 18 09:23:19 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:19.023+02:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.0.101:46875
Feb 18 09:23:19 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:19.053+02:00 level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.0.101:46875 @ 0x2b4b770" latency=-344.688911ms platform=PLATFORM_ANDROID version=5.260120.0
Feb 18 09:23:19 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:19.055+02:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.0.101:46875 @ 0x2b4b770" latency=-345.927229ms timeout=10s
Feb 18 09:23:19 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:19.055+02:00 level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770"
Feb 18 09:23:19 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 18 09:23:19 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 18 09:23:19 volumio volumio[1252]: info: Received Get System Info
Feb 18 09:23:19 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 18 09:23:19 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 18 09:23:19 volumio volumio[1252]: info: Discovery: Getting this device information
Feb 18 09:23:19 volumio volumio[1252]: info: CoreCommandRouter::volumioGetState
Feb 18 09:23:19 volumio volumio[1252]: info: CorePlayQueue::getTrack 0
Feb 18 09:23:19 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 18 09:23:19 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:19.087+02:00 level=INFO msg="emitting device name changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" name=Volumio
Feb 18 09:23:19 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:19.090+02:00 level=INFO msg="emitting device language changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" language=uk
Feb 18 09:23:19 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone
Feb 18 09:23:19 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:19.093+02:00 level=INFO msg="emitting device timezone changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" timezone=Europe/Kiev
Feb 18 09:23:19 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:19.098+02:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" available=true connected=false macAddress= ip4Address= ip6Address=
Feb 18 09:23:19 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:19.101+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" available=true connected=true macAddress=d8:3a:dd:fa:6b:31 ip4Address=192.168.0.112/24 ip6Address= ssid=TP-Link_5702_5G
Feb 18 09:23:19 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:19.102+02:00 level=INFO msg="emitting device setup status changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" setupComplete=true
Feb 18 09:23:19 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices
Feb 18 09:23:19 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Feb 18 09:23:19 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 18 09:23:19 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 18 09:23:19 volumio volumio[1252]: amixer -c 0 info | grep "bcm2835 ALSA"
Feb 18 09:23:19 volumio volumio[1252]: amixer -c 1 info | grep "bcm2835 Headphones"
Feb 18 09:23:19 volumio go-librespot[1862]: time="2026-02-18T09:23:19+02:00" level=trace msg="received accesspoint ping"
Feb 18 09:23:19 volumio go-librespot[1862]: time="2026-02-18T09:23:19+02:00" level=trace msg="received accesspoint pong ack"
Feb 18 09:23:19 volumio volumio[1252]: Card sysdefault:1 'Headphones'/'bcm2835 Headphones'
Feb 18 09:23:19 volumio volumio[1252]: amixer -c 2 info | grep "vc4-hdmi-0"
Feb 18 09:23:19 volumio volumio[1252]: Card sysdefault:2 'vc4hdmi0'/'vc4-hdmi-0'
Feb 18 09:23:19 volumio volumio[1252]: amixer -c 3 info | grep "vc4-hdmi-1"
Feb 18 09:23:19 volumio volumio[1252]: Card sysdefault:3 'vc4hdmi1'/'vc4-hdmi-1'
Feb 18 09:23:19 volumio go-librespot[1862]: time="2026-02-18T09:23:19+02:00" level=trace msg="sent dealer ping"
Feb 18 09:23:19 volumio volumio[1252]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 5
Feb 18 09:23:19 volumio volumio[1252]: /bin/sh: 1: /usr/local/bin/alsacap: not found
Feb 18 09:23:19 volumio volumio[1252]: {"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)"}
Feb 18 09:23:19 volumio volumio[1252]: amixer -c 5 info | grep "Combo384 Amanero"
Feb 18 09:23:19 volumio go-librespot[1862]: time="2026-02-18T09:23:19+02:00" level=trace msg="received dealer pong"
Feb 18 09:23:19 volumio volumio[1252]: Card sysdefault:5 'Amanero'/'Amanero Technologies Combo384 Amanero at usb-0000:01:00.0-1.1, high speed'
Feb 18 09:23:19 volumio volumio[1252]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 5
Feb 18 09:23:19 volumio volumio[1252]: /bin/sh: 1: /usr/local/bin/alsacap: not found
Feb 18 09:23:19 volumio volumio[1252]: {"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)"}
Feb 18 09:23:19 volumio volumio[1252]: amixer -c 5 info | grep "Combo384 Amanero"
Feb 18 09:23:19 volumio volumio[1252]: Card sysdefault:5 'Amanero'/'Amanero Technologies Combo384 Amanero at usb-0000:01:00.0-1.1, high speed'
Feb 18 09:23:19 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:19.904+02:00 level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" selectedOutputId=5
Feb 18 09:23:19 volumio volumio[1252]: info: Received Get System Info
Feb 18 09:23:19 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 18 09:23:19 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 18 09:23:19 volumio volumio[1252]: info: Discovery: Getting this device information
Feb 18 09:23:19 volumio volumio[1252]: info: CoreCommandRouter::volumioGetState
Feb 18 09:23:19 volumio volumio[1252]: info: CorePlayQueue::getTrack 0
Feb 18 09:23:19 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 18 09:23:19 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:19.948+02:00 level=INFO msg="emitting software info changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" currentVersion=4.096 latestVersion=4.096
Feb 18 09:23:19 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:19.949+02:00 level=INFO msg="emitting software update progress event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" status=UPDATE_STATUS_NONE progress=0
Feb 18 09:23:19 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:19.949+02:00 level=INFO msg="emitting user changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" userId=
Feb 18 09:23:19 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:19.949+02:00 level=INFO msg="emitting music providers changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" providers=3
Feb 18 09:23:19 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 18 09:23:19 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 18 09:23:19 volumio volumio[1252]: info: Discovery: Getting this device information
Feb 18 09:23:19 volumio volumio[1252]: info: CoreCommandRouter::volumioGetState
Feb 18 09:23:19 volumio volumio[1252]: info: CorePlayQueue::getTrack 0
Feb 18 09:23:19 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 18 09:23:19 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 18 09:23:20 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 18 09:23:20 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Feb 18 09:23:20 volumio volumio[1252]: verbose: New Socket.io Connection to 192.168.0.112:3000 from 192.168.0.101 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9
Feb 18 09:23:20 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 18 09:23:20 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 18 09:23:21 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:21.033+02:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.0.101:46875 @ 0x2b4b770" latency=-342.379063ms timeout=10s
Feb 18 09:23:21 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:21.033+02:00 level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770"
Feb 18 09:23:21 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:21.033+02:00 level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.0.101:46875 @ 0x2b4b770" latency=-340.397859ms platform=PLATFORM_ANDROID version=5.260120.0
Feb 18 09:23:21 volumio volumio[1252]: info: Received Get System Info
Feb 18 09:23:21 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 18 09:23:21 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 18 09:23:21 volumio volumio[1252]: info: Discovery: Getting this device information
Feb 18 09:23:21 volumio volumio[1252]: info: CoreCommandRouter::volumioGetState
Feb 18 09:23:21 volumio volumio[1252]: info: CorePlayQueue::getTrack 0
Feb 18 09:23:21 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 18 09:23:21 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:21.037+02:00 level=INFO msg="emitting device name changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" name=Volumio
Feb 18 09:23:21 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:21.038+02:00 level=INFO msg="emitting device language changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" language=uk
Feb 18 09:23:21 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone
Feb 18 09:23:21 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:21.053+02:00 level=INFO msg="emitting device timezone changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" timezone=Europe/Kiev
Feb 18 09:23:21 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:21.054+02:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" available=true connected=false macAddress= ip4Address= ip6Address=
Feb 18 09:23:21 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:21.057+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" available=true connected=true macAddress=d8:3a:dd:fa:6b:31 ip4Address=192.168.0.112/24 ip6Address= ssid=TP-Link_5702_5G
Feb 18 09:23:21 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:21.058+02:00 level=INFO msg="emitting device setup status changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" setupComplete=true
Feb 18 09:23:21 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices
Feb 18 09:23:21 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Feb 18 09:23:21 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 18 09:23:21 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 18 09:23:21 volumio volumio[1252]: amixer -c 0 info | grep "bcm2835 ALSA"
Feb 18 09:23:21 volumio volumio[1252]: amixer -c 1 info | grep "bcm2835 Headphones"
Feb 18 09:23:21 volumio volumio[1252]: Card sysdefault:1 'Headphones'/'bcm2835 Headphones'
Feb 18 09:23:21 volumio volumio[1252]: amixer -c 2 info | grep "vc4-hdmi-0"
Feb 18 09:23:21 volumio volumio[1252]: Card sysdefault:2 'vc4hdmi0'/'vc4-hdmi-0'
Feb 18 09:23:21 volumio volumio[1252]: amixer -c 3 info | grep "vc4-hdmi-1"
Feb 18 09:23:21 volumio volumio[1252]: Card sysdefault:3 'vc4hdmi1'/'vc4-hdmi-1'
Feb 18 09:23:21 volumio volumio[1252]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 5
Feb 18 09:23:21 volumio volumio[1252]: /bin/sh: 1: /usr/local/bin/alsacap: not found
Feb 18 09:23:21 volumio volumio[1252]: {"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)"}
Feb 18 09:23:21 volumio volumio[1252]: amixer -c 5 info | grep "Combo384 Amanero"
Feb 18 09:23:21 volumio volumio[1252]: Card sysdefault:5 'Amanero'/'Amanero Technologies Combo384 Amanero at usb-0000:01:00.0-1.1, high speed'
Feb 18 09:23:21 volumio volumio[1252]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 5
Feb 18 09:23:21 volumio volumio[1252]: /bin/sh: 1: /usr/local/bin/alsacap: not found
Feb 18 09:23:21 volumio volumio[1252]: {"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)"}
Feb 18 09:23:21 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 11.
Feb 18 09:23:21 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 18 09:23:21 volumio volumio[1252]: amixer -c 5 info | grep "Combo384 Amanero"
Feb 18 09:23:21 volumio volumio[1252]: Card sysdefault:5 'Amanero'/'Amanero Technologies Combo384 Amanero at usb-0000:01:00.0-1.1, high speed'
Feb 18 09:23:21 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:21.806+02:00 level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" selectedOutputId=5
Feb 18 09:23:21 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 18 09:23:21 volumio upmpdcli[2380]: Could not open config: /tmp/upmpdcli.conf
Feb 18 09:23:21 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 09:23:21 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Feb 18 09:23:21 volumio volumio[1252]: info: Received Get System Info
Feb 18 09:23:21 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 18 09:23:21 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 18 09:23:21 volumio volumio[1252]: info: Discovery: Getting this device information
Feb 18 09:23:21 volumio volumio[1252]: info: CoreCommandRouter::volumioGetState
Feb 18 09:23:21 volumio volumio[1252]: info: CorePlayQueue::getTrack 0
Feb 18 09:23:21 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 18 09:23:21 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:21.943+02:00 level=INFO msg="emitting software info changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" currentVersion=4.096 latestVersion=4.096
Feb 18 09:23:21 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:21.944+02:00 level=INFO msg="emitting software update progress event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" status=UPDATE_STATUS_NONE progress=0
Feb 18 09:23:21 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:21.944+02:00 level=INFO msg="emitting user changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" userId=
Feb 18 09:23:21 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:21.944+02:00 level=INFO msg="emitting music providers changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" providers=3
Feb 18 09:23:22 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:22.196+02:00 level=INFO msg="emitting plugins changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" plugins=60
Feb 18 09:23:22 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:22.197+02:00 level=INFO msg="emitting plugins changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" plugins=60
Feb 18 09:23:22 volumio volumio[1252]: info: CoreCommandRouter::volumioGetState
Feb 18 09:23:22 volumio volumio[1252]: info: CorePlayQueue::getTrack 0
Feb 18 09:23:22 volumio volumio[1252]: info: CoreCommandRouter::volumioGetState
Feb 18 09:23:22 volumio volumio[1252]: info: CorePlayQueue::getTrack 0
Feb 18 09:23:22 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:22.212+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" state=STATUS_STOPPED positionMs=0 volume=10
Feb 18 09:23:22 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:22.213+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" id= title=
Feb 18 09:23:22 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:22.213+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" state=STATUS_STOPPED positionMs=0 volume=10
Feb 18 09:23:22 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:22.213+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" id= title=
Feb 18 09:23:22 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:22.214+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" state=STATUS_STOPPED positionMs=0 volume=10
Feb 18 09:23:22 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:22.214+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.101:46875 @ 0x2b4b770" id= title=
Feb 18 09:23:22 volumio volumio5-onboarding[1586]: time=2026-02-18T09:23:22.348+02:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.0.101:46875 @ 0x2b4b770" latency=-345.870263ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE
Feb 18 09:23:30 volumio sudo[2405]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 18 09:23:30 volumio sudo[2405]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 18 09:23:30 volumio sudo[2407]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 18 09:23:30 volumio sudo[2407]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 18 09:23:30 volumio sudo[2405]: pam_unix(sudo:session): session closed for user root
Feb 18 09:23:30 volumio sudo[2407]: pam_unix(sudo:session): session closed for user root
Feb 18 09:23:30 volumio volumio[1252]: verbose: New Socket.io Connection to 192.168.0.112 from 192.168.0.101 UA: Mozilla/5.0 (Linux; Android 8.1.0; Redmi 5 Plus Build/OPM1.171019.019; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/138.0.7204.179 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Feb 18 09:23:32 volumio sudo[2411]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 18 09:23:32 volumio sudo[2411]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 18 09:23:32 volumio sudo[2411]: pam_unix(sudo:session): session closed for user root
Feb 18 09:23:32 volumio sudo[2413]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 18 09:23:32 volumio sudo[2413]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 18 09:23:32 volumio sudo[2413]: pam_unix(sudo:session): session closed for user root
Feb 18 09:23:33 volumio volumio[1252]: verbose: New Socket.io Connection to 192.168.0.112 from 192.168.0.101 UA: Mozilla/5.0 (Linux; Android 8.1.0; Redmi 5 Plus Build/OPM1.171019.019; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/138.0.7204.179 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10
Feb 18 09:23:34 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Feb 18 09:23:34 volumio volumio[1252]: info: CoreCommandRouter::volumioGetVisibleSources
Feb 18 09:23:34 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 18 09:23:34 volumio volumio[1252]: info: CoreCommandRouter::volumioGetState
Feb 18 09:23:34 volumio volumio[1252]: info: CorePlayQueue::getTrack 0
Feb 18 09:23:34 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Feb 18 09:23:34 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Feb 18 09:23:34 volumio volumio[1252]: info: Received Get System Info
Feb 18 09:23:34 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 18 09:23:34 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 18 09:23:34 volumio volumio[1252]: info: Discovery: Getting this device information
Feb 18 09:23:34 volumio volumio[1252]: info: CoreCommandRouter::volumioGetState
Feb 18 09:23:34 volumio volumio[1252]: info: CorePlayQueue::getTrack 0
Feb 18 09:23:34 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 18 09:23:34 volumio volumio[1252]: info: CoreCommandRouter::volumioGetState
Feb 18 09:23:34 volumio volumio[1252]: info: CorePlayQueue::getTrack 0
Feb 18 09:23:34 volumio volumio[1252]: info: Listing playlists
Feb 18 09:23:34 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Feb 18 09:23:34 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 18 09:23:34 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Feb 18 09:23:34 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 18 09:23:34 volumio volumio[1252]: info: Received Get System Info
Feb 18 09:23:34 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 18 09:23:34 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 18 09:23:34 volumio volumio[1252]: info: Discovery: Getting this device information
Feb 18 09:23:34 volumio volumio[1252]: info: CoreCommandRouter::volumioGetState
Feb 18 09:23:34 volumio volumio[1252]: info: CorePlayQueue::getTrack 0
Feb 18 09:23:34 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 18 09:23:34 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Feb 18 09:23:35 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Feb 18 09:23:36 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 18 09:23:36 volumio volumio[1252]: info: Received Get System Info
Feb 18 09:23:36 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 18 09:23:36 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 18 09:23:36 volumio volumio[1252]: info: Discovery: Getting this device information
Feb 18 09:23:36 volumio volumio[1252]: info: CoreCommandRouter::volumioGetState
Feb 18 09:23:36 volumio volumio[1252]: info: CorePlayQueue::getTrack 0
Feb 18 09:23:36 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 18 09:23:36 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 12.
Feb 18 09:23:36 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 18 09:23:37 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 18 09:23:37 volumio upmpdcli[2423]: Could not open config: /tmp/upmpdcli.conf
Feb 18 09:23:37 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 09:23:37 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Feb 18 09:23:37 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 18 09:23:37 volumio volumio[1252]: info: Received Get System Info
Feb 18 09:23:37 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 18 09:23:37 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 18 09:23:37 volumio volumio[1252]: info: Discovery: Getting this device information
Feb 18 09:23:37 volumio volumio[1252]: info: CoreCommandRouter::volumioGetState
Feb 18 09:23:37 volumio volumio[1252]: info: CorePlayQueue::getTrack 0
Feb 18 09:23:37 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 18 09:23:38 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 18 09:23:38 volumio volumio[1252]: info: Received Get System Info
Feb 18 09:23:38 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 18 09:23:38 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 18 09:23:38 volumio volumio[1252]: info: Discovery: Getting this device information
Feb 18 09:23:38 volumio volumio[1252]: info: CoreCommandRouter::volumioGetState
Feb 18 09:23:38 volumio volumio[1252]: info: CorePlayQueue::getTrack 0
Feb 18 09:23:38 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 18 09:23:42 volumio volumio[1252]: info: CoreCommandRouter::volumioGetQueue
Feb 18 09:23:42 volumio volumio[1252]: info: CoreStateMachine::getQueue
Feb 18 09:23:42 volumio volumio[1252]: info: CorePlayQueue::getQueue
Feb 18 09:23:43 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Feb 18 09:23:47 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Feb 18 09:23:47 volumio volumio[1252]: info: CURURI: music-library
Feb 18 09:23:47 volumio volumio[1252]: info: Preload queue cleared
Feb 18 09:23:49 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Feb 18 09:23:49 volumio volumio[1252]: info: CURURI: music-library/USB
Feb 18 09:23:49 volumio volumio[1252]: info: Preload queue cleared
Feb 18 09:23:49 volumio go-librespot[1862]: time="2026-02-18T09:23:49+02:00" level=trace msg="sent dealer ping"
Feb 18 09:23:49 volumio go-librespot[1862]: time="2026-02-18T09:23:49+02:00" level=trace msg="received dealer pong"
Feb 18 09:23:51 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 18 09:23:51 volumio volumio[1252]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Feb 18 09:23:51 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Feb 18 09:23:51 volumio volumio[1252]: info: Received Get System Version
Feb 18 09:23:51 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 18 09:23:51 volumio volumio[1252]: info: Received Get System Info
Feb 18 09:23:51 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 18 09:23:51 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 18 09:23:51 volumio volumio[1252]: info: Discovery: Getting this device information
Feb 18 09:23:51 volumio volumio[1252]: info: CoreCommandRouter::volumioGetState
Feb 18 09:23:51 volumio volumio[1252]: info: CorePlayQueue::getTrack 0
Feb 18 09:23:51 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 18 09:23:51 volumio volumio[1252]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Feb 18 09:23:51 volumio volumio[1252]: info: CURURI: music-library/USB/3A20E37E20E3400D
Feb 18 09:23:51 volumio volumio[1252]: info: Preload queue cleared
Feb 18 09:23:52 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 13.
Feb 18 09:23:52 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 18 09:23:52 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 18 09:23:52 volumio upmpdcli[2460]: Could not open config: /tmp/upmpdcli.conf
Feb 18 09:23:52 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Feb 18 09:23:52 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Feb 18 09:24:00 volumio volumio[1252]: info: Preload queue cleared
Feb 18 09:24:00 volumio volumio[1252]: info: CoreCommandRouter::volumioAddQueueItems
Feb 18 09:24:00 volumio volumio[1252]: info: CoreStateMachine::addQueueItems
Feb 18 09:24:00 volumio volumio[1252]: info: CorePlayQueue::addQueueItems
Feb 18 09:24:00 volumio volumio[1252]: info: Preload queue cleared
Feb 18 09:24:00 volumio volumio[1252]: info: Adding Item to queue: music-library/USB/3A20E37E20E3400D/1986 Paul Mauriat - Penelope Digital Best
Feb 18 09:24:00 volumio volumio[1252]: info: Exploding uri music-library/USB/3A20E37E20E3400D/1986 Paul Mauriat - Penelope Digital Best in service mpd
Feb 18 09:24:00 volumio volumio[1252]: info: ALBUMART /albumart?cacheid=251&web=Paul%20Mauriat/Paul%20Mauriat%20-%20Digital%20Best%20(Philips%20-%2028PP-50%2C%20Japan)/large&path=%2Fmnt%2FUSB%2F3A20E37E20E3400D%2F1986%20Paul%20Mauriat%20-%20Penelope%20Digital%20Best%2FA1.%20Penelope.dsf&metadata=false
Feb 18 09:24:00 volumio volumio[1252]: info: URI /mnt/USB/3A20E37E20E3400D/1986 Paul Mauriat - Penelope Digital Best/A1. Penelope.dsf
Feb 18 09:24:00 volumio volumio[1252]: info: ALBUMART /albumart?cacheid=251&web=Paul%20Mauriat/Paul%20Mauriat%20-%20Digital%20Best%20(Philips%20-%2028PP-50%2C%20Japan)/large&path=%2Fmnt%2FUSB%2F3A20E37E20E3400D%2F1986%20Paul%20Mauriat%20-%20Penelope%20Digital%20Best%2FA2.%20Love%20Is%20Still%20Blue.dsf&metadata=false
Feb 18 09:24:00 volumio volumio[1252]: info: URI /mnt/USB/3A20E37E20E3400D/1986 Paul Mauriat - Penelope Digital Best/A2. Love Is Still Blue.dsf
Feb 18 09:24:00 volumio volumio[1252]: info: ALBUMART /albumart?cacheid=251&web=Paul%20Mauriat/Paul%20Mauriat%20-%20Digital%20Best%20(Philips%20-%2028PP-50%2C%20Japan)/large&path=%2Fmnt%2FUSB%2F3A20E37E20E3400D%2F1986%20Paul%20Mauriat%20-%20Penelope%20Digital%20Best%2FA3.%20El%20Bimbo.dsf&metadata=false
Feb 18 09:24:00 volumio volumio[1252]: info: URI /mnt/USB/3A20E37E20E3400D/1986 Paul Mauriat - Penelope Digital Best/A3. El Bimbo.dsf
Feb 18 09:24:00 volumio volumio[1252]: info: ALBUMART /albumart?cacheid=251&web=Paul%20Mauriat/Paul%20Mauriat%20-%20Digital%20Best%20(Philips%20-%2028PP-50%2C%20Japan)/large&path=%2Fmnt%2FUSB%2F3A20E37E20E3400D%2F1986%20Paul%20Mauriat%20-%20Penelope%20Digital%20Best%2FA4.%20Toccata.dsf&metadata=false
Feb 18 09:24:00 volumio volumio[1252]: info: URI /mnt/USB/3A20E37E20E3400D/1986 Paul Mauriat - Penelope Digital Best/A4. Toccata.dsf
Feb 18 09:24:00 volumio volumio[1252]: info: ALBUMART /albumart?cacheid=251&web=Paul%20Mauriat/Paul%20Mauriat%20-%20Digital%20Best%20(Philips%20-%2028PP-50%2C%20Japan)/large&path=%2Fmnt%2FUSB%2F3A20E37E20E3400D%2F1986%20Paul%20Mauriat%20-%20Penelope%20Digital%20Best%2FA5.%20Minuetto.dsf&metadata=false
Feb 18 09:24:00 volumio volumio[1252]: info: URI /mnt/USB/3A20E37E20E3400D/1986 Paul Mauriat - Penelope Digital Best/A5. Minuetto.dsf
Feb 18 09:24:00 volumio volumio[1252]: info: ALBUMART /albumart?cacheid=251&web=Paul%20Mauriat/Paul%20Mauriat%20-%20Digital%20Best%20(Philips%20-%2028PP-50%2C%20Japan)/large&path=%2Fmnt%2FUSB%2F3A20E37E20E3400D%2F1986%20Paul%20Mauriat%20-%20Penelope%20Digital%20Best%2FA6.%20Jelux%20Interdits.dsf&metadata=false
Feb 18 09:24:00 volumio volumio[1252]: info: URI /mnt/USB/3A20E37E20E3400D/1986 Paul Mauriat - Penelope Digital Best/A6. Jelux Interdits.dsf
Feb 18 09:24:00 volumio volumio[1252]: info: ALBUMART /albumart?cacheid=251&web=Paul%20Mauriat/Paul%20Mauriat%20-%20Digital%20Best%20(Philips%20-%2028PP-50%2C%20Japan)/large&path=%2Fmnt%2FUSB%2F3A20E37E20E3400D%2F1986%20Paul%20Mauriat%20-%20Penelope%20Digital%20Best%2FB1.%20Dis%20Lui%20Feelings.dsf&metadata=false
Feb 18 09:24:00 volumio volumio[1252]: info: URI /mnt/USB/3A20E37E20E3400D/1986 Paul Mauriat - Penelope Digital Best/B1. Dis Lui Feelings.dsf
Feb 18 09:24:00 volumio volumio[1252]: info: ALBUMART /albumart?cacheid=251&web=Paul%20Mauriat/Paul%20Mauriat%20-%20Digital%20Best%20(Philips%20-%2028PP-50%2C%20Japan)/large&path=%2Fmnt%2FUSB%2F3A20E37E20E3400D%2F1986%20Paul%20Mauriat%20-%20Penelope%20Digital%20Best%2FB2.%20Pearl%20Fisher.dsf&metadata=false
Feb 18 09:24:00 volumio volumio[1252]: info: URI /mnt/USB/3A20E37E20E3400D/1986 Paul Mauriat - Penelope Digital Best/B2. Pearl Fisher.dsf
Feb 18 09:24:00 volumio volumio[1252]: info: ALBUMART /albumart?cacheid=251&web=Paul%20Mauriat/Paul%20Mauriat%20-%20Digital%20Best%20(Philips%20-%2028PP-50%2C%20Japan)/large&path=%2Fmnt%2FUSB%2F3A20E37E20E3400D%2F1986%20Paul%20Mauriat%20-%20Penelope%20Digital%20Best%2FB3.%20Sing.dsf&metadata=false
Feb 18 09:24:00 volumio volumio[1252]: info: URI /mnt/USB/3A20E37E20E3400D/1986 Paul Mauriat - Penelope Digital Best/B3. Sing.dsf
Feb 18 09:24:00 volumio volumio[1252]: info: ALBUMART /albumart?cacheid=251&web=Paul%20Mauriat/Paul%20Mauriat%20-%20Digital%20Best%20(Philips%20-%2028PP-50%2C%20Japan)/large&path=%2Fmnt%2FUSB%2F3A20E37E20E3400D%2F1986%20Paul%20Mauriat%20-%20Penelope%20Digital%20Best%2FB4.%20Contigo%20Mi%20Vida.dsf&metadata=false
Feb 18 09:24:00 volumio volumio[1252]: info: URI /mnt/USB/3A20E37E20E3400D/1986 Paul Mauriat - Penelope Digital Best/B4. Contigo Mi Vida.dsf
Feb 18 09:24:00 volumio volumio[1252]: info: ALBUMART /albumart?cacheid=251&web=Paul%20Mauriat/Paul%20Mauriat%20-%20Digital%20Best%20(Philips%20-%2028PP-50%2C%20Japan)/large&path=%2Fmnt%2FUSB%2F3A20E37E20E3400D%2F1986%20Paul%20Mauriat%20-%20Penelope%20Digital%20Best%2FB5.%20Yesterday%20Once%20More.dsf&metadata=false
Feb 18 09:24:00 volumio volumio[1252]: info: URI /mnt/USB/3A20E37E20E3400D/1986 Paul Mauriat - Penelope Digital Best/B5. Yesterday Once More.dsf
Feb 18 09:24:00 volumio volumio[1252]: info: ALBUMART /albumart?cacheid=251&web=Paul%20Mauriat/Paul%20Mauriat%20-%20Digital%20Best%20(Philips%20-%2028PP-50%2C%20Japan)/large&path=%2Fmnt%2FUSB%2F3A20E37E20E3400D%2F1986%20Paul%20Mauriat%20-%20Penelope%20Digital%20Best%2FB6.%20Theres%20A%20Kind%20Of%20Hush.dsf&metadata=false
Feb 18 09:24:00 volumio volumio[1252]: info: URI /mnt/USB/3A20E37E20E3400D/1986 Paul Mauriat - Penelope Digital Best/B6. Theres A Kind Of Hush.dsf
Feb 18 09:24:00 volumio volumio[1252]: info: ALBUMART /albumart?cacheid=251&web=Paul%20Mauriat/Paul%20Mauriat%20-%20Penelope%20Digital%20Best%20(Philips%20-%2028PP-50%2C%20Japan)/large&path=%2Fmnt%2FUSB%2F3A20E37E20E3400D%2F1986%20Paul%20Mauriat%20-%20Penelope%20Digital%20Best%2FPenelope%20Digital%20Best.cue&metadata=false
Feb 18 09:24:00 volumio volumio[1252]: info: URI /mnt/USB/3A20E37E20E3400D/1986 Paul Mauriat - Penelope Digital Best/Penelope Digital Best.cue
Feb 18 09:24:00 volumio volumio[1252]: info: ALBUMART /albumart?cacheid=251&web=Paul%20Mauriat/Paul%20Mauriat%20-%20Penelope%20Digital%20Best%20(Philips%20-%2028PP-50%2C%20Japan)/large&path=%2Fmnt%2FUSB%2F3A20E37E20E3400D%2F1986%20Paul%20Mauriat%20-%20Penelope%20Digital%20Best%2FPenelope%20Digital%20Best.cue&metadata=false
Feb 18 09:24:00 volumio volumio[1252]: info: URI /mnt/USB/3A20E37E20E3400D/1986 Paul Mauriat - Penelope Digital Best/Penelope Digital Best.cue
Feb 18 09:24:00 volumio volumio[1252]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 18 09:24:00 volumio volumio[1252]: Error: Unable to resolve or reject the same promise twice
Feb 18 09:24:00 volumio volumio[1252]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Feb 18 09:24:00 volumio volumio[1252]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21
Feb 18 09:24:00 volumio volumio[1252]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3)
Feb 18 09:24:00 volumio volumio[1252]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12)
Feb 18 09:24:00 volumio volumio[1252]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12)
Feb 18 09:24:00 volumio volumio[1252]: at Socket.emit (node:events:514:28)
Feb 18 09:24:00 volumio volumio[1252]: at addChunk (node:internal/streams/readable:343:12)
Feb 18 09:24:00 volumio volumio[1252]: at readableAddChunk (node:internal/streams/readable:312:11)
Feb 18 09:24:00 volumio volumio[1252]: at Readable.push (node:internal/streams/readable:253:10)
Feb 18 09:24:00 volumio volumio[1252]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23)
Feb 18 09:24:00 volumio volumio[1252]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 18 09:24:03 volumio sudo[2490]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-18 09:23'
Feb 18 09:24:03 volumio sudo[2490]: 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="a78d359cf1dc63ac74e9d151015afd30d31a709a"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026"
VOLUMIO_VERSION="4.096"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"