Apr 02 18:57:00 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 409. Apr 02 18:57:00 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Apr 02 18:57:00 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Apr 02 18:57:00 volumio upmpdcli[18078]: Could not open config: /tmp/upmpdcli.conf Apr 02 18:57:00 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Apr 02 18:57:00 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Apr 02 18:57:15 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 410. Apr 02 18:57:15 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Apr 02 18:57:15 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Apr 02 18:57:15 volumio upmpdcli[18122]: Could not open config: /tmp/upmpdcli.conf Apr 02 18:57:15 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Apr 02 18:57:15 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Apr 02 18:57:31 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 411. Apr 02 18:57:31 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Apr 02 18:57:31 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Apr 02 18:57:31 volumio upmpdcli[18153]: Could not open config: /tmp/upmpdcli.conf Apr 02 18:57:31 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Apr 02 18:57:31 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Apr 02 18:57:46 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 412. Apr 02 18:57:46 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Apr 02 18:57:46 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Apr 02 18:57:46 volumio upmpdcli[18197]: Could not open config: /tmp/upmpdcli.conf Apr 02 18:57:46 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Apr 02 18:57:46 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Apr 02 18:58:01 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 413. Apr 02 18:58:01 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Apr 02 18:58:01 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Apr 02 18:58:01 volumio upmpdcli[18227]: Could not open config: /tmp/upmpdcli.conf Apr 02 18:58:01 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Apr 02 18:58:01 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Apr 02 18:58:12 volumio volumio5-onboarding[1450]: time=2026-04-02T18:58:12.864+02:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.1.10:41996 Apr 02 18:58:12 volumio volumio5-onboarding[1450]: time=2026-04-02T18:58:12.910+02:00 level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.1.10:41996 @ 0xc0003941e0" latency=716.386068ms platform=PLATFORM_ANDROID version=5.260209.0 Apr 02 18:58:12 volumio volumio5-onboarding[1450]: time=2026-04-02T18:58:12.910+02:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.1.10:41996 @ 0xc0003941e0" latency=716.918465ms timeout=10s Apr 02 18:58:12 volumio volumio5-onboarding[1450]: time=2026-04-02T18:58:12.910+02:00 level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.1.10:41996 @ 0xc0003941e0" Apr 02 18:58:12 volumio volumio[1003]: info: Received Get System Info Apr 02 18:58:12 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 02 18:58:12 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 02 18:58:12 volumio volumio[1003]: info: Discovery: Getting this device information Apr 02 18:58:12 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Apr 02 18:58:12 volumio volumio[1003]: info: CorePlayQueue::getTrack 10 Apr 02 18:58:12 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 02 18:58:12 volumio volumio5-onboarding[1450]: time=2026-04-02T18:58:12.911+02:00 level=INFO msg="emitting device name changed event" component=server peer="192.168.1.10:41996 @ 0xc0003941e0" name=Volumio Apr 02 18:58:12 volumio volumio5-onboarding[1450]: time=2026-04-02T18:58:12.912+02:00 level=INFO msg="emitting device language changed event" component=server peer="192.168.1.10:41996 @ 0xc0003941e0" language=pl Apr 02 18:58:12 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Apr 02 18:58:12 volumio volumio5-onboarding[1450]: time=2026-04-02T18:58:12.912+02:00 level=INFO msg="emitting device timezone changed event" component=server peer="192.168.1.10:41996 @ 0xc0003941e0" timezone=Europe/Warsaw Apr 02 18:58:12 volumio volumio5-onboarding[1450]: time=2026-04-02T18:58:12.913+02:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.1.10:41996 @ 0xc0003941e0" available=true connected=false macAddress= ip4Address= ip6Address= Apr 02 18:58:12 volumio volumio5-onboarding[1450]: time=2026-04-02T18:58:12.913+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.10:41996 @ 0xc0003941e0" available=false connected=false macAddress= ip4Address= ip6Address= ssid= Apr 02 18:58:12 volumio volumio5-onboarding[1450]: time=2026-04-02T18:58:12.913+02:00 level=INFO msg="emitting device setup status changed event" component=server peer="192.168.1.10:41996 @ 0xc0003941e0" setupComplete=true Apr 02 18:58:12 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Apr 02 18:58:12 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 02 18:58:12 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 02 18:58:12 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 02 18:58:12 volumio volumio[1003]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 1 Apr 02 18:58:12 volumio volumio[1003]: /bin/sh: 1: /usr/local/bin/alsacap: not found Apr 02 18:58:12 volumio volumio[1003]: {"cmd":"/usr/local/bin/alsacap -C 1","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 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 02 18:58:12 volumio volumio[1003]: amixer -c 1 info | grep "Loopback" Apr 02 18:58:12 volumio volumio[1003]: Card sysdefault:1 'Loopback'/'Loopback 1' Apr 02 18:58:12 volumio volumio[1003]: Mixer name : 'Loopback Mixer' Apr 02 18:58:12 volumio volumio[1003]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 0 -D 0 Apr 02 18:58:12 volumio volumio[1003]: /bin/sh: 1: /usr/local/bin/alsacap: not found Apr 02 18:58:12 volumio volumio[1003]: {"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 02 18:58:12 volumio volumio[1003]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 5 Apr 02 18:58:12 volumio volumio[1003]: /bin/sh: 1: /usr/local/bin/alsacap: not found Apr 02 18:58:12 volumio volumio[1003]: {"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 02 18:58:12 volumio volumio[1003]: amixer -c 5 info | grep "Gustard USB Audio 2.0" Apr 02 18:58:12 volumio volumio[1003]: Card sysdefault:5 'G20'/'Gustard Gustard USB Audio 2.0 at usb-0000:02:00.0-1, high speed' Apr 02 18:58:12 volumio volumio[1003]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 5 Apr 02 18:58:12 volumio volumio[1003]: /bin/sh: 1: /usr/local/bin/alsacap: not found Apr 02 18:58:12 volumio volumio[1003]: {"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 02 18:58:12 volumio volumio[1003]: amixer -c 5 info | grep "Gustard USB Audio 2.0" Apr 02 18:58:12 volumio volumio[1003]: Card sysdefault:5 'G20'/'Gustard Gustard USB Audio 2.0 at usb-0000:02:00.0-1, high speed' Apr 02 18:58:12 volumio volumio5-onboarding[1450]: time=2026-04-02T18:58:12.958+02:00 level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.1.10:41996 @ 0xc0003941e0" selectedOutputId=5 Apr 02 18:58:12 volumio volumio[1003]: info: Received Get System Info Apr 02 18:58:12 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 02 18:58:12 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 02 18:58:12 volumio volumio[1003]: info: Discovery: Getting this device information Apr 02 18:58:12 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Apr 02 18:58:12 volumio volumio[1003]: info: CorePlayQueue::getTrack 10 Apr 02 18:58:12 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 02 18:58:12 volumio volumio5-onboarding[1450]: time=2026-04-02T18:58:12.963+02:00 level=INFO msg="emitting software info changed event" component=server peer="192.168.1.10:41996 @ 0xc0003941e0" currentVersion=4.119 latestVersion=4.119 Apr 02 18:58:12 volumio volumio5-onboarding[1450]: time=2026-04-02T18:58:12.963+02:00 level=INFO msg="emitting software update progress event" component=server peer="192.168.1.10:41996 @ 0xc0003941e0" status=UPDATE_STATUS_NONE progress=0 Apr 02 18:58:12 volumio volumio5-onboarding[1450]: time=2026-04-02T18:58:12.963+02:00 level=INFO msg="emitting user changed event" component=server peer="192.168.1.10:41996 @ 0xc0003941e0" userId=feFcHgNMWYUFZ97Oy9shUYzck3o2 Apr 02 18:58:12 volumio volumio5-onboarding[1450]: time=2026-04-02T18:58:12.963+02:00 level=INFO msg="emitting music providers changed event" component=server peer="192.168.1.10:41996 @ 0xc0003941e0" providers=9 Apr 02 18:58:12 volumio volumio5-onboarding[1450]: time=2026-04-02T18:58:12.963+02:00 level=INFO msg="emitting plugins changed event" component=server peer="192.168.1.10:41996 @ 0xc0003941e0" plugins=46 Apr 02 18:58:12 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Apr 02 18:58:12 volumio volumio[1003]: info: CorePlayQueue::getTrack 10 Apr 02 18:58:12 volumio volumio5-onboarding[1450]: time=2026-04-02T18:58:12.964+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.10:41996 @ 0xc0003941e0" state=STATUS_PLAYING positionMs=190237 volume=100 Apr 02 18:58:12 volumio volumio5-onboarding[1450]: time=2026-04-02T18:58:12.964+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.10:41996 @ 0xc0003941e0" id=tidal://song/391687 title="Take on Me" Apr 02 18:58:13 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 02 18:58:13 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 02 18:58:13 volumio volumio[1003]: info: Discovery: Getting this device information Apr 02 18:58:13 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Apr 02 18:58:13 volumio volumio[1003]: info: CorePlayQueue::getTrack 10 Apr 02 18:58:13 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 02 18:58:13 volumio volumio[1003]: verbose: New Socket.io Connection to 192.168.1.12:3000 from 192.168.1.10 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Apr 02 18:58:13 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 02 18:58:13 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 02 18:58:14 volumio volumio5-onboarding[1450]: time=2026-04-02T18:58:14.326+02:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.1.10:41996 @ 0xc0003941e0" latency=717.65705ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Apr 02 18:58:15 volumio sudo[18295]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 02 18:58:15 volumio sudo[18295]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 02 18:58:15 volumio sudo[18297]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 02 18:58:15 volumio sudo[18295]: pam_unix(sudo:session): session closed for user root Apr 02 18:58:15 volumio sudo[18297]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 02 18:58:15 volumio sudo[18297]: pam_unix(sudo:session): session closed for user root Apr 02 18:58:15 volumio volumio[1003]: verbose: New Socket.io Connection to 192.168.1.12 from 192.168.1.10 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.119 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Apr 02 18:58:15 volumio sudo[18304]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 02 18:58:15 volumio sudo[18304]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 02 18:58:15 volumio sudo[18304]: pam_unix(sudo:session): session closed for user root Apr 02 18:58:15 volumio sudo[18306]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 02 18:58:15 volumio sudo[18306]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 02 18:58:15 volumio sudo[18306]: pam_unix(sudo:session): session closed for user root Apr 02 18:58:15 volumio volumio[1003]: verbose: New Socket.io Connection to 192.168.1.12 from 192.168.1.10 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.119 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Apr 02 18:58:15 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 02 18:58:15 volumio volumio[1003]: info: CoreCommandRouter::volumioGetVisibleSources Apr 02 18:58:15 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 02 18:58:15 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Apr 02 18:58:15 volumio volumio[1003]: info: CorePlayQueue::getTrack 10 Apr 02 18:58:15 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 02 18:58:15 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 02 18:58:15 volumio volumio[1003]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 02 18:58:15 volumio volumio[1003]: info: Received Get System Info Apr 02 18:58:15 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 02 18:58:15 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 02 18:58:15 volumio volumio[1003]: info: Discovery: Getting this device information Apr 02 18:58:15 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Apr 02 18:58:15 volumio volumio[1003]: info: CorePlayQueue::getTrack 10 Apr 02 18:58:15 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 02 18:58:15 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Apr 02 18:58:15 volumio volumio[1003]: info: CorePlayQueue::getTrack 10 Apr 02 18:58:15 volumio volumio[1003]: info: Listing playlists Apr 02 18:58:15 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 02 18:58:15 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 02 18:58:15 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 02 18:58:16 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 414. Apr 02 18:58:16 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Apr 02 18:58:16 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Apr 02 18:58:16 volumio upmpdcli[18313]: Could not open config: /tmp/upmpdcli.conf Apr 02 18:58:16 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Apr 02 18:58:16 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Apr 02 18:58:17 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Apr 02 18:58:17 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 02 18:58:17 volumio volumio[1003]: info: Received Get System Info Apr 02 18:58:17 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 02 18:58:17 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 02 18:58:17 volumio volumio[1003]: info: Discovery: Getting this device information Apr 02 18:58:17 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Apr 02 18:58:17 volumio volumio[1003]: info: CorePlayQueue::getTrack 10 Apr 02 18:58:17 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 02 18:58:18 volumio volumio[1003]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 02 18:58:18 volumio volumio[1003]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 02 18:58:18 volumio volumio[1003]: info: Retrieving Cloud Streaming UI Apr 02 18:58:18 volumio volumio[1003]: info: Getting Tidal Cloud Configuration Apr 02 18:58:18 volumio volumio[1003]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 02 18:58:18 volumio volumio[1003]: info: Getting Qobuz Cloud Configuration Apr 02 18:58:18 volumio volumio[1003]: info: Asking plugin for UI Config Apr 02 18:58:18 volumio volumio[1003]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 02 18:58:18 volumio volumio[1003]: info: Getting Spotify Cloud Configuration Apr 02 18:58:18 volumio volumio[1003]: info: Asking plugin for UI Config Apr 02 18:58:18 volumio volumio[1003]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 02 18:58:18 volumio volumio[1003]: info: Saving Spotify Acccount Apr 02 18:58:18 volumio volumio[1003]: info: Got it Apr 02 18:58:18 volumio volumio[1003]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 02 18:58:18 volumio volumio[1003]: info: Got Tidal Cloud Configuration Apr 02 18:58:18 volumio volumio[1003]: info: Got it Apr 02 18:58:18 volumio volumio[1003]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 02 18:58:18 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 02 18:58:18 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 02 18:58:18 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 02 18:58:18 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 02 18:58:18 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 02 18:58:18 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 02 18:58:18 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 02 18:58:18 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 02 18:58:18 volumio volumio[1003]: info: CoreCommandRouter::volumioGetBrowseSources Apr 02 18:58:18 volumio volumio[1003]: info: CoreCommandRouter::volumioGetBrowseSources Apr 02 18:58:18 volumio volumio[1003]: info: CoreCommandRouter::volumioGetBrowseSources Apr 02 18:58:18 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 02 18:58:18 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 02 18:58:18 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 02 18:58:18 volumio volumio[1003]: info: Received Get System Info Apr 02 18:58:18 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 02 18:58:18 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 02 18:58:18 volumio volumio[1003]: info: Discovery: Getting this device information Apr 02 18:58:18 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Apr 02 18:58:18 volumio volumio[1003]: info: CorePlayQueue::getTrack 10 Apr 02 18:58:18 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 02 18:58:20 volumio sudo[18319]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 02 18:58:20 volumio sudo[18319]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 02 18:58:20 volumio sudo[18319]: pam_unix(sudo:session): session closed for user root Apr 02 18:58:20 volumio sudo[18322]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 02 18:58:20 volumio sudo[18322]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 02 18:58:20 volumio sudo[18322]: pam_unix(sudo:session): session closed for user root Apr 02 18:58:20 volumio volumio[1003]: verbose: New Socket.io Connection to 192.168.1.12 from 192.168.1.10 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.119 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Apr 02 18:58:20 volumio sudo[18328]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 02 18:58:20 volumio sudo[18328]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 02 18:58:20 volumio sudo[18328]: pam_unix(sudo:session): session closed for user root Apr 02 18:58:20 volumio sudo[18330]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 02 18:58:20 volumio sudo[18330]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 02 18:58:20 volumio sudo[18330]: pam_unix(sudo:session): session closed for user root Apr 02 18:58:20 volumio volumio[1003]: verbose: New Socket.io Connection to 192.168.1.12 from 192.168.1.10 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.119 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Apr 02 18:58:20 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 02 18:58:20 volumio volumio[1003]: info: CoreCommandRouter::volumioGetVisibleSources Apr 02 18:58:20 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 02 18:58:20 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Apr 02 18:58:20 volumio volumio[1003]: info: CorePlayQueue::getTrack 10 Apr 02 18:58:20 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 02 18:58:20 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 02 18:58:20 volumio volumio[1003]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 02 18:58:20 volumio volumio[1003]: info: Received Get System Info Apr 02 18:58:20 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 02 18:58:20 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 02 18:58:20 volumio volumio[1003]: info: Discovery: Getting this device information Apr 02 18:58:20 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Apr 02 18:58:20 volumio volumio[1003]: info: CorePlayQueue::getTrack 10 Apr 02 18:58:20 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 02 18:58:20 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Apr 02 18:58:20 volumio volumio[1003]: info: CorePlayQueue::getTrack 10 Apr 02 18:58:20 volumio volumio[1003]: info: Listing playlists Apr 02 18:58:20 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 02 18:58:20 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 02 18:58:20 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 02 18:58:21 volumio volumio[1003]: verbose: New Socket.io Connection to 192.168.1.12 from 192.168.1.10 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.119 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Apr 02 18:58:21 volumio sudo[18337]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 02 18:58:21 volumio sudo[18337]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 02 18:58:21 volumio sudo[18339]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 02 18:58:21 volumio sudo[18337]: pam_unix(sudo:session): session closed for user root Apr 02 18:58:21 volumio sudo[18339]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 02 18:58:21 volumio sudo[18339]: pam_unix(sudo:session): session closed for user root Apr 02 18:58:21 volumio volumio[1003]: verbose: New Socket.io Connection to 192.168.1.12 from 192.168.1.10 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.119 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Apr 02 18:58:21 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 02 18:58:21 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 02 18:58:21 volumio volumio[1003]: info: CoreCommandRouter::volumioGetVisibleSources Apr 02 18:58:21 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 02 18:58:21 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Apr 02 18:58:21 volumio volumio[1003]: info: CorePlayQueue::getTrack 10 Apr 02 18:58:21 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 02 18:58:21 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 02 18:58:21 volumio volumio[1003]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 02 18:58:21 volumio volumio[1003]: info: Received Get System Info Apr 02 18:58:21 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 02 18:58:21 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 02 18:58:21 volumio volumio[1003]: info: Discovery: Getting this device information Apr 02 18:58:21 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Apr 02 18:58:21 volumio volumio[1003]: info: CorePlayQueue::getTrack 10 Apr 02 18:58:21 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 02 18:58:21 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Apr 02 18:58:21 volumio volumio[1003]: info: CorePlayQueue::getTrack 10 Apr 02 18:58:21 volumio volumio[1003]: info: Listing playlists Apr 02 18:58:21 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 02 18:58:21 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 02 18:58:22 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 02 18:58:23 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Apr 02 18:58:23 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 02 18:58:23 volumio volumio[1003]: info: Received Get System Info Apr 02 18:58:23 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 02 18:58:23 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 02 18:58:23 volumio volumio[1003]: info: Discovery: Getting this device information Apr 02 18:58:23 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Apr 02 18:58:23 volumio volumio[1003]: info: CorePlayQueue::getTrack 10 Apr 02 18:58:23 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 02 18:58:24 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 02 18:58:24 volumio volumio[1003]: info: Received Get System Info Apr 02 18:58:24 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 02 18:58:24 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 02 18:58:24 volumio volumio[1003]: info: Discovery: Getting this device information Apr 02 18:58:24 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Apr 02 18:58:24 volumio volumio[1003]: info: CorePlayQueue::getTrack 10 Apr 02 18:58:24 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 02 18:58:25 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 02 18:58:26 volumio sudo[18364]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 02 18:58:26 volumio sudo[18364]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 02 18:58:26 volumio sudo[18364]: pam_unix(sudo:session): session closed for user root Apr 02 18:58:26 volumio sudo[18366]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 02 18:58:26 volumio sudo[18366]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 02 18:58:26 volumio sudo[18366]: pam_unix(sudo:session): session closed for user root Apr 02 18:58:26 volumio volumio[1003]: verbose: New Socket.io Connection to volumio.local from 192.168.1.10 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/146.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Apr 02 18:58:26 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 02 18:58:26 volumio volumio[1003]: info: CoreCommandRouter::volumioGetVisibleSources Apr 02 18:58:26 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 02 18:58:26 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Apr 02 18:58:26 volumio volumio[1003]: info: CorePlayQueue::getTrack 10 Apr 02 18:58:26 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 02 18:58:26 volumio volumio[1003]: info: CoreCommandRouter::volumioGetQueue Apr 02 18:58:26 volumio volumio[1003]: info: CoreStateMachine::getQueue Apr 02 18:58:26 volumio volumio[1003]: info: CorePlayQueue::getQueue Apr 02 18:58:26 volumio volumio[1003]: info: Listing playlists Apr 02 18:58:26 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 02 18:58:26 volumio volumio[1003]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 02 18:58:26 volumio volumio[1003]: info: Received Get System Info Apr 02 18:58:26 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 02 18:58:26 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 02 18:58:26 volumio volumio[1003]: info: Discovery: Getting this device information Apr 02 18:58:26 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Apr 02 18:58:26 volumio volumio[1003]: info: CorePlayQueue::getTrack 10 Apr 02 18:58:26 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 02 18:58:26 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Apr 02 18:58:26 volumio volumio[1003]: info: CorePlayQueue::getTrack 10 Apr 02 18:58:26 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 02 18:58:26 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 02 18:58:26 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 02 18:58:26 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 02 18:58:28 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Apr 02 18:58:28 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 02 18:58:28 volumio volumio[1003]: info: Received Get System Info Apr 02 18:58:28 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 02 18:58:28 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 02 18:58:28 volumio volumio[1003]: info: Discovery: Getting this device information Apr 02 18:58:28 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Apr 02 18:58:28 volumio volumio[1003]: info: CorePlayQueue::getTrack 10 Apr 02 18:58:28 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 02 18:58:29 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 02 18:58:29 volumio volumio[1003]: info: Received Get System Info Apr 02 18:58:29 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 02 18:58:29 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 02 18:58:29 volumio volumio[1003]: info: Discovery: Getting this device information Apr 02 18:58:29 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Apr 02 18:58:29 volumio volumio[1003]: info: CorePlayQueue::getTrack 10 Apr 02 18:58:29 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 02 18:58:30 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 02 18:58:31 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 02 18:58:32 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 415. Apr 02 18:58:32 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Apr 02 18:58:32 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Apr 02 18:58:32 volumio upmpdcli[18376]: Could not open config: /tmp/upmpdcli.conf Apr 02 18:58:32 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Apr 02 18:58:32 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Apr 02 18:58:34 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 02 18:58:34 volumio volumio[1003]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 02 18:58:34 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 02 18:58:34 volumio volumio[1003]: info: Received Get System Version Apr 02 18:58:34 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 02 18:58:34 volumio volumio[1003]: info: Received Get System Info Apr 02 18:58:34 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 02 18:58:34 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 02 18:58:34 volumio volumio[1003]: info: Discovery: Getting this device information Apr 02 18:58:34 volumio volumio[1003]: info: CoreCommandRouter::volumioGetState Apr 02 18:58:34 volumio volumio[1003]: info: CorePlayQueue::getTrack 10 Apr 02 18:58:34 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 02 18:58:34 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 02 18:58:35 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 02 18:58:35 volumio volumio[1003]: info: CURURI: music-library Apr 02 18:58:35 volumio volumio[1003]: info: Preload queue cleared Apr 02 18:58:36 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 02 18:58:36 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 02 18:58:36 volumio volumio[1003]: info: CURURI: music-library/USB Apr 02 18:58:36 volumio volumio[1003]: info: Preload queue cleared Apr 02 18:58:37 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 02 18:58:37 volumio volumio[1003]: info: CURURI: music-library/USB/Nowy Apr 02 18:58:37 volumio volumio[1003]: info: Preload queue cleared Apr 02 18:58:37 volumio volumio[1003]: info: Preloading song: music-library/USB/Nowy/Wendy_Carlos_-_Jiffy_Test_-_Bee_Dee_Bei_Mir.wav Apr 02 18:58:37 volumio volumio[1003]: info: Exploding uri music-library/USB/Nowy/Wendy_Carlos_-_Jiffy_Test_-_Bee_Dee_Bei_Mir.wav in service mpd Apr 02 18:58:37 volumio volumio[1003]: info: ALBUMART /albumart?cacheid=514&web=//extralarge&path=%2Fmnt%2FUSB%2FNowy%2FWendy_Carlos_-_Jiffy_Test_-_Bee_Dee_Bei_Mir.wav&metadata=false Apr 02 18:58:37 volumio volumio[1003]: info: URI /mnt/USB/Nowy/Wendy_Carlos_-_Jiffy_Test_-_Bee_Dee_Bei_Mir.wav Apr 02 18:58:38 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 02 18:58:39 volumio volumio[1003]: info: Preload queue cleared Apr 02 18:58:39 volumio volumio[1003]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 02 18:58:39 volumio volumio[1003]: info: CoreStateMachine::ClearQueue Apr 02 18:58:39 volumio volumio[1003]: info: CoreStateMachine::stop Apr 02 18:58:39 volumio volumio[1003]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 18:58:39 volumio volumio[1003]: info: CoreStateMachine::stPlaybackTimer Apr 02 18:58:39 volumio volumio[1003]: info: CoreStateMachine::updateTrackBlock Apr 02 18:58:39 volumio volumio[1003]: info: CorePlayQueue::getTrackBlock Apr 02 18:58:39 volumio volumio[1003]: info: CoreStateMachine::pushState Apr 02 18:58:39 volumio volumio[1003]: info: CorePlayQueue::getTrack 10 Apr 02 18:58:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 02 18:58:39 volumio volumio[1003]: info: CoreCommandRouter::volumioPushState Apr 02 18:58:39 volumio volumio[1003]: info: CoreStateMachine::serviceStop Apr 02 18:58:39 volumio volumio[1003]: info: CorePlayQueue::getTrack 10 Apr 02 18:58:39 volumio volumio[1003]: info: CoreCommandRouter::serviceStop Apr 02 18:58:39 volumio volumio[1003]: info: [1775149119396] ControllerTidal::stop Apr 02 18:58:39 volumio volumio[1003]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 02 18:58:39 volumio volumio[1003]: info: ControllerMpd::stop Apr 02 18:58:39 volumio volumio[1003]: verbose: ControllerMpd::sendMpdCommand stop Apr 02 18:58:39 volumio volumio[1003]: info: CorePlayQueue::clearPlayQueue Apr 02 18:58:39 volumio volumio[1003]: info: CorePlayQueue::saveQueue Apr 02 18:58:39 volumio volumio[1003]: info: CoreCommandRouter::volumioPushQueue Apr 02 18:58:39 volumio volumio[1003]: info: CoreStateMachine::addQueueItems Apr 02 18:58:39 volumio volumio[1003]: info: CorePlayQueue::addQueueItems Apr 02 18:58:39 volumio volumio[1003]: info: Preload queue cleared Apr 02 18:58:39 volumio volumio[1003]: info: Adding Item to queue: music-library/USB/Nowy/Wendy_Carlos_-_Jiffy_Test_-_Bee_Dee_Bei_Mir.wav Apr 02 18:58:39 volumio volumio[1003]: info: Using cached record of: music-library/USB/Nowy/Wendy_Carlos_-_Jiffy_Test_-_Bee_Dee_Bei_Mir.wav Apr 02 18:58:39 volumio volumio5-onboarding[1450]: time=2026-04-02T18:58:39.397+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.10:41996 @ 0xc0003941e0" state=STATUS_STOPPED positionMs=0 volume=100 Apr 02 18:58:39 volumio volumio5-onboarding[1450]: time=2026-04-02T18:58:39.397+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.10:41996 @ 0xc0003941e0" id=tidal://song/391687 title="Take on Me" Apr 02 18:58:39 volumio volumio[1003]: info: CoreCommandRouter::volumioPushQueue Apr 02 18:58:39 volumio volumio[1003]: info: CorePlayQueue::saveQueue Apr 02 18:58:39 volumio volumio[1003]: info: CoreStateMachine::updateTrackBlock Apr 02 18:58:39 volumio volumio[1003]: info: CorePlayQueue::getTrackBlock Apr 02 18:58:39 volumio volumio[1003]: info: CoreCommandRouter::volumioPlay Apr 02 18:58:39 volumio volumio[1003]: info: CoreStateMachine::play index 0 Apr 02 18:58:39 volumio volumio[1003]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 18:58:39 volumio volumio[1003]: info: CoreStateMachine::addQueueItems Apr 02 18:58:39 volumio volumio[1003]: info: CorePlayQueue::addQueueItems Apr 02 18:58:39 volumio volumio[1003]: info: Preload queue cleared Apr 02 18:58:39 volumio volumio[1003]: info: Adding Item to queue: music-library/USB/Nowy/CD Apr 02 18:58:39 volumio volumio[1003]: info: Exploding uri music-library/USB/Nowy/CD in service mpd Apr 02 18:58:39 volumio volumio[1003]: info: Adding Item to queue: music-library/USB/Nowy/Electric Light Orchestra - Discovery - 1979 Apr 02 18:58:39 volumio volumio[1003]: info: Exploding uri music-library/USB/Nowy/Electric Light Orchestra - Discovery - 1979 in service mpd Apr 02 18:58:39 volumio volumio[1003]: info: Adding Item to queue: music-library/USB/Nowy/Electric Light Orchestra - Eldorado (2022, SACD, MFSL, UDSACD 2213, 2.0) Apr 02 18:58:39 volumio volumio[1003]: info: Exploding uri music-library/USB/Nowy/Electric Light Orchestra - Eldorado (2022, SACD, MFSL, UDSACD 2213, 2.0) in service mpd Apr 02 18:58:39 volumio volumio[1003]: info: Adding Item to queue: music-library/USB/Nowy/electric-light-orchestra-dsd-stereo-x2-10.2025-colinzim Apr 02 18:58:39 volumio volumio[1003]: info: Exploding uri music-library/USB/Nowy/electric-light-orchestra-dsd-stereo-x2-10.2025-colinzim in service mpd Apr 02 18:58:39 volumio volumio[1003]: info: Adding Item to queue: music-library/USB/Nowy/HD audio Apr 02 18:58:39 volumio volumio[1003]: info: Exploding uri music-library/USB/Nowy/HD audio in service mpd Apr 02 18:58:39 volumio volumio[1003]: info: Adding Item to queue: music-library/USB/Nowy/oasis-morning-glory-sacd-fixed-downmix-stereo-5.1.zip Apr 02 18:58:39 volumio volumio[1003]: info: Exploding uri music-library/USB/Nowy/oasis-morning-glory-sacd-fixed-downmix-stereo-5.1.zip in service mpd Apr 02 18:58:39 volumio volumio[1003]: info: Adding Item to queue: music-library/USB/Nowy/pink-floyd-the-dark-side-of-the-moon-harvest-cp35-3017-harvest-shvl-804-aob-in-h.zip Apr 02 18:58:39 volumio volumio[1003]: info: Exploding uri music-library/USB/Nowy/pink-floyd-the-dark-side-of-the-moon-harvest-cp35-3017-harvest-shvl-804-aob-in-h.zip in service mpd Apr 02 18:58:39 volumio volumio[1003]: info: Adding Item to queue: music-library/USB/Nowy/pink-floyd-wish-you-were-here-cbssony-35dp-4.zip Apr 02 18:58:39 volumio volumio[1003]: info: Exploding uri music-library/USB/Nowy/pink-floyd-wish-you-were-here-cbssony-35dp-4.zip in service mpd Apr 02 18:58:39 volumio volumio[1003]: info: Adding Item to queue: music-library/USB/Nowy/polka-Frederic-chopin-the-complete-preludes.zip Apr 02 18:58:39 volumio volumio[1003]: info: Exploding uri music-library/USB/Nowy/polka-Frederic-chopin-the-complete-preludes.zip in service mpd Apr 02 18:58:39 volumio volumio[1003]: info: Adding Item to queue: music-library/USB/Nowy/Polka-gorecki-kleines-requiem-lerchenmusik-eac-flac.zip Apr 02 18:58:39 volumio volumio[1003]: info: Exploding uri music-library/USB/Nowy/Polka-gorecki-kleines-requiem-lerchenmusik-eac-flac.zip in service mpd Apr 02 18:58:39 volumio volumio[1003]: info: Adding Item to queue: music-library/USB/Nowy/the-alan-parsons-project-the-turn-of-a-friendly-card-dsd-hdtracks-dsf Apr 02 18:58:39 volumio volumio[1003]: info: Exploding uri music-library/USB/Nowy/the-alan-parsons-project-the-turn-of-a-friendly-card-dsd-hdtracks-dsf in service mpd Apr 02 18:58:39 volumio volumio[1003]: info: Adding Item to queue: music-library/USB/Nowy/WENCARREDLOSCORESVOL2 Apr 02 18:58:39 volumio volumio[1003]: info: Exploding uri music-library/USB/Nowy/WENCARREDLOSCORESVOL2 in service mpd Apr 02 18:58:39 volumio volumio[1003]: info: CoreStateMachine::stop Apr 02 18:58:39 volumio volumio[1003]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 18:58:39 volumio volumio[1003]: info: CoreStateMachine::play index undefined Apr 02 18:58:39 volumio volumio[1003]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 02 18:58:39 volumio volumio[1003]: info: CorePlayQueue::getTrack 0 Apr 02 18:58:39 volumio volumio[1003]: info: CoreStateMachine::startPlaybackTimer Apr 02 18:58:39 volumio volumio[1003]: info: CorePlayQueue::getTrack 0 Apr 02 18:58:39 volumio volumio[1003]: info: CoreCommandRouter::volumioGetVisibleSources Apr 02 18:58:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 02 18:58:39 volumio volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Apr 02 18:58:39 volumio volumio[1003]: verbose: ControllerMpd::clearAddPlayTracks USB/Nowy/Wendy_Carlos_-_Jiffy_Test_-_Bee_Dee_Bei_Mir.wav Apr 02 18:58:39 volumio volumio[1003]: verbose: ControllerMpd::sendMpdCommand stop Apr 02 18:58:39 volumio volumio[1003]: info: Apr 02 18:58:39 volumio volumio[1003]: ---------------------------- MPD announces state update: player Apr 02 18:58:39 volumio volumio[1003]: info: ALBUMART /albumart?cacheid=514&web=Unknown%20Artist/Unknown%20Title/extralarge&path=%2Fmnt%2FUSB%2FNowy%2FCD%2FABBEY_LINCOLN_A_Turtle's_Dream.cue&metadata=false Apr 02 18:58:39 volumio volumio[1003]: info: URI /mnt/USB/Nowy/CD/ABBEY_LINCOLN_A_Turtle's_Dream.cue Apr 02 18:58:39 volumio volumio[1003]: info: ALBUMART /albumart?cacheid=514&web=Unknown%20Artist/Unknown%20Title/extralarge&path=%2Fmnt%2FUSB%2FNowy%2FCD%2FABBEY_LINCOLN_A_Turtle's_Dream.cue&metadata=false Apr 02 18:58:39 volumio volumio[1003]: info: URI /mnt/USB/Nowy/CD/ABBEY_LINCOLN_A_Turtle's_Dream.cue Apr 02 18:58:39 volumio volumio[1003]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 02 18:58:39 volumio volumio[1003]: Error: Unable to resolve or reject the same promise twice Apr 02 18:58:39 volumio volumio[1003]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Apr 02 18:58:39 volumio volumio[1003]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Apr 02 18:58:39 volumio volumio[1003]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Apr 02 18:58:39 volumio volumio[1003]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Apr 02 18:58:39 volumio volumio[1003]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Apr 02 18:58:39 volumio volumio[1003]: at Socket.emit (node:events:514:28) Apr 02 18:58:39 volumio volumio[1003]: at addChunk (node:internal/streams/readable:343:12) Apr 02 18:58:39 volumio volumio[1003]: at readableAddChunk (node:internal/streams/readable:312:11) Apr 02 18:58:39 volumio volumio[1003]: at Readable.push (node:internal/streams/readable:253:10) Apr 02 18:58:39 volumio volumio[1003]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Apr 02 18:58:39 volumio volumio[1003]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 02 18:58:39 volumio sudo[18413]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-02 18:57' Apr 02 18:58:39 volumio sudo[18413]: 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"