-- Logs begin at Fri 2025-06-27 05:55:26 BST, end at Fri 2025-06-27 20:59:28 BST. -- Jun 27 20:58:00 volumiokitchen sudo[7212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-27 20:56 Jun 27 20:58:00 volumiokitchen sudo[7212]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 20:58:00 volumiokitchen sudo[7212]: pam_unix(sudo:session): session closed for user root Jun 27 20:58:09 volumiokitchen ntpd[439]: Soliciting pool server 82.219.4.30 Jun 27 20:58:22 volumiokitchen systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jun 27 20:58:22 volumiokitchen volumio-remote-updater[349]: [2025-06-27 20:58:22] [info] asio async_read_at_least error: system:104 (Connection reset by peer) Jun 27 20:58:22 volumiokitchen systemd[1]: volumio.service: Failed with result 'exit-code'. Jun 27 20:58:22 volumiokitchen volumio-remote-updater[349]: [2025-06-27 20:58:22] [error] handle_read_frame error: websocketpp.transport:2 (Underlying Transport Error) Jun 27 20:58:22 volumiokitchen volumio-remote-updater[349]: [2025-06-27 20:58:22] [disconnect] Disconnect close local:[1006,Underlying Transport Error] remote:[1006] Jun 27 20:58:22 volumiokitchen systemd[1]: Started dynamicswap service. Jun 27 20:58:22 volumiokitchen systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jun 27 20:58:22 volumiokitchen systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Jun 27 20:58:22 volumiokitchen systemd[1]: Stopped Volumio Backend Module. Jun 27 20:58:22 volumiokitchen systemd[1]: Started Volumio Backend Module. Jun 27 20:58:22 volumiokitchen systemd[1]: dynamicswap.service: Succeeded. Jun 27 20:58:26 volumiokitchen wpa_supplicant[612]: wlan0: CTRL-EVENT-DISCONNECTED bssid=e8:48:b8:e7:df:ec reason=2 Jun 27 20:58:26 volumiokitchen dhcpcd[632]: wlan0: carrier lost Jun 27 20:58:26 volumiokitchen wpa_supplicant[612]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Jun 27 20:58:26 volumiokitchen wpa_supplicant[612]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=DE Jun 27 20:58:26 volumiokitchen wpa_supplicant[612]: wlan0: Trying to associate with SSID 'Aerathos' Jun 27 20:58:26 volumiokitchen avahi-daemon[357]: Withdrawing address record for 169.254.83.143 on wlan0. Jun 27 20:58:26 volumiokitchen avahi-daemon[357]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 169.254.83.143. Jun 27 20:58:26 volumiokitchen dhcpcd[632]: wlan0: deleting route to 169.254.0.0/16 Jun 27 20:58:26 volumiokitchen dhcpcd[632]: wlan0: deleting default route Jun 27 20:58:26 volumiokitchen avahi-daemon[357]: Interface wlan0.IPv4 no longer relevant for mDNS. Jun 27 20:58:27 volumiokitchen volumio-remote-updater[349]: [2025-06-27 20:58:27] [info] asio async_connect error: system:111 (Connection refused) Jun 27 20:58:27 volumiokitchen volumio-remote-updater[349]: [2025-06-27 20:58:27] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jun 27 20:58:27 volumiokitchen volumio-remote-updater[349]: [2025-06-27 20:58:27] [error] handle_connect error: Underlying Transport Error Jun 27 20:58:27 volumiokitchen wpa_supplicant[612]: wlan0: Associated with e8:48:b8:e7:df:ec Jun 27 20:58:27 volumiokitchen wpa_supplicant[612]: wlan0: CTRL-EVENT-CONNECTED - Connection to e8:48:b8:e7:df:ec completed [id=0 id_str=] Jun 27 20:58:27 volumiokitchen dhcpcd[632]: wlan0: carrier acquired Jun 27 20:58:27 volumiokitchen wpa_supplicant[612]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Jun 27 20:58:27 volumiokitchen wpa_supplicant[612]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=DE Jun 27 20:58:27 volumiokitchen dhcpcd[632]: wlan0: IAID eb:c4:71:a7 Jun 27 20:58:27 volumiokitchen dhcpcd[632]: wlan0: soliciting a DHCP lease Jun 27 20:58:28 volumiokitchen dhcpcd[632]: wlan0: soliciting an IPv6 router Jun 27 20:58:29 volumiokitchen ntpd[439]: Deleting interface #8 wlan0, 169.254.83.143#123, interface stats: received=0, sent=7, dropped=0, active_time=30 secs Jun 27 20:58:29 volumiokitchen ntpd[439]: 213.210.39.123 local addr 169.254.83.143 -> Jun 27 20:58:29 volumiokitchen ntpd[439]: 195.171.43.12 local addr 169.254.83.143 -> Jun 27 20:58:29 volumiokitchen ntpd[439]: 185.53.45.4 local addr 169.254.83.143 -> Jun 27 20:58:29 volumiokitchen ntpd[439]: 77.74.199.184 local addr 169.254.83.143 -> Jun 27 20:58:29 volumiokitchen ntpd[439]: 131.111.8.63 local addr 169.254.83.143 -> Jun 27 20:58:29 volumiokitchen ntpd[439]: 185.103.117.60 local addr 169.254.83.143 -> Jun 27 20:58:32 volumiokitchen volumio[7222]: info: ------------------------------------------- Jun 27 20:58:32 volumiokitchen volumio[7222]: info: ----- Volumio3 ---- Jun 27 20:58:32 volumiokitchen volumio[7222]: info: ------------------------------------------- Jun 27 20:58:32 volumiokitchen volumio[7222]: info: ----- System startup ---- Jun 27 20:58:32 volumiokitchen volumio[7222]: info: ------------------------------------------- Jun 27 20:58:32 volumiokitchen dhcpcd[632]: wlan0: probing for an IPv4LL address Jun 27 20:58:33 volumiokitchen dhcpcd[632]: wlan0: offered 192.168.0.110 from 192.168.0.2 Jun 27 20:58:34 volumiokitchen volumio-remote-updater[349]: [2025-06-27 20:58:34] [connect] Successful connection Jun 27 20:58:36 volumiokitchen volumio[7222]: info: MYVOLUMIO Environment detected Jun 27 20:58:36 volumiokitchen volumio[7222]: info: Plugin folders cleanup Jun 27 20:58:36 volumiokitchen volumio[7222]: info: Scanning into folder /volumio/app/plugins/ Jun 27 20:58:36 volumiokitchen volumio[7222]: info: Scanning category audio_interface Jun 27 20:58:36 volumiokitchen volumio[7222]: info: Scanning category miscellanea Jun 27 20:58:36 volumiokitchen volumio[7222]: info: Scanning category music_service Jun 27 20:58:36 volumiokitchen volumio[7222]: info: Scanning category plugins.json Jun 27 20:58:36 volumiokitchen volumio[7222]: info: Scanning category system_controller Jun 27 20:58:36 volumiokitchen volumio[7222]: info: Scanning category user_interface Jun 27 20:58:36 volumiokitchen volumio[7222]: info: Scanning into folder /data/plugins/ Jun 27 20:58:36 volumiokitchen volumio[7222]: info: Scanning category music_service Jun 27 20:58:36 volumiokitchen volumio[7222]: info: Plugin folders cleanup completed Jun 27 20:58:36 volumiokitchen volumio[7222]: info: ------------------------------------------- Jun 27 20:58:36 volumiokitchen volumio[7222]: info: ----- Core plugins startup ---- Jun 27 20:58:36 volumiokitchen volumio[7222]: info: ------------------------------------------- Jun 27 20:58:36 volumiokitchen volumio[7222]: info: Loading plugins from folder /volumio/app/plugins/ Jun 27 20:58:36 volumiokitchen volumio[7222]: info: Adding plugin upnp to MyMusic Plugins Jun 27 20:58:36 volumiokitchen volumio[7222]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 27 20:58:36 volumiokitchen volumio[7222]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 27 20:58:36 volumiokitchen volumio[7222]: info: Loading plugins from folder /data/plugins/ Jun 27 20:58:36 volumiokitchen volumio[7222]: info: Loading plugin "system"... Jun 27 20:58:36 volumiokitchen volumio[7222]: info: Loading plugin "appearance"... Jun 27 20:58:38 volumiokitchen dhcpcd[632]: wlan0: using IPv4LL address 169.254.83.143 Jun 27 20:58:38 volumiokitchen avahi-daemon[357]: Joining mDNS multicast group on interface wlan0.IPv4 with address 169.254.83.143. Jun 27 20:58:38 volumiokitchen dhcpcd[632]: wlan0: adding route to 169.254.0.0/16 Jun 27 20:58:38 volumiokitchen avahi-daemon[357]: New relevant interface wlan0.IPv4 for mDNS. Jun 27 20:58:38 volumiokitchen avahi-daemon[357]: Registering new address record for 169.254.83.143 on wlan0.IPv4. Jun 27 20:58:38 volumiokitchen dhcpcd[632]: wlan0: adding default route Jun 27 20:58:39 volumiokitchen ntpd[439]: Listen normally on 9 wlan0 169.254.83.143:123 Jun 27 20:58:40 volumiokitchen ntpd[439]: new interface(s) found: waking up resolver Jun 27 20:58:41 volumiokitchen dhcpcd[632]: wlan0: ignoring offer of 192.168.0.110 from 192.168.0.2 Jun 27 20:58:41 volumiokitchen dhcpcd[632]: wlan0: probing address 192.168.0.110/24 Jun 27 20:58:41 volumiokitchen ntpd[439]: Soliciting pool server 51.89.151.183 Jun 27 20:58:42 volumiokitchen volumio[7222]: info: Loading plugin "network"... Jun 27 20:58:42 volumiokitchen volumio[7222]: info: Refreshing Cached IP Addresses Jun 27 20:58:42 volumiokitchen sudo[7290]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 27 20:58:42 volumiokitchen sudo[7290]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 20:58:42 volumiokitchen volumio[7222]: info: Loading plugin "services"... Jun 27 20:58:42 volumiokitchen volumio[7222]: info: Loading plugin "alsa_controller"... Jun 27 20:58:42 volumiokitchen sudo[7292]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 27 20:58:42 volumiokitchen sudo[7292]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 20:58:42 volumiokitchen sudo[7290]: pam_unix(sudo:session): session closed for user root Jun 27 20:58:42 volumiokitchen sudo[7292]: pam_unix(sudo:session): session closed for user root Jun 27 20:58:42 volumiokitchen sudo[7295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 27 20:58:42 volumiokitchen sudo[7295]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 20:58:43 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 27 20:58:43 volumiokitchen volumio[7222]: info: Loading plugin "wizard"... Jun 27 20:58:43 volumiokitchen volumio[7222]: info: Loading plugin "networkfs"... Jun 27 20:58:43 volumiokitchen volumio[7222]: info: Cannot mount NAS RadioSolferino at system boot, trial number 1 ,retrying in 5 seconds Jun 27 20:58:43 volumiokitchen volumio[7222]: info: Starting Udev Watcher for removable devices Jun 27 20:58:44 volumiokitchen sudo[7295]: pam_unix(sudo:session): session closed for user root Jun 27 20:58:44 volumiokitchen volumio[7222]: info: Ignoring mount for partition: boot Jun 27 20:58:44 volumiokitchen volumio[7222]: info: Ignoring mount for partition: volumio Jun 27 20:58:44 volumiokitchen volumio[7222]: info: Ignoring mount for partition: volumio_data Jun 27 20:58:44 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 27 20:58:44 volumiokitchen volumio[7222]: info: Loading plugin "volumio_command_line_client"... Jun 27 20:58:44 volumiokitchen volumio[7222]: info: Loading plugin "upnp"... Jun 27 20:58:44 volumiokitchen volumio[7222]: info: [1751054324533] Starting Upmpd Daemon Jun 27 20:58:44 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 27 20:58:44 volumiokitchen volumio[7222]: info: Loading plugin "my_music"... Jun 27 20:58:44 volumiokitchen volumio[7222]: info: Loading plugin "mpd"... Jun 27 20:58:46 volumiokitchen volumio[7222]: info: Loading plugin "upnp_browser"... Jun 27 20:58:47 volumiokitchen dhcpcd[632]: wlan0: leased 192.168.0.110 for 180 seconds Jun 27 20:58:47 volumiokitchen avahi-daemon[357]: Registering new address record for 192.168.0.110 on wlan0.IPv4. Jun 27 20:58:47 volumiokitchen dhcpcd[632]: wlan0: adding route to 192.168.0.0/24 Jun 27 20:58:47 volumiokitchen dhcpcd[632]: wlan0: changing default route via 192.168.0.2 Jun 27 20:58:47 volumiokitchen avahi-daemon[357]: Withdrawing address record for 169.254.83.143 on wlan0. Jun 27 20:58:47 volumiokitchen avahi-daemon[357]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 169.254.83.143. Jun 27 20:58:47 volumiokitchen dhcpcd[632]: wlan0: deleting route to 169.254.0.0/16 Jun 27 20:58:47 volumiokitchen avahi-daemon[357]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.110. Jun 27 20:58:48 volumiokitchen dhcpcd[632]: wlan0: pid 632 deleted default route via 192.168.0.2 Jun 27 20:58:48 volumiokitchen volumio[7222]: info: Loading plugin "alarm-clock"... Jun 27 20:58:48 volumiokitchen ntpd[439]: Soliciting pool server 95.215.175.2 Jun 27 20:58:48 volumiokitchen ntpd[439]: Listen normally on 10 wlan0 192.168.0.110:123 Jun 27 20:58:49 volumiokitchen ntpd[439]: Deleting interface #9 wlan0, 169.254.83.143#123, interface stats: received=0, sent=7, dropped=1, active_time=9 secs Jun 27 20:58:49 volumiokitchen ntpd[439]: 213.210.39.123 local addr 169.254.83.143 -> Jun 27 20:58:49 volumiokitchen ntpd[439]: 195.171.43.12 local addr 169.254.83.143 -> Jun 27 20:58:49 volumiokitchen ntpd[439]: 185.53.45.4 local addr 169.254.83.143 -> Jun 27 20:58:49 volumiokitchen ntpd[439]: 77.74.199.184 local addr 169.254.83.143 -> Jun 27 20:58:49 volumiokitchen ntpd[439]: 131.111.8.63 local addr 169.254.83.143 -> Jun 27 20:58:49 volumiokitchen ntpd[439]: 185.103.117.60 local addr 169.254.83.143 -> Jun 27 20:58:49 volumiokitchen ntpd[439]: new interface(s) found: waking up resolver Jun 27 20:58:49 volumiokitchen volumio[7222]: info: Plugin airplay_emulation is not enabled Jun 27 20:58:49 volumiokitchen volumio[7222]: info: Loading plugin "last_100"... Jun 27 20:58:49 volumiokitchen volumio[7222]: info: Loading plugin "webradio"... Jun 27 20:58:49 volumiokitchen volumio-remote-updater[349]: [2025-06-27 20:58:49] [connect] Successful connection Jun 27 20:58:49 volumiokitchen volumio[7222]: info: Loading plugin "i2s_dacs"... Jun 27 20:58:49 volumiokitchen volumio[7222]: info: Loading plugin "volumiodiscovery"... Jun 27 20:58:49 volumiokitchen volumio[7222]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 27 20:58:49 volumiokitchen node[7222]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 27 20:58:49 volumiokitchen volumio[7222]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 27 20:58:49 volumiokitchen node[7222]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 27 20:58:50 volumiokitchen volumio[7222]: *** WARNING *** For more information see Jun 27 20:58:50 volumiokitchen volumio[7222]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 27 20:58:50 volumiokitchen volumio[7222]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 27 20:58:50 volumiokitchen volumio[7222]: *** WARNING *** For more information see Jun 27 20:58:50 volumiokitchen node[7222]: *** WARNING *** For more information see Jun 27 20:58:50 volumiokitchen node[7222]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 27 20:58:50 volumiokitchen node[7222]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 27 20:58:50 volumiokitchen node[7222]: *** WARNING *** For more information see Jun 27 20:58:50 volumiokitchen volumio[7222]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 27 20:58:50 volumiokitchen volumio[7222]: info: Discovery: Started advertising with name: volumiokitchen Jun 27 20:58:50 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 27 20:58:50 volumiokitchen volumio[7222]: info: Loading plugin "squeezelite_mc"... Jun 27 20:58:54 volumiokitchen volumio[7222]: info: Loading plugin "outputs"... Jun 27 20:58:54 volumiokitchen volumio[7222]: info: Loading plugin "albumart"... Jun 27 20:58:54 volumiokitchen volumio[7222]: info: Plugin example_plugin is not enabled Jun 27 20:58:54 volumiokitchen volumio[7222]: info: Loading plugin "inputs"... Jun 27 20:58:54 volumiokitchen volumio[7222]: info: Loading plugin "updater_comm"... Jun 27 20:58:55 volumiokitchen volumio[7222]: info: Plugin mpdemulation is not enabled Jun 27 20:58:55 volumiokitchen volumio[7222]: info: Loading plugin "rest_api"... Jun 27 20:58:56 volumiokitchen volumio[7222]: info: Loading plugin "websocket"... Jun 27 20:58:56 volumiokitchen volumio[7222]: info: Plugin minidlna is not enabled Jun 27 20:58:56 volumiokitchen volumio[7222]: info: Loading i18n strings for locale en Jun 27 20:58:56 volumiokitchen volumio[7222]: Updating browse sources language Jun 27 20:58:56 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 27 20:58:58 volumiokitchen volumio[7222]: Forking 1 albumart workers Jun 27 20:58:58 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 27 20:58:58 volumiokitchen volumio[7222]: info: CoreCommandRouter::initPlayerControls Jun 27 20:58:58 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:58:59 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:58:59 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:58:59 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:58:59 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:58:59 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:58:59 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:58:59 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:58:59 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 27 20:58:59 volumiokitchen volumio[7222]: Express server listening on port 3000 Jun 27 20:58:59 volumiokitchen volumio[7222]: [Metrics] WebUI: 29s 827.77ms Jun 27 20:58:59 volumiokitchen volumio[7222]: info: CoreStateMachine::resetVolumioState Jun 27 20:58:59 volumiokitchen volumio[7222]: info: CoreStateMachine::getcurrentVolume Jun 27 20:58:59 volumiokitchen volumio[7222]: info: CoreCommandRouter::volumioRetrievevolume Jun 27 20:58:59 volumiokitchen volumio[7222]: info: Cannot mount NAS RadioSolferino at system boot, trial number 2 ,retrying in 5 seconds Jun 27 20:59:00 volumiokitchen sudo[7368]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 27 20:59:00 volumiokitchen sudo[7366]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 27 20:59:00 volumiokitchen sudo[7368]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 20:59:00 volumiokitchen sudo[7366]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 20:59:00 volumiokitchen sudo[7368]: pam_unix(sudo:session): session closed for user root Jun 27 20:59:00 volumiokitchen sudo[7366]: pam_unix(sudo:session): session closed for user root Jun 27 20:59:01 volumiokitchen volumio[7222]: info: VolumeController:: Volume=95 Mute =false Jun 27 20:59:01 volumiokitchen volumio[7222]: info: CoreStateMachine::pushState Jun 27 20:59:01 volumiokitchen volumio[7222]: info: CorePlayQueue::getTrack 0 Jun 27 20:59:01 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 20:59:01 volumiokitchen volumio[7222]: info: CoreCommandRouter::volumioPushState Jun 27 20:59:01 volumiokitchen volumio[7222]: info: CoreStateMachine::updateTrackBlock Jun 27 20:59:01 volumiokitchen volumio[7222]: info: CorePlayQueue::getTrackBlock Jun 27 20:59:01 volumiokitchen volumio[7222]: info: CoreCommandRouter::volumioRetrievevolume Jun 27 20:59:02 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 27 20:59:02 volumiokitchen volumio[7222]: info: CoreStateMachine::setRepeat true single undefined Jun 27 20:59:02 volumiokitchen volumio[7222]: info: CoreStateMachine::pushState Jun 27 20:59:02 volumiokitchen volumio[7222]: info: CorePlayQueue::getTrack 0 Jun 27 20:59:02 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 20:59:02 volumiokitchen volumio[7222]: info: CoreCommandRouter::volumioPushState Jun 27 20:59:02 volumiokitchen volumio[7222]: info: CoreStateMachine::setRandom true Jun 27 20:59:02 volumiokitchen volumio[7222]: info: CoreStateMachine::pushState Jun 27 20:59:02 volumiokitchen volumio[7222]: info: CorePlayQueue::getTrack 0 Jun 27 20:59:02 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 20:59:02 volumiokitchen volumio[7222]: info: CoreCommandRouter::volumioPushState Jun 27 20:59:02 volumiokitchen volumio[7222]: info: Setting Device type: Raspberry PI Jun 27 20:59:02 volumiokitchen volumio[7222]: info: Discovery: adding feed7cf2-9d3b-4f15-9f40-464b00de2227 Jun 27 20:59:02 volumiokitchen volumio[7222]: info: Discovery: Found device volumiobedroom Jun 27 20:59:03 volumiokitchen volumio[7222]: info: Discovery: Connecting to remote: 10.0.0.1 Jun 27 20:59:03 volumiokitchen volumio[7222]: info: VolumeController:: Volume=95 Mute =false Jun 27 20:59:03 volumiokitchen volumio[7222]: info: CoreStateMachine::pushState Jun 27 20:59:03 volumiokitchen volumio[7222]: info: CorePlayQueue::getTrack 0 Jun 27 20:59:03 volumiokitchen volumio[7222]: info: CoreCommandRouter::volumioPushState Jun 27 20:59:03 volumiokitchen sudo[7383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 27 20:59:03 volumiokitchen sudo[7383]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 20:59:03 volumiokitchen sudo[7383]: pam_unix(sudo:session): session closed for user root Jun 27 20:59:04 volumiokitchen ntpd[439]: Soliciting pool server 10.0.0.1 Jun 27 20:59:04 volumiokitchen volumio-remote-updater[349]: [2025-06-27 20:59:04] [connect] Successful connection Jun 27 20:59:04 volumiokitchen volumio[7222]: info: Reloading queue from file Jun 27 20:59:05 volumiokitchen volumio[7222]: info: Discovery: adding 7fa388f6-1f5c-4994-80e8-870ada811a99 Jun 27 20:59:05 volumiokitchen volumio[7222]: info: Discovery: Found device volumiokitchen Jun 27 20:59:05 volumiokitchen volumio[7222]: info: CoreCommandRouter::volumioGetState Jun 27 20:59:05 volumiokitchen volumio[7222]: info: CorePlayQueue::getTrack 0 Jun 27 20:59:05 volumiokitchen volumio[7222]: info: Cannot mount NAS RadioSolferino at system boot, trial number 3 ,retrying in 5 seconds Jun 27 20:59:05 volumiokitchen volumio[7222]: info: Upmpdcli Daemon Started Jun 27 20:59:05 volumiokitchen volumio-remote-updater[349]: [2025-06-27 20:59:05] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751054344 101 Jun 27 20:59:05 volumiokitchen volumio[7222]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 1 Jun 27 20:59:05 volumiokitchen volumio[7222]: info: Completed loading Core Plugins Jun 27 20:59:05 volumiokitchen volumio[7222]: info: Preparing to generate the ALSA configuration file Jun 27 20:59:06 volumiokitchen volumio[7222]: info: Asound.conf file unchanged, so no further update is needed Jun 27 20:59:06 volumiokitchen volumio[7222]: info: Output device has changed, restarting MPD Jun 27 20:59:06 volumiokitchen volumio[7222]: info: ___________ START PLUGINS ___________ Jun 27 20:59:06 volumiokitchen volumio[7222]: info: ControllerMpd::onStart: Initializing MPD Jun 27 20:59:06 volumiokitchen sudo[7387]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 27 20:59:06 volumiokitchen sudo[7387]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 20:59:06 volumiokitchen volumio[7222]: info: Creating MPD Configuration file Jun 27 20:59:06 volumiokitchen sudo[7387]: pam_unix(sudo:session): session closed for user root Jun 27 20:59:06 volumiokitchen sudo[7389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 27 20:59:06 volumiokitchen sudo[7389]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 20:59:07 volumiokitchen systemd[1]: Stopping Music Player Daemon... Jun 27 20:59:07 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 27 20:59:07 volumiokitchen volumio[7222]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 27 20:59:07 volumiokitchen volumio[7222]: info: [1751054347141] CoreMusicLibrary::Adding element Media Servers Jun 27 20:59:07 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 27 20:59:07 volumiokitchen sudo[7393]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 27 20:59:07 volumiokitchen sudo[7393]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 20:59:07 volumiokitchen sudo[7393]: pam_unix(sudo:session): session closed for user root Jun 27 20:59:07 volumiokitchen sudo[7395]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 27 20:59:07 volumiokitchen sudo[7395]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 20:59:08 volumiokitchen volumio[7222]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 27 20:59:08 volumiokitchen volumio[7222]: info: [1751054347465] CoreMusicLibrary::Adding element Last_100 Jun 27 20:59:08 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 27 20:59:08 volumiokitchen volumio[7222]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 27 20:59:08 volumiokitchen volumio[7222]: info: [1751054347476] CoreMusicLibrary::Adding element Webradio Jun 27 20:59:08 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 27 20:59:08 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 27 20:59:08 volumiokitchen volumio[7222]: info: [squeezelite_mc] Starting proxy server... Jun 27 20:59:08 volumiokitchen volumio[7222]: info: Volumio Calling Home Jun 27 20:59:09 volumiokitchen wpa_supplicant[612]: wlan0: CTRL-EVENT-DISCONNECTED bssid=e8:48:b8:e7:df:ec reason=2 Jun 27 20:59:09 volumiokitchen dhcpcd[632]: wlan0: carrier lost Jun 27 20:59:09 volumiokitchen wpa_supplicant[612]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Jun 27 20:59:09 volumiokitchen wpa_supplicant[612]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=DE Jun 27 20:59:10 volumiokitchen avahi-daemon[357]: Withdrawing address record for 192.168.0.110 on wlan0. Jun 27 20:59:10 volumiokitchen avahi-daemon[357]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.110. Jun 27 20:59:10 volumiokitchen dhcpcd[632]: wlan0: deleting route to 192.168.0.0/24 Jun 27 20:59:10 volumiokitchen avahi-daemon[357]: Interface wlan0.IPv4 no longer relevant for mDNS. Jun 27 20:59:10 volumiokitchen wpa_supplicant[612]: wlan0: Trying to associate with SSID 'Aerathos' Jun 27 20:59:10 volumiokitchen volumio[7222]: info: [squeezelite_mc] Proxy server started on port 42239 Jun 27 20:59:11 volumiokitchen wpa_supplicant[612]: wlan0: Associated with d8:47:32:51:ed:2f Jun 27 20:59:11 volumiokitchen wpa_supplicant[612]: wlan0: CTRL-EVENT-CONNECTED - Connection to d8:47:32:51:ed:2f completed [id=0 id_str=] Jun 27 20:59:11 volumiokitchen wpa_supplicant[612]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Jun 27 20:59:11 volumiokitchen dhcpcd[632]: wlan0: carrier acquired Jun 27 20:59:11 volumiokitchen dhcpcd[632]: wlan0: IAID eb:c4:71:a7 Jun 27 20:59:11 volumiokitchen volumio[7222]: Starting albumart workers Jun 27 20:59:12 volumiokitchen dhcpcd[632]: wlan0: rebinding lease of 192.168.0.110 Jun 27 20:59:12 volumiokitchen dhcpcd[632]: wlan0: soliciting an IPv6 router Jun 27 20:59:12 volumiokitchen volumio[7222]: info: CoreCommandRouter::volumioRetrievevolume Jun 27 20:59:12 volumiokitchen ntpd[439]: Deleting interface #10 wlan0, 192.168.0.110#123, interface stats: received=0, sent=7, dropped=0, active_time=24 secs Jun 27 20:59:13 volumiokitchen ntpd[439]: 213.210.39.123 local addr 192.168.0.110 -> Jun 27 20:59:13 volumiokitchen ntpd[439]: 195.171.43.12 local addr 192.168.0.110 -> Jun 27 20:59:13 volumiokitchen ntpd[439]: 185.53.45.4 local addr 192.168.0.110 -> Jun 27 20:59:13 volumiokitchen ntpd[439]: 77.74.199.184 local addr 192.168.0.110 -> Jun 27 20:59:13 volumiokitchen ntpd[439]: 131.111.8.63 local addr 192.168.0.110 -> Jun 27 20:59:13 volumiokitchen ntpd[439]: 185.103.117.60 local addr 192.168.0.110 -> Jun 27 20:59:13 volumiokitchen volumio[7222]: info: Cannot mount NAS RadioSolferino at system boot, trial number 4 ,retrying in 5 seconds Jun 27 20:59:13 volumiokitchen dhcpcd[632]: wlan0: NAK: address not available from 192.168.0.1 Jun 27 20:59:13 volumiokitchen dhcpcd[632]: wlan0: message: address not available Jun 27 20:59:13 volumiokitchen systemd[1]: mpd.service: Succeeded. Jun 27 20:59:13 volumiokitchen systemd[1]: Stopped Music Player Daemon. Jun 27 20:59:13 volumiokitchen systemd[1]: Starting Music Player Daemon... Jun 27 20:59:13 volumiokitchen volumio[7222]: info: MPD Permissions set Jun 27 20:59:13 volumiokitchen dhcpcd[632]: wlan0: soliciting a DHCP lease Jun 27 20:59:13 volumiokitchen volumio[7222]: info: MPD Permissions set Jun 27 20:59:13 volumiokitchen dhcpcd[632]: wlan0: offered 192.168.0.42 from 192.168.0.1 Jun 27 20:59:13 volumiokitchen dhcpcd[632]: wlan0: probing address 192.168.0.42/24 Jun 27 20:59:14 volumiokitchen volumio[7222]: info: Discovery: A device disappeared from network Jun 27 20:59:14 volumiokitchen volumio[7222]: info: Discovery: Device volumiokitchen disappeared from network Jun 27 20:59:14 volumiokitchen volumio[7222]: info: Discovery: A device disappeared from network Jun 27 20:59:14 volumiokitchen volumio[7222]: info: Discovery: Device volumiobedroom disappeared from network Jun 27 20:59:14 volumiokitchen sudo[7437]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 27 20:59:14 volumiokitchen sudo[7437]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 20:59:14 volumiokitchen sudo[7437]: pam_unix(sudo:session): session closed for user root Jun 27 20:59:14 volumiokitchen volumio[7222]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2 Jun 27 20:59:15 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:59:15 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:59:15 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:59:15 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:59:15 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:59:15 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:59:15 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:59:15 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:59:15 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 27 20:59:15 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:59:15 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:59:15 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:59:15 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:59:15 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:59:15 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:59:15 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:59:15 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:59:15 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:59:15 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 27 20:59:15 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:59:15 volumiokitchen ntpd[439]: Soliciting pool server 109.74.206.120 Jun 27 20:59:17 volumiokitchen volumio[7222]: info: VolumeController:: Volume=95 Mute =false Jun 27 20:59:17 volumiokitchen volumio[7222]: info: CoreStateMachine::pushState Jun 27 20:59:17 volumiokitchen volumio[7222]: info: CorePlayQueue::getTrack 0 Jun 27 20:59:18 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 20:59:18 volumiokitchen volumio[7222]: info: CoreCommandRouter::volumioPushState Jun 27 20:59:18 volumiokitchen volumio[7222]: info: [squeezelite_mc] Server discovery started Jun 27 20:59:18 volumiokitchen volumio[7222]: info: [squeezelite_mc] Player finder started Jun 27 20:59:18 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:59:18 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:59:18 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 20:59:18 volumiokitchen volumio[7222]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 27 20:59:18 volumiokitchen volumio[7222]: info: [squeezelite_mc] Executing aplay -D hw:0 --nonblock -f MPEG /dev/zero 2>&1 || true Jun 27 20:59:18 volumiokitchen dhcpcd[632]: wlan0: leased 192.168.0.42 for infinity Jun 27 20:59:18 volumiokitchen volumio[7222]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 27 20:59:18 volumiokitchen avahi-daemon[357]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.42. Jun 27 20:59:18 volumiokitchen avahi-daemon[357]: New relevant interface wlan0.IPv4 for mDNS. Jun 27 20:59:18 volumiokitchen avahi-daemon[357]: Registering new address record for 192.168.0.42 on wlan0.IPv4. Jun 27 20:59:18 volumiokitchen dhcpcd[632]: wlan0: adding route to 192.168.0.0/24 Jun 27 20:59:18 volumiokitchen dhcpcd[632]: wlan0: adding default route via 192.168.0.1 Jun 27 20:59:19 volumiokitchen volumio[7222]: Error: send ENETUNREACH 255.255.255.255:3483 Jun 27 20:59:19 volumiokitchen volumio[7222]: at doSend (dgram.js:692:16) Jun 27 20:59:19 volumiokitchen volumio[7222]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Jun 27 20:59:19 volumiokitchen volumio[7222]: at afterDns (dgram.js:638:5) Jun 27 20:59:19 volumiokitchen volumio[7222]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Jun 27 20:59:19 volumiokitchen volumio[7222]: errno: -101, Jun 27 20:59:19 volumiokitchen volumio[7222]: code: 'ENETUNREACH', Jun 27 20:59:19 volumiokitchen volumio[7222]: syscall: 'send', Jun 27 20:59:19 volumiokitchen volumio[7222]: address: '255.255.255.255', Jun 27 20:59:19 volumiokitchen volumio[7222]: port: 3483 Jun 27 20:59:19 volumiokitchen volumio[7222]: } Jun 27 20:59:19 volumiokitchen volumio[7222]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 27 20:59:19 volumiokitchen ntpd[439]: Listen normally on 11 wlan0 192.168.0.42:123 Jun 27 20:59:20 volumiokitchen ntpd[439]: new interface(s) found: waking up resolver Jun 27 20:59:22 volumiokitchen nmbd[415]: [2025/06/27 20:59:22.522690, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jun 27 20:59:22 volumiokitchen nmbd[415]: Packet send failed to 169.254.255.255(138) ERRNO=Network is unreachable Jun 27 20:59:28 volumiokitchen sudo[7511]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-27 20:58 Jun 27 20:59:28 volumiokitchen sudo[7511]: 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="f8baf7ad070f376535a93fcc6590774528ddb153" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="0e3cf2fcfe1906c5090fab62b4cc2a5ff0069fd8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 30 Jan 2024 03:58:37 PM CET" VOLUMIO_VERSION="3.611" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="1d6379ebb89c40061afa8aee78176887"