Apr 03 16:11:00 yamaha volumio5-onboarding[1583]: time=2026-04-03T16:11:00.320+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.68.123:59896,00:00:00:00:00:00%01 @ 0x1801cb0" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Apr 03 16:11:00 yamaha volumio[1189]: info: Received Get System Info Apr 03 16:11:00 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 16:11:00 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 16:11:00 yamaha volumio[1189]: info: Discovery: Getting this device information Apr 03 16:11:00 yamaha volumio[1189]: info: CoreCommandRouter::volumioGetState Apr 03 16:11:00 yamaha volumio[1189]: info: CorePlayQueue::getTrack 0 Apr 03 16:11:00 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 16:11:00 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 03 16:11:00 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 03 16:11:00 yamaha systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 12. Apr 03 16:11:00 yamaha systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 16:11:00 yamaha systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 16:11:00 yamaha upmpdcli[1889]: Could not open config: /tmp/upmpdcli.conf Apr 03 16:11:00 yamaha systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Apr 03 16:11:00 yamaha systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Apr 03 16:11:01 yamaha volumio5-onboarding[1583]: time=2026-04-03T16:11:01.360+02:00 level=INFO msg="service successfully established" component=discovery/localnet Apr 03 16:11:12 yamaha go-librespot[1432]: time="2026-04-03T16:11:12+02:00" level=trace msg="sent dealer ping" Apr 03 16:11:12 yamaha go-librespot[1432]: time="2026-04-03T16:11:12+02:00" level=trace msg="received dealer pong" Apr 03 16:11:15 yamaha systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 13. Apr 03 16:11:15 yamaha systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 16:11:15 yamaha systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 16:11:15 yamaha upmpdcli[1919]: Could not open config: /tmp/upmpdcli.conf Apr 03 16:11:15 yamaha systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Apr 03 16:11:15 yamaha systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Apr 03 16:11:31 yamaha systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 14. Apr 03 16:11:31 yamaha systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 16:11:31 yamaha systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 16:11:31 yamaha upmpdcli[1934]: Could not open config: /tmp/upmpdcli.conf Apr 03 16:11:31 yamaha systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Apr 03 16:11:31 yamaha systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Apr 03 16:11:41 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings Apr 03 16:11:41 yamaha volumio[1189]: info: Saving new wireless network Apr 03 16:11:41 yamaha sudo[1951]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf Apr 03 16:11:41 yamaha sudo[1951]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:11:41 yamaha sudo[1951]: pam_unix(sudo:session): session closed for user root Apr 03 16:11:42 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Apr 03 16:11:42 yamaha sudo[1967]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Apr 03 16:11:42 yamaha sudo[1967]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:11:42 yamaha systemd[1]: Stopping wireless.service - Wireless Services... Apr 03 16:11:42 yamaha systemd[1]: wireless.service: Killing process 1171 (wpa_supplicant) with signal SIGKILL. Apr 03 16:11:42 yamaha go-librespot[1432]: time="2026-04-03T16:11:42+02:00" level=trace msg="sent dealer ping" Apr 03 16:11:42 yamaha go-librespot[1432]: time="2026-04-03T16:11:42+02:00" level=trace msg="received dealer pong" Apr 03 16:11:42 yamaha systemd[1]: wireless.service: Deactivated successfully. Apr 03 16:11:42 yamaha systemd[1]: Stopped wireless.service - Wireless Services. Apr 03 16:11:42 yamaha systemd[1]: wireless.service: Consumed 7min 4.763s CPU time. Apr 03 16:11:42 yamaha systemd[1]: Starting wireless.service - Wireless Services... Apr 03 16:11:43 yamaha sudo[1984]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:11:43 yamaha sudo[1984]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:11:43 yamaha sudo[1984]: pam_unix(sudo:session): session closed for user root Apr 03 16:11:44 yamaha sudo[1987]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:11:44 yamaha sudo[1987]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:11:44 yamaha wireless.js[1973]: WIRELESS.JS - INFO: Single Network Mode enabled (default) - only one network device can be active at a time between ethernet and wireless Apr 03 16:11:44 yamaha wireless.js[1973]: WIRELESS.JS - INFO: === SNM TRANSITION === Apr 03 16:11:44 yamaha wireless.js[1973]: WIRELESS.JS - INFO: Previous ethernet state: disconnected Apr 03 16:11:44 yamaha wireless.js[1973]: WIRELESS.JS - INFO: New ethernet state: connected Apr 03 16:11:44 yamaha wireless.js[1973]: WIRELESS.JS - INFO: Single Network Mode: enabled Apr 03 16:11:44 yamaha wireless.js[1973]: WIRELESS.JS - INFO: First start: yes Apr 03 16:11:44 yamaha wireless.js[1973]: WIRELESS.JS - INFO: Action: Switch to ethernet (WiFi scan mode) Apr 03 16:11:44 yamaha wireless.js[1973]: WIRELESS.JS - INFO: === END TRANSITION === Apr 03 16:11:44 yamaha wireless.js[1973]: WIRELESS.JS - INFO: Wireless.js initializing wireless flow Apr 03 16:11:44 yamaha sudo[1987]: pam_unix(sudo:session): session closed for user root Apr 03 16:11:44 yamaha sudo[2002]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 03 16:11:44 yamaha sudo[2002]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Apr 03 16:11:44 yamaha sudo[2002]: pam_unix(sudo:session): session closed for user root Apr 03 16:11:44 yamaha sudo[2004]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 03 16:11:44 yamaha sudo[2004]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Apr 03 16:11:45 yamaha sudo[2004]: pam_unix(sudo:session): session closed for user root Apr 03 16:11:45 yamaha wireless.js[1973]: WIRELESS.JS - INFO: Cleaning previous... Apr 03 16:11:45 yamaha sudo[2007]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:11:45 yamaha sudo[2007]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:11:45 yamaha sudo[2009]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Apr 03 16:11:45 yamaha sudo[2007]: pam_unix(sudo:session): session closed for user root Apr 03 16:11:45 yamaha sudo[2009]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Apr 03 16:11:45 yamaha sudo[2009]: pam_unix(sudo:session): session closed for user root Apr 03 16:11:45 yamaha kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Apr 03 16:11:45 yamaha wireless.js[1973]: WIRELESS.JS - INFO: InterfaceValidator: READY - wlan0 is ready for operations Apr 03 16:11:45 yamaha wireless.js[1973]: WIRELESS.JS - INFO: InterfaceValidator: wlan0 became ready after 16ms Apr 03 16:11:45 yamaha wireless.js[1973]: WIRELESS.JS - INFO: ensureInterfaceReady: Interface ready (MAC: b8:27:eb:0b:6c:e4) Apr 03 16:11:45 yamaha sudo[2017]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Apr 03 16:11:45 yamaha sudo[2017]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:11:45 yamaha sudo[2017]: pam_unix(sudo:session): session closed for user root Apr 03 16:11:45 yamaha sudo[2025]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Apr 03 16:11:45 yamaha sudo[2025]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:11:46 yamaha volumio[1189]: info: Received Get System Info Apr 03 16:11:46 yamaha volumio5-onboarding[1583]: time=2026-04-03T16:11:46.012+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.68.123:59896,00:00:00:00:00:00%01 @ 0x1801cb0" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Apr 03 16:11:46 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 16:11:46 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 16:11:46 yamaha volumio[1189]: info: Discovery: Getting this device information Apr 03 16:11:46 yamaha volumio[1189]: info: CoreCommandRouter::volumioGetState Apr 03 16:11:46 yamaha volumio[1189]: info: CorePlayQueue::getTrack 0 Apr 03 16:11:46 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 16:11:46 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 03 16:11:46 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 03 16:11:46 yamaha systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 15. Apr 03 16:11:46 yamaha systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 16:11:46 yamaha sudo[2030]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:11:46 yamaha sudo[2030]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:11:46 yamaha sudo[2030]: pam_unix(sudo:session): session closed for user root Apr 03 16:11:46 yamaha systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 16:11:46 yamaha upmpdcli[2031]: Could not open config: /tmp/upmpdcli.conf Apr 03 16:11:46 yamaha systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Apr 03 16:11:46 yamaha systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Apr 03 16:11:46 yamaha volumio5-onboarding[1583]: time=2026-04-03T16:11:46.998+02:00 level=INFO msg="service successfully established" component=discovery/localnet Apr 03 16:11:47 yamaha sudo[2034]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:11:47 yamaha sudo[2034]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:11:47 yamaha sudo[2034]: pam_unix(sudo:session): session closed for user root Apr 03 16:11:48 yamaha sudo[2025]: pam_unix(sudo:session): session closed for user root Apr 03 16:11:48 yamaha wireless.js[1973]: WIRELESS.JS - INFO: Regdomain already correct: DE Apr 03 16:11:48 yamaha wireless.js[1973]: WIRELESS.JS - INFO: Single Network Mode: Ethernet active, maintaining WiFi scan capability Apr 03 16:11:48 yamaha wireless.js[1973]: WIRELESS.JS - INFO: SNM: Maintaining wlan0 UP without IP (scan mode) Apr 03 16:11:48 yamaha wireless.js[1973]: WIRELESS.JS - INFO: SNM: Users can configure WiFi via WebUI while ethernet is active Apr 03 16:11:48 yamaha sudo[2037]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:11:48 yamaha sudo[2037]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:11:48 yamaha sudo[2037]: pam_unix(sudo:session): session closed for user root Apr 03 16:11:48 yamaha sudo[2044]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Apr 03 16:11:48 yamaha sudo[2044]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Apr 03 16:11:48 yamaha sudo[2044]: pam_unix(sudo:session): session closed for user root Apr 03 16:11:48 yamaha sudo[2047]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 03 16:11:48 yamaha sudo[2047]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Apr 03 16:11:48 yamaha sudo[2047]: pam_unix(sudo:session): session closed for user root Apr 03 16:11:48 yamaha volumio5-onboarding[1583]: time=2026-04-03T16:11:48.866+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.68.123:59896,00:00:00:00:00:00%01 @ 0x1801cb0" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Apr 03 16:11:48 yamaha volumio[1189]: info: Received Get System Info Apr 03 16:11:48 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 16:11:48 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 16:11:48 yamaha volumio[1189]: info: Discovery: Getting this device information Apr 03 16:11:48 yamaha volumio[1189]: info: CoreCommandRouter::volumioGetState Apr 03 16:11:48 yamaha volumio[1189]: info: CorePlayQueue::getTrack 0 Apr 03 16:11:48 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 16:11:48 yamaha wpa_supplicant[2050]: Successfully initialized wpa_supplicant Apr 03 16:11:48 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 03 16:11:48 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 03 16:11:49 yamaha wpa_supplicant[2050]: nl80211: kernel reports: Registration to specific type not supported Apr 03 16:11:49 yamaha wpa_supplicant[2053]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all Apr 03 16:11:49 yamaha wireless.js[1973]: WIRELESS.JS - INFO: SNM: Transition to scan mode completed in 4755ms Apr 03 16:11:49 yamaha wireless.js[1973]: WIRELESS.JS - INFO: SNM: wlan0 is UP without IP, scan capable Apr 03 16:11:49 yamaha sudo[2070]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:11:49 yamaha sudo[2070]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:11:49 yamaha sudo[2070]: pam_unix(sudo:session): session closed for user root Apr 03 16:11:49 yamaha wireless.js[1973]: WIRELESS.JS - INFO: Notified systemd about wireless ready Apr 03 16:11:49 yamaha kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Apr 03 16:11:49 yamaha systemd[1]: Started wireless.service - Wireless Services. Apr 03 16:11:49 yamaha sudo[1967]: pam_unix(sudo:session): session closed for user root Apr 03 16:11:49 yamaha volumio5-onboarding[1583]: time=2026-04-03T16:11:49.828+02:00 level=INFO msg="service successfully established" component=discovery/localnet Apr 03 16:11:50 yamaha sudo[2075]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:11:50 yamaha sudo[2075]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:11:50 yamaha sudo[2075]: pam_unix(sudo:session): session closed for user root Apr 03 16:11:51 yamaha sudo[2078]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:11:51 yamaha sudo[2078]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:11:51 yamaha sudo[2078]: pam_unix(sudo:session): session closed for user root Apr 03 16:11:52 yamaha volumio[1189]: info: Discovery: Networking Restart detected, restarting advertisement and browsing Apr 03 16:11:52 yamaha volumio[1189]: info: Discovery: Restarting Advertising Apr 03 16:11:52 yamaha volumio[1189]: info: Discovery: Stopping existing advertisement Apr 03 16:11:52 yamaha volumio5-onboarding[1583]: time=2026-04-03T16:11:52.142+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.68.123:59896,00:00:00:00:00:00%01 @ 0x1801cb0" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Apr 03 16:11:52 yamaha volumio[1189]: info: Discovery: Restarting Browsing Apr 03 16:11:52 yamaha volumio[1189]: info: Received Get System Info Apr 03 16:11:52 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 16:11:52 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 16:11:52 yamaha volumio[1189]: info: Discovery: Getting this device information Apr 03 16:11:52 yamaha volumio[1189]: info: CoreCommandRouter::volumioGetState Apr 03 16:11:52 yamaha volumio[1189]: info: CorePlayQueue::getTrack 0 Apr 03 16:11:52 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 16:11:52 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 03 16:11:52 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 03 16:11:52 yamaha sudo[2085]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:11:52 yamaha sudo[2085]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:11:52 yamaha sudo[2085]: pam_unix(sudo:session): session closed for user root Apr 03 16:11:53 yamaha volumio5-onboarding[1583]: time=2026-04-03T16:11:53.131+02:00 level=INFO msg="service successfully established" component=discovery/localnet Apr 03 16:11:53 yamaha volumio[1189]: info: Discovery: A device disappeared from network Apr 03 16:11:53 yamaha volumio[1189]: info: Discovery: A device disappeared from network Apr 03 16:11:53 yamaha sudo[2098]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:11:53 yamaha sudo[2098]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:11:53 yamaha sudo[2098]: pam_unix(sudo:session): session closed for user root Apr 03 16:11:54 yamaha sudo[2101]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:11:54 yamaha sudo[2101]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:11:54 yamaha sudo[2101]: pam_unix(sudo:session): session closed for user root Apr 03 16:11:54 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Apr 03 16:11:54 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Apr 03 16:11:54 yamaha sudo[2104]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:11:54 yamaha sudo[2104]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:11:54 yamaha sudo[2104]: pam_unix(sudo:session): session closed for user root Apr 03 16:11:55 yamaha sudo[2107]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:11:55 yamaha sudo[2107]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:11:55 yamaha sudo[2107]: pam_unix(sudo:session): session closed for user root Apr 03 16:11:56 yamaha sudo[2111]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:11:56 yamaha sudo[2111]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:11:56 yamaha sudo[2111]: pam_unix(sudo:session): session closed for user root Apr 03 16:11:57 yamaha volumio[1189]: info: Discovery: Started advertising with name: Yamaha Apr 03 16:11:57 yamaha sudo[2116]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:11:57 yamaha sudo[2116]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:11:57 yamaha sudo[2116]: pam_unix(sudo:session): session closed for user root Apr 03 16:11:58 yamaha volumio[1189]: info: Discovery: adding 2c586465-7306-4146-a363-dbc4af4f9db0 Apr 03 16:11:58 yamaha volumio[1189]: info: Discovery: Found device Yamaha Apr 03 16:11:58 yamaha volumio[1189]: info: CoreCommandRouter::volumioGetState Apr 03 16:11:58 yamaha volumio[1189]: info: CorePlayQueue::getTrack 0 Apr 03 16:11:58 yamaha sudo[2123]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:11:58 yamaha sudo[2123]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:11:58 yamaha sudo[2123]: pam_unix(sudo:session): session closed for user root Apr 03 16:11:58 yamaha volumio[1189]: info: Discovery: this is already registered, 2c586465-7306-4146-a363-dbc4af4f9db0 Apr 03 16:11:58 yamaha volumio[1189]: info: Discovery: Found device Yamaha Apr 03 16:11:58 yamaha volumio[1189]: info: CoreCommandRouter::volumioGetState Apr 03 16:11:58 yamaha volumio[1189]: info: CorePlayQueue::getTrack 0 Apr 03 16:11:58 yamaha volumio[1189]: info: Discovery: this is already registered, 2c586465-7306-4146-a363-dbc4af4f9db0 Apr 03 16:11:58 yamaha volumio[1189]: info: Discovery: Found device Yamaha Apr 03 16:11:58 yamaha volumio[1189]: info: CoreCommandRouter::volumioGetState Apr 03 16:11:58 yamaha volumio[1189]: info: CorePlayQueue::getTrack 0 Apr 03 16:11:58 yamaha volumio[1189]: info: Discovery: this is already registered, 2c586465-7306-4146-a363-dbc4af4f9db0 Apr 03 16:11:58 yamaha volumio[1189]: info: Discovery: Found device Yamaha Apr 03 16:11:58 yamaha volumio[1189]: info: CoreCommandRouter::volumioGetState Apr 03 16:11:58 yamaha volumio[1189]: info: CorePlayQueue::getTrack 0 Apr 03 16:11:59 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 16:11:59 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 16:11:59 yamaha volumio[1189]: info: Discovery: Getting this device information Apr 03 16:11:59 yamaha volumio[1189]: info: CoreCommandRouter::volumioGetState Apr 03 16:11:59 yamaha volumio[1189]: info: CorePlayQueue::getTrack 0 Apr 03 16:11:59 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 16:11:59 yamaha volumio[1189]: verbose: New Socket.io Connection to 192.168.68.136:3000 from 192.168.68.123 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Apr 03 16:11:59 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 03 16:11:59 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 03 16:11:59 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Apr 03 16:11:59 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Apr 03 16:11:59 yamaha volumio[1189]: info: Refreshing Cached IP Addresses Apr 03 16:11:59 yamaha sudo[2126]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:11:59 yamaha sudo[2128]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 03 16:11:59 yamaha sudo[2128]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:11:59 yamaha sudo[2126]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:11:59 yamaha sudo[2128]: pam_unix(sudo:session): session closed for user root Apr 03 16:11:59 yamaha sudo[2126]: pam_unix(sudo:session): session closed for user root Apr 03 16:11:59 yamaha sudo[2130]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:11:59 yamaha sudo[2130]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:11:59 yamaha sudo[2130]: pam_unix(sudo:session): session closed for user root Apr 03 16:12:00 yamaha sudo[2135]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 03 16:12:00 yamaha sudo[2135]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:12:00 yamaha sudo[2135]: pam_unix(sudo:session): session closed for user root Apr 03 16:12:00 yamaha sudo[2137]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:12:00 yamaha sudo[2137]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:12:00 yamaha sudo[2137]: pam_unix(sudo:session): session closed for user root Apr 03 16:12:00 yamaha volumio[1189]: verbose: New Socket.io Connection to 192.168.68.136 from 192.168.68.123 UA: Mozilla/5.0 (Linux; Android 16; SM-S928B Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.164 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Apr 03 16:12:00 yamaha sudo[2141]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:12:00 yamaha sudo[2141]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:12:00 yamaha sudo[2141]: pam_unix(sudo:session): session closed for user root Apr 03 16:12:00 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 03 16:12:00 yamaha volumio[1189]: info: CoreCommandRouter::volumioGetVisibleSources Apr 03 16:12:00 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 03 16:12:00 yamaha volumio[1189]: info: CoreCommandRouter::volumioGetState Apr 03 16:12:00 yamaha volumio[1189]: info: CorePlayQueue::getTrack 0 Apr 03 16:12:00 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 03 16:12:00 yamaha volumio[1189]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 16:12:00 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 03 16:12:00 yamaha volumio[1189]: info: Received Get System Info Apr 03 16:12:00 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 16:12:00 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 16:12:00 yamaha volumio[1189]: info: Discovery: Getting this device information Apr 03 16:12:00 yamaha volumio[1189]: info: CoreCommandRouter::volumioGetState Apr 03 16:12:00 yamaha volumio[1189]: info: CorePlayQueue::getTrack 0 Apr 03 16:12:00 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 16:12:00 yamaha volumio[1189]: info: CoreCommandRouter::volumioGetState Apr 03 16:12:00 yamaha volumio[1189]: info: CorePlayQueue::getTrack 0 Apr 03 16:12:00 yamaha volumio[1189]: info: Listing playlists Apr 03 16:12:00 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 03 16:12:00 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 03 16:12:01 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 03 16:12:01 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 03 16:12:01 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Apr 03 16:12:01 yamaha systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 16. Apr 03 16:12:01 yamaha systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 16:12:01 yamaha systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 16:12:01 yamaha sudo[2152]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 03 16:12:01 yamaha sudo[2147]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Apr 03 16:12:01 yamaha sudo[2147]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:12:01 yamaha upmpdcli[2161]: Could not open config: /tmp/upmpdcli.conf Apr 03 16:12:01 yamaha systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Apr 03 16:12:01 yamaha systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Apr 03 16:12:01 yamaha sudo[2158]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 03 16:12:01 yamaha sudo[2158]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:12:01 yamaha sudo[2152]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:12:01 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Apr 03 16:12:01 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Apr 03 16:12:01 yamaha sudo[2147]: pam_unix(sudo:session): session closed for user root Apr 03 16:12:01 yamaha sudo[2163]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 03 16:12:01 yamaha sudo[2163]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:12:01 yamaha sudo[2152]: pam_unix(sudo:session): session closed for user root Apr 03 16:12:01 yamaha sudo[2173]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:12:01 yamaha sudo[2173]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:12:01 yamaha sudo[2158]: pam_unix(sudo:session): session closed for user root Apr 03 16:12:01 yamaha sudo[2169]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 03 16:12:01 yamaha sudo[2169]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:12:01 yamaha sudo[2163]: pam_unix(sudo:session): session closed for user root Apr 03 16:12:01 yamaha sudo[2169]: pam_unix(sudo:session): session closed for user root Apr 03 16:12:01 yamaha sudo[2173]: pam_unix(sudo:session): session closed for user root Apr 03 16:12:01 yamaha sudo[2179]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:12:01 yamaha sudo[2179]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:12:01 yamaha sudo[2176]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 03 16:12:01 yamaha sudo[2176]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:12:02 yamaha sudo[2179]: pam_unix(sudo:session): session closed for user root Apr 03 16:12:02 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 03 16:12:02 yamaha volumio[1189]: info: Received Get System Info Apr 03 16:12:02 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 16:12:02 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 16:12:02 yamaha volumio[1189]: info: Discovery: Getting this device information Apr 03 16:12:02 yamaha volumio[1189]: info: CoreCommandRouter::volumioGetState Apr 03 16:12:02 yamaha volumio[1189]: info: CorePlayQueue::getTrack 0 Apr 03 16:12:02 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 16:12:02 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 03 16:12:02 yamaha volumio[1189]: info: Received Get System Info Apr 03 16:12:02 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 16:12:02 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 16:12:02 yamaha volumio[1189]: info: Discovery: Getting this device information Apr 03 16:12:02 yamaha volumio[1189]: info: CoreCommandRouter::volumioGetState Apr 03 16:12:02 yamaha volumio[1189]: info: CorePlayQueue::getTrack 0 Apr 03 16:12:02 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 16:12:02 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Apr 03 16:12:02 yamaha sudo[2200]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:12:02 yamaha sudo[2200]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:12:02 yamaha sudo[2200]: pam_unix(sudo:session): session closed for user root Apr 03 16:12:03 yamaha sudo[2203]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:12:03 yamaha sudo[2203]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:12:03 yamaha sudo[2203]: pam_unix(sudo:session): session closed for user root Apr 03 16:12:04 yamaha sudo[2176]: pam_unix(sudo:session): session closed for user root Apr 03 16:12:04 yamaha sudo[2206]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:12:04 yamaha sudo[2206]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:12:04 yamaha sudo[2206]: pam_unix(sudo:session): session closed for user root Apr 03 16:12:05 yamaha volumio5-onboarding[1583]: time=2026-04-03T16:12:05.035+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.68.123:59896,00:00:00:00:00:00%01 @ 0x1801cb0" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Apr 03 16:12:05 yamaha volumio[1189]: info: Received Get System Info Apr 03 16:12:05 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 16:12:05 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 16:12:05 yamaha volumio[1189]: info: Discovery: Getting this device information Apr 03 16:12:05 yamaha volumio[1189]: info: CoreCommandRouter::volumioGetState Apr 03 16:12:05 yamaha volumio[1189]: info: CorePlayQueue::getTrack 0 Apr 03 16:12:05 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 16:12:05 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 03 16:12:05 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 03 16:12:05 yamaha sudo[2209]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:12:05 yamaha sudo[2209]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:12:05 yamaha sudo[2209]: pam_unix(sudo:session): session closed for user root Apr 03 16:12:05 yamaha volumio5-onboarding[1583]: time=2026-04-03T16:12:05.965+02:00 level=INFO msg="service successfully established" component=discovery/localnet Apr 03 16:12:06 yamaha sudo[2212]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:12:06 yamaha sudo[2212]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:12:06 yamaha sudo[2212]: pam_unix(sudo:session): session closed for user root Apr 03 16:12:07 yamaha volumio[1189]: info: CoreCommandRouter::volumioPlay Apr 03 16:12:07 yamaha volumio[1189]: info: CoreStateMachine::play index undefined Apr 03 16:12:07 yamaha volumio[1189]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 16:12:07 yamaha volumio[1189]: info: CorePlayQueue::getTrack 0 Apr 03 16:12:07 yamaha volumio[1189]: info: CoreStateMachine::startPlaybackTimer Apr 03 16:12:07 yamaha volumio[1189]: info: CorePlayQueue::getTrack 0 Apr 03 16:12:07 yamaha volumio[1189]: info: [1775225527557] ControllerSpotify::clearAddPlayTrack Apr 03 16:12:07 yamaha volumio[1189]: info: Sending Spotify command with payload to local API: /player/play Apr 03 16:12:07 yamaha go-librespot[1432]: time="2026-04-03T16:12:07+02:00" level=debug msg="resolved context of track" uri="spotify:track:7t7qXM0Jyahs4NUosh8Lsh" Apr 03 16:12:07 yamaha go-librespot[1432]: time="2026-04-03T16:12:07+02:00" level=trace msg="fetched new page 0 with 1 items (list: 1)" uri="spotify:track:7t7qXM0Jyahs4NUosh8Lsh" Apr 03 16:12:07 yamaha go-librespot[1432]: time="2026-04-03T16:12:07+02:00" level=debug msg="loading track (paused: false, position: 0ms)" uri="spotify:track:7t7qXM0Jyahs4NUosh8Lsh" Apr 03 16:12:07 yamaha go-librespot[1432]: time="2026-04-03T16:12:07+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Apr 03 16:12:07 yamaha go-librespot[1432]: time="2026-04-03T16:12:07+02:00" level=trace msg="emitting websocket event: will_play" Apr 03 16:12:07 yamaha volumio[1189]: SPOTIFY: received: {"type":"will_play","data":{"context_uri":"spotify:track:7t7qXM0Jyahs4NUosh8Lsh","uri":"spotify:track:7t7qXM0Jyahs4NUosh8Lsh","play_origin":"go-librespot"}} Apr 03 16:12:07 yamaha go-librespot[1432]: time="2026-04-03T16:12:07+02:00" level=debug msg="selected format OGG_VORBIS_320 (a1f422348c7c3bb62433078a0a1f35fb37a3a99b)" uri="spotify:track:7t7qXM0Jyahs4NUosh8Lsh" Apr 03 16:12:07 yamaha go-librespot[1432]: time="2026-04-03T16:12:07+02:00" level=debug msg="requested aes key for file a1f422348c7c3bb62433078a0a1f35fb37a3a99b, gid: 7t7qXM0Jyahs4NUosh8Lsh" Apr 03 16:12:07 yamaha go-librespot[1432]: time="2026-04-03T16:12:07+02:00" level=error msg="failed handling request play" error="failed loading context: failed loading current track (load context): failed creating stream for spotify:track:7t7qXM0Jyahs4NUosh8Lsh: failed retrieving audio key: failed retrieving aes key with code 1" Apr 03 16:12:07 yamaha volumio[1189]: error: Failed to send command to Spotify local API: /player/play: Error: Internal Server Error Apr 03 16:12:07 yamaha sudo[2215]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:12:07 yamaha sudo[2215]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:12:07 yamaha sudo[2215]: pam_unix(sudo:session): session closed for user root Apr 03 16:12:08 yamaha sudo[2218]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:12:08 yamaha sudo[2218]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:12:08 yamaha sudo[2218]: pam_unix(sudo:session): session closed for user root Apr 03 16:12:09 yamaha sudo[2221]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:12:09 yamaha sudo[2221]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:12:09 yamaha sudo[2221]: pam_unix(sudo:session): session closed for user root Apr 03 16:12:10 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 03 16:12:10 yamaha sudo[2224]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:12:10 yamaha sudo[2224]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:12:10 yamaha sudo[2224]: pam_unix(sudo:session): session closed for user root Apr 03 16:12:11 yamaha sudo[2227]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:12:11 yamaha sudo[2227]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:12:11 yamaha sudo[2227]: pam_unix(sudo:session): session closed for user root Apr 03 16:12:12 yamaha volumio[1189]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 16:12:12 yamaha volumio[1189]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 16:12:12 yamaha volumio[1189]: info: Retrieving Cloud Streaming UI Apr 03 16:12:12 yamaha go-librespot[1432]: time="2026-04-03T16:12:12+02:00" level=trace msg="sent dealer ping" Apr 03 16:12:12 yamaha go-librespot[1432]: time="2026-04-03T16:12:12+02:00" level=trace msg="received dealer pong" Apr 03 16:12:12 yamaha volumio[1189]: info: Getting Tidal Cloud Configuration Apr 03 16:12:12 yamaha volumio[1189]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 16:12:12 yamaha volumio[1189]: info: Getting Qobuz Cloud Configuration Apr 03 16:12:12 yamaha volumio[1189]: info: Asking plugin for UI Config Apr 03 16:12:12 yamaha volumio[1189]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 16:12:12 yamaha volumio[1189]: info: Getting Spotify Cloud Configuration Apr 03 16:12:12 yamaha volumio[1189]: info: Asking plugin for UI Config Apr 03 16:12:12 yamaha volumio[1189]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 16:12:12 yamaha volumio[1189]: info: Saving Spotify Acccount Apr 03 16:12:12 yamaha volumio[1189]: info: Got Tidal Cloud Configuration Apr 03 16:12:12 yamaha volumio[1189]: info: Got it Apr 03 16:12:12 yamaha volumio[1189]: info: Got it Apr 03 16:12:12 yamaha volumio[1189]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 03 16:12:12 yamaha sudo[2237]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 16:12:12 yamaha sudo[2237]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:12:12 yamaha volumio[1189]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 16:12:12 yamaha volumio[1189]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Apr 03 16:12:13 yamaha sudo[2237]: pam_unix(sudo:session): session closed for user root Apr 03 16:12:13 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 03 16:12:13 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 03 16:12:13 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 03 16:12:13 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 03 16:12:13 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 16:12:13 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 16:12:13 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 16:12:13 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 16:12:13 yamaha volumio[1189]: info: CoreCommandRouter::volumioGetBrowseSources Apr 03 16:12:13 yamaha volumio[1189]: info: CoreCommandRouter::volumioGetBrowseSources Apr 03 16:12:13 yamaha volumio[1189]: info: CoreCommandRouter::volumioGetBrowseSources Apr 03 16:12:13 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 03 16:12:13 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 03 16:12:16 yamaha systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 17. Apr 03 16:12:16 yamaha systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 16:12:16 yamaha systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 16:12:16 yamaha upmpdcli[2250]: Could not open config: /tmp/upmpdcli.conf Apr 03 16:12:16 yamaha systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Apr 03 16:12:16 yamaha systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Apr 03 16:12:17 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 03 16:12:18 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 03 16:12:18 yamaha volumio[1189]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 03 16:12:18 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 03 16:12:18 yamaha volumio[1189]: info: Received Get System Version Apr 03 16:12:18 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 03 16:12:18 yamaha volumio[1189]: info: Received Get System Info Apr 03 16:12:18 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 16:12:18 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 16:12:18 yamaha volumio[1189]: info: Discovery: Getting this device information Apr 03 16:12:18 yamaha volumio[1189]: info: CoreCommandRouter::volumioGetState Apr 03 16:12:18 yamaha volumio[1189]: info: CorePlayQueue::getTrack 0 Apr 03 16:12:18 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 16:12:21 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 03 16:12:25 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 03 16:12:32 yamaha systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 18. Apr 03 16:12:32 yamaha systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 16:12:32 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 03 16:12:32 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 03 16:12:32 yamaha systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 16:12:32 yamaha upmpdcli[2265]: Could not open config: /tmp/upmpdcli.conf Apr 03 16:12:32 yamaha systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Apr 03 16:12:32 yamaha systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Apr 03 16:12:42 yamaha go-librespot[1432]: time="2026-04-03T16:12:42+02:00" level=trace msg="received accesspoint ping" Apr 03 16:12:42 yamaha go-librespot[1432]: time="2026-04-03T16:12:42+02:00" level=trace msg="received accesspoint pong ack" Apr 03 16:12:42 yamaha go-librespot[1432]: time="2026-04-03T16:12:42+02:00" level=trace msg="sent dealer ping" Apr 03 16:12:42 yamaha go-librespot[1432]: time="2026-04-03T16:12:42+02:00" level=trace msg="received dealer pong" Apr 03 16:12:46 yamaha go-librespot[1432]: time="2026-04-03T16:12:46+02:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF" Apr 03 16:12:46 yamaha volumio[1189]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify Apr 03 16:12:46 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 03 16:12:46 yamaha volumio[1189]: Cannot find translation for source Calm Radio Apr 03 16:12:46 yamaha volumio[1189]: info: Disabling plugin spop Apr 03 16:12:46 yamaha sudo[2296]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop go-librespot-daemon.service Apr 03 16:12:46 yamaha sudo[2296]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:12:46 yamaha volumio[1189]: info: Done. Apr 03 16:12:46 yamaha volumio[1189]: info: Connection to go-librespot Websocket closed Apr 03 16:12:46 yamaha systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Apr 03 16:12:46 yamaha systemd[1]: go-librespot-daemon.service: Killing process 1433 (go-librespot) with signal SIGKILL. Apr 03 16:12:46 yamaha systemd[1]: go-librespot-daemon.service: Deactivated successfully. Apr 03 16:12:46 yamaha systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Apr 03 16:12:46 yamaha systemd[1]: go-librespot-daemon.service: Consumed 1.024s CPU time. Apr 03 16:12:46 yamaha systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Apr 03 16:12:46 yamaha systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Apr 03 16:12:46 yamaha systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Apr 03 16:12:46 yamaha systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Apr 03 16:12:46 yamaha sudo[2296]: pam_unix(sudo:session): session closed for user root Apr 03 16:12:47 yamaha systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 19. Apr 03 16:12:47 yamaha systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 16:12:47 yamaha systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 16:12:47 yamaha upmpdcli[2298]: Could not open config: /tmp/upmpdcli.conf Apr 03 16:12:47 yamaha systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Apr 03 16:12:47 yamaha systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Apr 03 16:12:48 yamaha volumio[1189]: info: Enabling plugin spop Apr 03 16:12:48 yamaha volumio[1189]: info: Loading plugin "spop"... Apr 03 16:12:48 yamaha volumio[1189]: info: PLUGIN START: spop Apr 03 16:12:48 yamaha volumio[1189]: info: Creating Spotify config file Apr 03 16:12:48 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 16:12:48 yamaha volumio[1189]: info: Done. Apr 03 16:12:48 yamaha volumio[1189]: info: Spotify config file written Apr 03 16:12:48 yamaha volumio[1189]: info: No need to fix Spotify hosts Apr 03 16:12:48 yamaha sudo[2300]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Apr 03 16:12:48 yamaha sudo[2300]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:12:48 yamaha systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Apr 03 16:12:48 yamaha systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Apr 03 16:12:48 yamaha systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Apr 03 16:12:48 yamaha go-librespot[2302]: go-librespot daemon starting... Apr 03 16:12:48 yamaha sudo[2300]: pam_unix(sudo:session): session closed for user root Apr 03 16:12:48 yamaha go-librespot[2303]: time="2026-04-03T16:12:48+02:00" level=info msg="running go-librespot 0.6.2" Apr 03 16:12:48 yamaha go-librespot[2303]: time="2026-04-03T16:12:48+02:00" level=debug msg="app state loaded" Apr 03 16:12:48 yamaha go-librespot[2303]: time="2026-04-03T16:12:48+02:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 03 16:12:48 yamaha volumio[1189]: info: New Spotify access tokenBQCYN0mUPU... Apr 03 16:12:48 yamaha volumio[1189]: info: Spotify credentials grant success - running version from March 24, 2019 Apr 03 16:12:48 yamaha volumio[1189]: SPOTIFY: User informations: {"country":"EG","display_name":"zcg067@outlook.com","email":"zcg067@outlook.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/31ffsqi2gn64dy35d3c254bngo6y"},"followers":{"href":null,"total":0},"href":"https://api.spotify.com/v1/users/31ffsqi2gn64dy35d3c254bngo6y","id":"31ffsqi2gn64dy35d3c254bngo6y","images":[],"product":"premium","type":"user","uri":"spotify:user:31ffsqi2gn64dy35d3c254bngo6y"} Apr 03 16:12:48 yamaha volumio[1189]: info: Spotify Successfully logged in Apr 03 16:12:48 yamaha go-librespot[2303]: time="2026-04-03T16:12:48+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 03 16:12:48 yamaha go-librespot[2303]: time="2026-04-03T16:12:48+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Apr 03 16:12:48 yamaha go-librespot[2303]: time="2026-04-03T16:12:48+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Apr 03 16:12:48 yamaha volumio[1189]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 03 16:12:48 yamaha volumio[1189]: info: [1775225568965] CoreMusicLibrary::Adding element Spotify Apr 03 16:12:48 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 03 16:12:48 yamaha volumio[1189]: Cannot find translation for source Calm Radio Apr 03 16:12:48 yamaha volumio[1189]: Cannot find translation for source Spotify Apr 03 16:12:48 yamaha go-librespot[2303]: time="2026-04-03T16:12:48+02:00" level=info msg="zeroconf server listening on port 43123" Apr 03 16:12:49 yamaha go-librespot[2303]: time="2026-04-03T16:12:49+02:00" level=debug msg="obtained new client token: AAD6Py7lXi053oZA7aRaKsbmc6pR3gd+Q6qQ+HwghV4COv0rDYduIObgvp7f/MqgC99u6JbPUZPCuEGi6dmYBIENenPcjyj6Gz4kt9imAU4pnzTQzQSal3iACh/cSozrGREBCFm8T4ttMbiXGhyzwxz4VnwAJxZMWIApAeP9GJlYISt5FUo42526UNTfPiV3D1iW18IzYUJ+V+tlG97aVT4dbCZkNcxspBgsfyqjP/z0ZtgF0m5cAw==" Apr 03 16:12:49 yamaha go-librespot[2303]: time="2026-04-03T16:12:49+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Apr 03 16:12:49 yamaha go-librespot[2303]: time="2026-04-03T16:12:49+02:00" level=debug msg="completed keyexchange" Apr 03 16:12:49 yamaha go-librespot[2303]: time="2026-04-03T16:12:49+02:00" level=debug msg="completed challenge" Apr 03 16:12:49 yamaha go-librespot[2303]: time="2026-04-03T16:12:49+02:00" level=info msg="authenticated AP" username="31************************6y" Apr 03 16:12:49 yamaha go-librespot[2303]: time="2026-04-03T16:12:49+02:00" level=info msg="authenticated Login5" username="31************************6y" Apr 03 16:12:49 yamaha go-librespot[2303]: time="2026-04-03T16:12:49+02:00" level=debug msg="initializing zeroconf session" username="31************************6y" Apr 03 16:12:49 yamaha go-librespot[2303]: time="2026-04-03T16:12:49+02:00" level=debug msg="dealer connection opened" Apr 03 16:12:49 yamaha go-librespot[2303]: time="2026-04-03T16:12:49+02:00" level=trace msg="starting accesspoint recv loop" Apr 03 16:12:49 yamaha go-librespot[2303]: time="2026-04-03T16:12:49+02:00" level=trace msg="starting dealer recv loop" Apr 03 16:12:49 yamaha go-librespot[2303]: time="2026-04-03T16:12:49+02:00" level=trace msg="received accesspoint ping" Apr 03 16:12:49 yamaha go-librespot[2303]: time="2026-04-03T16:12:49+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Apr 03 16:12:49 yamaha go-librespot[2303]: time="2026-04-03T16:12:49+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Apr 03 16:12:49 yamaha go-librespot[2303]: time="2026-04-03T16:12:49+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Apr 03 16:12:49 yamaha go-librespot[2303]: time="2026-04-03T16:12:49+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Apr 03 16:12:49 yamaha go-librespot[2303]: time="2026-04-03T16:12:49+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Apr 03 16:12:49 yamaha go-librespot[2303]: time="2026-04-03T16:12:49+02:00" level=debug msg="received connection id: NGI0ZDkwZmItOTA3...QjIyNzlERkUxRA==" Apr 03 16:12:49 yamaha go-librespot[2303]: time="2026-04-03T16:12:49+02:00" level=trace msg="received accesspoint pong ack" Apr 03 16:12:49 yamaha go-librespot[2303]: time="2026-04-03T16:12:49+02:00" level=debug msg="put connect state because NEW_DEVICE" Apr 03 16:12:51 yamaha volumio[1189]: info: go-librespot daemon successfully initialized Apr 03 16:12:54 yamaha volumio[1189]: info: Initializing connection to go-librespot Websocket Apr 03 16:12:54 yamaha go-librespot[2303]: time="2026-04-03T16:12:54+02:00" level=debug msg="new websocket client" Apr 03 16:12:54 yamaha volumio[1189]: info: Connection to go-librespot Websocket established Apr 03 16:12:55 yamaha volumio[1189]: info: Starting Uninstall of plugin music_service - spop Apr 03 16:12:55 yamaha volumio[1189]: info: Uninstalling plugin spop Apr 03 16:12:55 yamaha go-librespot[2303]: time="2026-04-03T16:12:55+02:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF" Apr 03 16:12:55 yamaha volumio[1189]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify Apr 03 16:12:55 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 03 16:12:55 yamaha volumio[1189]: Cannot find translation for source Calm Radio Apr 03 16:12:55 yamaha volumio5-onboarding[1583]: time=2026-04-03T16:12:55.505+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 03 16:12:55 yamaha volumio[1189]: info: Disabling plugin spop Apr 03 16:12:55 yamaha sudo[2327]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop go-librespot-daemon.service Apr 03 16:12:55 yamaha sudo[2327]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:12:55 yamaha volumio5-onboarding[1583]: time=2026-04-03T16:12:55.517+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 03 16:12:55 yamaha volumio[1189]: info: Checking if uninstall.sh is present Apr 03 16:12:55 yamaha volumio[1189]: info: Connection to go-librespot Websocket closed Apr 03 16:12:55 yamaha volumio[1189]: info: Executing uninstall.sh Apr 03 16:12:55 yamaha systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Apr 03 16:12:55 yamaha systemd[1]: go-librespot-daemon.service: Deactivated successfully. Apr 03 16:12:55 yamaha systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Apr 03 16:12:55 yamaha systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Apr 03 16:12:55 yamaha systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Apr 03 16:12:55 yamaha systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Apr 03 16:12:55 yamaha systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Apr 03 16:12:55 yamaha sudo[2327]: pam_unix(sudo:session): session closed for user root Apr 03 16:12:55 yamaha sudo[2331]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/music_service/spop/uninstall.sh Apr 03 16:12:55 yamaha sudo[2331]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 16:12:55 yamaha sudo[2331]: pam_unix(sudo:session): session closed for user root Apr 03 16:12:55 yamaha volumio[1189]: info: Uninstall script completed Apr 03 16:12:55 yamaha volumio5-onboarding[1583]: time=2026-04-03T16:12:55.649+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 03 16:12:55 yamaha volumio[1189]: info: Removing plugin spop from configuration Apr 03 16:12:55 yamaha volumio[1189]: info: Successfully removed spop configuration files Apr 03 16:12:55 yamaha volumio[1189]: info: Plugin folders cleanup Apr 03 16:12:55 yamaha volumio[1189]: info: Scanning into folder /volumio/app/plugins/ Apr 03 16:12:55 yamaha volumio[1189]: info: Scanning category audio_interface Apr 03 16:12:55 yamaha volumio[1189]: info: Scanning category miscellanea Apr 03 16:12:55 yamaha volumio[1189]: info: Scanning category music_service Apr 03 16:12:55 yamaha volumio[1189]: info: Scanning category plugins.json Apr 03 16:12:55 yamaha volumio[1189]: info: Scanning category system_controller Apr 03 16:12:55 yamaha volumio[1189]: info: Scanning category user_interface Apr 03 16:12:55 yamaha volumio5-onboarding[1583]: time=2026-04-03T16:12:55.727+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 03 16:12:55 yamaha volumio[1189]: info: Scanning into folder /data/plugins/ Apr 03 16:12:55 yamaha volumio[1189]: info: Scanning category music_service Apr 03 16:12:55 yamaha volumio[1189]: info: Cleaning folder for spop Apr 03 16:12:56 yamaha volumio[1189]: info: Plugin folders cleanup completed Apr 03 16:12:56 yamaha volumio5-onboarding[1583]: time=2026-04-03T16:12:56.482+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 03 16:12:56 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 03 16:12:56 yamaha volumio[1189]: info: [{"prettyName":"Calm Radio","name":"calmradio","category":"music_service","version":"2.2.4","icon":"fa-heartbeat","isManuallyInstalled":false,"enabled":true,"active":true}] Apr 03 16:12:56 yamaha volumio[1189]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 03 16:12:57 yamaha volumio[1189]: info: Getting Spotify volume Apr 03 16:12:57 yamaha volumio[1189]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 03 16:12:57 yamaha volumio[1189]: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 03 16:12:57 yamaha volumio[1189]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Apr 03 16:12:57 yamaha volumio[1189]: errno: -111, Apr 03 16:12:57 yamaha volumio[1189]: code: 'ECONNREFUSED', Apr 03 16:12:57 yamaha volumio[1189]: syscall: 'connect', Apr 03 16:12:57 yamaha volumio[1189]: address: '127.0.0.1', Apr 03 16:12:57 yamaha volumio[1189]: port: 9879, Apr 03 16:12:57 yamaha volumio[1189]: response: undefined Apr 03 16:12:57 yamaha volumio[1189]: } Apr 03 16:12:57 yamaha volumio[1189]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 03 16:12:58 yamaha sudo[2357]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-03 16:11' Apr 03 16:12:58 yamaha sudo[2357]: 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"