-- Logs begin at Thu 2019-02-14 12:11:59 IST, end at Fri 2026-01-09 15:03:56 IST. -- Jan 09 15:03:05 living-room systemd-timedated[1031]: Changed local time to Fri Jan 9 15:03:05 2026 Jan 09 15:03:05 living-room sudo[1029]: pam_unix(sudo:session): session closed for user root Jan 09 15:03:05 living-room volumio-time-update[634]: volumio-time-update-util: System time updated successfully. Jan 09 15:03:05 living-room systemd[1]: Started Volumio Time Update Utility. Jan 09 15:03:05 living-room systemd[1]: Reached target Multi-User System. Jan 09 15:03:05 living-room systemd[1]: Reached target Graphical Interface. Jan 09 15:03:05 living-room systemd[1]: Starting Update UTMP about System Runlevel Changes... Jan 09 15:03:05 living-room systemd[1]: Starting Daily apt download activities... Jan 09 15:03:05 living-room systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jan 09 15:03:05 living-room systemd[1]: Started Update UTMP about System Runlevel Changes. Jan 09 15:03:05 living-room volumio[986]: info: MYVOLUMIO Environment detected Jan 09 15:03:05 living-room volumio-remote-updater[637]: [2026-01-09 15:03:05] [connect] Successful connection Jan 09 15:03:05 living-room volumio[986]: info: Plugin folders cleanup Jan 09 15:03:05 living-room volumio[986]: info: Scanning into folder /volumio/app/plugins/ Jan 09 15:03:05 living-room volumio[986]: info: Scanning category audio_interface Jan 09 15:03:05 living-room volumio[986]: info: Scanning category miscellanea Jan 09 15:03:05 living-room volumio[986]: info: Scanning category music_service Jan 09 15:03:05 living-room volumio[986]: info: Scanning category plugins.json Jan 09 15:03:05 living-room volumio[986]: info: Scanning category system_controller Jan 09 15:03:05 living-room volumio[986]: info: Scanning category user_interface Jan 09 15:03:05 living-room volumio[986]: info: Scanning into folder /data/plugins/ Jan 09 15:03:05 living-room volumio[986]: info: Scanning category music_service Jan 09 15:03:05 living-room volumio[986]: info: Plugin folders cleanup completed Jan 09 15:03:05 living-room volumio[986]: info: ------------------------------------------- Jan 09 15:03:05 living-room volumio[986]: info: ----- Core plugins startup ---- Jan 09 15:03:05 living-room volumio[986]: info: ------------------------------------------- Jan 09 15:03:05 living-room volumio[986]: info: Loading plugins from folder /volumio/app/plugins/ Jan 09 15:03:05 living-room volumio[986]: info: Adding plugin upnp to MyMusic Plugins Jan 09 15:03:05 living-room volumio[986]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 09 15:03:05 living-room volumio[986]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 09 15:03:05 living-room volumio[986]: info: Loading plugins from folder /data/plugins/ Jan 09 15:03:05 living-room volumio[986]: info: Loading plugin "system"... Jan 09 15:03:05 living-room volumio[986]: info: Loading plugin "appearance"... Jan 09 15:03:06 living-room systemd[1]: apt-daily.service: Succeeded. Jan 09 15:03:06 living-room systemd[1]: Started Daily apt download activities. Jan 09 15:03:06 living-room systemd[1]: Starting Daily apt upgrade and clean activities... Jan 09 15:03:08 living-room systemd[1]: apt-daily-upgrade.service: Succeeded. Jan 09 15:03:08 living-room systemd[1]: Started Daily apt upgrade and clean activities. Jan 09 15:03:08 living-room systemd[1]: Startup finished in 13.780s (kernel) + 32.352s (userspace) = 46.133s. Jan 09 15:03:08 living-room volumio[986]: info: Loading plugin "network"... Jan 09 15:03:08 living-room volumio[986]: info: Refreshing Cached IP Addresses Jan 09 15:03:08 living-room sudo[1138]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 09 15:03:08 living-room sudo[1138]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 15:03:08 living-room sudo[1138]: pam_unix(sudo:session): session closed for user root Jan 09 15:03:08 living-room sudo[1140]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 09 15:03:08 living-room sudo[1140]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 15:03:08 living-room sudo[1140]: pam_unix(sudo:session): session closed for user root Jan 09 15:03:08 living-room volumio[986]: info: Loading plugin "services"... Jan 09 15:03:08 living-room volumio[986]: info: Loading plugin "alsa_controller"... Jan 09 15:03:08 living-room sudo[1149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 09 15:03:08 living-room sudo[1149]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 15:03:08 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 09 15:03:08 living-room volumio[986]: info: Loading plugin "wizard"... Jan 09 15:03:08 living-room volumio[986]: info: Loading plugin "networkfs"... Jan 09 15:03:08 living-room volumio[986]: info: Starting Udev Watcher for removable devices Jan 09 15:03:08 living-room volumio[986]: info: Ignoring mount for partition: boot Jan 09 15:03:08 living-room volumio[986]: info: Ignoring mount for partition: volumio Jan 09 15:03:08 living-room volumio[986]: info: Ignoring mount for partition: volumio_data Jan 09 15:03:08 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 09 15:03:08 living-room volumio[986]: info: Loading plugin "volumio_command_line_client"... Jan 09 15:03:08 living-room volumio[986]: info: Loading plugin "upnp"... Jan 09 15:03:08 living-room volumio[986]: info: [1767963788680] Starting Upmpd Daemon Jan 09 15:03:08 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 09 15:03:08 living-room volumio[986]: info: Loading plugin "my_music"... Jan 09 15:03:08 living-room volumio[986]: info: Loading plugin "mpd"... Jan 09 15:03:09 living-room volumio[986]: info: Loading plugin "upnp_browser"... Jan 09 15:03:09 living-room volumio[986]: info: Starting UPNP Browser Jan 09 15:03:09 living-room volumio[986]: info: Loading plugin "alarm-clock"... Jan 09 15:03:10 living-room sudo[1149]: pam_unix(sudo:session): session closed for user root Jan 09 15:03:10 living-room volumio[986]: info: Plugin airplay_emulation is not enabled Jan 09 15:03:10 living-room volumio[986]: info: Loading plugin "last_100"... Jan 09 15:03:10 living-room volumio[986]: info: Loading plugin "webradio"... Jan 09 15:03:10 living-room volumio[986]: info: Loading plugin "i2s_dacs"... Jan 09 15:03:10 living-room volumio[986]: info: I2S DAC not set, start Auto-detection Jan 09 15:03:10 living-room volumio[986]: info: Loading plugin "volumiodiscovery"... Jan 09 15:03:10 living-room volumio[986]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 09 15:03:10 living-room volumio[986]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 09 15:03:10 living-room volumio[986]: *** WARNING *** For more information see Jan 09 15:03:10 living-room node[986]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 09 15:03:10 living-room volumio[986]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 09 15:03:10 living-room volumio[986]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 09 15:03:10 living-room volumio[986]: *** WARNING *** For more information see Jan 09 15:03:10 living-room node[986]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 09 15:03:10 living-room node[986]: *** WARNING *** For more information see Jan 09 15:03:10 living-room node[986]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 09 15:03:10 living-room node[986]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 09 15:03:10 living-room node[986]: *** WARNING *** For more information see Jan 09 15:03:10 living-room volumio[986]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 09 15:03:10 living-room volumio[986]: info: Discovery: Started advertising with name: Living room Jan 09 15:03:10 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 09 15:03:10 living-room volumio[986]: info: Loading plugin "spop"... Jan 09 15:03:10 living-room dhcpcd[905]: wlan0: carrier lost Jan 09 15:03:10 living-room wpa_supplicant[893]: wlan0: Associated with d0:cf:0e:a1:e9:e5 Jan 09 15:03:10 living-room wpa_supplicant[893]: wlan0: CTRL-EVENT-CONNECTED - Connection to d0:cf:0e:a1:e9:e5 completed [id=0 id_str=] Jan 09 15:03:10 living-room wpa_supplicant[893]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Jan 09 15:03:10 living-room avahi-daemon[636]: Withdrawing address record for 10.100.102.18 on wlan0. Jan 09 15:03:10 living-room avahi-daemon[636]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 10.100.102.18. Jan 09 15:03:10 living-room dhcpcd[905]: wlan0: deleting route to 10.100.102.0/24 Jan 09 15:03:10 living-room dhcpcd[905]: wlan0: deleting default route via 10.100.102.1 Jan 09 15:03:10 living-room avahi-daemon[636]: Interface wlan0.IPv4 no longer relevant for mDNS. Jan 09 15:03:11 living-room dhcpcd[905]: wlan0: carrier acquired Jan 09 15:03:11 living-room dhcpcd[905]: wlan0: IAID 01:bb:55:5c Jan 09 15:03:11 living-room systemd[1]: systemd-fsckd.service: Succeeded. Jan 09 15:03:11 living-room dhcpcd[905]: wlan0: soliciting a DHCP lease Jan 09 15:03:11 living-room dhcpcd[905]: wlan0: offered 10.100.102.18 from 10.100.102.1 Jan 09 15:03:11 living-room dhcpcd[905]: wlan0: soliciting an IPv6 router Jan 09 15:03:11 living-room dhcpcd[905]: wlan0: probing address 10.100.102.18/24 Jan 09 15:03:12 living-room ntpd[784]: Deleting interface #3 wlan0, 10.100.102.18#123, interface stats: received=0, sent=0, dropped=0, active_time=12 secs Jan 09 15:03:12 living-room volumio[986]: info: Loading plugin "youtube2"... Jan 09 15:03:13 living-room sh[527]: timed out Jan 09 15:03:13 living-room dhcpcd[577]: timed out Jan 09 15:03:13 living-room sh[527]: dhcpcd exited Jan 09 15:03:13 living-room dhcpcd[577]: dhcpcd exited Jan 09 15:03:13 living-room sh[527]: ifup: failed to bring up eth0 Jan 09 15:03:13 living-room systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Jan 09 15:03:13 living-room systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Jan 09 15:03:17 living-room dhcpcd[905]: wlan0: leased 10.100.102.18 for 77408 seconds Jan 09 15:03:17 living-room avahi-daemon[636]: Joining mDNS multicast group on interface wlan0.IPv4 with address 10.100.102.18. Jan 09 15:03:17 living-room dhcpcd[905]: wlan0: adding route to 10.100.102.0/24 Jan 09 15:03:17 living-room dhcpcd[905]: wlan0: adding default route via 10.100.102.1 Jan 09 15:03:17 living-room avahi-daemon[636]: New relevant interface wlan0.IPv4 for mDNS. Jan 09 15:03:17 living-room avahi-daemon[636]: Registering new address record for 10.100.102.18 on wlan0.IPv4. Jan 09 15:03:19 living-room ntpd[784]: Listen normally on 4 wlan0 10.100.102.18:123 Jan 09 15:03:19 living-room ntpd[784]: new interface(s) found: waking up resolver Jan 09 15:03:19 living-room volumio[986]: info: Loading plugin "ytcr"... Jan 09 15:03:20 living-room volumio-remote-updater[637]: [2026-01-09 15:03:20] [connect] Successful connection Jan 09 15:03:26 living-room volumio[986]: info: Loading plugin "outputs"... Jan 09 15:03:26 living-room volumio[986]: info: Loading plugin "albumart"... Jan 09 15:03:26 living-room volumio[986]: info: Plugin example_plugin is not enabled Jan 09 15:03:26 living-room volumio[986]: info: Loading plugin "inputs"... Jan 09 15:03:26 living-room volumio[986]: info: Loading plugin "updater_comm"... Jan 09 15:03:27 living-room volumio[986]: info: Plugin mpdemulation is not enabled Jan 09 15:03:27 living-room volumio[986]: info: Loading plugin "rest_api"... Jan 09 15:03:27 living-room volumio[986]: info: Loading plugin "websocket"... Jan 09 15:03:27 living-room volumio[986]: info: Starting Socket.io Server version 2.3.0 Jan 09 15:03:27 living-room volumio[986]: info: Loading i18n strings for locale en Jan 09 15:03:27 living-room volumio[986]: Updating browse sources language Jan 09 15:03:27 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 09 15:03:27 living-room volumio[986]: Forking 3 albumart workers Jan 09 15:03:27 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 15:03:27 living-room volumio[986]: info: CoreCommandRouter::initPlayerControls Jan 09 15:03:27 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:03:27 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:03:27 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:03:27 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:03:27 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:03:27 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:03:27 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:03:27 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:03:27 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 15:03:27 living-room volumio[986]: Express server listening on port 3000 Jan 09 15:03:27 living-room volumio[986]: [Metrics] WebUI: 25s 503.24ms Jan 09 15:03:27 living-room volumio[986]: info: CoreStateMachine::resetVolumioState Jan 09 15:03:27 living-room volumio[986]: info: CoreStateMachine::getcurrentVolume Jan 09 15:03:27 living-room volumio[986]: info: CoreCommandRouter::volumioRetrievevolume Jan 09 15:03:27 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 15:03:27 living-room sudo[1269]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 09 15:03:27 living-room sudo[1269]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 15:03:27 living-room sudo[1269]: pam_unix(sudo:session): session closed for user root Jan 09 15:03:28 living-room sudo[1272]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 09 15:03:28 living-room sudo[1272]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 15:03:28 living-room volumio[986]: info: Volumio Network Manager: Network status updated: 2 Jan 09 15:03:28 living-room sudo[1272]: pam_unix(sudo:session): session closed for user root Jan 09 15:03:28 living-room volumio[986]: verbose: New Socket.io Connection to 10.100.102.18:3000 from 10.100.102.6 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Jan 09 15:03:28 living-room volumio[986]: verbose: New Socket.io Connection to 10.100.102.18:3000 from 10.100.102.6 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Jan 09 15:03:28 living-room volumio[986]: verbose: New Socket.io Connection to 10.100.102.18:3000 from 10.100.102.6 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jan 09 15:03:28 living-room volumio[986]: verbose: New Socket.io Connection to 10.100.102.18:3000 from 10.100.102.6 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jan 09 15:03:28 living-room volumio[986]: verbose: New Socket.io Connection to 10.100.102.18:3000 from 10.100.102.6 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Jan 09 15:03:28 living-room volumio[986]: info: VolumeController:: Volume=100 Mute =false Jan 09 15:03:28 living-room volumio[986]: info: CoreStateMachine::pushState Jan 09 15:03:28 living-room volumio[986]: info: CorePlayQueue::getTrack 0 Jan 09 15:03:28 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 15:03:28 living-room volumio[986]: info: CoreCommandRouter::volumioPushState Jan 09 15:03:28 living-room volumio[986]: info: CoreStateMachine::updateTrackBlock Jan 09 15:03:28 living-room volumio[986]: info: CorePlayQueue::getTrackBlock Jan 09 15:03:28 living-room volumio[986]: info: CoreCommandRouter::volumioRetrievevolume Jan 09 15:03:28 living-room volumio[986]: Starting albumart workers Jan 09 15:03:28 living-room volumio[986]: Starting albumart workers Jan 09 15:03:28 living-room volumio[986]: Starting albumart workers Jan 09 15:03:28 living-room volumio[986]: info: Reloading queue from file Jan 09 15:03:28 living-room volumio[986]: info: Setting Device type: Raspberry PI Jan 09 15:03:28 living-room volumio[986]: info: CoreStateMachine::setRepeat false single undefined Jan 09 15:03:28 living-room volumio[986]: info: CoreStateMachine::pushState Jan 09 15:03:28 living-room volumio[986]: info: CorePlayQueue::getTrack 0 Jan 09 15:03:28 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 15:03:28 living-room volumio[986]: info: CoreCommandRouter::volumioPushState Jan 09 15:03:28 living-room volumio[986]: info: CoreStateMachine::setRandom null Jan 09 15:03:28 living-room volumio[986]: info: CoreStateMachine::pushState Jan 09 15:03:28 living-room volumio[986]: info: CorePlayQueue::getTrack 0 Jan 09 15:03:28 living-room volumio[986]: info: CoreCommandRouter::volumioPushState Jan 09 15:03:28 living-room volumio[986]: info: Discovery: A device disappeared from network Jan 09 15:03:28 living-room volumio[986]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Jan 09 15:03:28 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Jan 09 15:03:28 living-room volumio[986]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jan 09 15:03:28 living-room volumio[986]: info: USB Boot Capable - System SBC Revision found in cpuinfo: d03115 Jan 09 15:03:28 living-room volumio[986]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jan 09 15:03:28 living-room volumio[986]: info: CoreCommandRouter::volumioGetState Jan 09 15:03:28 living-room volumio[986]: info: CorePlayQueue::getTrack 0 Jan 09 15:03:28 living-room volumio[986]: info: VolumeController:: Volume=100 Mute =false Jan 09 15:03:28 living-room volumio[986]: info: CoreStateMachine::pushState Jan 09 15:03:28 living-room sudo[1298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 09 15:03:28 living-room volumio[986]: info: CorePlayQueue::getTrack 0 Jan 09 15:03:28 living-room volumio[986]: info: CoreCommandRouter::volumioPushState Jan 09 15:03:28 living-room sudo[1298]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 15:03:29 living-room volumio[986]: info: Completed loading Core Plugins Jan 09 15:03:29 living-room volumio[986]: info: Preparing to generate the ALSA configuration file Jan 09 15:03:29 living-room volumio[986]: info: Discovery: adding 4c2fa311-f874-4e0a-9f77-2a4057a34f13 Jan 09 15:03:29 living-room volumio[986]: info: Discovery: Found device Basement Jan 09 15:03:29 living-room systemd[1]: Started UPnP Renderer front-end to MPD. Jan 09 15:03:29 living-room sudo[1298]: pam_unix(sudo:session): session closed for user root Jan 09 15:03:29 living-room volumio[986]: info: Discovery: Connecting to remote: 10.100.102.6 Jan 09 15:03:29 living-room volumio[986]: info: Upmpdcli Daemon Started Jan 09 15:03:29 living-room volumio[986]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Jan 09 15:03:29 living-room volumio[986]: info: Asound.conf file unchanged, so no further update is needed Jan 09 15:03:29 living-room volumio[986]: info: Output device has changed, restarting MPD Jan 09 15:03:29 living-room volumio[986]: info: ___________ START PLUGINS ___________ Jan 09 15:03:29 living-room sudo[1303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 09 15:03:29 living-room sudo[1303]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 15:03:29 living-room volumio[986]: info: ControllerMpd::onStart: Initializing MPD Jan 09 15:03:29 living-room volumio[986]: info: Creating MPD Configuration file Jan 09 15:03:29 living-room sudo[1303]: pam_unix(sudo:session): session closed for user root Jan 09 15:03:29 living-room sudo[1305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 09 15:03:29 living-room sudo[1305]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 15:03:29 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 09 15:03:29 living-room volumio[986]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 09 15:03:29 living-room volumio[986]: info: [1767963809601] CoreMusicLibrary::Adding element Media Servers Jan 09 15:03:29 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 09 15:03:29 living-room volumio[986]: info: UPNP Browser: Client initialized successfully Jan 09 15:03:29 living-room systemd[1]: Listening on mpd.socket. Jan 09 15:03:29 living-room sudo[1327]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 09 15:03:29 living-room sudo[1327]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 15:03:29 living-room sudo[1336]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 09 15:03:29 living-room systemd[1]: Starting Music Player Daemon... Jan 09 15:03:29 living-room sudo[1336]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 15:03:29 living-room volumio[986]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 09 15:03:29 living-room sudo[1327]: pam_unix(sudo:session): session closed for user root Jan 09 15:03:29 living-room systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jan 09 15:03:29 living-room systemd[1]: mpd.service: Succeeded. Jan 09 15:03:29 living-room volumio[986]: info: [1767963809699] CoreMusicLibrary::Adding element Last_100 Jan 09 15:03:29 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 09 15:03:29 living-room systemd[1]: Stopped Music Player Daemon. Jan 09 15:03:29 living-room volumio[986]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 09 15:03:29 living-room volumio[986]: info: [1767963809706] CoreMusicLibrary::Adding element Webradio Jan 09 15:03:29 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 09 15:03:29 living-room systemd[1]: Starting Music Player Daemon... Jan 09 15:03:29 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 09 15:03:29 living-room volumio[986]: info: Initializing BBC Radios Jan 09 15:03:29 living-room sudo[1340]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 09 15:03:29 living-room sudo[1340]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 15:03:29 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 09 15:03:29 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 15:03:29 living-room sudo[1340]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jan 09 15:03:29 living-room sudo[1340]: pam_unix(sudo:session): session closed for user root Jan 09 15:03:29 living-room volumio[986]: info: Creating Spotify config file Jan 09 15:03:29 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:03:30 living-room volumio[986]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 09 15:03:30 living-room volumio[986]: info: [1767963810051] CoreMusicLibrary::Adding element YouTube2 Jan 09 15:03:30 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 09 15:03:30 living-room volumio[986]: Cannot find translation for source YouTube2 Jan 09 15:03:30 living-room volumio[986]: info: Volumio Calling Home Jan 09 15:03:30 living-room volumio[986]: info: Discovery: Connected to remote: 10.100.102.6 Jan 09 15:03:30 living-room volumio[986]: info: MPD Permissions set Jan 09 15:03:30 living-room volumio[986]: info: MPD Permissions set Jan 09 15:03:30 living-room volumio[986]: info: Spotify config file written Jan 09 15:03:30 living-room volumio[986]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jan 09 15:03:30 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:03:30 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:03:30 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:03:30 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:03:30 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:03:30 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:03:30 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:03:30 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:03:30 living-room sudo[1357]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Jan 09 15:03:30 living-room sudo[1357]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 15:03:30 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 15:03:30 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:03:30 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:03:30 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:03:30 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:03:30 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:03:30 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:03:30 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:03:30 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:03:30 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:03:30 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 15:03:30 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:03:30 living-room volumio[986]: info: No need to fix Spotify hosts Jan 09 15:03:30 living-room systemd[1]: Started go-librespot Daemon. Jan 09 15:03:30 living-room go-librespot[1363]: go-librespot daemon starting... Jan 09 15:03:30 living-room sudo[1357]: pam_unix(sudo:session): session closed for user root Jan 09 15:03:30 living-room volumio[986]: info: CoreCommandRouter::volumioGetState Jan 09 15:03:30 living-room volumio[986]: info: CorePlayQueue::getTrack 0 Jan 09 15:03:30 living-room volumio[986]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Jan 09 15:03:30 living-room volumio[986]: SPOTIFY: BQCagIf6uErNx5Yg60GfbrQYVAJMuQKqnX54SdZAymZPmWJYhpTso0CCkwmmqQ9foQY4n42RexrTbdEKR6QUdg83AUz2lULleELzsENPI3NS6bjAFml2Uerf7lJYOW5eC6wZci8qoo9WnYaH_oh_2qFJ3ZRUdgLYVk_JA3B9sHHbM0IfGr7fOJV9tH9VsjgPAPAAhdpppRpHVBF5JDoAPehpLtL22x9-baJtz9WAJw6vMbknOoai3jfpZ-QYyBWHNqJm4t6ugezcY-M0H2CAkGIWG_567YeAepizQS8Xb9BXYl_Df9odzxyq Jan 09 15:03:30 living-room volumio[986]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Jan 09 15:03:30 living-room volumio[986]: info: New Spotify access token = BQCagIf6uErNx5Yg60GfbrQYVAJMuQKqnX54SdZAymZPmWJYhpTso0CCkwmmqQ9foQY4n42RexrTbdEKR6QUdg83AUz2lULleELzsENPI3NS6bjAFml2Uerf7lJYOW5eC6wZci8qoo9WnYaH_oh_2qFJ3ZRUdgLYVk_JA3B9sHHbM0IfGr7fOJV9tH9VsjgPAPAAhdpppRpHVBF5JDoAPehpLtL22x9-baJtz9WAJw6vMbknOoai3jfpZ-QYyBWHNqJm4t6ugezcY-M0H2CAkGIWG_567YeAepizQS8Xb9BXYl_Df9odzxyq Jan 09 15:03:30 living-room volumio[986]: info: Spotify credentials grant success - running version from March 24, 2019 Jan 09 15:03:31 living-room go-librespot[1363]: time="2026-01-09T15:03:31+02:00" level=info msg="running go-librespot 0.4.0" Jan 09 15:03:31 living-room go-librespot[1363]: time="2026-01-09T15:03:31+02:00" level=debug msg="app state loaded" Jan 09 15:03:31 living-room volumio[986]: SPOTIFY: User informations: {"country":"IL","display_name":"Teddy.pardo","email":"teddy.pardo@gmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/31deuymj6e3cu6ecoojmwc6pki4q"},"followers":{"href":null,"total":0},"href":"https://api.spotify.com/v1/users/31deuymj6e3cu6ecoojmwc6pki4q","id":"31deuymj6e3cu6ecoojmwc6pki4q","images":[],"product":"free","type":"user","uri":"spotify:user:31deuymj6e3cu6ecoojmwc6pki4q"} Jan 09 15:03:31 living-room volumio[986]: info: Spotify Successfully logged in Jan 09 15:03:31 living-room volumio[986]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 09 15:03:31 living-room volumio[986]: info: [1767963811218] CoreMusicLibrary::Adding element Spotify Jan 09 15:03:31 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 09 15:03:31 living-room volumio[986]: Cannot find translation for source YouTube2 Jan 09 15:03:31 living-room volumio[986]: Cannot find translation for source Spotify Jan 09 15:03:31 living-room go-librespot[1363]: time="2026-01-09T15:03:31+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jan 09 15:03:31 living-room volumio[986]: info: Volumio called home Jan 09 15:03:31 living-room volumio[986]: info: [yt-cast-receiver] DIAL server listening on port 8098 Jan 09 15:03:31 living-room volumio[986]: info: CoreCommandRouter::volumioRetrievevolume Jan 09 15:03:31 living-room go-librespot[1363]: time="2026-01-09T15:03:31+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Jan 09 15:03:31 living-room go-librespot[1363]: time="2026-01-09T15:03:31+02:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Jan 09 15:03:31 living-room go-librespot[1363]: time="2026-01-09T15:03:31+02:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Jan 09 15:03:31 living-room go-librespot[1363]: time="2026-01-09T15:03:31+02:00" level=info msg="zeroconf server listening on port 41455" Jan 09 15:03:32 living-room volumio[986]: info: VolumeController:: Volume=100 Mute =false Jan 09 15:03:32 living-room volumio[986]: info: CoreCommandRouter::volumioGetState Jan 09 15:03:32 living-room volumio[986]: info: CorePlayQueue::getTrack 0 Jan 09 15:03:32 living-room volumio[986]: info: CoreStateMachine::pushState Jan 09 15:03:32 living-room volumio[986]: info: CorePlayQueue::getTrack 0 Jan 09 15:03:32 living-room volumio[986]: info: CoreCommandRouter::volumioPushState Jan 09 15:03:32 living-room go-librespot[1363]: time="2026-01-09T15:03:32+02:00" level=debug msg="obtained new client token: AABn0sTNI7kuuNeRITe9BxCUj6erAt6py0Fa+OuwRRL8D+3N7oDbGcGGes5EldyJ9F3Ml2oVaEQ9t2EP5r5HRS56gNSYQ6edeGJX8ZwQwOOHv9rLkymwlnDBt/ViMDL3LxOWFPDzXBrzc0wR1iAEJ7/JRP9bDCtF8LWQmt165A5fq/8MSgoSAf1rgBQi9x09vYFlYUy+oNhP75/UpXaSr4w46sE77HTOsxJt5QEiSgGGr6rgCrze9AB5uA==" Jan 09 15:03:32 living-room go-librespot[1363]: time="2026-01-09T15:03:32+02:00" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused" Jan 09 15:03:32 living-room go-librespot[1363]: time="2026-01-09T15:03:32+02:00" level=debug msg="connected to ap-gew1.spotify.com:443" Jan 09 15:03:32 living-room go-librespot[1363]: time="2026-01-09T15:03:32+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed performing keyexchange: failed reading APResponseMessage message: failed reading message length: read tcp 10.100.102.18:42464->104.199.65.9:443: read: connection reset by peer" Jan 09 15:03:32 living-room systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jan 09 15:03:32 living-room systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jan 09 15:03:33 living-room volumio[986]: info: Discovery: Browse raised the following error Error: dns service error: unknown Jan 09 15:03:33 living-room volumio[986]: info: go-librespot daemon successfully initialized Jan 09 15:03:33 living-room volumio[986]: info: Discovery: Browse raised the following error Error: dns service error: unknown Jan 09 15:03:34 living-room mpd[1352]: Jan 09 15:03 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 09 15:03:34 living-room systemd[1]: Started Music Player Daemon. Jan 09 15:03:34 living-room sudo[1305]: pam_unix(sudo:session): session closed for user root Jan 09 15:03:34 living-room sudo[1336]: pam_unix(sudo:session): session closed for user root Jan 09 15:03:34 living-room volumio[986]: error: MPD error: The expression evaluated to a falsy value: Jan 09 15:03:34 living-room volumio[986]: assert.ok(self.idling) Jan 09 15:03:34 living-room volumio[986]: error: The expression evaluated to a falsy value: Jan 09 15:03:34 living-room volumio[986]: assert.ok(self.idling) Jan 09 15:03:34 living-room volumio[986]: error: updateQueue error: null Jan 09 15:03:34 living-room volumio[986]: info: MPD running with PID1352 Jan 09 15:03:34 living-room volumio[986]: ,establishing connection Jan 09 15:03:34 living-room volumio[986]: info: Completed starting Core Plugins Jan 09 15:03:34 living-room volumio[986]: info: ------------------------------------------- Jan 09 15:03:34 living-room volumio[986]: info: ----- MyVolumio plugins startup ---- Jan 09 15:03:34 living-room volumio[986]: info: ------------------------------------------- Jan 09 15:03:34 living-room volumio[986]: info: [MyVolumio PluginManager] Fetching plans data.... Jan 09 15:03:34 living-room volumio[986]: error: updateQueue error: null Jan 09 15:03:34 living-room volumio[1301]: Generating RSA private key, 4096 bit long modulus (2 primes) Jan 09 15:03:35 living-room systemd[1]: systemd-timedated.service: Succeeded. Jan 09 15:03:35 living-room systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jan 09 15:03:35 living-room systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Jan 09 15:03:35 living-room systemd[1]: Stopped go-librespot Daemon. Jan 09 15:03:35 living-room systemd[1]: Started go-librespot Daemon. Jan 09 15:03:35 living-room go-librespot[1400]: go-librespot daemon starting... Jan 09 15:03:35 living-room volumio-remote-updater[637]: [2026-01-09 15:03:35] [connect] Successful connection Jan 09 15:03:35 living-room volumio-remote-updater[637]: [2026-01-09 15:03:35] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1767963815 101 Jan 09 15:03:35 living-room volumio[986]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 7 Jan 09 15:03:35 living-room go-librespot[1400]: time="2026-01-09T15:03:35+02:00" level=info msg="running go-librespot 0.4.0" Jan 09 15:03:35 living-room go-librespot[1400]: time="2026-01-09T15:03:35+02:00" level=debug msg="app state loaded" Jan 09 15:03:35 living-room go-librespot[1400]: time="2026-01-09T15:03:35+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jan 09 15:03:35 living-room go-librespot[1400]: time="2026-01-09T15:03:35+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Jan 09 15:03:35 living-room go-librespot[1400]: time="2026-01-09T15:03:35+02:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Jan 09 15:03:35 living-room go-librespot[1400]: time="2026-01-09T15:03:35+02:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Jan 09 15:03:35 living-room go-librespot[1400]: time="2026-01-09T15:03:35+02:00" level=info msg="zeroconf server listening on port 32927" Jan 09 15:03:35 living-room go-librespot[1400]: time="2026-01-09T15:03:35+02:00" level=debug msg="obtained new client token: AADFEok+cs1771JTFKtudIgI54fPlB04jYsyDiLt74p2jBedUDsIMdHQySFJUXur+BkmkY8rxQLZ2zztsqYfTYtc2lcaopEpRdCimA/Gq+bb97I4cKLX4ng9ZRPHmpGXI4T4YbN00QttA2PhWkvuTgl2S7i+3k8LdIPk2dRxTQXyI9D+XOWEdsv4b/7SHFvUMqasmVP1/34gxXzd4tdXUaZNZe2OJoEJLM00sdwDjGpu8HThf0E/rjTFvg==" Jan 09 15:03:36 living-room go-librespot[1400]: time="2026-01-09T15:03:36+02:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Jan 09 15:03:36 living-room go-librespot[1400]: time="2026-01-09T15:03:36+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed performing keyexchange: failed reading APResponseMessage message: failed reading message length: read tcp 10.100.102.18:59406->104.199.65.9:4070: read: connection reset by peer" Jan 09 15:03:36 living-room systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jan 09 15:03:36 living-room systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jan 09 15:03:36 living-room volumio[986]: info: Initializing connection to go-librespot Websocket Jan 09 15:03:36 living-room volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jan 09 15:03:37 living-room sudo[1409]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 09 15:03:37 living-room sudo[1409]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 15:03:37 living-room sudo[1412]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 09 15:03:37 living-room sudo[1412]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 15:03:37 living-room systemd[1]: Started MPD Monitor Service. Jan 09 15:03:37 living-room mpd_monitor.sh[1414]: MPD Monitor Service: Starting MPD Monitor Service Jan 09 15:03:37 living-room sudo[1409]: pam_unix(sudo:session): session closed for user root Jan 09 15:03:37 living-room systemd[1]: Stopping MPD Monitor Service... Jan 09 15:03:37 living-room systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM Jan 09 15:03:37 living-room volumio[986]: info: Successfully started MPD Monitor Jan 09 15:03:37 living-room systemd[1]: mpd_monitor.service: Succeeded. Jan 09 15:03:37 living-room systemd[1]: Stopped MPD Monitor Service. Jan 09 15:03:37 living-room systemd[1]: Started MPD Monitor Service. Jan 09 15:03:37 living-room sudo[1412]: pam_unix(sudo:session): session closed for user root Jan 09 15:03:37 living-room mpd_monitor.sh[1417]: MPD Monitor Service: Starting MPD Monitor Service Jan 09 15:03:37 living-room volumio[986]: info: Successfully started MPD Monitor Jan 09 15:03:39 living-room volumio[986]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jan 09 15:03:39 living-room systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jan 09 15:03:39 living-room systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2. Jan 09 15:03:39 living-room systemd[1]: Stopped go-librespot Daemon. Jan 09 15:03:39 living-room systemd[1]: Started go-librespot Daemon. Jan 09 15:03:39 living-room go-librespot[1435]: go-librespot daemon starting... Jan 09 15:03:39 living-room go-librespot[1435]: time="2026-01-09T15:03:39+02:00" level=info msg="running go-librespot 0.4.0" Jan 09 15:03:39 living-room go-librespot[1435]: time="2026-01-09T15:03:39+02:00" level=debug msg="app state loaded" Jan 09 15:03:39 living-room go-librespot[1435]: time="2026-01-09T15:03:39+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jan 09 15:03:39 living-room volumio[986]: info: Initializing connection to go-librespot Websocket Jan 09 15:03:39 living-room go-librespot[1435]: time="2026-01-09T15:03:39+02:00" level=debug msg="new websocket client" Jan 09 15:03:39 living-room volumio[986]: info: Connection to go-librespot Websocket established Jan 09 15:03:40 living-room go-librespot[1435]: time="2026-01-09T15:03:40+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Jan 09 15:03:40 living-room go-librespot[1435]: time="2026-01-09T15:03:40+02:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Jan 09 15:03:40 living-room go-librespot[1435]: time="2026-01-09T15:03:40+02:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Jan 09 15:03:40 living-room go-librespot[1435]: time="2026-01-09T15:03:40+02:00" level=info msg="zeroconf server listening on port 33823" Jan 09 15:03:40 living-room go-librespot[1435]: time="2026-01-09T15:03:40+02:00" level=debug msg="obtained new client token: AADtKZ1fs4ihHuKDvltEVL4/Auusa/PfG5pn7I+n98/RQpPYiM4Jy/gwowlbHaeLhiJdwTKPMihuPoVAMdPqux3D5sbLjn/KgRk6DPC18oud/pTbK8Z05QX+8+nl4n6xccZMx6AW+28CgTlZpTxSVikLYLrlBFZrftYU6I6zmhE9bej4W7ENvZIhnMF4RKGBLN4m14CAViJkhAw3ienDD+ji4iVyQYXV4FM2hydGUFFN4ElmFGU4iQMi/w==" Jan 09 15:03:40 living-room go-librespot[1435]: time="2026-01-09T15:03:40+02:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Jan 09 15:03:40 living-room go-librespot[1435]: time="2026-01-09T15:03:40+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed performing keyexchange: failed reading APResponseMessage message: failed reading message length: EOF" Jan 09 15:03:40 living-room volumio[986]: info: Connection to go-librespot Websocket closed Jan 09 15:03:40 living-room systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jan 09 15:03:40 living-room systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jan 09 15:03:41 living-room volumio[1301]: ..............................++++ Jan 09 15:03:42 living-room volumio[986]: info: Getting Spotify volume Jan 09 15:03:42 living-room volumio[986]: (node:986) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Jan 09 15:03:42 living-room volumio[986]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Jan 09 15:03:42 living-room volumio[986]: (Use `node --trace-warnings ...` to show where the warning was created) Jan 09 15:03:42 living-room volumio[986]: (node:986) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 1) Jan 09 15:03:42 living-room volumio[986]: (node:986) [DEP0018] DeprecationWarning: Unhandled promise rejections are deprecated. In the future, promise rejections that are not handled will terminate the Node.js process with a non-zero exit code. Jan 09 15:03:42 living-room volumio[986]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Jan 09 15:03:42 living-room volumio[986]: info: CoreCommandRouter::volumioGetState Jan 09 15:03:42 living-room volumio[986]: info: CorePlayQueue::getTrack 0 Jan 09 15:03:43 living-room volumio[986]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 09 15:03:43 living-room volumio[986]: SPOTIFY: SPOTIFY VOLUME undefined Jan 09 15:03:43 living-room volumio[986]: SPOTIFY: VOLUMIO VOLUME 100 Jan 09 15:03:43 living-room volumio[986]: info: Aligning Spotify Volume to Volumio Volume Jan 09 15:03:43 living-room volumio[986]: info: CoreCommandRouter::volumioGetState Jan 09 15:03:43 living-room volumio[986]: info: CorePlayQueue::getTrack 0 Jan 09 15:03:43 living-room volumio[986]: info: Setting Spotify Volume from Volumio: 100 Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jan 09 15:03:43 living-room volumiologrotate[642]: ls: cannot access '/var/log/samba/log.wb-LIVING': No such file or directory Jan 09 15:03:43 living-room volumio[986]: info: Adding plugin bluetooth to MyMusic Plugins Jan 09 15:03:43 living-room volumio[986]: info: Adding plugin multiroom to MyMusic Plugins Jan 09 15:03:43 living-room volumio[986]: info: Adding plugin metavolumio to MyMusic Plugins Jan 09 15:03:43 living-room volumio[986]: info: Adding plugin cd_controller to MyMusic Plugins Jan 09 15:03:43 living-room volumio[986]: info: Adding plugin qobuzconnect to MyMusic Plugins Jan 09 15:03:43 living-room volumio[986]: info: Adding plugin smart_inputs to MyMusic Plugins Jan 09 15:03:43 living-room volumio[986]: info: Adding plugin tidalconnect to MyMusic Plugins Jan 09 15:03:43 living-room volumiologrotate[642]: ls: cannot access 'ROOM': No such file or directory Jan 09 15:03:43 living-room volumio[986]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jan 09 15:03:43 living-room systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jan 09 15:03:43 living-room systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3. Jan 09 15:03:43 living-room systemd[1]: Stopped go-librespot Daemon. Jan 09 15:03:43 living-room systemd[1]: Started go-librespot Daemon. Jan 09 15:03:43 living-room go-librespot[1484]: go-librespot daemon starting... Jan 09 15:03:43 living-room go-librespot[1484]: time="2026-01-09T15:03:43+02:00" level=info msg="running go-librespot 0.4.0" Jan 09 15:03:43 living-room go-librespot[1484]: time="2026-01-09T15:03:43+02:00" level=debug msg="app state loaded" Jan 09 15:03:43 living-room go-librespot[1484]: time="2026-01-09T15:03:43+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jan 09 15:03:43 living-room go-librespot[1484]: time="2026-01-09T15:03:43+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Jan 09 15:03:43 living-room go-librespot[1484]: time="2026-01-09T15:03:43+02:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Jan 09 15:03:43 living-room go-librespot[1484]: time="2026-01-09T15:03:43+02:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Jan 09 15:03:43 living-room go-librespot[1484]: time="2026-01-09T15:03:43+02:00" level=info msg="zeroconf server listening on port 43785" Jan 09 15:03:44 living-room go-librespot[1484]: time="2026-01-09T15:03:44+02:00" level=debug msg="obtained new client token: AAAIvDl/Bn5HItr7zzKUI2WSPXeksMMM4uB9XrAKYZk+C1PW4MoTIwgxwxUvtyabJJu2HFCJFSvVxx5Gmj4tQ+kD209XVJsydVR3oiM706KCKzjuO34ieV+j+aD356ye04VI9UKmY2ks4Y7v9PwPrLjZdEOWJ6/aMlU1+VedlNQEjgQ1inIwFS3Oggk+DteYchBoqqzIvq45ncyPzRaImwDiWxGCDm6aRFeFVtgL33CHlSaVxLY6rZhJrQ==" Jan 09 15:03:44 living-room go-librespot[1484]: time="2026-01-09T15:03:44+02:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Jan 09 15:03:44 living-room go-librespot[1484]: time="2026-01-09T15:03:44+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed performing keyexchange: failed reading APResponseMessage message: failed reading message length: read tcp 10.100.102.18:44470->104.199.65.9:4070: read: connection reset by peer" Jan 09 15:03:44 living-room systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jan 09 15:03:44 living-room systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jan 09 15:03:44 living-room volumio[986]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jan 09 15:03:44 living-room volumio[986]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jan 09 15:03:44 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 15:03:44 living-room volumio[986]: info: Starting MyVolumio Remote Streaming Endpoints Jan 09 15:03:44 living-room volumio[986]: info: MyVolumio login type: Token Jan 09 15:03:45 living-room volumio[986]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jan 09 15:03:45 living-room volumio[986]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jan 09 15:03:46 living-room volumio[986]: info: Starting Streaming Service Transparent Proxy Jan 09 15:03:46 living-room volumio[986]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jan 09 15:03:46 living-room volumio[986]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jan 09 15:03:46 living-room volumio[986]: info: Streaming services startup Jan 09 15:03:46 living-room volumio[986]: info: Starting Streaming Daemon Jan 09 15:03:47 living-room sudo[1499]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 09 15:03:47 living-room sudo[1499]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 15:03:47 living-room sudo[1499]: pam_unix(sudo:session): session closed for user root Jan 09 15:03:47 living-room volumio[986]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jan 09 15:03:47 living-room volumio[986]: info: Initializing connection to go-librespot Websocket Jan 09 15:03:47 living-room volumio[986]: SPOTIFY: SETTING SPOTIFY VOLUME 100 Jan 09 15:03:47 living-room volumio[986]: info: Sending Spotify command with payload to local API: /player/volume Jan 09 15:03:47 living-room volumio[986]: error: Failed to send command to Spotify local API: /player/volume: Error: connect ECONNREFUSED 127.0.0.1:9879 Jan 09 15:03:47 living-room volumio[986]: error: Cannot start Volumio Streaming Daemon Jan 09 15:03:47 living-room volumio[986]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jan 09 15:03:47 living-room volumio[986]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jan 09 15:03:47 living-room volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jan 09 15:03:47 living-room systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jan 09 15:03:47 living-room systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4. Jan 09 15:03:47 living-room systemd[1]: Stopped go-librespot Daemon. Jan 09 15:03:47 living-room systemd[1]: Started go-librespot Daemon. Jan 09 15:03:47 living-room go-librespot[1506]: go-librespot daemon starting... Jan 09 15:03:47 living-room go-librespot[1506]: time="2026-01-09T15:03:47+02:00" level=info msg="running go-librespot 0.4.0" Jan 09 15:03:47 living-room go-librespot[1506]: time="2026-01-09T15:03:47+02:00" level=debug msg="app state loaded" Jan 09 15:03:47 living-room go-librespot[1506]: time="2026-01-09T15:03:47+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jan 09 15:03:47 living-room volumio[986]: error: MyVolumio Custom Token format not valid, refreshing it Jan 09 15:03:47 living-room go-librespot[1506]: time="2026-01-09T15:03:47+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Jan 09 15:03:47 living-room go-librespot[1506]: time="2026-01-09T15:03:47+02:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Jan 09 15:03:47 living-room go-librespot[1506]: time="2026-01-09T15:03:47+02:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Jan 09 15:03:47 living-room go-librespot[1506]: time="2026-01-09T15:03:47+02:00" level=info msg="zeroconf server listening on port 45943" Jan 09 15:03:47 living-room go-librespot[1506]: time="2026-01-09T15:03:47+02:00" level=debug msg="obtained new client token: AADTXpPppkWBMsh5t2H4Nliwfq6ZPZvZyNM7a4iIi0bh6Fzj4Mik3oVeQcZ/fljlXxxXXi2S3p21eOdvIk09bBxDQogFwG+yfaulLlq6WWPHRNpiAA6CCoqnRFyWUCAkuhZmdXG4a459MVHgFbJVmoK2fErLQtaJhmYwgQhhMHCG8n4OJYPUqCvF52E9Nv+1lz+xr7DbujnStbKH9WzAVRMByt9Mtzw3NlzQtiWT1NUE+HtXaA/6Wph5vg==" Jan 09 15:03:47 living-room go-librespot[1506]: time="2026-01-09T15:03:47+02:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Jan 09 15:03:47 living-room go-librespot[1506]: time="2026-01-09T15:03:47+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed performing keyexchange: failed reading APResponseMessage message: failed reading message length: read tcp 10.100.102.18:44486->104.199.65.9:4070: read: connection reset by peer" Jan 09 15:03:47 living-room systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jan 09 15:03:47 living-room systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jan 09 15:03:48 living-room volumio[986]: info: MyVolumio login type: Token Jan 09 15:03:48 living-room volumio[986]: STREAMING PROXY: Starting server on port 3245 Jan 09 15:03:48 living-room volumio[986]: Node JS runtime: 14 Jan 09 15:03:49 living-room volumio[986]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jan 09 15:03:49 living-room volumio[986]: info: MyVolumio token set successfully Jan 09 15:03:49 living-room volumio[986]: info: MYVOLUMIO: Adding device Jan 09 15:03:49 living-room volumio[986]: info: MYVOLUMIO: Evaluating Server Jan 09 15:03:49 living-room wpa_supplicant[893]: RRM: Ignoring radio measurement request: Not RRM network Jan 09 15:03:50 living-room wpa_supplicant[893]: RRM: Ignoring radio measurement request: Not RRM network Jan 09 15:03:50 living-room volumio[986]: info: Initializing connection to go-librespot Websocket Jan 09 15:03:50 living-room volumio[986]: info: MyVolumio Plan changed: premium Jan 09 15:03:50 living-room volumio[986]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Jan 09 15:03:50 living-room volumio[986]: info: Removing browser output: myVolumio user plan is not superstar Jan 09 15:03:50 living-room volumio[986]: info: Removing audio output: Jan 09 15:03:50 living-room volumio[986]: info: MYVOLUMIO: Adding device Jan 09 15:03:50 living-room volumio[986]: info: MYVOLUMIO: Evaluating Server Jan 09 15:03:50 living-room volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jan 09 15:03:50 living-room volumio[986]: info: Remote config written successfully Jan 09 15:03:50 living-room volumio[986]: info: Starting Tunnel 1 Jan 09 15:03:50 living-room volumio[986]: info: Starting Tunnel Connection Checker Jan 09 15:03:50 living-room volumio[986]: info: Completed starting MyVolumio Plugin Jan 09 15:03:51 living-room systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jan 09 15:03:51 living-room systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 5. Jan 09 15:03:51 living-room systemd[1]: Stopped go-librespot Daemon. Jan 09 15:03:51 living-room systemd[1]: Started go-librespot Daemon. Jan 09 15:03:51 living-room go-librespot[1554]: go-librespot daemon starting... Jan 09 15:03:51 living-room go-librespot[1554]: time="2026-01-09T15:03:51+02:00" level=info msg="running go-librespot 0.4.0" Jan 09 15:03:51 living-room go-librespot[1554]: time="2026-01-09T15:03:51+02:00" level=debug msg="app state loaded" Jan 09 15:03:51 living-room go-librespot[1554]: time="2026-01-09T15:03:51+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jan 09 15:03:51 living-room ntpd[784]: Soliciting pool server 64.176.168.216 Jan 09 15:03:51 living-room ntpd[784]: Soliciting pool server 51.16.235.6 Jan 09 15:03:51 living-room dhcpcd[905]: wlan0: carrier lost Jan 09 15:03:51 living-room wpa_supplicant[893]: wlan0: Associated with d0:cf:0e:a1:e9:e4 Jan 09 15:03:51 living-room wpa_supplicant[893]: wlan0: CTRL-EVENT-CONNECTED - Connection to d0:cf:0e:a1:e9:e4 completed [id=0 id_str=] Jan 09 15:03:51 living-room wpa_supplicant[893]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Jan 09 15:03:51 living-room avahi-daemon[636]: Withdrawing address record for 10.100.102.18 on wlan0. Jan 09 15:03:51 living-room avahi-daemon[636]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 10.100.102.18. Jan 09 15:03:51 living-room avahi-daemon[636]: Interface wlan0.IPv4 no longer relevant for mDNS. Jan 09 15:03:51 living-room dhcpcd[905]: wlan0: deleting route to 10.100.102.0/24 Jan 09 15:03:51 living-room dhcpcd[905]: wlan0: deleting default route via 10.100.102.1 Jan 09 15:03:51 living-room dhcpcd[905]: wlan0: carrier acquired Jan 09 15:03:51 living-room dhcpcd[905]: wlan0: IAID 01:bb:55:5c Jan 09 15:03:51 living-room dhcpcd[905]: wlan0: soliciting an IPv6 router Jan 09 15:03:51 living-room volumio[986]: info: MYVolumio Device enabled Jan 09 15:03:51 living-room volumio[986]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Jan 09 15:03:51 living-room volumio[986]: info: MyVolumio status changed Jan 09 15:03:51 living-room volumio[986]: info: Streaming services startup Jan 09 15:03:51 living-room volumio[986]: info: Starting Streaming Daemon Jan 09 15:03:51 living-room volumio[986]: error: Failed to ping endpoint us3.myvolumio.org : unknown error Jan 09 15:03:51 living-room sudo[1607]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 09 15:03:51 living-room volumio[986]: error: Failed to ping endpoint as1.myvolumio.org : unknown error Jan 09 15:03:51 living-room volumio[986]: error: Failed to ping endpoint as2.myvolumio.org : unknown error Jan 09 15:03:51 living-room volumio[986]: error: Failed to ping endpoint au1.myvolumio.org : unknown error Jan 09 15:03:51 living-room volumio[986]: error: Failed to ping endpoint us4.myvolumio.org : unknown error Jan 09 15:03:51 living-room sudo[1607]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 15:03:51 living-room volumio[986]: error: Failed to ping endpoint eu11.myvolumio.org : unknown error Jan 09 15:03:51 living-room volumio[986]: info: Discovery: A device disappeared from network Jan 09 15:03:51 living-room volumio[986]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Jan 09 15:03:51 living-room volumio[986]: error: Failed to ping endpoint eu12.myvolumio.org : unknown error Jan 09 15:03:51 living-room volumio[986]: info: Discovery: A device disappeared from network Jan 09 15:03:51 living-room volumio[986]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Jan 09 15:03:51 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Jan 09 15:03:51 living-room volumio[986]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Jan 09 15:03:51 living-room sudo[1607]: pam_unix(sudo:session): session closed for user root Jan 09 15:03:52 living-room volumio[986]: info: [1767963832001] Starting BluetoothController Jan 09 15:03:52 living-room dhcpcd[905]: wlan0: rebinding lease of 10.100.102.18 Jan 09 15:03:52 living-room ntpd[784]: Soliciting pool server 185.217.99.236 Jan 09 15:03:52 living-room dhcpcd[905]: wlan0: probing address 10.100.102.18/24 Jan 09 15:03:52 living-room volumio[986]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Jan 09 15:03:53 living-room ntpd[784]: Deleting interface #4 wlan0, 10.100.102.18#123, interface stats: received=1, sent=2, dropped=0, active_time=34 secs Jan 09 15:03:53 living-room ntpd[784]: 64.176.168.216 local addr 10.100.102.18 -> Jan 09 15:03:53 living-room ntpd[784]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Jan 09 15:03:54 living-room ntpd[784]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Jan 09 15:03:54 living-room volumio[986]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Jan 09 15:03:54 living-room sudo[1610]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Jan 09 15:03:54 living-room sudo[1610]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 15:03:54 living-room sudo[1610]: pam_unix(sudo:session): session closed for user root Jan 09 15:03:54 living-room volumio[986]: info: MRS: MultiRoom plugin initialized Jan 09 15:03:54 living-room volumio[986]: info: MRS: STOPPING SNAPCLIENT Jan 09 15:03:54 living-room volumio[986]: info: MRS: Snap server stop Jan 09 15:03:54 living-room sudo[1626]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Jan 09 15:03:54 living-room sudo[1626]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 15:03:54 living-room volumio[986]: info: MRS: STOPPING volumioStreaming Jan 09 15:03:54 living-room sudo[1629]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Jan 09 15:03:54 living-room sudo[1629]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 15:03:54 living-room sudo[1626]: pam_unix(sudo:session): session closed for user root Jan 09 15:03:55 living-room sudo[1632]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Jan 09 15:03:55 living-room sudo[1632]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 15:03:55 living-room sudo[1629]: pam_unix(sudo:session): session closed for user root Jan 09 15:03:55 living-room volumio[986]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Jan 09 15:03:55 living-room sudo[1635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Jan 09 15:03:55 living-room sudo[1635]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 15:03:55 living-room sudo[1635]: pam_unix(sudo:session): session closed for user root Jan 09 15:03:55 living-room sudo[1632]: pam_unix(sudo:session): session closed for user root Jan 09 15:03:55 living-room volumio[986]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Jan 09 15:03:55 living-room volumio[986]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Jan 09 15:03:55 living-room volumio[986]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Jan 09 15:03:55 living-room volumio[986]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Jan 09 15:03:55 living-room volumio[986]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Jan 09 15:03:55 living-room volumio[986]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Jan 09 15:03:55 living-room volumio[986]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Jan 09 15:03:55 living-room volumio[986]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Jan 09 15:03:55 living-room volumio[986]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... Jan 09 15:03:55 living-room volumio[986]: info: Preparing to generate the ALSA configuration file Jan 09 15:03:55 living-room volumio[986]: info: Initializing connection to go-librespot Websocket Jan 09 15:03:55 living-room volumio[986]: error: Failed to ping endpoint eu7.myvolumio.org : unknown error Jan 09 15:03:55 living-room volumio[986]: error: Failed to ping endpoint eu8.myvolumio.org : unknown error Jan 09 15:03:55 living-room volumio[986]: info: Setting Geolocation for MyVolumio to eu6 Jan 09 15:03:55 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 15:03:55 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 15:03:55 living-room volumio[986]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 15:03:55 living-room volumio[986]: error: Failed to ping endpoint us1.myvolumio.org : unknown error Jan 09 15:03:55 living-room volumio[986]: error: Failed to ping endpoint eu10.myvolumio.org : unknown error Jan 09 15:03:55 living-room volumio[986]: error: Failed to ping endpoint us2.myvolumio.org : unknown error Jan 09 15:03:55 living-room volumio[986]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 09 15:03:55 living-room volumio[986]: Error: Unable to resolve or reject the same promise twice Jan 09 15:03:55 living-room volumio[986]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jan 09 15:03:55 living-room volumio[986]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32119) Jan 09 15:03:55 living-room volumio[986]: at Socket.emit (events.js:327:22) Jan 09 15:03:55 living-room volumio[986]: at endReadableNT (internal/streams/readable.js:1327:12) Jan 09 15:03:55 living-room volumio[986]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jan 09 15:03:55 living-room volumio[986]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 09 15:03:55 living-room volumio[1301]: .............................................................++++ Jan 09 15:03:55 living-room volumio[1301]: e is 65537 (0x010001) Jan 09 15:03:55 living-room volumio[1301]: writing RSA key Jan 09 15:03:56 living-room sudo[1649]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-09 15:02 Jan 09 15:03:56 living-room sudo[1649]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"