May 31 01:13:00 quarto volumio5-onboarding[2008]: time=2026-05-31T01:13:00.040+01:00 level=INFO msg="running volumio5-device-gateway" version=6370e0a8+CHANGES buildDate=2026-03-06T16:29:42Z May 31 01:13:00 quarto sudo[2005]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 31 01:13:00 quarto sudo[2005]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 01:13:01 quarto sudo[2007]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 31 01:13:01 quarto sudo[2007]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 01:13:01 quarto sudo[2007]: pam_unix(sudo:session): session closed for user root May 31 01:13:01 quarto sudo[2005]: pam_unix(sudo:session): session closed for user root May 31 01:13:04 quarto volumio[1092]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 31 01:13:04 quarto volumio[1092]: info: FusionDsp - Effects disabled May 31 01:13:05 quarto volumio[1092]: info: camilladsp service started and running in background, instance 1 May 31 01:13:05 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:05 quarto volumio[1092]: ALSA lib confmisc.c:165:(snd_config_get_card) Cannot get card index for undefined May 31 01:13:05 quarto volumio[1092]: cannot open device 'volumioHw': No such device May 31 01:13:05 quarto volumio[1092]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json May 31 01:13:05 quarto volumio[1092]: ALSA lib confmisc.c:165:(snd_config_get_card) Cannot get card index for undefined May 31 01:13:05 quarto volumio[1092]: cannot open device 'volumioHw': No such device May 31 01:13:06 quarto sudo[2046]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service May 31 01:13:06 quarto sudo[2046]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 01:13:06 quarto volumio[1092]: info: FusionDsp loaded May 31 01:13:06 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 31 01:13:06 quarto volumio[1092]: info: FusionDsp - --[object Object] May 31 01:13:06 quarto volumio[1092]: error: FusionDsp - Socket connection not established May 31 01:13:07 quarto volumio[1092]: info: FusionDsp - Reporting Fusion DSP Enabled May 31 01:13:07 quarto volumio[1092]: info: Adding Signal Path Element [object Object] May 31 01:13:07 quarto volumio[1092]: info: Adding fusiondspeq DSP Signal Path Element May 31 01:13:07 quarto volumio[1092]: info: FusionDsp - ---- installed callbackRead (debounced 200ms) May 31 01:13:07 quarto volumio[1092]: info: FusionDsp - PEQ graph server listening on port 10015 May 31 01:13:07 quarto volumio[1092]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory May 31 01:13:07 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:13:07 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 31 01:13:07 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:13:07 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 31 01:13:07 quarto volumio[1092]: error: Plugin system_controller volumio5onboarding failed to complete 'onStart' in a timely fashion May 31 01:13:07 quarto volumio[1092]: error: Plugin music_service mpd failed to complete 'onStart' in a timely fashion May 31 01:13:07 quarto volumio[1092]: error: Plugin music_service metaroon failed to complete 'onStart' in a timely fashion May 31 01:13:07 quarto volumio[1092]: error: Plugin music_service minidlna failed to complete 'onStart' in a timely fashion May 31 01:13:07 quarto volumio[1092]: error: Plugin system_hardware music_services_shield failed to complete 'onStart' in a timely fashion May 31 01:13:07 quarto volumio[1092]: info: ------------------------------------------- May 31 01:13:07 quarto volumio[1092]: info: ----- MyVolumio plugins startup ---- May 31 01:13:07 quarto volumio[1092]: info: ------------------------------------------- May 31 01:13:07 quarto volumio[1092]: info: [MyVolumio PluginManager] Fetching plans data.... May 31 01:13:08 quarto systemd[1]: Starting fusiondsp.service - FusionDsp Daemon... May 31 01:13:10 quarto volumio5-onboarding[2008]: 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:57502->127.0.0.1:3000: i/o timeout May 31 01:13:10 quarto systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE May 31 01:13:10 quarto systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. May 31 01:13:10 quarto systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 7. May 31 01:13:10 quarto systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. May 31 01:13:10 quarto systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. May 31 01:13:10 quarto volumio5-onboarding[2067]: time=2026-05-31T01:13:10.614+01:00 level=INFO msg="running volumio5-device-gateway" version=6370e0a8+CHANGES buildDate=2026-03-06T16:29:42Z May 31 01:13:11 quarto volumio[1092]: info: Discovery: this is already registered, 1c2b0c6c-4f58-4e69-84d9-27caf7cb874c May 31 01:13:11 quarto volumio[1092]: info: Discovery: Found device Quarto May 31 01:13:11 quarto volumio[1092]: info: CoreCommandRouter::volumioGetState May 31 01:13:11 quarto volumio[1092]: info: CorePlayQueue::getTrack 0 May 31 01:13:12 quarto volumio[1092]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf May 31 01:13:12 quarto volumio[1092]: info: Reading ALSA contributions from plugins. May 31 01:13:13 quarto systemd[1]: Started fusiondsp.service - FusionDsp Daemon. May 31 01:13:13 quarto sudo[2046]: pam_unix(sudo:session): session closed for user root May 31 01:13:17 quarto volumio[1092]: info: minidlna: Found miniDLNA version 1.3.0 May 31 01:13:17 quarto volumio[1092]: info: minidlna: Starting minidlna.service May 31 01:13:17 quarto volumio[1092]: info: metaroon: RoonBridge service started May 31 01:13:17 quarto sudo[2095]: volumio : PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/addservice.sh May 31 01:13:17 quarto sudo[2095]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 01:13:17 quarto sudo[2097]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service May 31 01:13:17 quarto sudo[2097]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 01:13:17 quarto volumio[1092]: info: metaroon: Creating new Roon API instance May 31 01:13:18 quarto volumio[1092]: info: metaroon: Starting Roon discovery May 31 01:13:18 quarto volumio[1092]: Setting up sood May 31 01:13:18 quarto systemd[1]: Started minidlna.service - MiniDLNA lightweight DLNA/UPnP-AV server. May 31 01:13:18 quarto sudo[2097]: pam_unix(sudo:session): session closed for user root May 31 01:13:19 quarto systemd[1]: Reloading. May 31 01:13:20 quarto volumio5-onboarding[2067]: 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:60946->127.0.0.1:3000: i/o timeout May 31 01:13:20 quarto volumio[1092]: Starting sood May 31 01:13:31 quarto ntpd[847]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 May 31 01:13:31 quarto ntpd[847]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 May 31 01:13:31 quarto ntpd[847]: DNS: Pool skipping: 194.117.47.42 May 31 01:13:31 quarto ntpd[847]: DNS: Pool taking: 162.159.200.123 May 31 01:13:31 quarto ntpd[847]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 May 31 01:13:32 quarto ntpd[847]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 May 31 01:13:32 quarto ntpd[847]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 May 31 01:13:32 quarto ntpd[847]: DNS: Pool skipping: 143.20.12.2 May 31 01:13:32 quarto ntpd[847]: DNS: Pool skipping: 162.159.200.1 May 31 01:13:32 quarto ntpd[847]: DNS: Pool skipping: 2606:4700:f1::1 May 31 01:13:32 quarto ntpd[847]: DNS: Pool taking: 2606:4700:f1::123 May 31 01:13:32 quarto ntpd[847]: DNS: Pool taking: 2001:690:2100:14::2 May 31 01:13:32 quarto ntpd[847]: DNS: Pool skipping: 2001:ba0:252:ee00::123 May 31 01:13:32 quarto ntpd[847]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 May 31 01:13:32 quarto systemd[1]: /etc/systemd/system/musicservicesshield.service:14: Failed to parse output specifier, ignoring: jouurnal May 31 01:13:32 quarto volumio[1092]: info: MPD Permissions set May 31 01:13:32 quarto volumio[1092]: info: MPD Permissions set May 31 01:13:32 quarto volumio[1092]: info: Upmpdcli Daemon Started May 31 01:13:33 quarto ntpd[847]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 May 31 01:13:33 quarto ntpd[847]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 May 31 01:13:33 quarto ntpd[847]: DNS: Pool skipping: 193.136.152.72 May 31 01:13:33 quarto ntpd[847]: DNS: Pool skipping: 194.117.47.44 May 31 01:13:33 quarto ntpd[847]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 May 31 01:13:33 quarto volumio[1092]: error: MyVolumio Plugin failed to start in a timely fashion May 31 01:13:34 quarto ntpd[847]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 May 31 01:13:34 quarto ntpd[847]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 May 31 01:13:34 quarto ntpd[847]: DNS: Pool skipping: 194.117.47.42 May 31 01:13:34 quarto ntpd[847]: DNS: Pool skipping: 143.20.12.2 May 31 01:13:34 quarto ntpd[847]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 May 31 01:13:35 quarto volumio[1092]: [Metrics] CommandRouter: 251s 334.68ms May 31 01:13:35 quarto volumio[1092]: info: CoreCommandRouter::volumiosetStartupVolume May 31 01:13:35 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:35 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:13:36 quarto volumio[1092]: info: CoreCommandRouter::Close All Modals sent May 31 01:13:36 quarto volumio[1092]: info: CoreCommandRouter::Close All Modals sent May 31 01:13:36 quarto systemd[1]: /lib/systemd/system/roonbridge.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 31 01:13:36 quarto systemd[1]: /lib/systemd/system/roonbridge.service:8: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 31 01:13:36 quarto volumio[1092]: error: FusionDsp - Reload WebSocket error: [object Object] May 31 01:13:37 quarto systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE May 31 01:13:37 quarto systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. May 31 01:13:37 quarto sudo[2095]: pam_unix(sudo:session): session closed for user root May 31 01:13:37 quarto systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 8. May 31 01:13:37 quarto systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. May 31 01:13:37 quarto systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. May 31 01:13:38 quarto volumio[1092]: info: MPD running with PID1657 May 31 01:13:38 quarto volumio[1092]: ,establishing connection May 31 01:13:38 quarto volumio[1092]: info: minidlna: systemctl start minidlna.service succeeded. May 31 01:13:39 quarto volumio[1092]: info: Volumio called home May 31 01:13:39 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable May 31 01:13:39 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 31 01:13:39 quarto volumio5-onboarding[2162]: time=2026-05-31T01:13:39.516+01:00 level=INFO msg="running volumio5-device-gateway" version=6370e0a8+CHANGES buildDate=2026-03-06T16:29:42Z May 31 01:13:39 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect May 31 01:13:43 quarto volumio[1092]: error: MPD error: The expression evaluated to a falsy value: May 31 01:13:43 quarto volumio[1092]: assert.ok(self.idling) May 31 01:13:43 quarto volumio[1092]: error: The expression evaluated to a falsy value: May 31 01:13:43 quarto volumio[1092]: assert.ok(self.idling) May 31 01:13:43 quarto volumio[1092]: error: MPD error: The expression evaluated to a falsy value: May 31 01:13:43 quarto volumio[1092]: assert.ok(self.idling) May 31 01:13:43 quarto volumio[1092]: error: The expression evaluated to a falsy value: May 31 01:13:43 quarto volumio[1092]: assert.ok(self.idling) May 31 01:13:43 quarto volumio[1092]: info: camilladsp respawn in 100 ms (attempt 1/10) May 31 01:13:43 quarto volumio[1092]: info: succeeded May 31 01:13:43 quarto volumio[1092]: info: BOOT COMPLETED May 31 01:13:43 quarto volumio[1092]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 May 31 01:13:43 quarto volumio[1092]: info: FusionDsp - ---- read samplerate from file: 44100 May 31 01:13:43 quarto volumio[1092]: info: camilladsp service terminated, instance 1 May 31 01:13:43 quarto volumio[1092]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 31 01:13:43 quarto volumio[1092]: info: FusionDsp - Effects disabled May 31 01:13:43 quarto volumio[1092]: info: camilladsp service started and running in background, instance 1 May 31 01:13:43 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:43 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:43 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:43 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:43 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:43 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:43 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:43 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:43 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:13:43 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:44 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:44 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:44 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:44 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:44 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:44 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:44 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:44 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:44 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:13:44 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:44 quarto volumio[1092]: info: mpdhttpout ---Boot completed detected! Patching mpd now! May 31 01:13:45 quarto volumio[1092]: error: updateQueue error: null May 31 01:13:45 quarto volumio[1092]: info: camilladsp respawn in 100 ms (attempt 1/10) May 31 01:13:45 quarto volumio[1092]: info: Starting Shairport Sync May 31 01:13:45 quarto volumio[1092]: info: Starting Shairport Sync May 31 01:13:46 quarto sudo[2219]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 31 01:13:46 quarto sudo[2219]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 01:13:46 quarto volumio[1092]: info: Starting Shairport Sync May 31 01:13:46 quarto sudo[2222]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 31 01:13:46 quarto sudo[2222]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 01:13:46 quarto sudo[2224]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 31 01:13:46 quarto sudo[2224]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 01:13:46 quarto volumio[1092]: (node:1092) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. May 31 01:13:46 quarto volumio[1092]: (Use `node --trace-deprecation ...` to show where the warning was created) May 31 01:13:46 quarto volumio[1092]: (node:1092) [DEP0106] DeprecationWarning: crypto.createDecipher is deprecated. May 31 01:13:46 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium May 31 01:13:46 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium May 31 01:13:46 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium May 31 01:13:46 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium May 31 01:13:46 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium May 31 01:13:46 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium May 31 01:13:46 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium May 31 01:13:46 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium May 31 01:13:46 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium May 31 01:13:46 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium May 31 01:13:46 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium May 31 01:13:46 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar May 31 01:13:46 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar May 31 01:13:46 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar May 31 01:13:46 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar May 31 01:13:46 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar May 31 01:13:46 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar May 31 01:13:46 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar May 31 01:13:46 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar May 31 01:13:46 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar May 31 01:13:46 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar May 31 01:13:46 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar May 31 01:13:46 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso May 31 01:13:46 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso May 31 01:13:46 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso May 31 01:13:46 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso May 31 01:13:46 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso May 31 01:13:46 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso May 31 01:13:46 quarto systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... May 31 01:13:46 quarto systemd[1]: shairport-sync.service: Deactivated successfully. May 31 01:13:46 quarto systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 31 01:13:46 quarto systemd[1]: shairport-sync.service: Consumed 3.377s CPU time. May 31 01:13:46 quarto volumio[1092]: info: Adding plugin bluetooth to MyMusic Plugins May 31 01:13:46 quarto systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 31 01:13:46 quarto volumio[1092]: info: Adding plugin multiroom to MyMusic Plugins May 31 01:13:46 quarto sudo[2224]: pam_unix(sudo:session): session closed for user root May 31 01:13:46 quarto sudo[2219]: pam_unix(sudo:session): session closed for user root May 31 01:13:46 quarto sudo[2222]: pam_unix(sudo:session): session closed for user root May 31 01:13:46 quarto volumio[1092]: info: Adding plugin metavolumio to MyMusic Plugins May 31 01:13:46 quarto volumio[1092]: info: Adding plugin cd_controller to MyMusic Plugins May 31 01:13:46 quarto volumio[1092]: info: Adding plugin qobuzconnect to MyMusic Plugins May 31 01:13:46 quarto volumio[1092]: info: Adding plugin smart_inputs to MyMusic Plugins May 31 01:13:47 quarto volumio[1092]: info: Adding plugin tidalconnect to MyMusic Plugins May 31 01:13:47 quarto volumio[1092]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... May 31 01:13:48 quarto ntpd[847]: CLOCK: time stepped by 0.885617 May 31 01:13:48 quarto ntpd[847]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes May 31 01:13:49 quarto nmbd[908]: [2026/05/31 01:13:49.508480, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 31 01:13:49 quarto nmbd[908]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.100.26 for name WORKGROUP<1d>. May 31 01:13:49 quarto nmbd[908]: This response was from IP 192.168.100.202, reporting an IP address of 192.168.100.235. May 31 01:13:49 quarto nmbd[908]: [2026/05/31 01:13:49.561203, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 31 01:13:49 quarto nmbd[908]: query_name_response: Multiple (3) responses received for a query on subnet 192.168.100.26 for name WORKGROUP<1d>. May 31 01:13:49 quarto nmbd[908]: This response was from IP 192.168.100.202, reporting an IP address of 192.168.100.235. May 31 01:13:49 quarto nmbd[908]: [2026/05/31 01:13:49.561465, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 31 01:13:49 quarto nmbd[908]: query_name_response: Multiple (4) responses received for a query on subnet 192.168.100.26 for name WORKGROUP<1d>. May 31 01:13:49 quarto nmbd[908]: This response was from IP 192.168.100.202, reporting an IP address of 192.168.100.235. May 31 01:13:49 quarto nmbd[908]: [2026/05/31 01:13:49.561668, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 31 01:13:49 quarto nmbd[908]: query_name_response: Multiple (5) responses received for a query on subnet 192.168.100.26 for name WORKGROUP<1d>. May 31 01:13:49 quarto nmbd[908]: This response was from IP 192.168.100.235, reporting an IP address of 192.168.100.235. May 31 01:13:49 quarto nmbd[908]: [2026/05/31 01:13:49.561890, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 31 01:13:49 quarto nmbd[908]: query_name_response: Multiple (6) responses received for a query on subnet 192.168.100.26 for name WORKGROUP<1d>. May 31 01:13:49 quarto nmbd[908]: This response was from IP 192.168.100.235, reporting an IP address of 192.168.100.235. May 31 01:13:49 quarto nmbd[908]: [2026/05/31 01:13:49.562093, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 31 01:13:49 quarto nmbd[908]: query_name_response: Multiple (7) responses received for a query on subnet 192.168.100.26 for name WORKGROUP<1d>. May 31 01:13:49 quarto nmbd[908]: This response was from IP 192.168.100.235, reporting an IP address of 192.168.100.235. May 31 01:13:49 quarto nmbd[908]: [2026/05/31 01:13:49.562288, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 31 01:13:49 quarto nmbd[908]: query_name_response: Multiple (8) responses received for a query on subnet 192.168.100.26 for name WORKGROUP<1d>. May 31 01:13:49 quarto nmbd[908]: This response was from IP 192.168.100.202, reporting an IP address of 192.168.100.235. May 31 01:13:49 quarto nmbd[908]: [2026/05/31 01:13:49.562513, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 31 01:13:49 quarto nmbd[908]: query_name_response: Multiple (9) responses received for a query on subnet 192.168.100.26 for name WORKGROUP<1d>. May 31 01:13:49 quarto nmbd[908]: This response was from IP 192.168.100.202, reporting an IP address of 192.168.100.235. May 31 01:13:49 quarto nmbd[908]: [2026/05/31 01:13:49.562708, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 31 01:13:49 quarto nmbd[908]: query_name_response: Multiple (10) responses received for a query on subnet 192.168.100.26 for name WORKGROUP<1d>. May 31 01:13:49 quarto nmbd[908]: This response was from IP 192.168.100.202, reporting an IP address of 192.168.100.235. May 31 01:13:49 quarto nmbd[908]: [2026/05/31 01:13:49.562904, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 31 01:13:49 quarto nmbd[908]: query_name_response: Multiple (11) responses received for a query on subnet 192.168.100.26 for name WORKGROUP<1d>. May 31 01:13:49 quarto nmbd[908]: This response was from IP 192.168.100.202, reporting an IP address of 192.168.100.235. May 31 01:13:49 quarto nmbd[908]: [2026/05/31 01:13:49.563107, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 31 01:13:49 quarto nmbd[908]: query_name_response: Multiple (12) responses received for a query on subnet 192.168.100.26 for name WORKGROUP<1d>. May 31 01:13:49 quarto nmbd[908]: This response was from IP 192.168.100.202, reporting an IP address of 192.168.100.235. May 31 01:13:49 quarto nmbd[908]: [2026/05/31 01:13:49.563320, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 31 01:13:49 quarto nmbd[908]: query_name_response: Multiple (13) responses received for a query on subnet 192.168.100.26 for name WORKGROUP<1d>. May 31 01:13:49 quarto nmbd[908]: This response was from IP 192.168.100.235, reporting an IP address of 192.168.100.235. May 31 01:13:49 quarto nmbd[908]: [2026/05/31 01:13:49.563537, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 31 01:13:49 quarto nmbd[908]: query_name_response: Multiple (14) responses received for a query on subnet 192.168.100.26 for name WORKGROUP<1d>. May 31 01:13:49 quarto nmbd[908]: This response was from IP 192.168.100.235, reporting an IP address of 192.168.100.235. May 31 01:13:49 quarto nmbd[908]: [2026/05/31 01:13:49.563738, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 31 01:13:49 quarto nmbd[908]: query_name_response: Multiple (15) responses received for a query on subnet 192.168.100.26 for name WORKGROUP<1d>. May 31 01:13:49 quarto nmbd[908]: This response was from IP 192.168.100.202, reporting an IP address of 192.168.100.235. May 31 01:13:50 quarto volumio5-onboarding[2162]: 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:41286->127.0.0.1:3000: i/o timeout May 31 01:13:50 quarto systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE May 31 01:13:50 quarto systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. May 31 01:13:50 quarto systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 9. May 31 01:13:50 quarto systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. May 31 01:13:50 quarto systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. May 31 01:13:50 quarto volumio5-onboarding[2252]: time=2026-05-31T01:13:50.831+01:00 level=INFO msg="running volumio5-device-gateway" version=6370e0a8+CHANGES buildDate=2026-03-06T16:29:42Z May 31 01:13:53 quarto volumio[1092]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded May 31 01:13:53 quarto volumio[1092]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio May 31 01:13:53 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:13:53 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:13:53 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:13:53 quarto volumio[1092]: info: Starting MyVolumio Remote Streaming Endpoints May 31 01:13:53 quarto volumio[1092]: info: MyVolumio login type: Token May 31 01:13:53 quarto volumio[1092]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started May 31 01:13:53 quarto volumio[1092]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... May 31 01:13:56 quarto volumio[1092]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded May 31 01:13:56 quarto volumio[1092]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services May 31 01:13:56 quarto volumio[1092]: info: Streaming services startup May 31 01:13:56 quarto volumio[1092]: info: Starting Streaming Daemon May 31 01:13:56 quarto volumio[1092]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started May 31 01:13:56 quarto sudo[2280]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 31 01:13:56 quarto sudo[2280]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 01:13:56 quarto volumio[1092]: info: Shairport-Sync Started May 31 01:13:57 quarto volumio[1092]: Error adding Membership: Error: addMembership EINVAL May 31 01:13:57 quarto volumio[1092]: info: Shairport-Sync Started May 31 01:13:57 quarto volumio[1092]: info: Shairport-Sync Started May 31 01:13:57 quarto volumio[1092]: info: Asound.conf file unchanged, so no further update is needed May 31 01:13:57 quarto volumio[1092]: info: Output device has changed, restarting MPD May 31 01:13:57 quarto volumio[1092]: info: Output device has changed, restarting Shairport Sync May 31 01:13:57 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:57 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:13:57 quarto sudo[2280]: pam_unix(sudo:session): session closed for user root May 31 01:13:57 quarto sudo[2298]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 31 01:13:57 quarto sudo[2298]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 01:13:57 quarto sudo[2295]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 31 01:13:57 quarto sudo[2295]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 01:13:57 quarto volumio[1092]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 31 01:13:57 quarto sudo[2295]: pam_unix(sudo:session): session closed for user root May 31 01:13:57 quarto volumio[1092]: info: camilladsp respawn in 200 ms (attempt 2/10) May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso May 31 01:13:57 quarto systemd[1]: musicservicesshield.service: Deactivated successfully. May 31 01:13:57 quarto systemd[1]: Stopped musicservicesshield.service - Shield Volumio Music Services in the User CPU Set. May 31 01:13:57 quarto systemd[1]: Stopping musicservicesshield.service - Shield Volumio Music Services in the User CPU Set... May 31 01:13:57 quarto systemd[1]: Stopping mpd.service - Music Player Daemon... May 31 01:13:57 quarto volumio[1092]: info: Adding plugin bluetooth to MyMusic Plugins May 31 01:13:57 quarto volumio[1092]: info: Adding plugin multiroom to MyMusic Plugins May 31 01:13:57 quarto volumio[1092]: info: Adding plugin metavolumio to MyMusic Plugins May 31 01:13:57 quarto volumio[1092]: info: Adding plugin cd_controller to MyMusic Plugins May 31 01:13:57 quarto volumio[1092]: info: Adding plugin qobuzconnect to MyMusic Plugins May 31 01:13:57 quarto volumio[1092]: info: Adding plugin smart_inputs to MyMusic Plugins May 31 01:13:57 quarto volumio[1092]: info: Adding plugin tidalconnect to MyMusic Plugins May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded May 31 01:13:57 quarto volumio[1092]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio May 31 01:13:57 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:13:57 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:13:57 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:13:57 quarto volumio[1092]: info: Starting MyVolumio Remote Streaming Endpoints May 31 01:13:57 quarto volumio[1092]: info: MPD Permissions set May 31 01:13:57 quarto volumio[1092]: error: Cannot start Volumio Streaming Daemon May 31 01:13:57 quarto volumio[1092]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 31 01:13:57 quarto volumio[1092]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 31 01:13:57 quarto volumio[1092]: info: CoreCommandRouter::volumioGetState May 31 01:13:57 quarto volumio[1092]: info: CorePlayQueue::getTrack 0 May 31 01:13:57 quarto volumio[1092]: info: CoreCommandRouter::volumioPause May 31 01:13:57 quarto volumio[1092]: info: CoreStateMachine::pause May 31 01:13:57 quarto volumio[1092]: info: mpdhttpout --- Volumio set on pause May 31 01:13:57 quarto volumio[1092]: info: mpdhttpout ---Configuration successfully added to mpd.conf. May 31 01:13:57 quarto volumio[1092]: info: CoreCommandRouter::volumioGetState May 31 01:13:57 quarto volumio[1092]: info: CorePlayQueue::getTrack 0 May 31 01:13:57 quarto volumio[1092]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 May 31 01:13:57 quarto volumio[1092]: info: camilladsp respawn in 400 ms (attempt 3/10) May 31 01:13:57 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:57 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:57 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:57 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:57 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:57 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:57 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:57 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:57 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:13:57 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:13:57 quarto volumio[1092]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 May 31 01:13:57 quarto volumio[1092]: info: Listing playlists May 31 01:13:57 quarto volumio[1092]: info: Listing playlists May 31 01:13:57 quarto volumio[1092]: verbose: New Socket.io Connection to 192.168.100.26 from 192.168.100.66 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.5 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 4 May 31 01:13:57 quarto volumio[1092]: info: Starting Shairport Sync May 31 01:13:57 quarto volumio[1092]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. May 31 01:13:57 quarto volumio[1092]: info: CoreCommandRouter::volumioGetState May 31 01:13:57 quarto volumio[1092]: info: CorePlayQueue::getTrack 0 May 31 01:13:57 quarto volumio[1092]: info: CoreCommandRouter::volumioPause May 31 01:13:57 quarto volumio[1092]: info: CoreStateMachine::pause May 31 01:13:57 quarto volumio[1092]: info: mpdhttpout --- Volumio set on pause May 31 01:13:57 quarto sudo[2321]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 31 01:13:57 quarto sudo[2321]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 01:13:57 quarto volumio[1092]: verbose: New Socket.io Connection to 192.168.100.26 from 192.168.100.66 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.5 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 5 May 31 01:13:58 quarto systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... May 31 01:13:58 quarto systemd[1]: shairport-sync.service: Deactivated successfully. May 31 01:13:58 quarto systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 31 01:13:58 quarto systemd[1]: shairport-sync.service: Consumed 1.938s CPU time. May 31 01:13:58 quarto volumio[1092]: verbose: New Socket.io Connection to 192.168.100.26 from 192.168.100.66 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.5 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 6 May 31 01:13:58 quarto systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 31 01:13:58 quarto volumio[1092]: verbose: New Socket.io Connection to 192.168.100.26 from 192.168.100.66 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.5 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 7 May 31 01:13:58 quarto sudo[2321]: pam_unix(sudo:session): session closed for user root May 31 01:13:58 quarto volumio[1092]: verbose: New Socket.io Connection to 192.168.100.26 from 192.168.100.66 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.5 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 8 May 31 01:13:58 quarto volumio[1092]: verbose: New Socket.io Connection to 192.168.100.26 from 192.168.100.66 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.5 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 9 May 31 01:13:58 quarto volumio[1092]: verbose: New Socket.io Connection to 192.168.100.26 from 192.168.100.66 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.5 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 10 May 31 01:13:58 quarto volumio[1092]: verbose: New Socket.io Connection to 192.168.100.26 from 192.168.100.66 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.5 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 11 May 31 01:13:58 quarto volumio[1092]: info: Shairport-Sync Started May 31 01:13:58 quarto volumio[1092]: verbose: New Socket.io Connection to 192.168.100.26 from 192.168.100.66 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.5 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 12 May 31 01:13:58 quarto volumio[1092]: info: camilladsp respawn in 800 ms (attempt 4/10) May 31 01:13:58 quarto volumio[1092]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory May 31 01:13:58 quarto volumio[1092]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13 May 31 01:13:58 quarto volumio[1092]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14 May 31 01:13:58 quarto volumio[1092]: 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: 15 May 31 01:13:58 quarto volumio[1092]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN May 31 01:13:58 quarto volumio[1092]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 16 May 31 01:13:58 quarto volumio[1092]: 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: 16 May 31 01:13:58 quarto volumio[1092]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 17 May 31 01:13:59 quarto volumio[1092]: info: Received Get System Info May 31 01:13:59 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 31 01:13:59 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 31 01:13:59 quarto volumio[1092]: info: Discovery: Getting this device information May 31 01:13:59 quarto volumio[1092]: info: CoreCommandRouter::volumioGetState May 31 01:13:59 quarto volumio[1092]: info: CorePlayQueue::getTrack 0 May 31 01:13:59 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 31 01:13:59 quarto volumio5-onboarding[2252]: time=2026-05-31T01:13:59.299+01:00 level=INFO msg="system info for 4d7548bc43856a10d05027fbef2a7592" deviceName=Quarto deviceVariant=volumio deviceModel= softwareVersion=4.119 May 31 01:13:59 quarto volumio[1092]: info: CoreCommandRouter::volumioGetState May 31 01:13:59 quarto volumio[1092]: info: CorePlayQueue::getTrack 0 May 31 01:13:59 quarto volumio[1092]: info: camilladsp respawn in 1600 ms (attempt 5/10) May 31 01:13:59 quarto volumio5-onboarding[2252]: time=2026-05-31T01:13:59.441+01:00 level=INFO msg="bootstrapping state" hasInternet=true May 31 01:13:59 quarto volumio[1092]: info: Received Get System Info May 31 01:13:59 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 31 01:13:59 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 31 01:13:59 quarto volumio[1092]: info: Discovery: Getting this device information May 31 01:13:59 quarto volumio[1092]: info: CoreCommandRouter::volumioGetState May 31 01:13:59 quarto volumio[1092]: info: CorePlayQueue::getTrack 0 May 31 01:13:59 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 31 01:13:59 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd May 31 01:14:00 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd May 31 01:14:00 quarto volumio[1092]: verbose: New Socket.io Connection to 192.168.100.26 from 192.168.100.66 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.5 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 18 May 31 01:14:00 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 31 01:14:02 quarto volumio[1092]: info: CoreCommandRouter::volumioGetVisibleSources May 31 01:14:02 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 31 01:14:03 quarto sudo[2361]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 31 01:14:03 quarto sudo[2361]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 01:14:03 quarto volumio[1092]: info: CoreCommandRouter::volumioGetState May 31 01:14:03 quarto volumio[1092]: info: CorePlayQueue::getTrack 0 May 31 01:14:03 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 31 01:14:03 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 31 01:14:03 quarto volumio[1092]: info: Received Get System Info May 31 01:14:03 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 31 01:14:03 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 31 01:14:03 quarto volumio[1092]: info: Discovery: Getting this device information May 31 01:14:03 quarto volumio[1092]: info: CoreCommandRouter::volumioGetState May 31 01:14:03 quarto volumio[1092]: info: CorePlayQueue::getTrack 0 May 31 01:14:03 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 31 01:14:03 quarto volumio-remote-updater[605]: Test mode disabled May 31 01:14:03 quarto volumio-remote-updater[605]: Alpha mode disabled May 31 01:14:03 quarto volumio-remote-updater[605]: Alpha legacy test mode disabled May 31 01:14:03 quarto volumio[1092]: info: CoreCommandRouter::volumioGetState May 31 01:14:03 quarto volumio[1092]: info: CorePlayQueue::getTrack 0 May 31 01:14:03 quarto sudo[2366]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 31 01:14:03 quarto sudo[2366]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 01:14:03 quarto volumio[1092]: info: Listing playlists May 31 01:14:03 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 31 01:14:03 quarto volumio[1092]: info: Received Get System Info May 31 01:14:03 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 31 01:14:03 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 31 01:14:03 quarto volumio[1092]: info: Discovery: Getting this device information May 31 01:14:03 quarto volumio[1092]: info: CoreCommandRouter::volumioGetState May 31 01:14:03 quarto volumio[1092]: info: CorePlayQueue::getTrack 0 May 31 01:14:03 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 31 01:14:03 quarto volumio[1092]: info: CoreCommandRouter::volumioGetState May 31 01:14:03 quarto volumio[1092]: info: CorePlayQueue::getTrack 0 May 31 01:14:03 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 31 01:14:03 quarto volumio[1092]: info: Received Get System Info May 31 01:14:03 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 31 01:14:03 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 31 01:14:03 quarto volumio[1092]: info: Discovery: Getting this device information May 31 01:14:03 quarto volumio[1092]: info: CoreCommandRouter::volumioGetState May 31 01:14:03 quarto volumio[1092]: info: CorePlayQueue::getTrack 0 May 31 01:14:03 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 31 01:14:03 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 31 01:14:03 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 31 01:14:03 quarto volumio[1092]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 31 01:14:03 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 31 01:14:03 quarto volumio[1092]: info: Received Get System Version May 31 01:14:03 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 31 01:14:04 quarto volumio[1092]: info: Received Get System Info May 31 01:14:04 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 31 01:14:04 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 31 01:14:04 quarto volumio[1092]: info: Discovery: Getting this device information May 31 01:14:04 quarto volumio[1092]: info: CoreCommandRouter::volumioGetState May 31 01:14:04 quarto volumio[1092]: info: CorePlayQueue::getTrack 0 May 31 01:14:04 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 31 01:14:04 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 31 01:14:04 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 31 01:14:04 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 31 01:14:04 quarto volumio[1092]: info: CoreCommandRouter::volumioGetVisibleSources May 31 01:14:04 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 31 01:14:04 quarto volumio[1092]: info: CoreCommandRouter::volumioGetState May 31 01:14:04 quarto volumio[1092]: info: CorePlayQueue::getTrack 0 May 31 01:14:04 quarto volumio[1092]: info: CoreCommandRouter::volumioGetState May 31 01:14:04 quarto volumio[1092]: info: CorePlayQueue::getTrack 0 May 31 01:14:04 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 31 01:14:04 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 31 01:14:04 quarto volumio[1092]: info: Received Get System Info May 31 01:14:04 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 31 01:14:04 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 31 01:14:04 quarto volumio[1092]: info: Discovery: Getting this device information May 31 01:14:04 quarto volumio[1092]: info: CoreCommandRouter::volumioGetState May 31 01:14:04 quarto volumio[1092]: info: CorePlayQueue::getTrack 0 May 31 01:14:04 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 31 01:14:04 quarto volumio[1092]: info: CoreCommandRouter::volumioGetState May 31 01:14:04 quarto volumio[1092]: info: CorePlayQueue::getTrack 0 May 31 01:14:04 quarto volumio[1092]: info: Listing playlists May 31 01:14:04 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 31 01:14:04 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 31 01:14:04 quarto volumio[1092]: info: MyVolumio token set successfully May 31 01:14:04 quarto volumio[1092]: info: MYVOLUMIO: Adding device May 31 01:14:04 quarto volumio[1092]: info: MYVOLUMIO: Evaluating Server May 31 01:14:04 quarto volumio[1092]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} May 31 01:14:04 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 31 01:14:04 quarto volumio[1092]: info: camilladsp respawn in 3200 ms (attempt 6/10) May 31 01:14:04 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 31 01:14:04 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 31 01:14:04 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 31 01:14:05 quarto volumio[1092]: info: MyVolumio Plan changed: premium May 31 01:14:05 quarto volumio[1092]: info: [MyVolumio PluginManager] Subscribed plan changed to premium May 31 01:14:05 quarto volumio[1092]: info: Removing browser output: myVolumio user plan is not superstar May 31 01:14:05 quarto volumio[1092]: info: Removing audio output: May 31 01:14:05 quarto volumio[1092]: info: MYVOLUMIO: Adding device May 31 01:14:05 quarto volumio[1092]: info: MYVOLUMIO: Evaluating Server May 31 01:14:05 quarto volumio[1092]: info: CoreCommandRouter::getUIConfigOnPlugin May 31 01:14:05 quarto volumio[1092]: info: CoreCommandRouter::getUIConfigOnPlugin May 31 01:14:05 quarto volumio[1092]: info: CoreCommandRouter::getUIConfigOnPlugin May 31 01:14:05 quarto volumio[1092]: info: CoreCommandRouter::getUIConfigOnPlugin May 31 01:14:05 quarto volumio[1092]: info: Remote config written successfully May 31 01:14:05 quarto volumio[1092]: info: Starting Tunnel 1 May 31 01:14:05 quarto volumio[1092]: info: Starting Tunnel Connection Checker May 31 01:14:07 quarto volumio[1092]: info: MYVolumio Device enabled May 31 01:14:07 quarto volumio[1092]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... May 31 01:14:08 quarto volumio[1092]: info: MyVolumio status changed May 31 01:14:08 quarto volumio[1092]: info: Streaming services startup May 31 01:14:08 quarto volumio[1092]: info: Starting Streaming Daemon May 31 01:14:08 quarto volumio[1092]: info: Setting Geolocation for MyVolumio to eu2 May 31 01:14:08 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:14:08 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:14:08 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:14:08 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:14:09 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 31 01:14:09 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 31 01:14:09 quarto volumio[1092]: info: Setting Geolocation for MyVolumio to eu9 May 31 01:14:09 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:14:09 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:14:09 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:14:09 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:14:09 quarto sudo[2441]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 31 01:14:09 quarto sudo[2441]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 01:14:09 quarto volumio[1092]: info: camilladsp respawn in 6400 ms (attempt 7/10) May 31 01:14:09 quarto volumio[1092]: info: Successfully Added MyVolumio device May 31 01:14:09 quarto volumio[1092]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 19 May 31 01:14:09 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid May 31 01:14:09 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:14:09 quarto sudo[2441]: pam_unix(sudo:session): session closed for user root May 31 01:14:10 quarto volumio[1092]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... May 31 01:14:11 quarto volumio[1092]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin bluetooth May 31 01:14:11 quarto volumio[1092]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin bluetooth May 31 01:14:11 quarto volumio[1092]: ------------------------------------ BT MESSAGE: [FUNC] onVolumioStart May 31 01:14:11 quarto volumio[1092]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... May 31 01:14:19 quarto systemd[1]: mpd.service: Deactivated successfully. May 31 01:14:19 quarto systemd[1]: Stopped mpd.service - Music Player Daemon. May 31 01:14:19 quarto systemd[1]: mpd.service: Consumed 10.773s CPU time. May 31 01:14:19 quarto systemd[1]: mpd.socket: Deactivated successfully. May 31 01:14:19 quarto systemd[1]: Closed mpd.socket - Music Player Daemon Socket. May 31 01:14:19 quarto systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... May 31 01:14:19 quarto systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. May 31 01:14:20 quarto systemd[1]: Starting mpd.service - Music Player Daemon... May 31 01:14:20 quarto volumio[1092]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom May 31 01:14:20 quarto sudo[2484]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 31 01:14:20 quarto sudo[2484]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 31 01:14:21 quarto sudo[2484]: pam_unix(sudo:session): session closed for user root May 31 01:14:21 quarto sudo[2488]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom May 31 01:14:21 quarto sudo[2488]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 01:14:21 quarto sudo[2488]: pam_unix(sudo:session): session closed for user root May 31 01:14:21 quarto volumio[1092]: info: MRS: MultiRoom plugin initialized May 31 01:14:21 quarto volumio[1092]: info: MRS: STOPPING SNAPCLIENT May 31 01:14:21 quarto volumio[1092]: info: MRS: Snap server stop May 31 01:14:21 quarto volumio[1092]: info: MRS: STOPPING volumioStreaming May 31 01:14:21 quarto sudo[2507]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient May 31 01:14:21 quarto sudo[2509]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver May 31 01:14:21 quarto sudo[2509]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 01:14:21 quarto sudo[2507]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 01:14:21 quarto sudo[2511]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming May 31 01:14:21 quarto sudo[2511]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 01:14:21 quarto volumio[1092]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... May 31 01:14:21 quarto sudo[2515]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* May 31 01:14:21 quarto sudo[2515]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 01:14:21 quarto sudo[2515]: pam_unix(sudo:session): session closed for user root May 31 01:14:22 quarto sudo[2507]: pam_unix(sudo:session): session closed for user root May 31 01:14:22 quarto sudo[2511]: pam_unix(sudo:session): session closed for user root May 31 01:14:22 quarto sudo[2509]: pam_unix(sudo:session): session closed for user root May 31 01:14:24 quarto volumio[1092]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... May 31 01:14:24 quarto volumio[1092]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... May 31 01:14:25 quarto volumio[1092]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... May 31 01:14:25 quarto volumio[1092]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... May 31 01:14:26 quarto volumio[1092]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio May 31 01:14:27 quarto volumio[1092]: info: [MyVolumio PluginManager] Loading plugin "tidal"... May 31 01:14:27 quarto volumio[1092]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... May 31 01:14:31 quarto volumio[1092]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... May 31 01:14:35 quarto volumio[1092]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... May 31 01:14:35 quarto volumio5-onboarding[2252]: failed to bootstrap state: failed to get music providers: could not get available plugins: could not get available plugins: context deadline exceeded May 31 01:14:35 quarto systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE May 31 01:14:35 quarto systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. May 31 01:14:36 quarto systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 10. May 31 01:14:36 quarto systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. May 31 01:14:36 quarto systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. May 31 01:14:36 quarto volumio[1092]: info: Preparing to generate the ALSA configuration file May 31 01:14:38 quarto volumio[1092]: info: CoreCommandRouter::volumioGetState May 31 01:14:38 quarto volumio[1092]: info: CorePlayQueue::getTrack 0 May 31 01:14:38 quarto volumio5-onboarding[2537]: time=2026-05-31T01:14:38.316+01:00 level=INFO msg="running volumio5-device-gateway" version=6370e0a8+CHANGES buildDate=2026-03-06T16:29:42Z May 31 01:14:38 quarto volumio[1092]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf May 31 01:14:38 quarto volumio[1092]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf May 31 01:14:38 quarto volumio[1092]: info: Reading ALSA contributions from plugins. May 31 01:14:39 quarto volumio[1092]: info: Updating MyVolumio device info May 31 01:14:39 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:14:39 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:14:39 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:14:39 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:14:39 quarto volumio[1092]: info: Updating MyVolumio device info May 31 01:14:39 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:14:39 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:14:39 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:14:39 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 01:14:39 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 31 01:14:39 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:14:39 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:14:39 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam May 31 01:14:39 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 31 01:14:39 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject May 31 01:14:39 quarto volumio[1092]: info: CoreCommandRouter::volumioGetBrowseSources May 31 01:14:39 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 31 01:14:40 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:14:40 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 01:14:40 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam May 31 01:14:40 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 31 01:14:40 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject May 31 01:14:40 quarto volumio[1092]: info: CoreCommandRouter::volumioGetBrowseSources May 31 01:14:40 quarto volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 31 01:14:40 quarto volumio[1092]: error: Cannot download Available plugins list: Error: ESOCKETTIMEDOUT May 31 01:14:41 quarto dbus-daemon[592]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30000ms) May 31 01:14:42 quarto volumio[1092]: error: Failed to add MyVolumio device: undefined May 31 01:14:47 quarto volumio[1092]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 31 01:14:47 quarto volumio[1092]: Error: write EPIPE May 31 01:14:47 quarto volumio[1092]: at afterWriteDispatched (node:internal/stream_base_commons:160:15) May 31 01:14:47 quarto volumio[1092]: at writeGeneric (node:internal/stream_base_commons:151:3) May 31 01:14:47 quarto volumio[1092]: at Socket._writeGeneric (node:net:952:11) May 31 01:14:47 quarto volumio[1092]: at Socket._write (node:net:964:8) May 31 01:14:47 quarto volumio[1092]: at writeOrBuffer (node:internal/streams/writable:399:12) May 31 01:14:47 quarto volumio[1092]: at _write (node:internal/streams/writable:340:10) May 31 01:14:47 quarto volumio[1092]: at Writable.write (node:internal/streams/writable:344:10) May 31 01:14:47 quarto volumio[1092]: at auth (/myvolumio/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/handshake.js:67:10) May 31 01:14:47 quarto volumio[1092]: at Socket. (/myvolumio/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/connection.js:137:32) May 31 01:14:47 quarto volumio[1092]: at Object.onceWrapper (node:events:628:28) May 31 01:14:47 quarto volumio[1092]: at Socket.emit (node:events:514:28) May 31 01:14:47 quarto volumio[1092]: at PipeConnectWrap.afterConnect [as oncomplete] (node:net:1580:10) { May 31 01:14:47 quarto volumio[1092]: errno: -32, May 31 01:14:47 quarto volumio[1092]: code: 'EPIPE', May 31 01:14:47 quarto volumio[1092]: syscall: 'write' May 31 01:14:47 quarto volumio[1092]: } May 31 01:14:47 quarto volumio[1092]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 31 01:14:48 quarto volumio5-onboarding[2537]: 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:40016->127.0.0.1:3000: i/o timeout May 31 01:14:48 quarto systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE May 31 01:14:48 quarto systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. May 31 01:14:48 quarto systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 11. May 31 01:14:48 quarto systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. May 31 01:14:48 quarto systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. May 31 01:14:49 quarto volumio5-onboarding[2591]: time=2026-05-31T01:14:49.476+01:00 level=INFO msg="running volumio5-device-gateway" version=6370e0a8+CHANGES buildDate=2026-03-06T16:29:42Z May 31 01:14:59 quarto volumio5-onboarding[2591]: 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:34826->127.0.0.1:3000: i/o timeout May 31 01:14:59 quarto systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE May 31 01:14:59 quarto systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. May 31 01:14:59 quarto systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 12. May 31 01:14:59 quarto systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. May 31 01:14:59 quarto systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. May 31 01:15:00 quarto volumio5-onboarding[2630]: time=2026-05-31T01:15:00.515+01:00 level=INFO msg="running volumio5-device-gateway" version=6370e0a8+CHANGES buildDate=2026-03-06T16:29:42Z May 31 01:15:00 quarto sudo[2633]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-05-31 01:13' May 31 01:15:00 quarto sudo[2633]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 01:15:02 quarto mpd[2491]: 2026-05-31T01:15:02 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 31 01:15:04 quarto systemd[1]: Started mpd.service - Music Player Daemon. May 31 01:15:05 quarto systemd[1]: Starting musicservicesshield.service - Shield Volumio Music Services in the User CPU Set... 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"