Apr 03 06:14:00 habitacion volumio[1114]: info: Volumio Network Manager: Network status updated: 2 Apr 03 06:14:00 habitacion volumio[1114]: verbose: New Socket.io Connection to 192.168.68.61:3000 from 192.168.68.55 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Apr 03 06:14:00 habitacion volumio[1114]: verbose: New Socket.io Connection to 192.168.68.61:3000 from 192.168.68.76 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Apr 03 06:14:01 habitacion volumio[1114]: info: Reloading queue from file Apr 03 06:14:01 habitacion systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Apr 03 06:14:01 habitacion volumio[1297]: Forking 3 albumart workers Apr 03 06:14:01 habitacion volumio[1114]: info: VolumeController:: Volume=86 Mute =false Apr 03 06:14:01 habitacion volumio[1114]: info: CoreStateMachine::pushState Apr 03 06:14:01 habitacion volumio[1114]: info: CorePlayQueue::getTrack 0 Apr 03 06:14:01 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 06:14:01 habitacion volumio[1114]: info: CoreCommandRouter::volumioPushState Apr 03 06:14:01 habitacion volumio[1114]: info: CoreStateMachine::updateTrackBlock Apr 03 06:14:01 habitacion volumio[1114]: info: CorePlayQueue::getTrackBlock Apr 03 06:14:01 habitacion volumio[1114]: info: CoreCommandRouter::volumioRetrievevolume Apr 03 06:14:01 habitacion volumio[1114]: info: CoreStateMachine::setRepeat null single undefined Apr 03 06:14:01 habitacion systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 3. Apr 03 06:14:01 habitacion volumio[1114]: info: CoreStateMachine::pushState Apr 03 06:14:01 habitacion volumio[1114]: info: CorePlayQueue::getTrack 0 Apr 03 06:14:01 habitacion volumio[1114]: info: CoreCommandRouter::volumioPushState Apr 03 06:14:01 habitacion systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 06:14:01 habitacion volumio[1114]: info: CoreStateMachine::setRandom null Apr 03 06:14:02 habitacion sudo[1360]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 06:14:02 habitacion systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 06:14:02 habitacion volumio[1114]: info: CoreStateMachine::pushState Apr 03 06:14:02 habitacion sudo[1360]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 06:14:02 habitacion volumio[1114]: info: CorePlayQueue::getTrack 0 Apr 03 06:14:02 habitacion volumio[1114]: info: CoreCommandRouter::volumioPushState Apr 03 06:14:02 habitacion sudo[1360]: pam_unix(sudo:session): session closed for user root Apr 03 06:14:02 habitacion volumio[1114]: info: Setting Device type: Raspberry PI Apr 03 06:14:02 habitacion upmpdcli[1365]: Could not open config: /tmp/upmpdcli.conf Apr 03 06:14:02 habitacion systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Apr 03 06:14:02 habitacion systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Apr 03 06:14:02 habitacion sudo[1353]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 03 06:14:02 habitacion sudo[1353]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 06:14:02 habitacion sudo[1353]: pam_unix(sudo:session): session closed for user root Apr 03 06:14:02 habitacion volumio[1114]: verbose: New Socket.io Connection to 192.168.68.61:3000 from 192.168.68.55 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Apr 03 06:14:03 habitacion volumio-remote-updater[671]: [2026-04-03 06:14:03] [connect] Successful connection Apr 03 06:14:03 habitacion systemd[1]: setdatetime-helper.service: Deactivated successfully. Apr 03 06:14:03 habitacion systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Apr 03 06:14:03 habitacion systemd[1]: setdatetime-helper.service: Consumed 1.827s CPU time. Apr 03 06:14:04 habitacion volumio[1114]: verbose: New Socket.io Connection to 192.168.68.61:3000 from 192.168.68.76 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Apr 03 06:14:04 habitacion volumio[1114]: info: Discovery: adding 77cb5c1e-ec83-4d11-93f4-1f4f5ba35a19 Apr 03 06:14:04 habitacion volumio[1114]: info: Discovery: Found device Office Apr 03 06:14:05 habitacion volumio[1114]: info: Discovery: Connecting to remote: 192.168.68.76 Apr 03 06:14:05 habitacion volumio[1114]: verbose: New Socket.io Connection to 192.168.68.61:3000 from 192.168.68.55 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Apr 03 06:14:05 habitacion volumio[1114]: info: Discovery: adding 540e4126-9f23-427c-98ff-b75755298a4c Apr 03 06:14:05 habitacion volumio[1114]: info: Discovery: Found device Habitacion Apr 03 06:14:05 habitacion volumio[1114]: info: CoreCommandRouter::volumioGetState Apr 03 06:14:05 habitacion volumio[1114]: info: CorePlayQueue::getTrack 0 Apr 03 06:14:05 habitacion volumio[1114]: verbose: New Socket.io Connection to 192.168.68.61:3000 from 192.168.68.55 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Apr 03 06:14:05 habitacion volumio[1114]: info: VolumeController:: Volume=86 Mute =false Apr 03 06:14:05 habitacion volumio[1114]: info: CoreStateMachine::pushState Apr 03 06:14:05 habitacion volumio[1114]: info: CorePlayQueue::getTrack 0 Apr 03 06:14:05 habitacion volumio[1114]: info: CoreCommandRouter::volumioPushState Apr 03 06:14:05 habitacion volumio[1114]: info: Discovery: this is already registered, 540e4126-9f23-427c-98ff-b75755298a4c Apr 03 06:14:05 habitacion volumio[1114]: info: Discovery: Found device Habitacion Apr 03 06:14:05 habitacion volumio[1114]: info: CoreCommandRouter::volumioGetState Apr 03 06:14:05 habitacion volumio[1114]: info: CorePlayQueue::getTrack 0 Apr 03 06:14:05 habitacion volumio[1114]: verbose: New Socket.io Connection to 192.168.68.61:3000 from 192.168.68.55 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 03 06:14:05 habitacion volumio[1114]: info: Discovery: adding b0ab14ec-4291-4f9a-968c-62a005ee2511 Apr 03 06:14:05 habitacion volumio[1114]: info: Discovery: Found device Sala Apr 03 06:14:05 habitacion volumio[1114]: info: Discovery: Connecting to remote: 192.168.68.55 Apr 03 06:14:05 habitacion volumio-remote-updater[671]: [2026-04-03 06:14:05] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1775214843 101 Apr 03 06:14:05 habitacion volumio[1114]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 8 Apr 03 06:14:05 habitacion volumio[1114]: verbose: New Socket.io Connection to 192.168.68.61:3000 from 192.168.68.76 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Apr 03 06:14:05 habitacion volumio[1114]: verbose: New Socket.io Connection to 192.168.68.61:3000 from 192.168.68.55 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Apr 03 06:14:05 habitacion volumio[1114]: info: Discovery: Connected to remote: 192.168.68.76 Apr 03 06:14:05 habitacion volumio[1114]: info: Completed loading Core Plugins Apr 03 06:14:05 habitacion volumio[1114]: info: Preparing to generate the ALSA configuration file Apr 03 06:14:06 habitacion volumio[1114]: info: Discovery: Connected to remote: 192.168.68.55 Apr 03 06:14:06 habitacion sudo[1402]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 03 06:14:06 habitacion sudo[1402]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 06:14:06 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Apr 03 06:14:06 habitacion volumio[1114]: info: CoreCommandRouter::volumioGetState Apr 03 06:14:06 habitacion volumio[1114]: info: CorePlayQueue::getTrack 0 Apr 03 06:14:08 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Apr 03 06:14:08 habitacion volumio[1114]: info: CoreCommandRouter::volumioGetState Apr 03 06:14:08 habitacion volumio[1114]: info: CorePlayQueue::getTrack 0 Apr 03 06:14:08 habitacion volumio[1114]: info: Asound.conf file written Apr 03 06:14:08 habitacion sudo[1407]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 03 06:14:08 habitacion sudo[1407]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 06:14:09 habitacion sudo[1407]: pam_unix(sudo:session): session closed for user root Apr 03 06:14:09 habitacion volumio[1114]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Apr 03 06:14:09 habitacion volumio[1114]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Apr 03 06:14:09 habitacion volumio[1114]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Apr 03 06:14:09 habitacion volumio[1114]: info: Output device has changed, restarting MPD Apr 03 06:14:09 habitacion volumio[1114]: info: Output device has changed, restarting Shairport Sync Apr 03 06:14:09 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 06:14:09 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 06:14:10 habitacion sudo[1413]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 03 06:14:10 habitacion sudo[1413]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 06:14:10 habitacion sudo[1415]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 03 06:14:10 habitacion sudo[1415]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 06:14:10 habitacion sudo[1413]: pam_unix(sudo:session): session closed for user root Apr 03 06:14:10 habitacion volumio[1114]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 03 06:14:10 habitacion volumio[1114]: info: ___________ START PLUGINS ___________ Apr 03 06:14:10 habitacion volumio[1114]: info: ControllerMpd::onStart: Initializing MPD Apr 03 06:14:10 habitacion volumio[1114]: info: Creating MPD Configuration file Apr 03 06:14:10 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 06:14:10 habitacion volumio[1114]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 03 06:14:10 habitacion volumio[1114]: info: [1775214850369] CoreMusicLibrary::Adding element Media Servers Apr 03 06:14:10 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 03 06:14:10 habitacion volumio[1114]: info: UPNP Browser: Client initialized successfully Apr 03 06:14:10 habitacion sudo[1427]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 03 06:14:10 habitacion sudo[1427]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 06:14:10 habitacion systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Apr 03 06:14:10 habitacion sudo[1423]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Apr 03 06:14:10 habitacion sudo[1423]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 06:14:10 habitacion systemd[1]: Starting mpd.service - Music Player Daemon... Apr 03 06:14:10 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 06:14:10 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 06:14:10 habitacion sudo[1425]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 03 06:14:10 habitacion sudo[1425]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 06:14:10 habitacion sudo[1425]: pam_unix(sudo:session): session closed for user root Apr 03 06:14:10 habitacion systemd[1]: mpd.service: Deactivated successfully. Apr 03 06:14:10 habitacion systemd[1]: Stopped mpd.service - Music Player Daemon. Apr 03 06:14:10 habitacion systemd[1]: mpd.socket: Deactivated successfully. Apr 03 06:14:10 habitacion systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Apr 03 06:14:10 habitacion systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Apr 03 06:14:11 habitacion volumio[1114]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 03 06:14:11 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 06:14:11 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 06:14:11 habitacion systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Apr 03 06:14:11 habitacion systemd[1]: Starting mpd.service - Music Player Daemon... Apr 03 06:14:11 habitacion systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Apr 03 06:14:11 habitacion sudo[1423]: pam_unix(sudo:session): session closed for user root Apr 03 06:14:11 habitacion sudo[1439]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 03 06:14:11 habitacion sudo[1439]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Apr 03 06:14:11 habitacion sudo[1454]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Apr 03 06:14:11 habitacion sudo[1439]: pam_unix(sudo:session): session closed for user root Apr 03 06:14:11 habitacion volumio[1114]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 03 06:14:11 habitacion volumio[1114]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 03 06:14:11 habitacion volumio[1114]: info: [1775214851884] CoreMusicLibrary::Adding element Last_100 Apr 03 06:14:11 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 03 06:14:11 habitacion volumio[1114]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 03 06:14:11 habitacion volumio[1114]: info: [1775214851986] CoreMusicLibrary::Adding element Webradio Apr 03 06:14:11 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 03 06:14:12 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 03 06:14:12 habitacion volumio5-onboarding[1440]: time=2026-04-03T06:14:12.388-05:00 level=INFO msg="running volumio5-device-gateway" version=6370e0a8+CHANGES buildDate=2026-03-06T16:29:42Z Apr 03 06:14:12 habitacion volumio[1114]: info: Initializing BBC Radios Apr 03 06:14:13 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 03 06:14:13 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 06:14:13 habitacion volumio[1114]: info: Volumio Calling Home Apr 03 06:14:16 habitacion volumio[1351]: Starting albumart workers Apr 03 06:14:17 habitacion systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 4. Apr 03 06:14:17 habitacion systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 06:14:17 habitacion systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 06:14:17 habitacion sudo[1402]: pam_unix(sudo:session): session closed for user root Apr 03 06:14:20 habitacion volumio[1349]: Starting albumart workers Apr 03 06:14:20 habitacion volumio[1348]: Starting albumart workers Apr 03 06:14:22 habitacion volumio5-onboarding[1440]: failed to create app: failed to initialize host: failed to create socket connection: could not connect to socket.io server: read tcp 127.0.0.1:47524->127.0.0.1:3000: i/o timeout Apr 03 06:14:22 habitacion systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Apr 03 06:14:22 habitacion systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Apr 03 06:14:22 habitacion systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 1. Apr 03 06:14:22 habitacion systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Apr 03 06:14:22 habitacion systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Apr 03 06:14:22 habitacion volumio5-onboarding[1497]: time=2026-04-03T06:14:22.900-05:00 level=INFO msg="running volumio5-device-gateway" version=6370e0a8+CHANGES buildDate=2026-03-06T16:29:42Z Apr 03 06:14:24 habitacion mpd[1455]: 2026-04-03T06:14:24 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 03 06:14:24 habitacion systemd[1]: Started mpd.service - Music Player Daemon. Apr 03 06:14:24 habitacion sudo[1415]: pam_unix(sudo:session): session closed for user root Apr 03 06:14:24 habitacion sudo[1427]: pam_unix(sudo:session): session closed for user root Apr 03 06:14:25 habitacion volumio[1114]: info: MPD Permissions set Apr 03 06:14:25 habitacion volumio[1114]: info: Completed starting Core Plugins Apr 03 06:14:25 habitacion volumio[1114]: info: ------------------------------------------- Apr 03 06:14:25 habitacion volumio[1114]: info: ----- MyVolumio plugins startup ---- Apr 03 06:14:25 habitacion volumio[1114]: info: ------------------------------------------- Apr 03 06:14:25 habitacion volumio[1114]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 03 06:14:26 habitacion volumio[1114]: info: MPD Permissions set Apr 03 06:14:26 habitacion volumio[1114]: info: Upmpdcli Daemon Started Apr 03 06:14:26 habitacion volumio[1114]: info: Volumio called home Apr 03 06:14:28 habitacion volumio[1114]: error: MPD error: The expression evaluated to a falsy value: Apr 03 06:14:28 habitacion volumio[1114]: assert.ok(self.idling) Apr 03 06:14:28 habitacion volumio[1114]: error: The expression evaluated to a falsy value: Apr 03 06:14:28 habitacion volumio[1114]: assert.ok(self.idling) Apr 03 06:14:28 habitacion volumio[1114]: 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: 11 Apr 03 06:14:28 habitacion volumio[1114]: info: MPD running with PID1455 Apr 03 06:14:28 habitacion volumio[1114]: ,establishing connection Apr 03 06:14:28 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 06:14:28 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 06:14:28 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 06:14:28 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 06:14:28 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 06:14:28 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 06:14:28 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 06:14:28 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 06:14:28 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 06:14:28 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 06:14:28 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 06:14:28 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 06:14:28 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 06:14:28 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 06:14:28 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 06:14:28 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 06:14:28 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 06:14:28 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 06:14:28 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 06:14:28 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 06:14:29 habitacion volumio[1114]: error: updateQueue error: null Apr 03 06:14:29 habitacion volumio[1114]: 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: 11 Apr 03 06:14:29 habitacion volumio[1114]: info: Received Get System Info Apr 03 06:14:29 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 06:14:29 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 06:14:29 habitacion volumio[1114]: info: Discovery: Getting this device information Apr 03 06:14:29 habitacion volumio[1114]: info: CoreCommandRouter::volumioGetState Apr 03 06:14:29 habitacion volumio[1114]: info: CorePlayQueue::getTrack 0 Apr 03 06:14:29 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 06:14:29 habitacion volumio5-onboarding[1497]: time=2026-04-03T06:14:29.679-05:00 level=INFO msg="system info for ff1d5a0da10408c4fdbd05461ccc4a80" deviceName=Habitacion deviceVariant=volumio deviceModel= softwareVersion=4.119 Apr 03 06:14:29 habitacion volumio5-onboarding[1497]: time=2026-04-03T06:14:29.707-05:00 level=INFO msg="bootstrapping state" hasInternet=true Apr 03 06:14:30 habitacion volumio[1114]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Apr 03 06:14:30 habitacion volumio[1114]: info: Received Get System Info Apr 03 06:14:30 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 06:14:30 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 06:14:30 habitacion volumio[1114]: info: Discovery: Getting this device information Apr 03 06:14:30 habitacion volumio[1114]: info: CoreCommandRouter::volumioGetState Apr 03 06:14:30 habitacion volumio[1114]: info: CorePlayQueue::getTrack 0 Apr 03 06:14:30 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 06:14:31 habitacion volumio-remote-updater[671]: Test mode disabled Apr 03 06:14:31 habitacion volumio-remote-updater[671]: Alpha mode disabled Apr 03 06:14:31 habitacion volumio-remote-updater[671]: Alpha legacy test mode disabled Apr 03 06:14:31 habitacion volumio[1114]: error: updateQueue error: null Apr 03 06:14:31 habitacion volumio[1114]: info: Starting Shairport Sync Apr 03 06:14:32 habitacion volumio[1114]: info: Starting Shairport Sync Apr 03 06:14:32 habitacion sudo[1553]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 03 06:14:32 habitacion sudo[1553]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 06:14:32 habitacion volumio[1114]: info: Starting Shairport Sync Apr 03 06:14:32 habitacion volumio[1114]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Apr 03 06:14:32 habitacion sudo[1556]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 03 06:14:32 habitacion sudo[1556]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 06:14:32 habitacion sudo[1558]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 03 06:14:32 habitacion sudo[1558]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 06:14:32 habitacion systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Apr 03 06:14:32 habitacion systemd[1]: shairport-sync.service: Deactivated successfully. Apr 03 06:14:32 habitacion systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Apr 03 06:14:32 habitacion systemd[1]: shairport-sync.service: Consumed 1.858s CPU time. Apr 03 06:14:32 habitacion volumio[1114]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Apr 03 06:14:32 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 03 06:14:32 habitacion systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Apr 03 06:14:32 habitacion sudo[1556]: pam_unix(sudo:session): session closed for user root Apr 03 06:14:32 habitacion sudo[1553]: pam_unix(sudo:session): session closed for user root Apr 03 06:14:32 habitacion systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Apr 03 06:14:32 habitacion systemd[1]: shairport-sync.service: Deactivated successfully. Apr 03 06:14:32 habitacion systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Apr 03 06:14:32 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 03 06:14:32 habitacion systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Apr 03 06:14:32 habitacion sudo[1558]: pam_unix(sudo:session): session closed for user root Apr 03 06:14:32 habitacion volumio[1114]: info: Shairport-Sync Started Apr 03 06:14:32 habitacion volumio[1114]: Error adding Membership: Error: addMembership EINVAL Apr 03 06:14:32 habitacion volumio[1114]: info: Shairport-Sync Started Apr 03 06:14:32 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 03 06:14:33 habitacion volumio[1114]: info: Shairport-Sync Started Apr 03 06:14:33 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 03 06:14:33 habitacion volumio[1114]: info: Received Get System Info Apr 03 06:14:33 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 06:14:33 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 06:14:33 habitacion volumio[1114]: info: Discovery: Getting this device information Apr 03 06:14:33 habitacion volumio[1114]: info: CoreCommandRouter::volumioGetState Apr 03 06:14:33 habitacion volumio[1114]: info: CorePlayQueue::getTrack 0 Apr 03 06:14:33 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 06:14:33 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 03 06:14:33 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 03 06:14:33 habitacion volumio5-onboarding[1497]: time=2026-04-03T06:14:33.453-05:00 level=INFO msg="enabling local network discovery" Apr 03 06:14:33 habitacion volumio[1114]: info: CoreCommandRouter::volumioGetState Apr 03 06:14:33 habitacion volumio5-onboarding[1497]: time=2026-04-03T06:14:33.524-05:00 level=INFO msg="enabling BLE discovery" Apr 03 06:14:33 habitacion volumio[1114]: info: CorePlayQueue::getTrack 0 Apr 03 06:14:34 habitacion volumio5-onboarding[1497]: time=2026-04-03T06:14:34.464-05:00 level=INFO msg="service successfully established" component=discovery/localnet Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 03 06:14:35 habitacion volumio[1114]: info: Adding plugin bluetooth to MyMusic Plugins Apr 03 06:14:35 habitacion volumio[1114]: info: Adding plugin multiroom to MyMusic Plugins Apr 03 06:14:35 habitacion volumio[1114]: info: Adding plugin metavolumio to MyMusic Plugins Apr 03 06:14:35 habitacion volumio[1114]: info: Adding plugin cd_controller to MyMusic Plugins Apr 03 06:14:35 habitacion volumio[1114]: info: Adding plugin qobuzconnect to MyMusic Plugins Apr 03 06:14:35 habitacion volumio[1114]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 03 06:14:35 habitacion volumio[1114]: info: Adding plugin tidalconnect to MyMusic Plugins Apr 03 06:14:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 03 06:14:45 habitacion volumio[1114]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 03 06:14:45 habitacion volumio[1114]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 03 06:14:45 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 06:14:45 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 06:14:45 habitacion volumio[1114]: info: Starting MyVolumio Remote Streaming Endpoints Apr 03 06:14:45 habitacion volumio[1114]: info: MyVolumio login type: Token Apr 03 06:14:45 habitacion volumio[1114]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 03 06:14:45 habitacion volumio[1114]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 03 06:14:54 habitacion volumio[1114]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 03 06:14:54 habitacion volumio[1114]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 03 06:14:54 habitacion volumio[1114]: info: Streaming services startup Apr 03 06:14:54 habitacion volumio[1114]: info: Starting Streaming Daemon Apr 03 06:14:54 habitacion sudo[1609]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 03 06:14:54 habitacion sudo[1609]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 06:14:54 habitacion volumio[1114]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Apr 03 06:14:55 habitacion sudo[1609]: pam_unix(sudo:session): session closed for user root Apr 03 06:14:55 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 03 06:14:55 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 06:14:55 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 03 06:14:56 habitacion volumio[1114]: error: Cannot start Volumio Streaming Daemon Apr 03 06:14:56 habitacion volumio[1114]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 03 06:14:56 habitacion volumio[1114]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 03 06:14:56 habitacion bluealsa[939]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_7C_04_3F_88_DC_CD, ...) Apr 03 06:14:58 habitacion volumio-remote-updater[671]: Test mode disabled Apr 03 06:14:58 habitacion volumio-remote-updater[671]: Alpha mode disabled Apr 03 06:14:58 habitacion volumio-remote-updater[671]: Alpha legacy test mode disabled Apr 03 06:14:58 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Apr 03 06:14:59 habitacion volumio[1114]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Apr 03 06:14:59 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 03 06:14:59 habitacion volumio[1114]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Apr 03 06:14:59 habitacion volumio[1114]: info: MyVolumio token set successfully Apr 03 06:14:59 habitacion volumio[1114]: info: MYVOLUMIO: Adding device Apr 03 06:14:59 habitacion volumio[1114]: info: MYVOLUMIO: Evaluating Server Apr 03 06:15:01 habitacion volumio5-onboarding[1497]: time=2026-04-03T06:15:01.377-05:00 level=INFO msg="new address was allocated" component=ble/conn old=1 new=2 Apr 03 06:15:01 habitacion dbus-daemon[656]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.20" (uid=0 pid=1497 comm="/usr/bin/volumio5-onboarding") interface="(unset)" member="(unset)" error name="org.freedesktop.DBus.Error.UnknownMethod" requested_reply="0" destination=":1.4" (uid=0 pid=832 comm="/usr/libexec/bluetooth/bluetoothd --noplugin=sap,b") Apr 03 06:15:01 habitacion volumio[1114]: info: MyVolumio Plan changed: premium Apr 03 06:15:02 habitacion volumio[1114]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Apr 03 06:15:02 habitacion volumio[1114]: info: Removing browser output: myVolumio user plan is not superstar Apr 03 06:15:02 habitacion volumio[1114]: info: Removing audio output: Apr 03 06:15:02 habitacion volumio[1114]: info: MYVOLUMIO: Adding device Apr 03 06:15:02 habitacion volumio[1114]: info: MYVOLUMIO: Evaluating Server Apr 03 06:15:02 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 03 06:15:04 habitacion volumio[1114]: info: Setting Geolocation for MyVolumio to us4 Apr 03 06:15:04 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 06:15:04 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 06:15:04 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 06:15:05 habitacion volumio[1114]: info: Setting Geolocation for MyVolumio to us4 Apr 03 06:15:05 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 06:15:05 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 06:15:05 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 06:15:05 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 06:15:05 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 06:15:05 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Apr 03 06:15:05 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 03 06:15:05 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Apr 03 06:15:05 habitacion volumio[1114]: info: CoreCommandRouter::volumioGetBrowseSources Apr 03 06:15:05 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 03 06:15:05 habitacion volumio[1114]: info: Successfully Added MyVolumio device Apr 03 06:15:05 habitacion volumio[1114]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13 Apr 03 06:15:05 habitacion volumio[1114]: info: Remote config written successfully Apr 03 06:15:05 habitacion volumio[1114]: info: Starting Tunnel 1 Apr 03 06:15:05 habitacion volumio[1114]: info: Starting Tunnel Connection Checker Apr 03 06:15:05 habitacion volumio[1114]: info: Completed starting MyVolumio Plugin Apr 03 06:15:06 habitacion volumio[1114]: info: Updating MyVolumio device info Apr 03 06:15:06 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 06:15:06 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 06:15:06 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 06:15:06 habitacion volumio[1114]: info: MYVolumio Device enabled Apr 03 06:15:06 habitacion volumio[1114]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Apr 03 06:15:06 habitacion volumio[1114]: info: MyVolumio status changed Apr 03 06:15:06 habitacion volumio[1114]: info: Streaming services startup Apr 03 06:15:06 habitacion volumio[1114]: info: Starting Streaming Daemon Apr 03 06:15:06 habitacion sudo[1693]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 03 06:15:06 habitacion sudo[1693]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 06:15:06 habitacion volumio[1114]: info: Updating MyVolumio device info Apr 03 06:15:06 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 06:15:06 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 06:15:06 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 06:15:06 habitacion sudo[1693]: pam_unix(sudo:session): session closed for user root Apr 03 06:15:07 habitacion volumio[1114]: info: Successfully Added MyVolumio device Apr 03 06:15:07 habitacion volumio[1114]: info: Successfully Updated MyVolumio device Apr 03 06:15:07 habitacion volumio[1114]: info: CoreCommandRouter::volumioGetState Apr 03 06:15:07 habitacion volumio[1114]: info: CorePlayQueue::getTrack 0 Apr 03 06:15:07 habitacion volumio[1114]: error: Cannot start Volumio Streaming Daemon Apr 03 06:15:07 habitacion volumio[1114]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 03 06:15:07 habitacion volumio[1114]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 03 06:15:07 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Apr 03 06:15:07 habitacion volumio[1114]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Apr 03 06:15:10 habitacion volumio[1114]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin bluetooth Apr 03 06:15:10 habitacion volumio[1114]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin bluetooth Apr 03 06:15:10 habitacion volumio[1114]: ------------------------------------ BT MESSAGE: [FUNC] onVolumioStart Apr 03 06:15:10 habitacion volumio[1114]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Apr 03 06:15:32 habitacion volumio[1114]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Apr 03 06:15:32 habitacion sudo[1726]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Apr 03 06:15:32 habitacion sudo[1726]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 06:15:32 habitacion sudo[1726]: pam_unix(sudo:session): session closed for user root Apr 03 06:15:33 habitacion volumio[1114]: info: MRS: MultiRoom plugin initialized Apr 03 06:15:33 habitacion volumio[1114]: info: MRS: STOPPING SNAPCLIENT Apr 03 06:15:33 habitacion volumio[1114]: info: MRS: Snap server stop Apr 03 06:15:33 habitacion volumio[1114]: info: MRS: STOPPING volumioStreaming Apr 03 06:15:34 habitacion volumio[1114]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Apr 03 06:15:34 habitacion sudo[1743]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Apr 03 06:15:34 habitacion sudo[1743]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 06:15:34 habitacion sudo[1745]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Apr 03 06:15:34 habitacion sudo[1745]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 06:15:34 habitacion sudo[1747]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Apr 03 06:15:34 habitacion sudo[1747]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 06:15:34 habitacion sudo[1749]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Apr 03 06:15:34 habitacion sudo[1749]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 06:15:34 habitacion sudo[1743]: pam_unix(sudo:session): session closed for user root Apr 03 06:15:34 habitacion sudo[1749]: pam_unix(sudo:session): session closed for user root Apr 03 06:15:34 habitacion volumio[1114]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Apr 03 06:15:35 habitacion sudo[1745]: pam_unix(sudo:session): session closed for user root Apr 03 06:15:35 habitacion sudo[1747]: pam_unix(sudo:session): session closed for user root Apr 03 06:15:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Apr 03 06:15:35 habitacion volumio[1114]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Apr 03 06:15:36 habitacion volumio[1114]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Apr 03 06:15:36 habitacion volumio[1114]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Apr 03 06:15:36 habitacion volumio[1114]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Apr 03 06:15:37 habitacion volumio[1114]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Apr 03 06:15:37 habitacion volumio[1114]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Apr 03 06:15:37 habitacion volumio[1114]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... Apr 03 06:15:38 habitacion volumio[1114]: info: Preparing to generate the ALSA configuration file Apr 03 06:15:38 habitacion volumio[1114]: error: MyVolumio Plugins failed to start in a timely fashion Apr 03 06:15:38 habitacion volumio[1114]: [Metrics] CommandRouter: 114s 374.74ms Apr 03 06:15:38 habitacion volumio[1114]: info: CoreCommandRouter::volumiosetStartupVolume Apr 03 06:15:38 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 06:15:38 habitacion volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 06:15:39 habitacion volumio[1114]: info: CoreCommandRouter::Close All Modals sent Apr 03 06:15:39 habitacion volumio[1114]: info: CoreCommandRouter::Close All Modals sent Apr 03 06:15:39 habitacion volumio[1114]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Apr 03 06:15:39 habitacion volumio[1114]: info: Reading ALSA contributions from plugins. Apr 03 06:15:39 habitacion volumio[1114]: info: Successfully Updated MyVolumio device Apr 03 06:15:39 habitacion volumio[1114]: info: MRS: Removed streaming files Apr 03 06:15:39 habitacion volumio[1114]: info: MRS: volumioStreaming STOPPED Apr 03 06:15:39 habitacion volumio[1114]: info: MRS: SNAPSERVER STOPPED Apr 03 06:15:39 habitacion volumio[1114]: info: MRS: SNAPCLIENT STOPPED Apr 03 06:15:40 habitacion dbus-daemon[656]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30000ms) Apr 03 06:15:40 habitacion volumio[1114]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 03 06:15:40 habitacion volumio[1114]: Error: write EPIPE Apr 03 06:15:40 habitacion volumio[1114]: at afterWriteDispatched (node:internal/stream_base_commons:160:15) Apr 03 06:15:40 habitacion volumio[1114]: at writeGeneric (node:internal/stream_base_commons:151:3) Apr 03 06:15:40 habitacion volumio[1114]: at Socket._writeGeneric (node:net:952:11) Apr 03 06:15:40 habitacion volumio[1114]: at Socket._write (node:net:964:8) Apr 03 06:15:40 habitacion volumio[1114]: at writeOrBuffer (node:internal/streams/writable:399:12) Apr 03 06:15:40 habitacion volumio[1114]: at _write (node:internal/streams/writable:340:10) Apr 03 06:15:40 habitacion volumio[1114]: at Writable.write (node:internal/streams/writable:344:10) Apr 03 06:15:40 habitacion volumio[1114]: at EventEmitter. (/myvolumio/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/connection.js:154:16) Apr 03 06:15:40 habitacion volumio[1114]: at Object.onceWrapper (node:events:628:28) Apr 03 06:15:40 habitacion volumio[1114]: at EventEmitter.emit (node:events:514:28) Apr 03 06:15:40 habitacion volumio[1114]: at afterHandshake (/myvolumio/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/connection.js:122:10) Apr 03 06:15:40 habitacion volumio[1114]: at /myvolumio/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/handshake.js:90:18 Apr 03 06:15:40 habitacion volumio[1114]: at Socket.readable (/myvolumio/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/readline.js:12:11) Apr 03 06:15:40 habitacion volumio[1114]: at Socket.emit (node:events:514:28) Apr 03 06:15:40 habitacion volumio[1114]: at emitReadable_ (node:internal/streams/readable:609:12) Apr 03 06:15:40 habitacion volumio[1114]: at process.processTicksAndRejections (node:internal/process/task_queues:81:21) { Apr 03 06:15:40 habitacion volumio[1114]: errno: -32, Apr 03 06:15:40 habitacion volumio[1114]: code: 'EPIPE', Apr 03 06:15:40 habitacion volumio[1114]: syscall: 'write' Apr 03 06:15:40 habitacion volumio[1114]: } Apr 03 06:15:40 habitacion volumio[1114]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 03 06:15:51 habitacion dbus-daemon[656]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.20" (uid=0 pid=1497 comm="/usr/bin/volumio5-onboarding") interface="(unset)" member="(unset)" error name="org.freedesktop.DBus.Error.UnknownMethod" requested_reply="0" destination=":1.4" (uid=0 pid=832 comm="/usr/libexec/bluetooth/bluetoothd --noplugin=sap,b") Apr 03 06:15:55 habitacion sudo[1800]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-03 06:14' Apr 03 06:15:55 habitacion sudo[1800]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 06:15:56 habitacion upmpdcli[1802]: writing RSA key PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"