-- Logs begin at Sun 2026-08-30 23:23:30 CEST, end at Mon 2026-08-31 06:28:07 CEST. -- Aug 31 06:27:08 volumio-bedroom volumiologrotate[677]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Aug 31 06:27:08 volumio-bedroom volumiologrotate[677]: ls: cannot access 'BEDROOM': No such file or directory Aug 31 06:27:43 volumio-bedroom wpa_supplicant[914]: wlan0: CTRL-EVENT-DISCONNECTED bssid=18:e8:29:b0:ed:30 reason=0 locally_generated=1 Aug 31 06:27:43 volumio-bedroom dhcpcd[980]: wlan0: carrier lost Aug 31 06:27:43 volumio-bedroom wpa_supplicant[914]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Aug 31 06:27:43 volumio-bedroom wpa_supplicant[914]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=NL Aug 31 06:27:44 volumio-bedroom avahi-daemon[625]: Withdrawing address record for 192.168.2.146 on wlan0. Aug 31 06:27:44 volumio-bedroom avahi-daemon[625]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.2.146. Aug 31 06:27:44 volumio-bedroom dhcpcd[980]: wlan0: deleting route to 192.168.2.0/24 Aug 31 06:27:44 volumio-bedroom dhcpcd[980]: eth0: deleting route to 192.168.2.0/24 Aug 31 06:27:44 volumio-bedroom dhcpcd[980]: wlan0: deleting default route via 192.168.2.1 Aug 31 06:27:44 volumio-bedroom dhcpcd[980]: eth0: deleting default route via 192.168.2.1 Aug 31 06:27:44 volumio-bedroom dhcpcd[1027]: eth0: pid 980 deleted route to 192.168.2.0/24 Aug 31 06:27:44 volumio-bedroom dhcpcd[1027]: eth0: pid 980 deleted default route via 192.168.2.1 Aug 31 06:27:44 volumio-bedroom avahi-daemon[625]: Interface wlan0.IPv4 no longer relevant for mDNS. Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: Discovery: A device disappeared from network Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: Discovery: A device disappeared from network Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: Discovery: A device disappeared from network Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: Discovery: A device disappeared from network Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: Discovery: A device disappeared from network Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: Discovery: A device disappeared from network Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: Discovery: A device disappeared from network Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: Discovery: A device disappeared from network Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: Discovery: A device disappeared from network Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: Discovery: A device disappeared from network Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: Discovery: A device disappeared from network Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: Discovery: A device disappeared from network Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: Discovery: A device disappeared from network Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: Discovery: A device disappeared from network Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: Received Get System Info Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: Discovery: Getting this device information Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: CoreCommandRouter::volumioGetState Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: CorePlayQueue::getTrack 0 Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: Received Get System Info Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: Discovery: Getting this device information Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: CoreCommandRouter::volumioGetState Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: CorePlayQueue::getTrack 0 Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 31 06:27:44 volumio-bedroom volumio[1589]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 31 06:27:45 volumio-bedroom volumio[1589]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 06:27:45 volumio-bedroom volumio[1589]: Error: send ENETUNREACH 255.255.255.255:3483 Aug 31 06:27:45 volumio-bedroom volumio[1589]: at doSend (dgram.js:692:16) Aug 31 06:27:45 volumio-bedroom volumio[1589]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Aug 31 06:27:45 volumio-bedroom volumio[1589]: at afterDns (dgram.js:638:5) Aug 31 06:27:45 volumio-bedroom volumio[1589]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Aug 31 06:27:45 volumio-bedroom volumio[1589]: errno: -101, Aug 31 06:27:45 volumio-bedroom volumio[1589]: code: 'ENETUNREACH', Aug 31 06:27:45 volumio-bedroom volumio[1589]: syscall: 'send', Aug 31 06:27:45 volumio-bedroom volumio[1589]: address: '255.255.255.255', Aug 31 06:27:45 volumio-bedroom volumio[1589]: port: 3483 Aug 31 06:27:45 volumio-bedroom volumio[1589]: } Aug 31 06:27:45 volumio-bedroom volumio[1589]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 06:27:45 volumio-bedroom ntpd[818]: Deleting interface #942 wlan0, 192.168.2.146#123, interface stats: received=0, sent=0, dropped=0, active_time=156 secs Aug 31 06:27:45 volumio-bedroom sudo[2502]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-31 06:26 Aug 31 06:27:45 volumio-bedroom sudo[2502]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:27:45 volumio-bedroom sudo[2502]: pam_unix(sudo:session): session closed for user root Aug 31 06:27:45 volumio-bedroom volumio-remote-updater[674]: [2026-08-31 06:27:45] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Aug 31 06:27:45 volumio-bedroom volumio-remote-updater[674]: [2026-08-31 06:27:45] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Aug 31 06:27:45 volumio-bedroom volumio5-onboarding[1340]: time=2026-08-31T06:27:45.462+02:00 level=ERROR msg="failed reading message" error="websocket: close 1006 (abnormal closure): unexpected EOF" Aug 31 06:27:45 volumio-bedroom systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Aug 31 06:27:45 volumio-bedroom volumio5-onboarding[1340]: time=2026-08-31T06:27:45.463+02:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Aug 31 06:27:45 volumio-bedroom systemd[1]: volumio.service: Failed with result 'exit-code'. Aug 31 06:27:45 volumio-bedroom systemd[1]: Started dynamicswap service. Aug 31 06:27:45 volumio-bedroom systemd[1]: dynamicswap.service: Succeeded. Aug 31 06:27:45 volumio-bedroom systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Aug 31 06:27:45 volumio-bedroom systemd[1]: volumio.service: Scheduled restart job, restart counter is at 4. Aug 31 06:27:45 volumio-bedroom systemd[1]: Started dynamicswap service. Aug 31 06:27:45 volumio-bedroom systemd[1]: Stopped Volumio Backend Module. Aug 31 06:27:45 volumio-bedroom systemd[1]: Started Volumio Backend Module. Aug 31 06:27:45 volumio-bedroom systemd[1]: dynamicswap.service: Succeeded. Aug 31 06:27:46 volumio-bedroom volumio5-onboarding[1340]: time=2026-08-31T06:27:46.465+02:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Aug 31 06:27:46 volumio-bedroom volumio[2518]: info: ------------------------------------------- Aug 31 06:27:46 volumio-bedroom volumio[2518]: info: ----- Volumio3 ---- Aug 31 06:27:46 volumio-bedroom volumio[2518]: info: ------------------------------------------- Aug 31 06:27:46 volumio-bedroom volumio[2518]: info: ----- System startup ---- Aug 31 06:27:46 volumio-bedroom volumio[2518]: info: ------------------------------------------- Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: MYVOLUMIO Environment detected Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: Plugin folders cleanup Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: Scanning into folder /volumio/app/plugins/ Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: Scanning category audio_interface Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: Scanning category miscellanea Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: Scanning category music_service Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: Scanning category plugins.json Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: Scanning category system_controller Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: Scanning category user_interface Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: Scanning into folder /data/plugins/ Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: Scanning category music_service Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: Scanning category system_hardware Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: Scanning category user_interface Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: Plugin folders cleanup completed Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: ------------------------------------------- Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: ----- Core plugins startup ---- Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: ------------------------------------------- Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: Loading plugins from folder /volumio/app/plugins/ Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: Adding plugin upnp to MyMusic Plugins Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: Loading plugins from folder /data/plugins/ Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: Loading plugin "system"... Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: Loading plugin "appearance"... Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: Loading plugin "network"... Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: Refreshing Cached IP Addresses Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: Loading plugin "services"... Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: Loading plugin "volumio5onboarding"... Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: Loading plugin "alsa_controller"... Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: Loading plugin "wizard"... Aug 31 06:27:47 volumio-bedroom volumio[2518]: info: Loading plugin "networkfs"... Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: Cannot mount NAS DSD256 at system boot, trial number 1 ,retrying in 5 seconds Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: Cannot mount NAS DSD at system boot, trial number 1 ,retrying in 5 seconds Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: Cannot mount NAS FLAC at system boot, trial number 1 ,retrying in 5 seconds Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: Starting Udev Watcher for removable devices Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: Ignoring mount for partition: boot Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: Ignoring mount for partition: volumio Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: Ignoring mount for partition: volumio_data Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: Loading plugin "volumio_command_line_client"... Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: Loading plugin "upnp"... Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: [1788150468034] Starting Upmpd Daemon Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: Loading plugin "my_music"... Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: Loading plugin "mpd"... Aug 31 06:27:48 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd022 fail, reason -52 Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: Loading plugin "upnp_browser"... Aug 31 06:27:48 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd026 fail, reason -52 Aug 31 06:27:48 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02a fail, reason -52 Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: Starting UPNP Browser Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: Loading plugin "alarm-clock"... Aug 31 06:27:48 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02e fail, reason -52 Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: Alarm: Scheduling Playlist Radio NPO at 7:0 Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: Loading plugin "airplay_emulation"... Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: Starting Shairport Sync Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: Loading plugin "last_100"... Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: Loading plugin "webradio"... Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: Loading plugin "i2s_dacs"... Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: Loading plugin "volumiodiscovery"... Aug 31 06:27:48 volumio-bedroom volumio[2518]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 31 06:27:48 volumio-bedroom volumio[2518]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 31 06:27:48 volumio-bedroom volumio[2518]: *** WARNING *** For more information see Aug 31 06:27:48 volumio-bedroom volumio[2518]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 31 06:27:48 volumio-bedroom node[2518]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 31 06:27:48 volumio-bedroom volumio[2518]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 31 06:27:48 volumio-bedroom volumio[2518]: *** WARNING *** For more information see Aug 31 06:27:48 volumio-bedroom node[2518]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 31 06:27:48 volumio-bedroom node[2518]: *** WARNING *** For more information see Aug 31 06:27:48 volumio-bedroom node[2518]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 31 06:27:48 volumio-bedroom node[2518]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 31 06:27:48 volumio-bedroom node[2518]: *** WARNING *** For more information see Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: Discovery: Started advertising with name: Volumio Bedroom Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: Plugin spop is not enabled Aug 31 06:27:48 volumio-bedroom volumio[2518]: info: Loading plugin "squeezelite_mc"... Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: Plugin now_playing is not enabled Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: Loading plugin "outputs"... Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: Loading plugin "albumart"... Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: Plugin example_plugin is not enabled Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: Loading plugin "inputs"... Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: Loading plugin "updater_comm"... Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: Plugin mpdemulation is not enabled Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: Loading plugin "rest_api"... Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: Loading plugin "websocket"... Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: Starting Socket.io Server version 2.3.0 Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: Loading plugin "audiophonics_evo_sabre"... Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: Applying required configuration parameters for plugin audiophonics_evo_sabre Aug 31 06:27:49 volumio-bedroom volumio[2518]: Forking 3 albumart workers Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: Plugin mpd_oled is not enabled Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: Loading i18n strings for locale en Aug 31 06:27:49 volumio-bedroom volumio[2518]: Updating browse sources language Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CoreCommandRouter::initPlayerControls Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 06:27:49 volumio-bedroom volumio[2518]: Express server listening on port 3000 Aug 31 06:27:49 volumio-bedroom volumio[2518]: [Metrics] WebUI: 2s 958.31ms Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CoreStateMachine::resetVolumioState Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CoreStateMachine::getcurrentVolume Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CoreCommandRouter::volumioRetrievevolume Aug 31 06:27:49 volumio-bedroom volumio[2518]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Aug 31 06:27:49 volumio-bedroom volumio[2518]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Aug 31 06:27:49 volumio-bedroom volumio[2518]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: Reloading queue from file Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: VolumeController:: Volume=70 Mute =true Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CoreStateMachine::pushState Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CorePlayQueue::getTrack 0 Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CoreCommandRouter::volumioPushState Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CoreStateMachine::updateTrackBlock Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CorePlayQueue::getTrackBlock Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CoreCommandRouter::volumioRetrievevolume Aug 31 06:27:49 volumio-bedroom volumio[2518]: Starting albumart workers Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CoreStateMachine::setRepeat true single undefined Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CoreStateMachine::pushState Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CorePlayQueue::getTrack 0 Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CoreCommandRouter::volumioPushState Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CoreStateMachine::setRandom null Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CoreStateMachine::pushState Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CorePlayQueue::getTrack 0 Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: CoreCommandRouter::volumioPushState Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03115 Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: Setting Device type: Raspberry PI Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: Discovery: adding 56407226-c5a5-48c6-97da-e8b8840229cc Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: Discovery: Found device VolumioDAC Aug 31 06:27:49 volumio-bedroom volumio[2518]: info: Discovery: Connecting to remote: 192.168.2.126 Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: VolumeController:: Volume=70 Mute =true Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreStateMachine::pushState Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CorePlayQueue::getTrack 0 Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::volumioPushState Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: Discovery: adding 1ae4494d-87e1-45e1-802e-ef1104d1910e Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: Discovery: Found device Volumio Bedroom Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::volumioGetState Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CorePlayQueue::getTrack 0 Aug 31 06:27:50 volumio-bedroom volumio[2518]: Starting albumart workers Aug 31 06:27:50 volumio-bedroom volumio[2518]: Starting albumart workers Aug 31 06:27:50 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd090 fail, reason -52 Aug 31 06:27:50 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd095 fail, reason -52 Aug 31 06:27:50 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd099 fail, reason -52 Aug 31 06:27:50 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd09d fail, reason -52 Aug 31 06:27:50 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd0a1 fail, reason -52 Aug 31 06:27:50 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd0a5 fail, reason -52 Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: Received Get System Info Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: Discovery: Getting this device information Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::volumioGetState Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CorePlayQueue::getTrack 0 Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 31 06:27:50 volumio-bedroom sudo[2546]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 31 06:27:50 volumio-bedroom sudo[2544]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 31 06:27:50 volumio-bedroom sudo[2546]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:27:50 volumio-bedroom sudo[2544]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:27:50 volumio-bedroom sudo[2553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 31 06:27:50 volumio-bedroom sudo[2553]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:27:50 volumio-bedroom sudo[2546]: pam_unix(sudo:session): session closed for user root Aug 31 06:27:50 volumio-bedroom sudo[2544]: pam_unix(sudo:session): session closed for user root Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: Completed loading Core Plugins Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: Preparing to generate the ALSA configuration file Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: Volumio Network Manager: Network status updated: 1 Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: Asound.conf file unchanged, so no further update is needed Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: Output device has changed, restarting MPD Aug 31 06:27:50 volumio-bedroom sudo[2633]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 31 06:27:50 volumio-bedroom sudo[2633]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: Output device has changed, restarting Shairport Sync Aug 31 06:27:50 volumio-bedroom sudo[2633]: pam_unix(sudo:session): session closed for user root Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 06:27:50 volumio-bedroom sudo[2642]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 31 06:27:50 volumio-bedroom sudo[2642]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:27:50 volumio-bedroom volumio-remote-updater[674]: [2026-08-31 06:27:50] [connect] Successful connection Aug 31 06:27:50 volumio-bedroom systemd[1]: Stopping Music Player Daemon... Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: ___________ START PLUGINS ___________ Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: ControllerMpd::onStart: Initializing MPD Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: Creating MPD Configuration file Aug 31 06:27:50 volumio-bedroom sudo[2650]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Aug 31 06:27:50 volumio-bedroom sudo[2650]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:27:50 volumio-bedroom sudo[2653]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 31 06:27:50 volumio-bedroom sudo[2653]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:27:50 volumio-bedroom sudo[2653]: pam_unix(sudo:session): session closed for user root Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: [1788150470558] CoreMusicLibrary::Adding element Media Servers Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 06:27:50 volumio-bedroom sudo[2656]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 31 06:27:50 volumio-bedroom sudo[2656]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: UPNP Browser: Client initialized successfully Aug 31 06:27:50 volumio-bedroom sudo[2650]: pam_unix(sudo:session): session closed for user root Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 06:27:50 volumio-bedroom systemd[1]: mpd.service: Succeeded. Aug 31 06:27:50 volumio-bedroom systemd[1]: Stopped Music Player Daemon. Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: [1788150470660] CoreMusicLibrary::Adding element Last_100 Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: [1788150470662] CoreMusicLibrary::Adding element Webradio Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: Initializing BBC Radios Aug 31 06:27:50 volumio-bedroom systemd[1]: Starting Music Player Daemon... Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: [squeezelite_mc] Starting proxy server... Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: EVO SABRE : Starting Plugin Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: Loading i18n strings for locale en Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: Volumio Calling Home Aug 31 06:27:50 volumio-bedroom sudo[2661]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 31 06:27:50 volumio-bedroom sudo[2661]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:27:50 volumio-bedroom sudo[2661]: pam_unix(sudo:session): session closed for user root Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: [squeezelite_mc] Proxy server started on port 35161 Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::volumioRetrievevolume Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: MPD Permissions set Aug 31 06:27:50 volumio-bedroom sudo[2685]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Aug 31 06:27:50 volumio-bedroom volumio[2518]: 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: 3 Aug 31 06:27:50 volumio-bedroom sudo[2685]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:27:50 volumio-bedroom volumio-remote-updater[674]: [2026-08-31 06:27:50] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1788150470 101 Aug 31 06:27:50 volumio-bedroom systemd[1]: Reloading. Aug 31 06:27:50 volumio-bedroom volumio[2518]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:50 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:51 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:51 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:51 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 06:27:51 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:51 volumio-bedroom volumio[2518]: info: VolumeController:: Volume=70 Mute =true Aug 31 06:27:51 volumio-bedroom volumio[2518]: info: CoreStateMachine::pushState Aug 31 06:27:51 volumio-bedroom volumio[2518]: info: CorePlayQueue::getTrack 0 Aug 31 06:27:51 volumio-bedroom volumio[2518]: info: CoreCommandRouter::volumioPushState Aug 31 06:27:51 volumio-bedroom volumio[2518]: info: [squeezelite_mc] Server discovery started Aug 31 06:27:51 volumio-bedroom volumio[2518]: info: [squeezelite_mc] Player finder started Aug 31 06:27:51 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:51 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:51 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:51 volumio-bedroom volumio[2518]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 06:27:51 volumio-bedroom volumio[2518]: info: [squeezelite_mc] Executing aplay -D hw:2 --nonblock -f MPEG /dev/zero 2>&1 || true Aug 31 06:27:51 volumio-bedroom volumio[2518]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 06:27:51 volumio-bedroom volumio[2518]: Error: send ENETUNREACH 255.255.255.255:3483 Aug 31 06:27:51 volumio-bedroom volumio[2518]: at doSend (dgram.js:692:16) Aug 31 06:27:51 volumio-bedroom volumio[2518]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Aug 31 06:27:51 volumio-bedroom volumio[2518]: at afterDns (dgram.js:638:5) Aug 31 06:27:51 volumio-bedroom volumio[2518]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Aug 31 06:27:51 volumio-bedroom volumio[2518]: errno: -101, Aug 31 06:27:51 volumio-bedroom volumio[2518]: code: 'ENETUNREACH', Aug 31 06:27:51 volumio-bedroom volumio[2518]: syscall: 'send', Aug 31 06:27:51 volumio-bedroom volumio[2518]: address: '255.255.255.255', Aug 31 06:27:51 volumio-bedroom volumio[2518]: port: 3483 Aug 31 06:27:51 volumio-bedroom volumio[2518]: } Aug 31 06:27:51 volumio-bedroom volumio[2518]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 06:27:51 volumio-bedroom systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Aug 31 06:27:51 volumio-bedroom sudo[2721]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-31 06:26 Aug 31 06:27:51 volumio-bedroom sudo[2721]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:27:51 volumio-bedroom sudo[2721]: pam_unix(sudo:session): session closed for user root Aug 31 06:27:51 volumio-bedroom sudo[2685]: pam_unix(sudo:session): session closed for user root Aug 31 06:27:51 volumio-bedroom mpd[2681]: Aug 31 06:27 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 31 06:27:51 volumio-bedroom volumio5-onboarding[1340]: time=2026-08-31T06:27:51.714+02:00 level=ERROR msg="failed reading message" error="websocket: close 1006 (abnormal closure): unexpected EOF" Aug 31 06:27:51 volumio-bedroom volumio-remote-updater[674]: [2026-08-31 06:27:51] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Aug 31 06:27:51 volumio-bedroom volumio-remote-updater[674]: [2026-08-31 06:27:51] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Aug 31 06:27:51 volumio-bedroom systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Aug 31 06:27:51 volumio-bedroom volumio5-onboarding[1340]: time=2026-08-31T06:27:51.719+02:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Aug 31 06:27:51 volumio-bedroom sudo[2553]: pam_unix(sudo:session): session closed for user root Aug 31 06:27:51 volumio-bedroom sudo[2642]: pam_unix(sudo:session): session closed for user root Aug 31 06:27:51 volumio-bedroom sudo[2656]: pam_unix(sudo:session): session closed for user root Aug 31 06:27:51 volumio-bedroom systemd[1]: volumio.service: Failed with result 'exit-code'. Aug 31 06:27:51 volumio-bedroom systemd[1]: Started dynamicswap service. Aug 31 06:27:51 volumio-bedroom systemd[1]: dynamicswap.service: Succeeded. Aug 31 06:27:52 volumio-bedroom systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Aug 31 06:27:52 volumio-bedroom systemd[1]: volumio.service: Scheduled restart job, restart counter is at 5. Aug 31 06:27:52 volumio-bedroom systemd[1]: Started dynamicswap service. Aug 31 06:27:52 volumio-bedroom systemd[1]: Stopped Volumio Backend Module. Aug 31 06:27:52 volumio-bedroom systemd[1]: Started Volumio Backend Module. Aug 31 06:27:52 volumio-bedroom systemd[1]: dynamicswap.service: Succeeded. Aug 31 06:27:52 volumio-bedroom systemd[1]: Started Music Player Daemon. Aug 31 06:27:52 volumio-bedroom volumio5-onboarding[1340]: time=2026-08-31T06:27:52.720+02:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: ------------------------------------------- Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: ----- Volumio3 ---- Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: ------------------------------------------- Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: ----- System startup ---- Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: ------------------------------------------- Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: MYVOLUMIO Environment detected Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: Plugin folders cleanup Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: Scanning into folder /volumio/app/plugins/ Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: Scanning category audio_interface Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: Scanning category miscellanea Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: Scanning category music_service Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: Scanning category plugins.json Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: Scanning category system_controller Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: Scanning category user_interface Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: Scanning into folder /data/plugins/ Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: Scanning category music_service Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: Scanning category system_hardware Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: Scanning category user_interface Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: Plugin folders cleanup completed Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: ------------------------------------------- Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: ----- Core plugins startup ---- Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: ------------------------------------------- Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: Loading plugins from folder /volumio/app/plugins/ Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: Adding plugin upnp to MyMusic Plugins Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: Loading plugins from folder /data/plugins/ Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: Loading plugin "system"... Aug 31 06:27:53 volumio-bedroom volumio[2735]: info: Loading plugin "appearance"... Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Loading plugin "network"... Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Refreshing Cached IP Addresses Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Loading plugin "services"... Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Loading plugin "volumio5onboarding"... Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Loading plugin "alsa_controller"... Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Loading plugin "wizard"... Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Loading plugin "networkfs"... Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Cannot mount NAS DSD256 at system boot, trial number 1 ,retrying in 5 seconds Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Cannot mount NAS DSD at system boot, trial number 1 ,retrying in 5 seconds Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Cannot mount NAS FLAC at system boot, trial number 1 ,retrying in 5 seconds Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Starting Udev Watcher for removable devices Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Ignoring mount for partition: boot Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Ignoring mount for partition: volumio Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Ignoring mount for partition: volumio_data Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Loading plugin "volumio_command_line_client"... Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Loading plugin "upnp"... Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: [1788150474339] Starting Upmpd Daemon Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Loading plugin "my_music"... Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Loading plugin "mpd"... Aug 31 06:27:54 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd022 fail, reason -52 Aug 31 06:27:54 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd026 fail, reason -52 Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Loading plugin "upnp_browser"... Aug 31 06:27:54 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02a fail, reason -52 Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Starting UPNP Browser Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Loading plugin "alarm-clock"... Aug 31 06:27:54 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02e fail, reason -52 Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Alarm: Scheduling Playlist Radio NPO at 7:0 Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Loading plugin "airplay_emulation"... Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Starting Shairport Sync Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Loading plugin "last_100"... Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Loading plugin "webradio"... Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Loading plugin "i2s_dacs"... Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Loading plugin "volumiodiscovery"... Aug 31 06:27:54 volumio-bedroom volumio[2735]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 31 06:27:54 volumio-bedroom volumio[2735]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 31 06:27:54 volumio-bedroom volumio[2735]: *** WARNING *** For more information see Aug 31 06:27:54 volumio-bedroom volumio[2735]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 31 06:27:54 volumio-bedroom node[2735]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 31 06:27:54 volumio-bedroom volumio[2735]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 31 06:27:54 volumio-bedroom volumio[2735]: *** WARNING *** For more information see Aug 31 06:27:54 volumio-bedroom node[2735]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 31 06:27:54 volumio-bedroom node[2735]: *** WARNING *** For more information see Aug 31 06:27:54 volumio-bedroom node[2735]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 31 06:27:54 volumio-bedroom node[2735]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 31 06:27:54 volumio-bedroom node[2735]: *** WARNING *** For more information see Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Discovery: Started advertising with name: Volumio Bedroom Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Plugin spop is not enabled Aug 31 06:27:54 volumio-bedroom volumio[2735]: info: Loading plugin "squeezelite_mc"... Aug 31 06:27:55 volumio-bedroom volumio[2735]: info: Plugin now_playing is not enabled Aug 31 06:27:55 volumio-bedroom volumio[2735]: info: Loading plugin "outputs"... Aug 31 06:27:55 volumio-bedroom volumio[2735]: info: Loading plugin "albumart"... Aug 31 06:27:55 volumio-bedroom volumio[2735]: info: Plugin example_plugin is not enabled Aug 31 06:27:55 volumio-bedroom volumio[2735]: info: Loading plugin "inputs"... Aug 31 06:27:55 volumio-bedroom volumio[2735]: info: Loading plugin "updater_comm"... Aug 31 06:27:55 volumio-bedroom volumio[2735]: info: Plugin mpdemulation is not enabled Aug 31 06:27:55 volumio-bedroom volumio[2735]: info: Loading plugin "rest_api"... Aug 31 06:27:55 volumio-bedroom volumio[2735]: info: Loading plugin "websocket"... Aug 31 06:27:55 volumio-bedroom volumio[2735]: info: Starting Socket.io Server version 2.3.0 Aug 31 06:27:55 volumio-bedroom volumio[2735]: info: Loading plugin "audiophonics_evo_sabre"... Aug 31 06:27:55 volumio-bedroom volumio[2735]: info: Applying required configuration parameters for plugin audiophonics_evo_sabre Aug 31 06:27:55 volumio-bedroom volumio[2735]: Forking 3 albumart workers Aug 31 06:27:55 volumio-bedroom volumio[2735]: info: Plugin mpd_oled is not enabled Aug 31 06:27:55 volumio-bedroom volumio[2735]: info: Loading i18n strings for locale en Aug 31 06:27:55 volumio-bedroom volumio[2735]: Updating browse sources language Aug 31 06:27:55 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 06:27:55 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 06:27:55 volumio-bedroom volumio[2735]: info: CoreCommandRouter::initPlayerControls Aug 31 06:27:55 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:55 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 06:27:55 volumio-bedroom volumio[2735]: Express server listening on port 3000 Aug 31 06:27:55 volumio-bedroom volumio[2735]: [Metrics] WebUI: 2s 961.81ms Aug 31 06:27:55 volumio-bedroom volumio[2735]: info: CoreStateMachine::resetVolumioState Aug 31 06:27:55 volumio-bedroom volumio[2735]: info: CoreStateMachine::getcurrentVolume Aug 31 06:27:55 volumio-bedroom volumio[2735]: info: CoreCommandRouter::volumioRetrievevolume Aug 31 06:27:55 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: Reloading queue from file Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 06:27:56 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: VolumeController:: Volume=70 Mute =true Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreStateMachine::pushState Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CorePlayQueue::getTrack 0 Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreCommandRouter::volumioPushState Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreStateMachine::updateTrackBlock Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CorePlayQueue::getTrackBlock Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreCommandRouter::volumioRetrievevolume Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreStateMachine::setRepeat true single undefined Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreStateMachine::pushState Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CorePlayQueue::getTrack 0 Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreCommandRouter::volumioPushState Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreStateMachine::setRandom null Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreStateMachine::pushState Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CorePlayQueue::getTrack 0 Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreCommandRouter::volumioPushState Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: Setting Device type: Raspberry PI Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03115 Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Aug 31 06:27:56 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:27:56 volumio-bedroom volumio[2735]: Starting albumart workers Aug 31 06:27:56 volumio-bedroom volumio[2735]: Starting albumart workers Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: Discovery: adding 56407226-c5a5-48c6-97da-e8b8840229cc Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: Discovery: Found device VolumioDAC Aug 31 06:27:56 volumio-bedroom volumio[2735]: Starting albumart workers Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: Discovery: Connecting to remote: 192.168.2.126 Aug 31 06:27:56 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: VolumeController:: Volume=70 Mute =true Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreStateMachine::pushState Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CorePlayQueue::getTrack 0 Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreCommandRouter::volumioPushState Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: Discovery: adding 1ae4494d-87e1-45e1-802e-ef1104d1910e Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: Discovery: Found device Volumio Bedroom Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreCommandRouter::volumioGetState Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CorePlayQueue::getTrack 0 Aug 31 06:27:56 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:27:56 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:27:56 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:27:56 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:27:56 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:27:56 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:27:56 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:27:56 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:27:56 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:27:56 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:27:56 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:27:56 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:27:56 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:27:56 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:27:56 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:27:56 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:27:56 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:27:56 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:27:56 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:27:56 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:27:56 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:27:56 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:27:56 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd090 fail, reason -52 Aug 31 06:27:56 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd095 fail, reason -52 Aug 31 06:27:56 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd099 fail, reason -52 Aug 31 06:27:56 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd09d fail, reason -52 Aug 31 06:27:56 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd0a1 fail, reason -52 Aug 31 06:27:56 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd0a5 fail, reason -52 Aug 31 06:27:56 volumio-bedroom sudo[2764]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 31 06:27:56 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:27:56 volumio-bedroom sudo[2766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 31 06:27:56 volumio-bedroom sudo[2766]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:27:56 volumio-bedroom sudo[2764]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:27:56 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: Received Get System Info Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: Discovery: Getting this device information Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreCommandRouter::volumioGetState Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CorePlayQueue::getTrack 0 Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 06:27:56 volumio-bedroom sudo[2766]: pam_unix(sudo:session): session closed for user root Aug 31 06:27:56 volumio-bedroom sudo[2764]: pam_unix(sudo:session): session closed for user root Aug 31 06:27:56 volumio-bedroom sudo[2773]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 31 06:27:56 volumio-bedroom sudo[2773]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:27:56 volumio-bedroom sudo[2773]: pam_unix(sudo:session): session closed for user root Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: Completed loading Core Plugins Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: Preparing to generate the ALSA configuration file Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 31 06:27:56 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Aug 31 06:27:56 volumio-bedroom volumio[2735]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Aug 31 06:27:56 volumio-bedroom volumio[2735]: wlan0 Interface doesn't support scanning : Device or resource busy Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: Cannot use regular scanning, forcing with ap-force Aug 31 06:27:56 volumio-bedroom volumio-remote-updater[674]: [2026-08-31 06:27:56] [connect] Successful connection Aug 31 06:27:56 volumio-bedroom sudo[2848]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Aug 31 06:27:56 volumio-bedroom sudo[2848]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:27:56 volumio-bedroom sudo[2848]: pam_unix(sudo:session): session closed for user root Aug 31 06:27:56 volumio-bedroom volumio[2735]: command failed: Device or resource busy (-16) Aug 31 06:27:56 volumio-bedroom volumio[2735]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Aug 31 06:27:56 volumio-bedroom volumio[2735]: command failed: Device or resource busy (-16) Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: Volumio Network Manager: Network status updated: 1 Aug 31 06:27:56 volumio-bedroom volumio-remote-updater[674]: [2026-08-31 06:27:56] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1788150476 101 Aug 31 06:27:56 volumio-bedroom volumio[2735]: 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: 3 Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: Asound.conf file unchanged, so no further update is needed Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: Output device has changed, restarting MPD Aug 31 06:27:56 volumio-bedroom sudo[2863]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 31 06:27:56 volumio-bedroom sudo[2863]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: Output device has changed, restarting Shairport Sync Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 06:27:56 volumio-bedroom sudo[2863]: pam_unix(sudo:session): session closed for user root Aug 31 06:27:56 volumio-bedroom sudo[2866]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 31 06:27:56 volumio-bedroom sudo[2866]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:27:56 volumio-bedroom systemd[1]: Stopping Music Player Daemon... Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: ___________ START PLUGINS ___________ Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: ControllerMpd::onStart: Initializing MPD Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: Creating MPD Configuration file Aug 31 06:27:56 volumio-bedroom sudo[2872]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Aug 31 06:27:56 volumio-bedroom sudo[2872]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:27:56 volumio-bedroom sudo[2875]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 06:27:56 volumio-bedroom sudo[2875]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: [1788150476911] CoreMusicLibrary::Adding element Media Servers Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 06:27:56 volumio-bedroom sudo[2875]: pam_unix(sudo:session): session closed for user root Aug 31 06:27:56 volumio-bedroom sudo[2877]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 31 06:27:56 volumio-bedroom sudo[2877]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:27:56 volumio-bedroom sudo[2872]: pam_unix(sudo:session): session closed for user root Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: UPNP Browser: Client initialized successfully Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:56 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 31 06:27:57 volumio-bedroom systemd[1]: mpd.service: Succeeded. Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:57 volumio-bedroom systemd[1]: Stopped Music Player Daemon. Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: [1788150477047] CoreMusicLibrary::Adding element Last_100 Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: [1788150477050] CoreMusicLibrary::Adding element Webradio Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: Initializing BBC Radios Aug 31 06:27:57 volumio-bedroom systemd[1]: Starting Music Player Daemon... Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: [squeezelite_mc] Starting proxy server... Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: EVO SABRE : Starting Plugin Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: Loading i18n strings for locale en Aug 31 06:27:57 volumio-bedroom sudo[2883]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 31 06:27:57 volumio-bedroom sudo[2883]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:27:57 volumio-bedroom sudo[2883]: pam_unix(sudo:session): session closed for user root Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: Volumio Calling Home Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: [squeezelite_mc] Proxy server started on port 39565 Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::volumioRetrievevolume Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: MPD Permissions set Aug 31 06:27:57 volumio-bedroom sudo[2906]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Aug 31 06:27:57 volumio-bedroom sudo[2906]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:27:57 volumio-bedroom systemd[1]: Reloading. Aug 31 06:27:57 volumio-bedroom volumio[2735]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: VolumeController:: Volume=70 Mute =true Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreStateMachine::pushState Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CorePlayQueue::getTrack 0 Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::volumioPushState Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: [squeezelite_mc] Server discovery started Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: [squeezelite_mc] Player finder started Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 06:27:57 volumio-bedroom volumio[2735]: info: [squeezelite_mc] Executing aplay -D hw:2 --nonblock -f MPEG /dev/zero 2>&1 || true Aug 31 06:27:57 volumio-bedroom volumio[2735]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 06:27:57 volumio-bedroom volumio[2735]: Error: send ENETUNREACH 255.255.255.255:3483 Aug 31 06:27:57 volumio-bedroom volumio[2735]: at doSend (dgram.js:692:16) Aug 31 06:27:57 volumio-bedroom volumio[2735]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Aug 31 06:27:57 volumio-bedroom volumio[2735]: at afterDns (dgram.js:638:5) Aug 31 06:27:57 volumio-bedroom volumio[2735]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Aug 31 06:27:57 volumio-bedroom volumio[2735]: errno: -101, Aug 31 06:27:57 volumio-bedroom volumio[2735]: code: 'ENETUNREACH', Aug 31 06:27:57 volumio-bedroom volumio[2735]: syscall: 'send', Aug 31 06:27:57 volumio-bedroom volumio[2735]: address: '255.255.255.255', Aug 31 06:27:57 volumio-bedroom volumio[2735]: port: 3483 Aug 31 06:27:57 volumio-bedroom volumio[2735]: } Aug 31 06:27:57 volumio-bedroom volumio[2735]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 06:27:57 volumio-bedroom systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Aug 31 06:27:57 volumio-bedroom sudo[2906]: pam_unix(sudo:session): session closed for user root Aug 31 06:27:58 volumio-bedroom sudo[2941]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-31 06:26 Aug 31 06:27:58 volumio-bedroom sudo[2941]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:27:58 volumio-bedroom mpd[2900]: Aug 31 06:27 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 31 06:27:58 volumio-bedroom sudo[2941]: pam_unix(sudo:session): session closed for user root Aug 31 06:27:58 volumio-bedroom volumio-remote-updater[674]: [2026-08-31 06:27:58] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Aug 31 06:27:58 volumio-bedroom volumio-remote-updater[674]: [2026-08-31 06:27:58] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Aug 31 06:27:58 volumio-bedroom volumio5-onboarding[1340]: time=2026-08-31T06:27:58.140+02:00 level=ERROR msg="failed reading message" error="websocket: close 1006 (abnormal closure): unexpected EOF" Aug 31 06:27:58 volumio-bedroom volumio5-onboarding[1340]: time=2026-08-31T06:27:58.142+02:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Aug 31 06:27:58 volumio-bedroom systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Aug 31 06:27:58 volumio-bedroom sudo[2866]: pam_unix(sudo:session): session closed for user root Aug 31 06:27:58 volumio-bedroom sudo[2877]: pam_unix(sudo:session): session closed for user root Aug 31 06:27:58 volumio-bedroom systemd[1]: volumio.service: Failed with result 'exit-code'. Aug 31 06:27:58 volumio-bedroom systemd[1]: Started dynamicswap service. Aug 31 06:27:58 volumio-bedroom systemd[1]: dynamicswap.service: Succeeded. Aug 31 06:27:58 volumio-bedroom systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Aug 31 06:27:58 volumio-bedroom systemd[1]: volumio.service: Scheduled restart job, restart counter is at 6. Aug 31 06:27:58 volumio-bedroom systemd[1]: Started dynamicswap service. Aug 31 06:27:58 volumio-bedroom systemd[1]: Stopped Volumio Backend Module. Aug 31 06:27:58 volumio-bedroom systemd[1]: Started Volumio Backend Module. Aug 31 06:27:58 volumio-bedroom systemd[1]: dynamicswap.service: Succeeded. Aug 31 06:27:59 volumio-bedroom systemd[1]: Started Music Player Daemon. Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: ------------------------------------------- Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: ----- Volumio3 ---- Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: ------------------------------------------- Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: ----- System startup ---- Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: ------------------------------------------- Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: MYVOLUMIO Environment detected Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: Plugin folders cleanup Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: Scanning into folder /volumio/app/plugins/ Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: Scanning category audio_interface Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: Scanning category miscellanea Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: Scanning category music_service Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: Scanning category plugins.json Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: Scanning category system_controller Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: Scanning category user_interface Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: Scanning into folder /data/plugins/ Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: Scanning category music_service Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: Scanning category system_hardware Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: Scanning category user_interface Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: Plugin folders cleanup completed Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: ------------------------------------------- Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: ----- Core plugins startup ---- Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: ------------------------------------------- Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: Loading plugins from folder /volumio/app/plugins/ Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: Adding plugin upnp to MyMusic Plugins Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: Loading plugins from folder /data/plugins/ Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: Loading plugin "system"... Aug 31 06:27:59 volumio-bedroom volumio[2955]: info: Loading plugin "appearance"... Aug 31 06:28:00 volumio-bedroom volumio[2955]: info: Loading plugin "network"... Aug 31 06:28:00 volumio-bedroom volumio[2955]: info: Refreshing Cached IP Addresses Aug 31 06:28:00 volumio-bedroom volumio[2955]: info: Loading plugin "services"... Aug 31 06:28:00 volumio-bedroom volumio[2955]: info: Loading plugin "volumio5onboarding"... Aug 31 06:28:00 volumio-bedroom volumio[2955]: info: Loading plugin "alsa_controller"... Aug 31 06:28:00 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 31 06:28:00 volumio-bedroom volumio[2955]: info: Loading plugin "wizard"... Aug 31 06:28:00 volumio-bedroom volumio[2955]: info: Loading plugin "networkfs"... Aug 31 06:28:00 volumio-bedroom volumio[2955]: info: Cannot mount NAS DSD256 at system boot, trial number 1 ,retrying in 5 seconds Aug 31 06:28:00 volumio-bedroom volumio[2955]: info: Cannot mount NAS DSD at system boot, trial number 1 ,retrying in 5 seconds Aug 31 06:28:00 volumio-bedroom volumio[2955]: info: Cannot mount NAS FLAC at system boot, trial number 1 ,retrying in 5 seconds Aug 31 06:28:00 volumio-bedroom volumio[2955]: info: Starting Udev Watcher for removable devices Aug 31 06:28:00 volumio-bedroom volumio[2955]: info: Ignoring mount for partition: boot Aug 31 06:28:00 volumio-bedroom volumio[2955]: info: Ignoring mount for partition: volumio Aug 31 06:28:00 volumio-bedroom volumio[2955]: info: Ignoring mount for partition: volumio_data Aug 31 06:28:00 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 31 06:28:00 volumio-bedroom volumio[2955]: info: Loading plugin "volumio_command_line_client"... Aug 31 06:28:00 volumio-bedroom volumio[2955]: info: Loading plugin "upnp"... Aug 31 06:28:00 volumio-bedroom volumio[2955]: info: [1788150480598] Starting Upmpd Daemon Aug 31 06:28:00 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 31 06:28:00 volumio-bedroom volumio[2955]: info: Loading plugin "my_music"... Aug 31 06:28:00 volumio-bedroom volumio[2955]: info: Loading plugin "mpd"... Aug 31 06:28:00 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd022 fail, reason -52 Aug 31 06:28:00 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd026 fail, reason -52 Aug 31 06:28:00 volumio-bedroom volumio[2955]: info: Loading plugin "upnp_browser"... Aug 31 06:28:00 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02a fail, reason -52 Aug 31 06:28:00 volumio-bedroom volumio[2955]: info: Starting UPNP Browser Aug 31 06:28:00 volumio-bedroom volumio[2955]: info: Loading plugin "alarm-clock"... Aug 31 06:28:00 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02e fail, reason -52 Aug 31 06:28:01 volumio-bedroom volumio[2955]: info: Alarm: Scheduling Playlist Radio NPO at 7:0 Aug 31 06:28:01 volumio-bedroom volumio[2955]: info: Loading plugin "airplay_emulation"... Aug 31 06:28:01 volumio-bedroom volumio[2955]: info: Starting Shairport Sync Aug 31 06:28:01 volumio-bedroom volumio[2955]: info: Loading plugin "last_100"... Aug 31 06:28:01 volumio-bedroom volumio[2955]: info: Loading plugin "webradio"... Aug 31 06:28:01 volumio-bedroom volumio[2955]: info: Loading plugin "i2s_dacs"... Aug 31 06:28:01 volumio-bedroom volumio[2955]: info: Loading plugin "volumiodiscovery"... Aug 31 06:28:01 volumio-bedroom volumio[2955]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 31 06:28:01 volumio-bedroom volumio[2955]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 31 06:28:01 volumio-bedroom volumio[2955]: *** WARNING *** For more information see Aug 31 06:28:01 volumio-bedroom volumio[2955]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 31 06:28:01 volumio-bedroom node[2955]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 31 06:28:01 volumio-bedroom volumio[2955]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 31 06:28:01 volumio-bedroom volumio[2955]: *** WARNING *** For more information see Aug 31 06:28:01 volumio-bedroom node[2955]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 31 06:28:01 volumio-bedroom node[2955]: *** WARNING *** For more information see Aug 31 06:28:01 volumio-bedroom node[2955]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 31 06:28:01 volumio-bedroom node[2955]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 31 06:28:01 volumio-bedroom node[2955]: *** WARNING *** For more information see Aug 31 06:28:01 volumio-bedroom volumio[2955]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 31 06:28:01 volumio-bedroom volumio[2955]: info: Discovery: Started advertising with name: Volumio Bedroom Aug 31 06:28:01 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 31 06:28:01 volumio-bedroom volumio[2955]: info: Plugin spop is not enabled Aug 31 06:28:01 volumio-bedroom volumio[2955]: info: Loading plugin "squeezelite_mc"... Aug 31 06:28:01 volumio-bedroom volumio[2955]: info: Plugin now_playing is not enabled Aug 31 06:28:01 volumio-bedroom volumio[2955]: info: Loading plugin "outputs"... Aug 31 06:28:01 volumio-bedroom volumio[2955]: info: Loading plugin "albumart"... Aug 31 06:28:01 volumio-bedroom volumio[2955]: info: Plugin example_plugin is not enabled Aug 31 06:28:01 volumio-bedroom volumio[2955]: info: Loading plugin "inputs"... Aug 31 06:28:01 volumio-bedroom volumio[2955]: info: Loading plugin "updater_comm"... Aug 31 06:28:01 volumio-bedroom volumio[2955]: info: Plugin mpdemulation is not enabled Aug 31 06:28:01 volumio-bedroom volumio[2955]: info: Loading plugin "rest_api"... Aug 31 06:28:01 volumio-bedroom volumio[2955]: info: Loading plugin "websocket"... Aug 31 06:28:01 volumio-bedroom volumio[2955]: info: Starting Socket.io Server version 2.3.0 Aug 31 06:28:01 volumio-bedroom volumio[2955]: info: Loading plugin "audiophonics_evo_sabre"... Aug 31 06:28:01 volumio-bedroom volumio[2955]: info: Applying required configuration parameters for plugin audiophonics_evo_sabre Aug 31 06:28:01 volumio-bedroom volumio[2955]: Forking 3 albumart workers Aug 31 06:28:01 volumio-bedroom volumio[2955]: info: Plugin mpd_oled is not enabled Aug 31 06:28:01 volumio-bedroom volumio[2955]: info: Loading i18n strings for locale en Aug 31 06:28:01 volumio-bedroom volumio[2955]: Updating browse sources language Aug 31 06:28:01 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 06:28:01 volumio-bedroom nmbd[761]: [2026/08/31 06:28:01.975915, 0] ../source3/libsmb/nmblib.c:917(send_udp) Aug 31 06:28:01 volumio-bedroom nmbd[761]: Packet send failed to 192.168.2.255(138) ERRNO=Network is unreachable Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreCommandRouter::initPlayerControls Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 06:28:02 volumio-bedroom volumio[2955]: Express server listening on port 3000 Aug 31 06:28:02 volumio-bedroom volumio[2955]: [Metrics] WebUI: 2s 961.77ms Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreStateMachine::resetVolumioState Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreStateMachine::getcurrentVolume Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreCommandRouter::volumioRetrievevolume Aug 31 06:28:02 volumio-bedroom volumio[2955]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Aug 31 06:28:02 volumio-bedroom volumio[2955]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: Reloading queue from file Aug 31 06:28:02 volumio-bedroom volumio[2955]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: VolumeController:: Volume=70 Mute =true Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreStateMachine::pushState Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CorePlayQueue::getTrack 0 Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 06:28:02 volumio-bedroom volumio[2955]: Starting albumart workers Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreCommandRouter::volumioPushState Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreStateMachine::updateTrackBlock Aug 31 06:28:02 volumio-bedroom volumio[2955]: Starting albumart workers Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CorePlayQueue::getTrackBlock Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreCommandRouter::volumioRetrievevolume Aug 31 06:28:02 volumio-bedroom volumio[2955]: Starting albumart workers Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreStateMachine::setRepeat true single undefined Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreStateMachine::pushState Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CorePlayQueue::getTrack 0 Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreCommandRouter::volumioPushState Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreStateMachine::setRandom null Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreStateMachine::pushState Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CorePlayQueue::getTrack 0 Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreCommandRouter::volumioPushState Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: Setting Device type: Raspberry PI Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03115 Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Aug 31 06:28:02 volumio-bedroom volumio[2955]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: Discovery: adding 56407226-c5a5-48c6-97da-e8b8840229cc Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: Discovery: Found device VolumioDAC Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: Discovery: Connecting to remote: 192.168.2.126 Aug 31 06:28:02 volumio-bedroom volumio[2955]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: Discovery: adding 1ae4494d-87e1-45e1-802e-ef1104d1910e Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: Discovery: Found device Volumio Bedroom Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreCommandRouter::volumioGetState Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CorePlayQueue::getTrack 0 Aug 31 06:28:02 volumio-bedroom volumio[2955]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: VolumeController:: Volume=70 Mute =true Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreStateMachine::pushState Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CorePlayQueue::getTrack 0 Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreCommandRouter::volumioPushState Aug 31 06:28:02 volumio-bedroom volumio[2955]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Aug 31 06:28:02 volumio-bedroom volumio[2955]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Aug 31 06:28:02 volumio-bedroom volumio[2955]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Aug 31 06:28:02 volumio-bedroom volumio[2955]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Aug 31 06:28:02 volumio-bedroom volumio[2955]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Aug 31 06:28:02 volumio-bedroom volumio[2955]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Aug 31 06:28:02 volumio-bedroom volumio[2955]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Aug 31 06:28:02 volumio-bedroom volumio[2955]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Aug 31 06:28:02 volumio-bedroom volumio[2955]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Aug 31 06:28:02 volumio-bedroom wpa_supplicant[914]: wlan0: Trying to associate with SSID 'van Hooft 5gHz' Aug 31 06:28:02 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd090 fail, reason -52 Aug 31 06:28:02 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd095 fail, reason -52 Aug 31 06:28:02 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd099 fail, reason -52 Aug 31 06:28:02 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd09d fail, reason -52 Aug 31 06:28:02 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd0a1 fail, reason -52 Aug 31 06:28:02 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd0a5 fail, reason -52 Aug 31 06:28:02 volumio-bedroom volumio[2955]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Aug 31 06:28:02 volumio-bedroom volumio[2955]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Aug 31 06:28:02 volumio-bedroom sudo[2993]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 31 06:28:02 volumio-bedroom sudo[2986]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 31 06:28:02 volumio-bedroom sudo[2993]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:28:02 volumio-bedroom sudo[2984]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 31 06:28:02 volumio-bedroom sudo[2984]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:28:02 volumio-bedroom sudo[2986]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:28:02 volumio-bedroom volumio[2955]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Aug 31 06:28:02 volumio-bedroom sudo[2993]: pam_unix(sudo:session): session closed for user root Aug 31 06:28:02 volumio-bedroom kernel: ieee80211 phy0: brcmf_cfg80211_scan: Connecting: status (3) Aug 31 06:28:02 volumio-bedroom sudo[2984]: pam_unix(sudo:session): session closed for user root Aug 31 06:28:02 volumio-bedroom sudo[2986]: pam_unix(sudo:session): session closed for user root Aug 31 06:28:02 volumio-bedroom volumio[2955]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: Received Get System Info Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: Discovery: Getting this device information Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreCommandRouter::volumioGetState Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CorePlayQueue::getTrack 0 Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 31 06:28:02 volumio-bedroom wpa_supplicant[914]: wlan0: Associated with 18:e8:29:b0:ed:30 Aug 31 06:28:02 volumio-bedroom wpa_supplicant[914]: wlan0: CTRL-EVENT-CONNECTED - Connection to 18:e8:29:b0:ed:30 completed [id=0 id_str=] Aug 31 06:28:02 volumio-bedroom dhcpcd[980]: wlan0: carrier acquired Aug 31 06:28:02 volumio-bedroom wpa_supplicant[914]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Aug 31 06:28:02 volumio-bedroom wpa_supplicant[914]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=NL Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: Completed loading Core Plugins Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: Preparing to generate the ALSA configuration file Aug 31 06:28:02 volumio-bedroom dhcpcd[980]: wlan0: IAID 01:f3:b3:e2 Aug 31 06:28:02 volumio-bedroom dhcpcd[980]: wlan0: carrier lost Aug 31 06:28:02 volumio-bedroom volumio[2955]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Aug 31 06:28:02 volumio-bedroom volumio[2955]: wlan0 Interface doesn't support scanning : Resource temporarily unavailable Aug 31 06:28:02 volumio-bedroom volumio[2955]: info: Cannot use regular scanning, forcing with ap-force Aug 31 06:28:02 volumio-bedroom dhcpcd[980]: wlan0: carrier acquired Aug 31 06:28:02 volumio-bedroom dhcpcd[980]: wlan0: IAID 01:f3:b3:e2 Aug 31 06:28:02 volumio-bedroom sudo[3071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Aug 31 06:28:02 volumio-bedroom sudo[3071]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:28:03 volumio-bedroom dhcpcd[980]: wlan0: rebinding lease of 192.168.2.146 Aug 31 06:28:03 volumio-bedroom dhcpcd[980]: wlan0: probing address 192.168.2.146/24 Aug 31 06:28:03 volumio-bedroom volumio-remote-updater[674]: [2026-08-31 06:28:03] [connect] Successful connection Aug 31 06:28:03 volumio-bedroom dhcpcd[980]: wlan0: soliciting an IPv6 router Aug 31 06:28:06 volumio-bedroom sudo[3071]: pam_unix(sudo:session): session closed for user root Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: Cannot mount NAS DSD256 at system boot, trial number 2 ,retrying in 5 seconds Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: Cannot mount NAS DSD at system boot, trial number 2 ,retrying in 5 seconds Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: Cannot mount NAS FLAC at system boot, trial number 2 ,retrying in 5 seconds Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: Received Get System Info Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: Discovery: Getting this device information Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: CoreCommandRouter::volumioGetState Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: CorePlayQueue::getTrack 0 Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: Volumio Network Manager: Network status updated: 1 Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 31 06:28:06 volumio-bedroom volumio-remote-updater[674]: [2026-08-31 06:28:06] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1788150483 101 Aug 31 06:28:06 volumio-bedroom volumio[2955]: 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: 3 Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: Asound.conf file unchanged, so no further update is needed Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: Output device has changed, restarting MPD Aug 31 06:28:06 volumio-bedroom sudo[3103]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 31 06:28:06 volumio-bedroom sudo[3103]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: Output device has changed, restarting Shairport Sync Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 06:28:06 volumio-bedroom sudo[3103]: pam_unix(sudo:session): session closed for user root Aug 31 06:28:06 volumio-bedroom sudo[3106]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 31 06:28:06 volumio-bedroom sudo[3106]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:28:06 volumio-bedroom systemd[1]: Stopping Music Player Daemon... Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: ___________ START PLUGINS ___________ Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: ControllerMpd::onStart: Initializing MPD Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: Creating MPD Configuration file Aug 31 06:28:06 volumio-bedroom sudo[3112]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Aug 31 06:28:06 volumio-bedroom sudo[3112]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:28:06 volumio-bedroom sudo[3115]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 31 06:28:06 volumio-bedroom sudo[3115]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:28:06 volumio-bedroom sudo[3115]: pam_unix(sudo:session): session closed for user root Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: [1788150486759] CoreMusicLibrary::Adding element Media Servers Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 06:28:06 volumio-bedroom sudo[3112]: pam_unix(sudo:session): session closed for user root Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: UPNP Browser: Client initialized successfully Aug 31 06:28:06 volumio-bedroom sudo[3118]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 31 06:28:06 volumio-bedroom sudo[3118]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 06:28:06 volumio-bedroom systemd[1]: mpd.service: Succeeded. Aug 31 06:28:06 volumio-bedroom systemd[1]: Stopped Music Player Daemon. Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: [1788150486879] CoreMusicLibrary::Adding element Last_100 Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: [1788150486882] CoreMusicLibrary::Adding element Webradio Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: Initializing BBC Radios Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: [squeezelite_mc] Starting proxy server... Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: EVO SABRE : Starting Plugin Aug 31 06:28:06 volumio-bedroom systemd[1]: Starting Music Player Daemon... Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: Loading i18n strings for locale en Aug 31 06:28:06 volumio-bedroom volumio[2955]: info: Volumio Calling Home Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: [squeezelite_mc] Proxy server started on port 33839 Aug 31 06:28:07 volumio-bedroom sudo[3126]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 31 06:28:07 volumio-bedroom sudo[3126]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:28:07 volumio-bedroom sudo[3126]: pam_unix(sudo:session): session closed for user root Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: CoreCommandRouter::volumioRetrievevolume Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: MPD Permissions set Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: Received Get System Info Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: Discovery: Getting this device information Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: CoreCommandRouter::volumioGetState Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: CorePlayQueue::getTrack 0 Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 06:28:07 volumio-bedroom sudo[3146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Aug 31 06:28:07 volumio-bedroom sudo[3146]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 06:28:07 volumio-bedroom systemd[1]: Reloading. Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 31 06:28:07 volumio-bedroom volumio[2955]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: VolumeController:: Volume=70 Mute =true Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: CoreStateMachine::pushState Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: CorePlayQueue::getTrack 0 Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: CoreCommandRouter::volumioPushState Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: [squeezelite_mc] Server discovery started Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: [squeezelite_mc] Player finder started Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 06:28:07 volumio-bedroom volumio[2955]: info: [squeezelite_mc] Executing aplay -D hw:2 --nonblock -f MPEG /dev/zero 2>&1 || true Aug 31 06:28:07 volumio-bedroom volumio[2955]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 06:28:07 volumio-bedroom volumio[2955]: Error: send ENETUNREACH 255.255.255.255:3483 Aug 31 06:28:07 volumio-bedroom volumio[2955]: at doSend (dgram.js:692:16) Aug 31 06:28:07 volumio-bedroom volumio[2955]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Aug 31 06:28:07 volumio-bedroom volumio[2955]: at afterDns (dgram.js:638:5) Aug 31 06:28:07 volumio-bedroom volumio[2955]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Aug 31 06:28:07 volumio-bedroom volumio[2955]: errno: -101, Aug 31 06:28:07 volumio-bedroom volumio[2955]: code: 'ENETUNREACH', Aug 31 06:28:07 volumio-bedroom volumio[2955]: syscall: 'send', Aug 31 06:28:07 volumio-bedroom volumio[2955]: address: '255.255.255.255', Aug 31 06:28:07 volumio-bedroom volumio[2955]: port: 3483 Aug 31 06:28:07 volumio-bedroom volumio[2955]: } Aug 31 06:28:07 volumio-bedroom volumio[2955]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 06:28:07 volumio-bedroom systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Aug 31 06:28:07 volumio-bedroom dhcpcd[980]: wlan0: leased 192.168.2.146 for 86400 seconds Aug 31 06:28:07 volumio-bedroom avahi-daemon[625]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.2.146. Aug 31 06:28:07 volumio-bedroom avahi-daemon[625]: New relevant interface wlan0.IPv4 for mDNS. Aug 31 06:28:07 volumio-bedroom avahi-daemon[625]: Registering new address record for 192.168.2.146 on wlan0.IPv4. Aug 31 06:28:07 volumio-bedroom dhcpcd[980]: wlan0: adding route to 192.168.2.0/24 Aug 31 06:28:07 volumio-bedroom dhcpcd[980]: wlan0: adding default route via 192.168.2.1 Aug 31 06:28:07 volumio-bedroom sudo[3204]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-31 06:27 Aug 31 06:28:07 volumio-bedroom sudo[3204]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"