Aug 29 16:35:00 living-room sudo[1554]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:00 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 16:35:00 living-room volumio[1222]: info: Reloading queue from file Aug 29 16:35:00 living-room volumio[1222]: info: CoreStateMachine::setRepeat null single undefined Aug 29 16:35:00 living-room volumio[1222]: info: CoreStateMachine::pushState Aug 29 16:35:00 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:00 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 16:35:00 living-room volumio[1222]: info: CoreCommandRouter::volumioPushState Aug 29 16:35:00 living-room volumio[1222]: info: CoreStateMachine::setRandom null Aug 29 16:35:00 living-room volumio[1222]: info: CoreStateMachine::pushState Aug 29 16:35:00 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:00 living-room volumio[1222]: info: CoreCommandRouter::volumioPushState Aug 29 16:35:00 living-room volumio[1222]: info: Setting Device type: Raspberry PI Aug 29 16:35:00 living-room volumio[1222]: info: Completed loading Core Plugins Aug 29 16:35:00 living-room volumio[1222]: info: Preparing to generate the ALSA configuration file Aug 29 16:35:00 living-room volumio[1222]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Aug 29 16:35:00 living-room volumio[1222]: info: USB Boot Capable - System SBC Revision found in cpuinfo: d03114 Aug 29 16:35:00 living-room volumio[1222]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Aug 29 16:35:00 living-room volumio[1222]: info: Discovery: A device disappeared from network Aug 29 16:35:00 living-room volumio[1222]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 29 16:35:00 living-room volumio[1222]: info: Reading ALSA contributions from plugins. Aug 29 16:35:00 living-room volumio[1222]: info: Discovery: adding 43e57110-1273-48e3-8d7b-4dfc3acd8789 Aug 29 16:35:00 living-room volumio[1222]: info: Discovery: Found device Living Room Aug 29 16:35:00 living-room volumio[1222]: info: CoreCommandRouter::volumioGetState Aug 29 16:35:00 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:00 living-room volumio[1222]: info: Discovery: A device disappeared from network Aug 29 16:35:00 living-room volumio[1222]: info: Discovery: adding 43e57110-1273-48e3-8d7b-4dfc3acd8789 Aug 29 16:35:00 living-room volumio[1222]: info: Discovery: Found device Living Room Aug 29 16:35:00 living-room volumio[1222]: info: CoreCommandRouter::volumioGetState Aug 29 16:35:00 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:00 living-room sudo[1568]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Aug 29 16:35:00 living-room sudo[1568]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:00 living-room volumio[1222]: info: Discovery: this is already registered, 43e57110-1273-48e3-8d7b-4dfc3acd8789 Aug 29 16:35:00 living-room volumio[1222]: info: Discovery: Found device Living Room Aug 29 16:35:00 living-room volumio[1222]: info: CoreCommandRouter::volumioGetState Aug 29 16:35:00 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:00 living-room volumio[1222]: info: Discovery: this is already registered, 43e57110-1273-48e3-8d7b-4dfc3acd8789 Aug 29 16:35:00 living-room volumio[1222]: info: Discovery: Found device Living Room Aug 29 16:35:00 living-room volumio[1222]: info: CoreCommandRouter::volumioGetState Aug 29 16:35:00 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:00 living-room volumio[1222]: info: Asound.conf file written Aug 29 16:35:00 living-room sudo[1575]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Aug 29 16:35:00 living-room sudo[1575]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:01 living-room sudo[1575]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:01 living-room volumio[1222]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Aug 29 16:35:01 living-room volumio[1222]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Aug 29 16:35:01 living-room volumio[1222]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Aug 29 16:35:01 living-room volumio[1222]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:3 use case configuration -2 Aug 29 16:35:01 living-room volumio[1222]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:4 use case configuration -2 Aug 29 16:35:01 living-room volumio[1222]: info: Output device has changed, restarting MPD Aug 29 16:35:01 living-room volumio[1222]: info: Output device has changed, restarting Shairport Sync Aug 29 16:35:01 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:01 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 16:35:01 living-room sudo[1581]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 29 16:35:01 living-room sudo[1581]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:01 living-room sudo[1581]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:01 living-room sudo[1584]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 29 16:35:01 living-room sudo[1584]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:01 living-room volumio[1222]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 29 16:35:01 living-room volumio[1222]: info: ___________ START PLUGINS ___________ Aug 29 16:35:01 living-room volumio[1222]: info: ControllerMpd::onStart: Initializing MPD Aug 29 16:35:01 living-room volumio[1222]: info: Creating MPD Configuration file Aug 29 16:35:01 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 29 16:35:01 living-room volumio[1222]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 29 16:35:01 living-room volumio[1222]: info: [1788039301523] CoreMusicLibrary::Adding element Media Servers Aug 29 16:35:01 living-room systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 29 16:35:01 living-room systemd[1]: Starting mpd.service - Music Player Daemon... Aug 29 16:35:01 living-room sudo[1593]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 29 16:35:01 living-room sudo[1593]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:01 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 29 16:35:01 living-room sudo[1596]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 29 16:35:01 living-room sudo[1596]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:01 living-room volumio[1222]: info: UPNP Browser: Client initialized successfully Aug 29 16:35:01 living-room sudo[1592]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Aug 29 16:35:01 living-room sudo[1592]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:01 living-room sudo[1593]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:01 living-room sudo[1597]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 29 16:35:01 living-room sudo[1597]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Aug 29 16:35:01 living-room sudo[1600]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Aug 29 16:35:01 living-room sudo[1597]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:01 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:01 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 16:35:01 living-room volumio[1222]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 29 16:35:01 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:01 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 16:35:01 living-room systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Aug 29 16:35:01 living-room sudo[1592]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:01 living-room systemd[1]: mpd.service: Deactivated successfully. Aug 29 16:35:01 living-room systemd[1]: Stopped mpd.service - Music Player Daemon. Aug 29 16:35:01 living-room systemd[1]: mpd.socket: Deactivated successfully. Aug 29 16:35:01 living-room systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Aug 29 16:35:01 living-room systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Aug 29 16:35:01 living-room systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 29 16:35:01 living-room systemd[1]: Starting mpd.service - Music Player Daemon... Aug 29 16:35:01 living-room volumio[1222]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 29 16:35:01 living-room volumio[1222]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 29 16:35:01 living-room volumio[1222]: info: [1788039301850] CoreMusicLibrary::Adding element Last_100 Aug 29 16:35:01 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 29 16:35:01 living-room volumio[1222]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 29 16:35:01 living-room volumio[1222]: info: [1788039301877] CoreMusicLibrary::Adding element Webradio Aug 29 16:35:01 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 29 16:35:01 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 29 16:35:01 living-room systemd[1]: systemd-fsckd.service: Deactivated successfully. Aug 29 16:35:02 living-room volumio[1222]: info: Initializing BBC Radios Aug 29 16:35:02 living-room volumio-remote-updater[781]: [2026-08-29 16:35:02] [connect] Successful connection Aug 29 16:35:02 living-room sudo[1613]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 29 16:35:02 living-room sudo[1613]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Aug 29 16:35:02 living-room sudo[1621]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Aug 29 16:35:02 living-room sudo[1613]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:02 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:02.220-05:00 level=INFO msg="running volumio5-device-gateway" version=6370e0a8+CHANGES buildDate=2026-03-06T16:29:42Z Aug 29 16:35:02 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 29 16:35:02 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 16:35:02 living-room volumio[1222]: info: FusionDsp - CamillaDSP binary found. Aug 29 16:35:02 living-room volumio[1222]: info: Loading i18n strings for locale en Aug 29 16:35:02 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Aug 29 16:35:02 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:02 living-room volumio[1222]: info: FusionDsp - mixtype--------------------- None Aug 29 16:35:02 living-room volumio[1222]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 29 16:35:02 living-room volumio[1222]: info: [1788039302745] CoreMusicLibrary::Adding element Radio Paradise Aug 29 16:35:02 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 29 16:35:02 living-room volumio[1222]: Cannot find translation for source Radio Paradise Aug 29 16:35:02 living-room volumio[1222]: info: Volumio Calling Home Aug 29 16:35:02 living-room volumio[1222]: info: Preparing to generate the ALSA configuration file Aug 29 16:35:04 living-room systemd[1]: systemd-hostnamed.service: Deactivated successfully. Aug 29 16:35:05 living-room systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2. Aug 29 16:35:05 living-room systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Aug 29 16:35:05 living-room systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Aug 29 16:35:05 living-room sudo[1568]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:05 living-room volumio[1222]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 29 16:35:05 living-room volumio[1222]: info: Reading ALSA contributions from plugins. Aug 29 16:35:05 living-room volumio[1222]: info: MPD Permissions set Aug 29 16:35:05 living-room volumio[1222]: info: MPD Permissions set Aug 29 16:35:05 living-room volumio[1222]: info: Upmpdcli Daemon Started Aug 29 16:35:05 living-room volumio-remote-updater[781]: [2026-08-29 16:35:05] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1788039302 101 Aug 29 16:35:05 living-room volumio[1222]: 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: 1 Aug 29 16:35:05 living-room volumio[1222]: info: Volumio called home Aug 29 16:35:05 living-room volumio[1222]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Aug 29 16:35:05 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:05 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:05 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:05 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:05 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:05 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:05 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:05 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:05 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 16:35:05 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:05 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:05 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:05 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:05 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:05 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:05 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:05 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:05 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:06 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 16:35:06 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:06 living-room volumio[1222]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Aug 29 16:35:06 living-room volumio[1222]: info: Received Get System Info Aug 29 16:35:06 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 29 16:35:06 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 29 16:35:06 living-room volumio[1222]: info: Discovery: Getting this device information Aug 29 16:35:06 living-room volumio[1222]: info: CoreCommandRouter::volumioGetState Aug 29 16:35:06 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:06 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 29 16:35:06 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:06.151-05:00 level=INFO msg="system info for 5aa3f7333110af86468f5b368db248bc" deviceName="Living Room" deviceVariant=volumio deviceModel= softwareVersion=4.119 Aug 29 16:35:06 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:06.178-05:00 level=INFO msg="bootstrapping state" hasInternet=true Aug 29 16:35:06 living-room mpd[1622]: decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 29 16:35:06 living-room mpd[1622]: output: No 'audio_output' defined in config file Aug 29 16:35:06 living-room mpd[1622]: output: Successfully detected a sndio audio device Aug 29 16:35:06 living-room mpd[1622]: zeroconf: No global port, disabling zeroconf Aug 29 16:35:06 living-room systemd[1]: Started mpd.service - Music Player Daemon. Aug 29 16:35:06 living-room sudo[1584]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:06 living-room sudo[1596]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:06 living-room volumio[1222]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 29 16:35:06 living-room volumio[1222]: info: Received Get System Info Aug 29 16:35:06 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 29 16:35:06 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 29 16:35:06 living-room volumio[1222]: info: Discovery: Getting this device information Aug 29 16:35:06 living-room volumio[1222]: info: CoreCommandRouter::volumioGetState Aug 29 16:35:06 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:06 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 29 16:35:06 living-room volumio[1222]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Aug 29 16:35:06 living-room volumio[1222]: info: Completed starting Core Plugins Aug 29 16:35:06 living-room volumio[1222]: info: ------------------------------------------- Aug 29 16:35:06 living-room volumio[1222]: info: ----- MyVolumio plugins startup ---- Aug 29 16:35:06 living-room volumio[1222]: info: ------------------------------------------- Aug 29 16:35:06 living-room volumio[1222]: info: [MyVolumio PluginManager] Fetching plans data.... Aug 29 16:35:06 living-room volumio-remote-updater[781]: Test mode disabled Aug 29 16:35:06 living-room volumio-remote-updater[781]: Alpha mode disabled Aug 29 16:35:06 living-room volumio-remote-updater[781]: Alpha legacy test mode disabled Aug 29 16:35:07 living-room volumio[1222]: info: Starting Shairport Sync Aug 29 16:35:07 living-room volumio[1222]: info: Starting Shairport Sync Aug 29 16:35:07 living-room volumio[1222]: info: Starting Shairport Sync Aug 29 16:35:07 living-room sudo[1675]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 29 16:35:07 living-room sudo[1675]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:07 living-room sudo[1677]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 29 16:35:07 living-room sudo[1677]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:07 living-room sudo[1679]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 29 16:35:07 living-room sudo[1679]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:07 living-room systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Aug 29 16:35:07 living-room systemd[1]: shairport-sync.service: Deactivated successfully. Aug 29 16:35:07 living-room systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 29 16:35:07 living-room systemd[1]: shairport-sync.service: Consumed 1.675s CPU time. Aug 29 16:35:07 living-room systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 29 16:35:07 living-room systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Aug 29 16:35:07 living-room sudo[1679]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:07 living-room systemd[1]: shairport-sync.service: Deactivated successfully. Aug 29 16:35:07 living-room systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 29 16:35:07 living-room systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 29 16:35:07 living-room sudo[1677]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:07 living-room sudo[1675]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:07 living-room volumio[1222]: error: MPD error: The expression evaluated to a falsy value: Aug 29 16:35:07 living-room volumio[1222]: assert.ok(self.idling) Aug 29 16:35:07 living-room volumio[1222]: error: The expression evaluated to a falsy value: Aug 29 16:35:07 living-room volumio[1222]: assert.ok(self.idling) Aug 29 16:35:07 living-room volumio[1222]: info: MPD running with PID1622 Aug 29 16:35:07 living-room volumio[1222]: ,establishing connection Aug 29 16:35:07 living-room volumio[1222]: error: updateQueue error: null Aug 29 16:35:07 living-room volumio[1222]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Aug 29 16:35:07 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Aug 29 16:35:08 living-room volumio[1222]: info: Shairport-Sync Started Aug 29 16:35:08 living-room volumio[1222]: Error adding Membership: Error: addMembership EINVAL Aug 29 16:35:08 living-room volumio[1222]: info: Shairport-Sync Started Aug 29 16:35:08 living-room volumio[1222]: info: Shairport-Sync Started Aug 29 16:35:08 living-room volumio[1222]: info: Asound.conf file unchanged, so no further update is needed Aug 29 16:35:08 living-room volumio[1222]: info: Output device has changed, restarting MPD Aug 29 16:35:08 living-room volumio[1222]: info: Output device has changed, restarting Shairport Sync Aug 29 16:35:08 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:08 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 16:35:08 living-room sudo[1702]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 29 16:35:08 living-room sudo[1702]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:08 living-room sudo[1704]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 29 16:35:08 living-room sudo[1704]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:08 living-room volumio[1222]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 29 16:35:08 living-room sudo[1702]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:08 living-room systemd[1]: Stopping mpd.service - Music Player Daemon... Aug 29 16:35:08 living-room volumio[1222]: error: MPD error: Error: write EPIPE Aug 29 16:35:08 living-room volumio[1222]: error: write EPIPE {"code":"EPIPE","errno":-32,"syscall":"write"} Aug 29 16:35:08 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 29 16:35:08 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 29 16:35:08 living-room volumio[1222]: error: Upnp client error: Error: This socket has been ended by the other party Aug 29 16:35:08 living-room systemd[1]: mpd.service: Deactivated successfully. Aug 29 16:35:08 living-room systemd[1]: Stopped mpd.service - Music Player Daemon. Aug 29 16:35:08 living-room systemd[1]: mpd.service: Consumed 2.885s CPU time. Aug 29 16:35:08 living-room systemd[1]: mpd.socket: Deactivated successfully. Aug 29 16:35:08 living-room systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Aug 29 16:35:08 living-room systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Aug 29 16:35:08 living-room volumio[1222]: info: MPD Permissions set Aug 29 16:35:08 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 29 16:35:08 living-room systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 29 16:35:08 living-room systemd[1]: Starting mpd.service - Music Player Daemon... Aug 29 16:35:08 living-room volumio[1222]: info: Received Get System Info Aug 29 16:35:08 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 29 16:35:08 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 29 16:35:08 living-room volumio[1222]: info: Discovery: Getting this device information Aug 29 16:35:08 living-room volumio[1222]: info: CoreCommandRouter::volumioGetState Aug 29 16:35:08 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:08 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 29 16:35:08 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:08 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:08 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:08 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:08 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:08 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:08 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:08 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:08 living-room sudo[1716]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 29 16:35:09 living-room sudo[1716]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Aug 29 16:35:09 living-room sudo[1722]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Aug 29 16:35:09 living-room sudo[1716]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:09 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 16:35:09 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:09 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 29 16:35:09 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 29 16:35:09 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:09.322-05:00 level=INFO msg="enabling local network discovery" Aug 29 16:35:09 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:09.350-05:00 level=INFO msg="enabling BLE discovery" Aug 29 16:35:09 living-room volumio[1222]: info: CoreCommandRouter::volumioGetState Aug 29 16:35:09 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:09 living-room volumio[1222]: info: Starting Shairport Sync Aug 29 16:35:09 living-room sudo[1741]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 29 16:35:09 living-room sudo[1741]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:10 living-room systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Aug 29 16:35:10 living-room systemd[1]: shairport-sync.service: Deactivated successfully. Aug 29 16:35:10 living-room systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 29 16:35:10 living-room systemd[1]: shairport-sync.service: Consumed 1.284s CPU time. Aug 29 16:35:10 living-room systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 29 16:35:10 living-room sudo[1741]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:10 living-room volumio[1222]: info: Shairport-Sync Started Aug 29 16:35:10 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:10.281-05:00 level=INFO msg="service successfully established" component=discovery/localnet Aug 29 16:35:10 living-room mpd[1723]: 2026-08-29T16:35:10 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 29 16:35:10 living-room systemd[1]: Started mpd.service - Music Player Daemon. Aug 29 16:35:10 living-room sudo[1704]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:10 living-room volumio[1222]: error: updateQueue error: null Aug 29 16:35:11 living-room volumio[1222]: info: FusionDsp - If filter freq >samplerate/2 then disable it Aug 29 16:35:12 living-room volumio[1222]: info: camilladsp service started and running in background, instance 1 Aug 29 16:35:12 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:12 living-room volumio[1222]: info: FusionDsp - AAAAAAAAAAAAAA-> 22050 44100 48000 88200 96000 176400 192000 384000 <-AAAAAAAAAAAAA Aug 29 16:35:12 living-room volumio[1222]: info: FusionDsp loaded Aug 29 16:35:12 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 29 16:35:12 living-room volumio[1222]: info: FusionDsp - --[object Object] Aug 29 16:35:12 living-room volumio[1222]: info: FusionDsp - Reporting Fusion DSP Enabled Aug 29 16:35:12 living-room volumio[1222]: info: Adding Signal Path Element [object Object] Aug 29 16:35:12 living-room volumio[1222]: info: Adding fusiondspeq DSP Signal Path Element Aug 29 16:35:12 living-room volumio[1222]: info: FusionDsp - ---- installed callbackRead (debounced 200ms) Aug 29 16:35:12 living-room volumio[1222]: info: FusionDsp - PEQ graph server listening on port 10015 Aug 29 16:35:12 living-room volumio[1222]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Aug 29 16:35:12 living-room volumio[1222]: error: FusionDsp - Reload WebSocket error: [object Object] Aug 29 16:35:12 living-room sudo[1776]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Aug 29 16:35:12 living-room sudo[1776]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:13 living-room systemd[1]: Starting fusiondsp.service - FusionDsp Daemon... Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Aug 29 16:35:15 living-room volumio[1222]: info: Adding plugin bluetooth to MyMusic Plugins Aug 29 16:35:15 living-room volumio[1222]: info: Adding plugin multiroom to MyMusic Plugins Aug 29 16:35:15 living-room volumio[1222]: info: Adding plugin metavolumio to MyMusic Plugins Aug 29 16:35:15 living-room volumio[1222]: info: Adding plugin cd_controller to MyMusic Plugins Aug 29 16:35:15 living-room volumio[1222]: info: Adding plugin qobuzconnect to MyMusic Plugins Aug 29 16:35:15 living-room volumio[1222]: info: Adding plugin smart_inputs to MyMusic Plugins Aug 29 16:35:15 living-room volumio[1222]: info: Adding plugin tidalconnect to MyMusic Plugins Aug 29 16:35:15 living-room volumio[1222]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Aug 29 16:35:18 living-room systemd[1]: Started fusiondsp.service - FusionDsp Daemon. Aug 29 16:35:18 living-room systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Aug 29 16:35:18 living-room sudo[1776]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:21 living-room volumio[1222]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Aug 29 16:35:21 living-room volumio[1222]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Aug 29 16:35:21 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 16:35:21 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 16:35:21 living-room volumio[1222]: info: Starting MyVolumio Remote Streaming Endpoints Aug 29 16:35:21 living-room volumio[1222]: info: MyVolumio login type: Token Aug 29 16:35:22 living-room volumio[1222]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Aug 29 16:35:22 living-room volumio[1222]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Aug 29 16:35:23 living-room systemd[1]: setdatetime-helper.service: Deactivated successfully. Aug 29 16:35:23 living-room systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Aug 29 16:35:24 living-room kernel: usb 1-1.1: new high-speed USB device number 3 using xhci_hcd Aug 29 16:35:25 living-room kernel: usb 1-1.1: New USB device found, idVendor=0781, idProduct=5567, bcdDevice= 1.00 Aug 29 16:35:25 living-room kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Aug 29 16:35:25 living-room kernel: usb 1-1.1: Product: Cruzer Blade Aug 29 16:35:25 living-room kernel: usb 1-1.1: Manufacturer: SanDisk Aug 29 16:35:25 living-room kernel: usb 1-1.1: SerialNumber: 4C530000220331107412 Aug 29 16:35:25 living-room kernel: usb-storage 1-1.1:1.0: USB Mass Storage device detected Aug 29 16:35:25 living-room kernel: scsi host0: usb-storage 1-1.1:1.0 Aug 29 16:35:25 living-room upmpdcli[1825]: writing RSA key Aug 29 16:35:26 living-room kernel: scsi 0:0:0:0: Direct-Access SanDisk Cruzer Blade 1.00 PQ: 0 ANSI: 6 Aug 29 16:35:26 living-room kernel: sd 0:0:0:0: [sda] 61341696 512-byte logical blocks: (31.4 GB/29.3 GiB) Aug 29 16:35:26 living-room kernel: sd 0:0:0:0: [sda] Write Protect is off Aug 29 16:35:26 living-room kernel: sd 0:0:0:0: [sda] Mode Sense: 43 00 00 00 Aug 29 16:35:26 living-room kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Aug 29 16:35:26 living-room kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Aug 29 16:35:26 living-room kernel: sda: sda1 Aug 29 16:35:26 living-room kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk Aug 29 16:35:27 living-room volumio[1222]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Aug 29 16:35:27 living-room volumio[1222]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Aug 29 16:35:27 living-room volumio[1222]: info: Streaming services startup Aug 29 16:35:27 living-room volumio[1222]: info: Starting Streaming Daemon Aug 29 16:35:27 living-room volumio[1222]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Aug 29 16:35:27 living-room sudo[1837]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 29 16:35:27 living-room sudo[1837]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:27 living-room sudo[1837]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:27 living-room volumio[1222]: error: Cannot start Volumio Streaming Daemon Aug 29 16:35:27 living-room volumio[1222]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 29 16:35:27 living-room volumio[1222]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Aug 29 16:35:27 living-room volumio[1222]: info: Mounting Device ESD-USB Aug 29 16:35:27 living-room sudo[1852]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/ESD-USB -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Aug 29 16:35:27 living-room sudo[1852]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:27 living-room kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Aug 29 16:35:27 living-room sudo[1852]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:28 living-room volumio[1222]: info: Scanning new location : "USB/ESD-USB" Aug 29 16:35:28 living-room volumio[1222]: verbose: ControllerMpd::sendMpdCommand status Aug 29 16:35:28 living-room volumio[1222]: info: Aug 29 16:35:28 living-room volumio[1222]: ---------------------------- MPD announces state update: update Aug 29 16:35:28 living-room volumio[1222]: info: ControllerMpd::getState Aug 29 16:35:28 living-room volumio[1222]: verbose: ControllerMpd::sendMpdCommand status Aug 29 16:35:28 living-room volumio[1222]: info: sendMpdCommand status took 22 milliseconds Aug 29 16:35:28 living-room volumio[1222]: info: sendMpdCommand status took 40 milliseconds Aug 29 16:35:28 living-room volumio[1222]: verbose: ControllerMpd::parseState Aug 29 16:35:28 living-room volumio[1222]: info: Command Router : Notfying DB Updatetrue Aug 29 16:35:28 living-room volumio[1222]: verbose: ControllerMpd::parseState Aug 29 16:35:28 living-room volumio[1222]: info: ControllerMpd::pushState Aug 29 16:35:28 living-room volumio[1222]: info: CoreCommandRouter::servicePushState Aug 29 16:35:28 living-room volumio[1222]: info: CoreStateMachine::pushState Aug 29 16:35:28 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:28 living-room volumio[1222]: info: CoreCommandRouter::volumioPushState Aug 29 16:35:28 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:28 living-room volumio[1222]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Aug 29 16:35:28 living-room volumio[1222]: info: ------------------------------ 439ms Aug 29 16:35:28 living-room volumio[1222]: info: FusionDsp - Volumio is not playing Aug 29 16:35:28 living-room volumio[1222]: info: FusionDsp - Clipped samples monitor stopped Aug 29 16:35:28 living-room volumio[1222]: error: MyVolumio Custom Token format not valid, refreshing it Aug 29 16:35:29 living-room volumio[1222]: info: MyVolumio login type: Token Aug 29 16:35:30 living-room volumio[1222]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Aug 29 16:35:30 living-room volumio[1222]: info: MyVolumio token set successfully Aug 29 16:35:30 living-room volumio[1222]: info: MYVOLUMIO: Adding device Aug 29 16:35:30 living-room volumio[1222]: info: MYVOLUMIO: Evaluating Server Aug 29 16:35:31 living-room volumio[1222]: info: MyVolumio Plan changed: premium Aug 29 16:35:31 living-room volumio[1222]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Aug 29 16:35:31 living-room volumio[1222]: info: Removing browser output: myVolumio user plan is not superstar Aug 29 16:35:31 living-room volumio[1222]: info: Removing audio output: Aug 29 16:35:31 living-room volumio[1222]: info: MYVOLUMIO: Adding device Aug 29 16:35:31 living-room volumio[1222]: info: MYVOLUMIO: Evaluating Server Aug 29 16:35:32 living-room volumio[1222]: info: Setting Geolocation for MyVolumio to us2 Aug 29 16:35:32 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 16:35:32 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 16:35:32 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 16:35:32 living-room volumio[1222]: info: Remote config written successfully Aug 29 16:35:32 living-room volumio[1222]: info: Starting Tunnel 1 Aug 29 16:35:32 living-room volumio[1222]: info: Starting Tunnel Connection Checker Aug 29 16:35:32 living-room volumio[1222]: info: Completed starting MyVolumio Plugin Aug 29 16:35:32 living-room volumio[1222]: info: Setting Geolocation for MyVolumio to us2 Aug 29 16:35:32 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 16:35:32 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 16:35:32 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 16:35:32 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 29 16:35:32 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 16:35:32 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 29 16:35:32 living-room volumio[1222]: info: MYVolumio Device enabled Aug 29 16:35:32 living-room volumio[1222]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Aug 29 16:35:32 living-room volumio[1222]: info: MyVolumio status changed Aug 29 16:35:32 living-room volumio[1222]: info: Streaming services startup Aug 29 16:35:32 living-room volumio[1222]: info: Starting Streaming Daemon Aug 29 16:35:32 living-room volumio-remote-updater[781]: Test mode disabled Aug 29 16:35:32 living-room volumio-remote-updater[781]: Alpha mode disabled Aug 29 16:35:32 living-room volumio-remote-updater[781]: Alpha legacy test mode disabled Aug 29 16:35:32 living-room sudo[1921]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 29 16:35:32 living-room sudo[1921]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:32 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Aug 29 16:35:32 living-room sudo[1921]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:33 living-room volumio[1222]: info: Successfully Added MyVolumio device Aug 29 16:35:33 living-room volumio[1222]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Aug 29 16:35:33 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Aug 29 16:35:33 living-room volumio[1222]: error: Cannot start Volumio Streaming Daemon Aug 29 16:35:33 living-room volumio[1222]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 29 16:35:33 living-room volumio[1222]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Aug 29 16:35:33 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Aug 29 16:35:33 living-room volumio[1222]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Aug 29 16:35:33 living-room volumio[1222]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin bluetooth Aug 29 16:35:33 living-room volumio[1222]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin bluetooth Aug 29 16:35:33 living-room volumio[1222]: ------------------------------------ BT MESSAGE: [FUNC] onVolumioStart Aug 29 16:35:33 living-room volumio[1222]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Aug 29 16:35:38 living-room volumio[1222]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Aug 29 16:35:38 living-room sudo[1926]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Aug 29 16:35:38 living-room sudo[1926]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:38 living-room sudo[1926]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:38 living-room volumio[1222]: info: MRS: MultiRoom plugin initialized Aug 29 16:35:38 living-room volumio[1222]: info: MRS: STOPPING SNAPCLIENT Aug 29 16:35:38 living-room volumio[1222]: info: MRS: Snap server stop Aug 29 16:35:38 living-room volumio[1222]: info: MRS: STOPPING volumioStreaming Aug 29 16:35:38 living-room volumio[1222]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Aug 29 16:35:38 living-room sudo[1947]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Aug 29 16:35:38 living-room sudo[1947]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:38 living-room sudo[1945]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Aug 29 16:35:38 living-room sudo[1943]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Aug 29 16:35:38 living-room sudo[1945]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:38 living-room sudo[1949]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Aug 29 16:35:38 living-room sudo[1949]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:38 living-room sudo[1943]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:38 living-room volumio[1222]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Aug 29 16:35:38 living-room sudo[1949]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:38 living-room sudo[1945]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:38 living-room volumio[1222]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Aug 29 16:35:38 living-room sudo[1947]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:38 living-room sudo[1943]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:38 living-room volumio[1222]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Aug 29 16:35:38 living-room volumio[1222]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Aug 29 16:35:38 living-room volumio[1222]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Aug 29 16:35:38 living-room volumio[1222]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Aug 29 16:35:38 living-room volumio[1222]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Aug 29 16:35:39 living-room volumio[1222]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Aug 29 16:35:39 living-room volumio[1222]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... Aug 29 16:35:39 living-room volumio[1222]: info: Preparing to generate the ALSA configuration file Aug 29 16:35:39 living-room volumio[1222]: info: Successfully Added MyVolumio device Aug 29 16:35:39 living-room volumio[1222]: info: Updating MyVolumio device info Aug 29 16:35:39 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 16:35:39 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 16:35:39 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 16:35:39 living-room volumio[1222]: info: Updating MyVolumio device info Aug 29 16:35:39 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 16:35:39 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 16:35:39 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 16:35:39 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 29 16:35:39 living-room volumio[1222]: info: MPD Database updated - AlbumList cache refreshed Aug 29 16:35:39 living-room volumio[1222]: info: Aug 29 16:35:39 living-room volumio[1222]: ---------------------------- MPD announces state update: database Aug 29 16:35:39 living-room volumio[1222]: verbose: ControllerMpd::sendMpdCommand status Aug 29 16:35:39 living-room volumio[1222]: info: Aug 29 16:35:39 living-room volumio[1222]: ---------------------------- MPD announces state update: update Aug 29 16:35:39 living-room volumio[1222]: info: ControllerMpd::getState Aug 29 16:35:39 living-room volumio[1222]: verbose: ControllerMpd::sendMpdCommand status Aug 29 16:35:39 living-room volumio[1222]: info: ControllerMpd::getState Aug 29 16:35:39 living-room volumio[1222]: verbose: ControllerMpd::sendMpdCommand status Aug 29 16:35:39 living-room volumio[1222]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 29 16:35:39 living-room volumio[1222]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Aug 29 16:35:39 living-room volumio[1222]: info: Reading ALSA contributions from plugins. Aug 29 16:35:39 living-room volumio[1222]: info: MRS: Removed streaming files Aug 29 16:35:39 living-room volumio[1222]: info: MRS: volumioStreaming STOPPED Aug 29 16:35:39 living-room volumio[1222]: info: MRS: SNAPSERVER STOPPED Aug 29 16:35:39 living-room volumio[1222]: info: MRS: SNAPCLIENT STOPPED Aug 29 16:35:39 living-room volumio[1222]: info: sendMpdCommand status took 186 milliseconds Aug 29 16:35:39 living-room volumio[1222]: info: sendMpdCommand status took 206 milliseconds Aug 29 16:35:39 living-room volumio[1222]: info: sendMpdCommand status took 199 milliseconds Aug 29 16:35:39 living-room volumio[1222]: verbose: ControllerMpd::parseState Aug 29 16:35:39 living-room volumio[1222]: info: Command Router : Notfying DB Updatefalse Aug 29 16:35:39 living-room volumio[1222]: info: CoreCommandRouter::Close All Modals sent Aug 29 16:35:39 living-room volumio[1222]: verbose: ControllerMpd::parseState Aug 29 16:35:39 living-room volumio[1222]: verbose: ControllerMpd::parseState Aug 29 16:35:39 living-room volumio[1222]: info: ControllerMpd::pushState Aug 29 16:35:39 living-room volumio[1222]: info: CoreCommandRouter::servicePushState Aug 29 16:35:39 living-room volumio[1222]: info: CoreStateMachine::pushState Aug 29 16:35:39 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:39 living-room volumio[1222]: info: CoreCommandRouter::volumioPushState Aug 29 16:35:39 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:39 living-room volumio[1222]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Aug 29 16:35:39 living-room volumio[1222]: info: ControllerMpd::pushState Aug 29 16:35:39 living-room volumio[1222]: info: CoreCommandRouter::servicePushState Aug 29 16:35:39 living-room volumio[1222]: info: CoreStateMachine::pushState Aug 29 16:35:39 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:39 living-room volumio[1222]: info: CoreCommandRouter::volumioPushState Aug 29 16:35:39 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:39 living-room volumio[1222]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Aug 29 16:35:39 living-room volumio[1222]: info: ------------------------------ 374ms Aug 29 16:35:39 living-room volumio[1222]: info: ------------------------------ 399ms Aug 29 16:35:39 living-room volumio[1222]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 29 16:35:40 living-room volumio[1222]: info: Successfully Updated MyVolumio device Aug 29 16:35:40 living-room volumio[1222]: info: Successfully Updated MyVolumio device Aug 29 16:35:40 living-room sudo[1978]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Aug 29 16:35:40 living-room sudo[1978]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:40 living-room systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Aug 29 16:35:40 living-room systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Aug 29 16:35:40 living-room systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Aug 29 16:35:40 living-room volumio[1222]: info: CoreCommandRouter::volumioGetState Aug 29 16:35:40 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:40 living-room autossh[1981]: port set to 0, monitoring disabled Aug 29 16:35:40 living-room autossh[1981]: starting ssh (count 1) Aug 29 16:35:40 living-room autossh[1981]: ssh child pid is 1984 Aug 29 16:35:40 living-room sudo[1978]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:40 living-room volumio[1222]: info: Remote SSH Started Aug 29 16:35:41 living-room volumiossh-tunnel[1984]: Warning: Permanently added '[us2.myvolumio.org]:2222' (RSA) to the list of known hosts. Aug 29 16:35:41 living-room volumio[1222]: info: Asound.conf file written Aug 29 16:35:41 living-room sudo[1987]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Aug 29 16:35:41 living-room sudo[1987]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:41 living-room sudo[1987]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:41 living-room volumio[1222]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Aug 29 16:35:41 living-room volumio[1222]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Aug 29 16:35:41 living-room volumio[1222]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Aug 29 16:35:41 living-room volumio[1222]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:3 use case configuration -2 Aug 29 16:35:41 living-room volumio[1222]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:4 use case configuration -2 Aug 29 16:35:41 living-room volumio[1222]: info: Output device has changed, restarting MPD Aug 29 16:35:41 living-room volumio[1222]: info: Output device has changed, restarting Shairport Sync Aug 29 16:35:41 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:41 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 16:35:41 living-room sudo[1993]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 29 16:35:41 living-room sudo[1993]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:41 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:41.753-05:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.7.0:58239 Aug 29 16:35:41 living-room sudo[1993]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:41 living-room volumio[1222]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 29 16:35:41 living-room volumio[1222]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 29 16:35:41 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:41 living-room sudo[1995]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 29 16:35:41 living-room sudo[1995]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:41 living-room volumio[1222]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Aug 29 16:35:41 living-room volumio[1222]: ------------------------------------ BT MESSAGE: [FUNC] onStart Aug 29 16:35:41 living-room volumio[1222]: ------------------------------------ BT MESSAGE: Starting Volumio Bluetooth Service Aug 29 16:35:41 living-room volumio[1222]: ------------------------------------ BT MESSAGE: Boot config /etc/bluetooth/volumio.conf: cache mode = tmp Aug 29 16:35:41 living-room volumio[1222]: ------------------------------------ BT MESSAGE: [metaCache] Created directory: /tmp/bluetooth-cache/ Aug 29 16:35:41 living-room volumio[1222]: ------------------------------------ BT MESSAGE: [metaCache] Directory exists and is ready. Aug 29 16:35:41 living-room systemd[1]: Stopping mpd.service - Music Player Daemon... Aug 29 16:35:41 living-room systemd[1]: mpd.service: Deactivated successfully. Aug 29 16:35:41 living-room systemd[1]: Stopped mpd.service - Music Player Daemon. Aug 29 16:35:41 living-room systemd[1]: mpd.service: Consumed 1.990s CPU time. Aug 29 16:35:41 living-room volumio[1222]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Aug 29 16:35:41 living-room systemd[1]: mpd.socket: Deactivated successfully. Aug 29 16:35:41 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Aug 29 16:35:41 living-room volumio[1222]: info: MRS: Pushing multiroomSync output for this device Aug 29 16:35:41 living-room systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Aug 29 16:35:41 living-room systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Aug 29 16:35:41 living-room volumio[1222]: info: MRS: Pushing multiroomSync output Aug 29 16:35:41 living-room volumio[1222]: info: Adding audio output: Aug 29 16:35:42 living-room volumio[1222]: info: Adding audio output: Aug 29 16:35:42 living-room systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 29 16:35:42 living-room systemd[1]: Starting mpd.service - Music Player Daemon... Aug 29 16:35:42 living-room volumio[1222]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 29 16:35:42 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:42 living-room volumio[1222]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Aug 29 16:35:42 living-room volumio[1222]: info: Adding METAVOLUMIO REST API Endpoints Aug 29 16:35:42 living-room volumio[1222]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Aug 29 16:35:42 living-room volumio[1222]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Aug 29 16:35:42 living-room volumio[1222]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Aug 29 16:35:42 living-room volumio[1222]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Aug 29 16:35:42 living-room volumio[1222]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Aug 29 16:35:42 living-room volumio[1222]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Aug 29 16:35:42 living-room volumio[1222]: info: Preparing CD Folders Aug 29 16:35:42 living-room volumio[1222]: info: Adding CD REST API Endpoints Aug 29 16:35:42 living-room volumio[1222]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Aug 29 16:35:42 living-room volumio[1222]: info: Starting UDEV Watcher for CD Aug 29 16:35:42 living-room volumio[1222]: info: Detecting CD presence with UDEV Aug 29 16:35:42 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Aug 29 16:35:42 living-room sudo[2008]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 29 16:35:42 living-room sudo[2008]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Aug 29 16:35:42 living-room bluetoothd[764]: Path / reserved for Adv Monitor app :1.24 Aug 29 16:35:42 living-room sudo[2008]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:42 living-room bluetoothd[764]: Adv Monitor app :1.24 disconnected from D-Bus Aug 29 16:35:43 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:43.156-05:00 level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.7.0:58239 @ 0x308f1a0" latency=-40.987585ms platform=PLATFORM_IOS version=6.260807.0 Aug 29 16:35:43 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:43.155-05:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.7.0:58239 @ 0x308f1a0" latency=-42.776862ms timeout=20s Aug 29 16:35:43 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:43.161-05:00 level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.7.0:58239 @ 0x308f1a0" Aug 29 16:35:43 living-room mpd[2012]: 2026-08-29T16:35:43 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 29 16:35:43 living-room systemd[1]: Started mpd.service - Music Player Daemon. Aug 29 16:35:43 living-room sudo[1995]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:46 living-room bluealsa[956]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_67_AD_CE_C8_B0_68, ...) Aug 29 16:35:47 living-room volumio[1222]: warn: [cd-plugin] cdspeedctl: device or media not ready Aug 29 16:35:47 living-room volumio[1222]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Aug 29 16:35:47 living-room volumio[1222]: info: Adding inputs REST Endpoints Aug 29 16:35:47 living-room volumio[1222]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Aug 29 16:35:47 living-room volumio[1222]: info: Scanning Audio Inputs Aug 29 16:35:47 living-room volumio[1222]: info: Checking against Known Cards name Aug 29 16:35:47 living-room volumio[1222]: info: Adding Server instance for streaming Aug 29 16:35:47 living-room volumio[1222]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Aug 29 16:35:47 living-room volumio[1222]: error: Hi Res Audio Failed Login: Missing Login Data Aug 29 16:35:47 living-room volumio[1222]: info: Adding HIGHRESAUDIO REST API Endpoints Aug 29 16:35:47 living-room volumio[1222]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Aug 29 16:35:47 living-room volumio[1222]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Aug 29 16:35:47 living-room volumio[1222]: info: Refreshing TIDAL token Aug 29 16:35:47 living-room volumio[1222]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Aug 29 16:35:47 living-room volumio[1222]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Aug 29 16:35:47 living-room volumio[1222]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuzconnect Aug 29 16:35:47 living-room volumio[1222]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect Aug 29 16:35:47 living-room sudo[2023]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 29 16:35:47 living-room volumio[1222]: info: QobuzConnect: Starting Qobuz Connect socket and service Aug 29 16:35:47 living-room sudo[2023]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:47 living-room volumio[1222]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections Aug 29 16:35:47 living-room volumio[1222]: info: Stopping AccessToken refresher cron for QOBUZ Aug 29 16:35:47 living-room sudo[2030]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Aug 29 16:35:47 living-room sudo[2030]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:47 living-room sudo[2023]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:47 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:47.945-05:00 level=INFO msg="new address was allocated" component=ble/conn old=1 new=2 Aug 29 16:35:47 living-room sudo[2030]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:48 living-room volumio[1222]: info: AccessToken refresher cron started for QOBUZ Aug 29 16:35:48 living-room volumio[1222]: info: Adding QOBUZ REST API Endpoints Aug 29 16:35:48 living-room sudo[2033]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Aug 29 16:35:48 living-room sudo[2033]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:48 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:48 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:48 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Aug 29 16:35:48 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Aug 29 16:35:48 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 29 16:35:48 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Aug 29 16:35:48 living-room volumio[1222]: info: CoreCommandRouter::volumioGetBrowseSources Aug 29 16:35:48 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 29 16:35:48 living-room volumio[1222]: info: MRS: Getting audio outputs on start Aug 29 16:35:48 living-room volumio[1222]: info: MRS: Requesting all other devices output Aug 29 16:35:48 living-room dbus-daemon[765]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.17" (uid=0 pid=1611 comm="/usr/bin/volumio5-onboarding") interface="(unset)" member="(unset)" error name="org.freedesktop.DBus.Error.UnknownMethod" requested_reply="0" destination=":1.1" (uid=0 pid=764 comm="/usr/libexec/bluetooth/bluetoothd --noplugin=sap,b") Aug 29 16:35:48 living-room systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Aug 29 16:35:48 living-room sudo[2033]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:48 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 29 16:35:48 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 29 16:35:48 living-room volumio[1222]: info: Received Get System Info Aug 29 16:35:48 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 29 16:35:48 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 29 16:35:48 living-room volumio[1222]: info: Discovery: Getting this device information Aug 29 16:35:48 living-room volumio[1222]: info: CoreCommandRouter::volumioGetState Aug 29 16:35:48 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:48 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 29 16:35:48 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:48.266-05:00 level=INFO msg="emitting device name changed event" component=server peer="192.168.7.0:58239 @ 0x308f1a0" name="Living Room" Aug 29 16:35:48 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:48.273-05:00 level=INFO msg="emitting device language changed event" component=server peer="192.168.7.0:58239 @ 0x308f1a0" language=en Aug 29 16:35:48 living-room volumio[1222]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Aug 29 16:35:48 living-room volumio[1222]: ------------------------------------ BT MESSAGE: Bluetooth adapter powered on Aug 29 16:35:48 living-room volumio[1222]: info: MPD Permissions set Aug 29 16:35:48 living-room sudo[2037]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Aug 29 16:35:48 living-room sudo[2037]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:48 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Aug 29 16:35:48 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:48.574-05:00 level=INFO msg="emitting device timezone changed event" component=server peer="192.168.7.0:58239 @ 0x308f1a0" timezone=America/Chicago Aug 29 16:35:48 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:48.575-05:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.7.0:58239 @ 0x308f1a0" available=true connected=true macAddress=dc:a6:32:ce:0f:09 ip4Address=192.168.6.253/22 ip6Address= Aug 29 16:35:48 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:48.576-05:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.7.0:58239 @ 0x308f1a0" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Aug 29 16:35:48 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:48.576-05:00 level=INFO msg="emitting device setup status changed event" component=server peer="192.168.7.0:58239 @ 0x308f1a0" setupComplete=true Aug 29 16:35:48 living-room systemd[1]: Started volumiobt.service - Volumio Bluetooth Module. Aug 29 16:35:48 living-room volumiobt[2041]: INFO [BTSTART] Ensuring Bluetooth directory exists... Aug 29 16:35:48 living-room sudo[2037]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:48 living-room sudo[2042]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /var/lib/bluetooth Aug 29 16:35:48 living-room sudo[2042]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:48 living-room sudo[2042]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:48 living-room sudo[2044]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth Aug 29 16:35:48 living-room sudo[2044]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:48 living-room sudo[2044]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:48 living-room volumiobt[2046]: INFO [BTSTART] Powering on Bluetooth if needed... Aug 29 16:35:48 living-room volumiobt[2049]: INFO [BTSTART] Making Bluetooth discoverable and pairable... Aug 29 16:35:48 living-room bluetoothd[764]: Adv Monitor app :1.25 disconnected from D-Bus Aug 29 16:35:48 living-room volumiobt[2050]: [198B blob data] Aug 29 16:35:48 living-room volumiobt[2050]: [162B blob data] Aug 29 16:35:48 living-room volumiobt[2050]: [162B blob data] Aug 29 16:35:48 living-room volumiobt[2050]: [162B blob data] Aug 29 16:35:48 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Aug 29 16:35:48 living-room volumiobt[2050]: [118B blob data] Aug 29 16:35:48 living-room volumiobt[2050]: [67-AD-CE-C8-B0-68]> discoverable on Aug 29 16:35:48 living-room volumiobt[2050]: Warning: setting discoverable while discoverable-timeout not set(0) is not recommended Aug 29 16:35:48 living-room volumiobt[2050]: [67-AD-CE-C8-B0-68]> pairable on Aug 29 16:35:48 living-room bluetoothd[764]: Path / reserved for Adv Monitor app :1.26 Aug 29 16:35:48 living-room bluetoothd[764]: Adv Monitor app :1.26 disconnected from D-Bus Aug 29 16:35:48 living-room volumiobt[2050]: [67-AD-CE-C8-B0-68]> Aug 29 16:35:48 living-room volumiobt[2051]: INFO [BTSTART] Registering Bluetooth agent... Aug 29 16:35:48 living-room volumiobt[2052]: [NEW] Media /org/bluez/hci0 Aug 29 16:35:48 living-room volumiobt[2052]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb Aug 29 16:35:48 living-room volumiobt[2052]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb Aug 29 16:35:48 living-room volumiobt[2052]: SupportedUUIDs: 0000FDF0-0000-1000-8000-00805f9b34fb Aug 29 16:35:48 living-room bluetoothd[764]: Adv Monitor app :1.27 disconnected from D-Bus Aug 29 16:35:48 living-room volumiobt[2055]: No agent is registered Aug 29 16:35:48 living-room volumiobt[2055]: [NEW] Media /org/bluez/hci0 Aug 29 16:35:48 living-room volumiobt[2055]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb Aug 29 16:35:48 living-room volumiobt[2055]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb Aug 29 16:35:48 living-room volumiobt[2055]: SupportedUUIDs: 0000FDF0-0000-1000-8000-00805f9b34fb Aug 29 16:35:48 living-room bluetoothd[764]: Adv Monitor app :1.28 disconnected from D-Bus Aug 29 16:35:48 living-room volumiobt[2057]: INFO [BTSTART] Agent registered successfully. Aug 29 16:35:48 living-room volumiobt[2058]: INFO [BTSTART] Starting A2DP agent (a2dp-agent)... Aug 29 16:35:49 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 29 16:35:49 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 16:35:49 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 29 16:35:49 living-room volumio[1222]: amixer -c 0 info | grep "bcm2835 ALSA" Aug 29 16:35:49 living-room volumio[1222]: amixer -c 1 info | grep "bcm2835 Headphones" Aug 29 16:35:49 living-room volumio[1222]: Card sysdefault:1 'Headphones'/'bcm2835 Headphones' Aug 29 16:35:49 living-room volumio[1222]: amixer -c 2 info | grep "vc4-hdmi-0" Aug 29 16:35:49 living-room volumio[1222]: Card sysdefault:2 'vc4hdmi0'/'vc4-hdmi-0' Aug 29 16:35:49 living-room volumio[1222]: amixer -c 3 info | grep "vc4-hdmi-1" Aug 29 16:35:49 living-room volumio[1222]: Card sysdefault:3 'vc4hdmi1'/'vc4-hdmi-1' Aug 29 16:35:49 living-room volumio[1222]: amixer -c 4 info | grep "snd_rpi_hifiberry_dac" Aug 29 16:35:50 living-room volumio[1222]: Card sysdefault:4 'sndrpihifiberry'/'snd_rpi_hifiberry_dac' Aug 29 16:35:50 living-room volumiobt[2059]: 2026-08-29 16:35:50 a2dp-agent [INFO] Connecting to system D-Bus Aug 29 16:35:50 living-room volumiobt[2059]: 2026-08-29 16:35:50 a2dp-agent [INFO] Connected to system D-Bus Aug 29 16:35:50 living-room volumiobt[2059]: 2026-08-29 16:35:50 bluezutils [INFO] Found adapter at: /org/bluez/hci0 Aug 29 16:35:50 living-room volumiobt[2059]: 2026-08-29 16:35:50 a2dp-agent [INFO] Found Bluetooth adapter: /org/bluez/hci0 Aug 29 16:35:50 living-room volumiobt[2059]: 2026-08-29 16:35:50 a2dp-agent [INFO] Set DiscoverableTimeout to infinite Aug 29 16:35:50 living-room volumiobt[2059]: 2026-08-29 16:35:50 a2dp-agent [INFO] Enabled Discoverable mode Aug 29 16:35:50 living-room volumiobt[2059]: 2026-08-29 16:35:50 a2dp-agent [INFO] Agent registered at /local/a2dpagent Aug 29 16:35:50 living-room volumiobt[2059]: 2026-08-29 16:35:50 a2dp-agent [INFO] Agent set as default Aug 29 16:35:50 living-room volumiobt[2059]: 2026-08-29 16:35:50 a2dp-agent [INFO] A2DP agent running, waiting for connections... Aug 29 16:35:50 living-room volumio[1222]: ------------------------------------ BT MESSAGE: volumiobt.service started successfully Aug 29 16:35:50 living-room volumio[1222]: ------------------------------------ BT MESSAGE: [FUNC] dbusStart Aug 29 16:35:50 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:50 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:50 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:50 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:50 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:50 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:50 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:50 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:50 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 16:35:50 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:50 living-room volumio[1222]: info: Access Token successfully retrieved Aug 29 16:35:50 living-room volumio[1222]: error: updateQueue error: null Aug 29 16:35:50 living-room volumio[1222]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 4 Aug 29 16:35:50 living-room volumio[1222]: /bin/sh: 1: /usr/local/bin/alsacap: not found Aug 29 16:35:50 living-room volumio[1222]: {"cmd":"/usr/local/bin/alsacap -C 4","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 4\n/bin/sh: 1: /usr/local/bin/alsacap: not found\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)"} Aug 29 16:35:50 living-room volumio[1222]: amixer -c 4 info | grep "HiFiBerry DAC" Aug 29 16:35:50 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:50.866-05:00 level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.7.0:58239 @ 0x308f1a0" selectedOutputId=4 Aug 29 16:35:50 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 29 16:35:50 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 29 16:35:50 living-room volumio[1222]: info: Discovery: Getting this device information Aug 29 16:35:50 living-room volumio[1222]: info: CoreCommandRouter::volumioGetState Aug 29 16:35:50 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:50 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 29 16:35:51 living-room volumio[1222]: info: Executing endpoint qc_getconfig Aug 29 16:35:51 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Aug 29 16:35:51 living-room qobuz-connect[2035]: 20260829 16:35:51.191 [2035.2035] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Aug 29 16:35:51 living-room volumio[1222]: info: Received Get System Info Aug 29 16:35:51 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 29 16:35:51 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 29 16:35:51 living-room volumio[1222]: info: Discovery: Getting this device information Aug 29 16:35:51 living-room volumio[1222]: info: CoreCommandRouter::volumioGetState Aug 29 16:35:51 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:51 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 29 16:35:51 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:51.271-05:00 level=INFO msg="emitting software info changed event" component=server peer="192.168.7.0:58239 @ 0x308f1a0" currentVersion=4.119 latestVersion=4.119 Aug 29 16:35:51 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:51.272-05:00 level=INFO msg="emitting software update progress event" component=server peer="192.168.7.0:58239 @ 0x308f1a0" status=UPDATE_STATUS_NONE progress=0 Aug 29 16:35:51 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:51.272-05:00 level=INFO msg="emitting user changed event" component=server peer="192.168.7.0:58239 @ 0x308f1a0" userId= Aug 29 16:35:51 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:51.272-05:00 level=INFO msg="emitting music providers changed event" component=server peer="192.168.7.0:58239 @ 0x308f1a0" providers=3 Aug 29 16:35:51 living-room qobuz-connect[2035]: 20260829 16:35:51.275 [2035.2035] INFO VolumeManager: [0xe262b8]: Setting new playback volume: 75 Aug 29 16:35:51 living-room qobuz-connect[2035]: 20260829 16:35:51.275 [2035.2035] INFO VolumeManager: [0xe262b8]: Setting new mute state: 0 Aug 29 16:35:51 living-room qobuz-connect[2035]: 20260829 16:35:51.275 [2035.2035] INFO AudioStreamManager: [0xe26010]: Setting new audio download buffer size: 1048576 Aug 29 16:35:51 living-room qobuz-connect[2035]: 20260829 16:35:51.275 [2035.2035] INFO QobuzConnect: [0xe26b80]: Client initialized! Aug 29 16:35:51 living-room qobuz-connect[2035]: 20260829 16:35:51.275 [2035.2035] INFO SampleApp: Starting Avahi advertising, name: Living Room, service name: _qobuz-connect._tcp Aug 29 16:35:51 living-room volumio[1222]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Aug 29 16:35:51 living-room volumio[1222]: info: QobuzConnect: QOBUZ Connect daemon connected Aug 29 16:35:51 living-room qobuz-connect[2035]: 20260829 16:35:51.287 [2035.2035] INFO LocalConfigManager: [0xe25d38]: Starting Local Configuration server Aug 29 16:35:51 living-room qobuz-connect[2035]: 20260829 16:35:51.288 [2035.2035] INFO SampleApp: Starting Local configuration server Aug 29 16:35:51 living-room qobuz-connect[2035]: 20260829 16:35:51.288 [2035.2035] INFO SampleApp: Connected to UNIX socket client 0xe10818 Aug 29 16:35:51 living-room volumio[1222]: info: TidalConnect service stoped! Aug 29 16:35:51 living-room qobuz-connect[2035]: 20260829 16:35:51.341 [2035.2035] INFO SampleApp: Playback volume changed: 75 Aug 29 16:35:51 living-room volumio[1222]: info: Starting Shairport Sync Aug 29 16:35:51 living-room sudo[2116]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 29 16:35:51 living-room sudo[2116]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:51 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 29 16:35:51 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 29 16:35:51 living-room volumio[1222]: info: Discovery: Getting this device information Aug 29 16:35:51 living-room volumio[1222]: info: CoreCommandRouter::volumioGetState Aug 29 16:35:51 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:51 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 29 16:35:51 living-room systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Aug 29 16:35:51 living-room systemd[1]: shairport-sync.service: Deactivated successfully. Aug 29 16:35:51 living-room systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 29 16:35:51 living-room systemd[1]: shairport-sync.service: Consumed 1.469s CPU time. Aug 29 16:35:51 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 29 16:35:51 living-room volumio[1222]: info: MRS: Found cast device: SmartTV-4K-FFM-88e442e690aaa00f03aebc72ced83b2a Aug 29 16:35:51 living-room systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 29 16:35:51 living-room sudo[2116]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:51 living-room volumio[1222]: info: Adding audio output: Aug 29 16:35:51 living-room volumio[1222]: info: CoreCommandRouter::volumioGetState Aug 29 16:35:51 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:51 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 29 16:35:51 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 29 16:35:52 living-room volumio[1222]: info: Shairport-Sync Started Aug 29 16:35:52 living-room volumio[1222]: info: Successfully retrieved User Session From TIDAL Aug 29 16:35:52 living-room volumio[1222]: verbose: New Socket.io Connection to 192.168.6.253:3000 from 192.168.7.0 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Aug 29 16:35:52 living-room volumio[1222]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Aug 29 16:35:52 living-room volumio[1222]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Aug 29 16:35:52 living-room volumio[1222]: info: Successfully retrieved User Subscription From TIDAL Aug 29 16:35:52 living-room volumio[1222]: info: Adding TIDAL to Browse Sources Aug 29 16:35:52 living-room volumio[1222]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 29 16:35:52 living-room volumio[1222]: info: [1788039352519] CoreMusicLibrary::Adding element TIDAL Aug 29 16:35:52 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 29 16:35:52 living-room volumio[1222]: Cannot find translation for source Radio Paradise Aug 29 16:35:52 living-room volumio[1222]: Cannot find translation for source TIDAL Aug 29 16:35:52 living-room volumio[1222]: info: Adding TIDAL REST API Endpoints Aug 29 16:35:52 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 29 16:35:52 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 29 16:35:52 living-room volumio[1222]: info: CoreCommandRouter::volumioGetState Aug 29 16:35:52 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:52 living-room sudo[2138]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Aug 29 16:35:52 living-room sudo[2138]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:52 living-room systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Aug 29 16:35:52 living-room sudo[2138]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:53 living-room volumio[1222]: info: Executing endpoint tc_getconfig Aug 29 16:35:53 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Aug 29 16:35:53 living-room vtcs[2141]: STARTING TidalConnect services, version: 1.6.1 Aug 29 16:35:53 living-room vtcs[2141]: STARTED TidalConnect services. Aug 29 16:35:53 living-room volumio[1222]: info: Executing endpoint tc_connect Aug 29 16:35:53 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Aug 29 16:35:53 living-room volumio[1222]: info: Connecting to TidalConnect Aug 29 16:35:53 living-room volumio[1222]: info: CoreCommandRouter::servicePushState Aug 29 16:35:53 living-room volumio[1222]: info: CoreStateMachine::pushState Aug 29 16:35:53 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:53 living-room volumio[1222]: info: CoreCommandRouter::volumioPushState Aug 29 16:35:53 living-room volumio[1222]: info: MRS: Pushing multiroomSync output update for this device Aug 29 16:35:53 living-room volumio[1222]: info: MRS: Pushing multiroomSync output Aug 29 16:35:53 living-room volumio[1222]: info: CoreCommandRouter::volumioGetState Aug 29 16:35:53 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:53 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:53 living-room volumio[1222]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received tidalconnect Aug 29 16:35:53 living-room volumio[1222]: info: CoreCommandRouter::servicePushState Aug 29 16:35:53 living-room volumio[1222]: info: CoreStateMachine::pushState Aug 29 16:35:53 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:53 living-room volumio[1222]: info: CoreCommandRouter::volumioPushState Aug 29 16:35:53 living-room volumio[1222]: info: MRS: Pushing multiroomSync output update for this device Aug 29 16:35:53 living-room volumio[1222]: info: MRS: Pushing multiroomSync output Aug 29 16:35:53 living-room volumio[1222]: info: CoreCommandRouter::volumioGetState Aug 29 16:35:53 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:53 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:53 living-room volumio[1222]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received tidalconnect Aug 29 16:35:53 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:53.751-05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" state=STATUS_STOPPED positionMs=0 volume=100 Aug 29 16:35:53 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:53.752-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" id=http://stream.radioparadise.com/beyond-flacm title="Radio Paradise Beyond...(FLAC)" Aug 29 16:35:53 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:53.754-05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" state=STATUS_STOPPED positionMs=0 volume=100 Aug 29 16:35:53 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:53.754-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" id=http://stream.radioparadise.com/beyond-flacm title="Radio Paradise Beyond...(FLAC)" Aug 29 16:35:53 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:53.828-05:00 level=INFO msg="emitting plugins changed event" component=server peer="192.168.7.0:58239 @ 0x308f1a0" plugins=71 Aug 29 16:35:53 living-room volumio[1222]: info: CoreCommandRouter::volumioGetState Aug 29 16:35:53 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:53 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:53.952-05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.0:58239 @ 0x308f1a0" state=STATUS_STOPPED positionMs=0 volume=100 Aug 29 16:35:53 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:53.953-05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.0:58239 @ 0x308f1a0" id=http://stream.radioparadise.com/beyond-flacm title="Radio Paradise Beyond...(FLAC)" Aug 29 16:35:53 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:53.981-05:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=-37.500758ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Aug 29 16:35:54 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:54.000-05:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=-38.489165ms timeout=10s Aug 29 16:35:54 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:54.309-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=-38.489165ms timeout=10s endpoint=http://pushupdates.volumio.org duration=307.449593ms Aug 29 16:35:54 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:54.406-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=-38.489165ms timeout=10s endpoint=http://plugins.volumio.org duration=403.298759ms Aug 29 16:35:54 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:54.424-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=-38.489165ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=423.612722ms Aug 29 16:35:54 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:54.455-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=-38.489165ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=454.995426ms Aug 29 16:35:54 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:54.734-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=-38.489165ms timeout=10s endpoint=https://functions.volumio.cloud duration=731.790296ms Aug 29 16:35:54 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:54.734-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=-38.489165ms timeout=10s endpoint=https://functions.volumio.cloud duration=732.807204ms Aug 29 16:35:54 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:54.734-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=-38.489165ms timeout=10s endpoint=https://securetoken.googleapis.com duration=733.520148ms Aug 29 16:35:54 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:54.843-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=-38.489165ms timeout=10s endpoint=https://google.com duration=842.489758ms Aug 29 16:35:54 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:54.848-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=-38.489165ms timeout=10s endpoint=https://www.googleapis.com duration=846.223241ms Aug 29 16:35:54 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:54.918-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=-38.489165ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=917.150906ms Aug 29 16:35:54 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:54.971-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=-38.489165ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=969.704925ms Aug 29 16:35:55 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:55.028-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=-38.489165ms timeout=10s endpoint=https://database.volumio.cloud duration=1.025876611s Aug 29 16:35:55 living-room sudo[2167]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 29 16:35:55 living-room sudo[2167]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:55 living-room sudo[2167]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:55 living-room sudo[2169]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 29 16:35:55 living-room sudo[2169]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:55 living-room volumio5-onboarding[1611]: time=2026-08-29T16:35:55.306-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=-38.489165ms timeout=10s endpoint=http://cddb.volumio.org duration=1.304056388s Aug 29 16:35:55 living-room sudo[2169]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:55 living-room volumio[1222]: verbose: New Socket.io Connection to 192.168.6.253 from 192.168.7.0 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7 Aug 29 16:35:56 living-room sudo[2175]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 29 16:35:56 living-room sudo[2175]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:56 living-room volumio[1222]: info: TidalConnect service started! Aug 29 16:35:56 living-room volumio[1222]: [Metrics] CommandRouter: 71s 621.80ms Aug 29 16:35:56 living-room volumio[1222]: info: CoreCommandRouter::volumiosetStartupVolume Aug 29 16:35:56 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 16:35:56 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 16:35:56 living-room sudo[2176]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 29 16:35:56 living-room sudo[2176]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 29 16:35:56 living-room sudo[2175]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:56 living-room volumio[1222]: info: CoreCommandRouter::Close All Modals sent Aug 29 16:35:56 living-room sudo[2176]: pam_unix(sudo:session): session closed for user root Aug 29 16:35:56 living-room volumio[1222]: info: CoreCommandRouter::Close All Modals sent Aug 29 16:35:56 living-room volumio[1222]: verbose: New Socket.io Connection to 192.168.6.253 from 192.168.7.0 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 8 Aug 29 16:35:56 living-room volumio[1222]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Aug 29 16:35:56 living-room volumio[1222]: info: FusionDsp - ---- read samplerate from file: 44100 Aug 29 16:35:56 living-room volumio[1222]: info: camilladsp stopping service pid 1769... Aug 29 16:35:56 living-room volumio[1222]: grep: /proc/1769/cmdline: binary file matches Aug 29 16:35:56 living-room volumio[1222]: info: camilladsp service terminated, instance 1 Aug 29 16:35:56 living-room volumio[1222]: info: FusionDsp - If filter freq >samplerate/2 then disable it Aug 29 16:35:56 living-room volumio[1222]: info: camilladsp service started and running in background, instance 1 Aug 29 16:35:56 living-room volumio[1222]: info: camilladsp respawn in 100 ms (attempt 1/10) Aug 29 16:35:57 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 29 16:35:57 living-room volumio[1222]: info: CoreCommandRouter::volumioGetVisibleSources Aug 29 16:35:57 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 29 16:35:57 living-room volumio[1222]: info: CoreCommandRouter::volumioGetState Aug 29 16:35:57 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:57 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Aug 29 16:35:57 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 29 16:35:57 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Aug 29 16:35:57 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 29 16:35:57 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 29 16:35:57 living-room volumio[1222]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Aug 29 16:35:57 living-room volumio[1222]: info: Received Get System Info Aug 29 16:35:57 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 29 16:35:57 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 29 16:35:57 living-room volumio[1222]: info: Discovery: Getting this device information Aug 29 16:35:57 living-room volumio[1222]: info: CoreCommandRouter::volumioGetState Aug 29 16:35:57 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:57 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 29 16:35:57 living-room volumio[1222]: info: CoreCommandRouter::volumioGetState Aug 29 16:35:57 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:57 living-room volumio[1222]: info: Listing playlists Aug 29 16:35:57 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 29 16:35:57 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 29 16:35:57 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 29 16:35:57 living-room volumio[1222]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 29 16:35:58 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 29 16:35:58 living-room volumio[1222]: info: Received Get System Info Aug 29 16:35:58 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 29 16:35:58 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 29 16:35:58 living-room volumio[1222]: info: Discovery: Getting this device information Aug 29 16:35:58 living-room volumio[1222]: info: CoreCommandRouter::volumioGetState Aug 29 16:35:58 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:58 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 29 16:35:58 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 29 16:35:59 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 29 16:35:59 living-room volumio[1222]: info: Received Get System Info Aug 29 16:35:59 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 29 16:35:59 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 29 16:35:59 living-room volumio[1222]: info: Discovery: Getting this device information Aug 29 16:35:59 living-room volumio[1222]: info: CoreCommandRouter::volumioGetState Aug 29 16:35:59 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:35:59 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 29 16:36:03 living-room volumio[1222]: info: BOOT COMPLETED Aug 29 16:36:04 living-room volumio[1222]: info: camilladsp respawn in 200 ms (attempt 2/10) Aug 29 16:36:06 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 29 16:36:12 living-room volumio5-onboarding[1611]: time=2026-08-29T16:36:12.438-05:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=519.49µs timeout=10s Aug 29 16:36:12 living-room volumio5-onboarding[1611]: time=2026-08-29T16:36:12.454-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=519.49µs timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=15.801833ms Aug 29 16:36:12 living-room volumio5-onboarding[1611]: time=2026-08-29T16:36:12.461-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=519.49µs timeout=10s endpoint=https://securetoken.googleapis.com duration=22.4935ms Aug 29 16:36:12 living-room volumio5-onboarding[1611]: time=2026-08-29T16:36:12.470-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=519.49µs timeout=10s endpoint=https://myvolumio.firebaseio.com duration=31.344074ms Aug 29 16:36:12 living-room volumio5-onboarding[1611]: time=2026-08-29T16:36:12.487-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=519.49µs timeout=10s endpoint=https://database.volumio.cloud duration=44.642778ms Aug 29 16:36:12 living-room volumio5-onboarding[1611]: time=2026-08-29T16:36:12.491-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=519.49µs timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=51.663074ms Aug 29 16:36:12 living-room volumio5-onboarding[1611]: time=2026-08-29T16:36:12.514-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=519.49µs timeout=10s endpoint=https://functions.volumio.cloud duration=73.219648ms Aug 29 16:36:12 living-room volumio5-onboarding[1611]: time=2026-08-29T16:36:12.516-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=519.49µs timeout=10s endpoint=https://functions.volumio.cloud duration=76.445241ms Aug 29 16:36:12 living-room volumio5-onboarding[1611]: time=2026-08-29T16:36:12.521-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=519.49µs timeout=10s endpoint=https://google.com duration=82.178537ms Aug 29 16:36:12 living-room volumio5-onboarding[1611]: time=2026-08-29T16:36:12.543-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=519.49µs timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=103.374351ms Aug 29 16:36:12 living-room volumio5-onboarding[1611]: time=2026-08-29T16:36:12.553-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=519.49µs timeout=10s endpoint=https://www.googleapis.com duration=114.187148ms Aug 29 16:36:12 living-room volumio5-onboarding[1611]: time=2026-08-29T16:36:12.588-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=519.49µs timeout=10s endpoint=http://pushupdates.volumio.org duration=146.602944ms Aug 29 16:36:12 living-room volumio5-onboarding[1611]: time=2026-08-29T16:36:12.604-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=519.49µs timeout=10s endpoint=http://plugins.volumio.org duration=162.15987ms Aug 29 16:36:12 living-room volumio5-onboarding[1611]: time=2026-08-29T16:36:12.704-05:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.7.0:58239,00:00:00:00:00:00%01 @ 0x308f1a0" latency=519.49µs timeout=10s endpoint=http://cddb.volumio.org duration=263.967963ms Aug 29 16:36:13 living-room volumio[1222]: info: CoreCommandRouter::volumioGetQueue Aug 29 16:36:13 living-room volumio[1222]: info: CoreStateMachine::getQueue Aug 29 16:36:13 living-room volumio[1222]: info: CorePlayQueue::getQueue Aug 29 16:36:15 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 29 16:36:15 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 29 16:36:15 living-room volumio[1222]: info: Discovery: Getting this device information Aug 29 16:36:15 living-room volumio[1222]: info: CoreCommandRouter::volumioGetState Aug 29 16:36:15 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:36:15 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 29 16:36:15 living-room volumio[1222]: verbose: New Socket.io Connection to 192.168.6.253:3000 from 192.168.7.0 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Aug 29 16:36:15 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 29 16:36:15 living-room volumio[1222]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 29 16:36:15 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 29 16:36:15 living-room volumio[1222]: info: Received Get System Version Aug 29 16:36:15 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 29 16:36:15 living-room volumio[1222]: info: Received Get System Info Aug 29 16:36:15 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 29 16:36:15 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 29 16:36:15 living-room volumio[1222]: info: Discovery: Getting this device information Aug 29 16:36:15 living-room volumio[1222]: info: CoreCommandRouter::volumioGetState Aug 29 16:36:15 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:36:15 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 29 16:36:15 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 29 16:36:15 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 29 16:36:17 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 29 16:36:17 living-room volumio[1222]: info: CURURI: music-library Aug 29 16:36:17 living-room volumio[1222]: info: Preload queue cleared Aug 29 16:36:18 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 29 16:36:18 living-room volumio[1222]: info: CURURI: music-library/USB Aug 29 16:36:18 living-room volumio[1222]: info: Preload queue cleared Aug 29 16:36:19 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 29 16:36:19 living-room volumio[1222]: info: CURURI: music-library/USB/ESD-USB Aug 29 16:36:19 living-room volumio[1222]: info: Preload queue cleared Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/24bit96_Pink-Noise_24_384.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/Aham - Nirangale - High Quality Audio - Raveendran.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/FLAC-Testfile.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/Nadodi - Doore Doore - High Quality Audio - S.P Venkatesh.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/No 1 Shehatheeram - Mele Mele Maanam - High Quality Audio - Jerry Amaldev.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/Oru Vadakkan Veeragadha - Chandanalepa - High Quality Audio - Bombay Ravi.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/Oru Vadakkan Veeragatha - Indulekha - Bombay Ravi - High Quality Audio.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/Oru Vadakkan Veeragatha - Kalarivilakku - Bombay Ravi - High Quality Audio.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/Pappayude Swantham Appoose - Olathumbathirunnu - High Quality Audio - Ilaiyaraaja.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/sample-1.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/sample-5.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/sample1.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/sample2 (1).flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/sample2.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/sample3.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/sample4.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/Thoovanathumbikal - Megham Poothuthudangi - Perumbavoor G. Raveendranath - High Quality Audio.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/Thumboli Kadappuram - Kaathil Thenmazhayayi - High Quality Audio - Salil Chowdhury.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/Vaishali - Indupushpam - Bombay Ravi - High Quality Audio.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/TV Torso - Clear Lake Strangler.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/1. A. R. Rahman - Vellai Pookal.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/01-01 Minnalvala (From _Narivetta_) (1).flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/01-01 Minnalvala (From _Narivetta_).flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/Raaja Raaja Cholan.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/04. Kun Faya Kun.wav Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/sample-file-1.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/sample-file-2.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/07 - Thiruda Thiruda Theme (Instrumental).wav Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/2023-Yuri_Korzunov-Through-Purity_44kHz_24bit.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/2024-Yuri_Korzunov-Through-Sunset-384kHz-32bit.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/yuri_korzunov-through-chill-192kHz-32bit.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/yuri_korzunov-through-moon_ring-96kHz-32bit.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/yuri_korzunov-through-wait-for_spring-384kHz-24bit.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/yuri_korzunov-through-winter_jazz-96kHz-24bit.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/yuri_korzunov-through-winter_jazz-96kHz-32bit.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/01-01 Kanmanipoove.flac Aug 29 16:36:19 living-room volumio[1222]: info: Preloading song: music-library/USB/ESD-USB/Symphony No.6 (1st movement).flac Aug 29 16:36:19 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/24bit96_Pink-Noise_24_384.flac in service mpd Aug 29 16:36:19 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=24%20Bit%20384%20kHz//extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2F24bit96_Pink-Noise_24_384.flac&metadata=false Aug 29 16:36:19 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/24bit96_Pink-Noise_24_384.flac Aug 29 16:36:19 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/Aham - Nirangale - High Quality Audio - Raveendran.flac in service mpd Aug 29 16:36:19 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=//extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2FAham%20-%20Nirangale%20-%20High%20Quality%20Audio%20-%20Raveendran.flac&metadata=false Aug 29 16:36:19 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/Aham - Nirangale - High Quality Audio - Raveendran.flac Aug 29 16:36:19 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/FLAC-Testfile.flac in service mpd Aug 29 16:36:19 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=//extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2FFLAC-Testfile.flac&metadata=false Aug 29 16:36:19 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/FLAC-Testfile.flac Aug 29 16:36:19 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/Nadodi - Doore Doore - High Quality Audio - S.P Venkatesh.flac in service mpd Aug 29 16:36:19 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=//extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2FNadodi%20-%20Doore%20Doore%20-%20High%20Quality%20Audio%20-%20S.P%20Venkatesh.flac&metadata=false Aug 29 16:36:19 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/Nadodi - Doore Doore - High Quality Audio - S.P Venkatesh.flac Aug 29 16:36:19 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/No 1 Shehatheeram - Mele Mele Maanam - High Quality Audio - Jerry Amaldev.flac in service mpd Aug 29 16:36:19 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=//extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2FNo%201%20Shehatheeram%20-%20Mele%20Mele%20Maanam%20-%20High%20Quality%20Audio%20-%20Jerry%20Amaldev.flac&metadata=false Aug 29 16:36:19 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/No 1 Shehatheeram - Mele Mele Maanam - High Quality Audio - Jerry Amaldev.flac Aug 29 16:36:19 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/Oru Vadakkan Veeragadha - Chandanalepa - High Quality Audio - Bombay Ravi.flac in service mpd Aug 29 16:36:19 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=//extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2FOru%20Vadakkan%20Veeragadha%20-%20Chandanalepa%20-%20High%20Quality%20Audio%20-%20Bombay%20Ravi.flac&metadata=false Aug 29 16:36:19 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/Oru Vadakkan Veeragadha - Chandanalepa - High Quality Audio - Bombay Ravi.flac Aug 29 16:36:19 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/Oru Vadakkan Veeragatha - Indulekha - Bombay Ravi - High Quality Audio.flac in service mpd Aug 29 16:36:19 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=//extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2FOru%20Vadakkan%20Veeragatha%20-%20Indulekha%20-%20Bombay%20Ravi%20-%20High%20Quality%20Audio.flac&metadata=false Aug 29 16:36:19 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/Oru Vadakkan Veeragatha - Indulekha - Bombay Ravi - High Quality Audio.flac Aug 29 16:36:19 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/Oru Vadakkan Veeragatha - Kalarivilakku - Bombay Ravi - High Quality Audio.flac in service mpd Aug 29 16:36:19 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=//extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2FOru%20Vadakkan%20Veeragatha%20-%20Kalarivilakku%20-%20Bombay%20Ravi%20-%20High%20Quality%20Audio.flac&metadata=false Aug 29 16:36:19 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/Oru Vadakkan Veeragatha - Kalarivilakku - Bombay Ravi - High Quality Audio.flac Aug 29 16:36:19 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/Pappayude Swantham Appoose - Olathumbathirunnu - High Quality Audio - Ilaiyaraaja.flac in service mpd Aug 29 16:36:19 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=//extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2FPappayude%20Swantham%20Appoose%20-%20Olathumbathirunnu%20-%20High%20Quality%20Audio%20-%20Ilaiyaraaja.flac&metadata=false Aug 29 16:36:19 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/Pappayude Swantham Appoose - Olathumbathirunnu - High Quality Audio - Ilaiyaraaja.flac Aug 29 16:36:19 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/sample-1.flac in service mpd Aug 29 16:36:19 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=//extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2Fsample-1.flac&metadata=false Aug 29 16:36:19 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/sample-1.flac Aug 29 16:36:19 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/sample-5.flac in service mpd Aug 29 16:36:19 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=//extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2Fsample-5.flac&metadata=false Aug 29 16:36:19 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/sample-5.flac Aug 29 16:36:20 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/sample1.flac in service mpd Aug 29 16:36:20 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=//extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2Fsample1.flac&metadata=false Aug 29 16:36:20 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/sample1.flac Aug 29 16:36:20 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/sample2 (1).flac in service mpd Aug 29 16:36:20 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=//extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2Fsample2%20(1).flac&metadata=false Aug 29 16:36:20 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/sample2 (1).flac Aug 29 16:36:20 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/sample2.flac in service mpd Aug 29 16:36:20 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=//extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2Fsample2.flac&metadata=false Aug 29 16:36:20 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/sample2.flac Aug 29 16:36:20 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/sample3.flac in service mpd Aug 29 16:36:20 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=//extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2Fsample3.flac&metadata=false Aug 29 16:36:20 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/sample3.flac Aug 29 16:36:20 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/sample4.flac in service mpd Aug 29 16:36:20 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=//extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2Fsample4.flac&metadata=false Aug 29 16:36:20 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/sample4.flac Aug 29 16:36:20 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/Thoovanathumbikal - Megham Poothuthudangi - Perumbavoor G. Raveendranath - High Quality Audio.flac in service mpd Aug 29 16:36:20 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=//extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2FThoovanathumbikal%20-%20Megham%20Poothuthudangi%20-%20Perumbavoor%20G.%20Raveendranath%20-%20High%20Quality%20Audio.flac&metadata=false Aug 29 16:36:20 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/Thoovanathumbikal - Megham Poothuthudangi - Perumbavoor G. Raveendranath - High Quality Audio.flac Aug 29 16:36:20 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/Thumboli Kadappuram - Kaathil Thenmazhayayi - High Quality Audio - Salil Chowdhury.flac in service mpd Aug 29 16:36:20 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=//extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2FThumboli%20Kadappuram%20-%20Kaathil%20Thenmazhayayi%20-%20High%20Quality%20Audio%20-%20Salil%20Chowdhury.flac&metadata=false Aug 29 16:36:20 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/Thumboli Kadappuram - Kaathil Thenmazhayayi - High Quality Audio - Salil Chowdhury.flac Aug 29 16:36:20 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/Vaishali - Indupushpam - Bombay Ravi - High Quality Audio.flac in service mpd Aug 29 16:36:20 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=//extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2FVaishali%20-%20Indupushpam%20-%20Bombay%20Ravi%20-%20High%20Quality%20Audio.flac&metadata=false Aug 29 16:36:20 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/Vaishali - Indupushpam - Bombay Ravi - High Quality Audio.flac Aug 29 16:36:20 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/TV Torso - Clear Lake Strangler.flac in service mpd Aug 29 16:36:20 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=TV%20Torso/Clear%20Lake%20Strangler/extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2FTV%20Torso%20-%20Clear%20Lake%20Strangler.flac&metadata=false Aug 29 16:36:20 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/TV Torso - Clear Lake Strangler.flac Aug 29 16:36:20 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/1. A. R. Rahman - Vellai Pookal.flac in service mpd Aug 29 16:36:20 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=A.%20R.%20Rahman/Kannathil%20Muthamittal%20(2002)%20(flac)/extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2F1.%20A.%20R.%20Rahman%20-%20Vellai%20Pookal.flac&metadata=false Aug 29 16:36:20 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/1. A. R. Rahman - Vellai Pookal.flac Aug 29 16:36:20 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/01-01 Minnalvala (From _Narivetta_) (1).flac in service mpd Aug 29 16:36:20 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=Jakes%20Bejoy/Minnalvala%20%20(From%20%22Narivetta%22)/extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2F01-01%20Minnalvala%20(From%20_Narivetta_)%20(1).flac&metadata=false Aug 29 16:36:20 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/01-01 Minnalvala (From _Narivetta_) (1).flac Aug 29 16:36:20 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/01-01 Minnalvala (From _Narivetta_).flac in service mpd Aug 29 16:36:20 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=Jakes%20Bejoy/Minnalvala%20%20(From%20%22Narivetta%22)/extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2F01-01%20Minnalvala%20(From%20_Narivetta_).flac&metadata=false Aug 29 16:36:20 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/01-01 Minnalvala (From _Narivetta_).flac Aug 29 16:36:20 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/Raaja Raaja Cholan.flac in service mpd Aug 29 16:36:20 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=K.%20J.%20Yesudas/Rettai%20Vaal%20Kuruvi/extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2FRaaja%20Raaja%20Cholan.flac&metadata=false Aug 29 16:36:20 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/Raaja Raaja Cholan.flac Aug 29 16:36:20 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/04. Kun Faya Kun.wav in service mpd Aug 29 16:36:20 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=A.R.%20Rahman%2C%20Javed%20Ali%2C%20Mohit%20Chauhan/Rockstar/extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2F04.%20Kun%20Faya%20Kun.wav&metadata=false Aug 29 16:36:20 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/04. Kun Faya Kun.wav Aug 29 16:36:20 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/sample-file-1.flac in service mpd Aug 29 16:36:20 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=Samples%20Files/Samples%20files/extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2Fsample-file-1.flac&metadata=false Aug 29 16:36:20 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/sample-file-1.flac Aug 29 16:36:20 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/sample-file-2.flac in service mpd Aug 29 16:36:20 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=Samples%20Files/Samples%20files/extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2Fsample-file-2.flac&metadata=false Aug 29 16:36:20 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/sample-file-2.flac Aug 29 16:36:20 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/07 - Thiruda Thiruda Theme (Instrumental).wav in service mpd Aug 29 16:36:20 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=AR%20Rahman/Thiruda%20Thiruda/extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2F07%20-%20Thiruda%20Thiruda%20Theme%20(Instrumental).wav&metadata=false Aug 29 16:36:20 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/07 - Thiruda Thiruda Theme (Instrumental).wav Aug 29 16:36:20 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/2023-Yuri_Korzunov-Through-Purity_44kHz_24bit.flac in service mpd Aug 29 16:36:20 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=Yuri%20Korzunov/Through/extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2F2023-Yuri_Korzunov-Through-Purity_44kHz_24bit.flac&metadata=false Aug 29 16:36:20 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/2023-Yuri_Korzunov-Through-Purity_44kHz_24bit.flac Aug 29 16:36:20 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/2024-Yuri_Korzunov-Through-Sunset-384kHz-32bit.flac in service mpd Aug 29 16:36:20 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=Yuri%20Korzunov/Through/extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2F2024-Yuri_Korzunov-Through-Sunset-384kHz-32bit.flac&metadata=false Aug 29 16:36:20 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/2024-Yuri_Korzunov-Through-Sunset-384kHz-32bit.flac Aug 29 16:36:20 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/yuri_korzunov-through-chill-192kHz-32bit.flac in service mpd Aug 29 16:36:20 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=Yuri%20Korzunov/Through/extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2Fyuri_korzunov-through-chill-192kHz-32bit.flac&metadata=false Aug 29 16:36:20 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/yuri_korzunov-through-chill-192kHz-32bit.flac Aug 29 16:36:21 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/yuri_korzunov-through-moon_ring-96kHz-32bit.flac in service mpd Aug 29 16:36:21 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=Yuri%20Korzunov/Through/extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2Fyuri_korzunov-through-moon_ring-96kHz-32bit.flac&metadata=false Aug 29 16:36:21 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/yuri_korzunov-through-moon_ring-96kHz-32bit.flac Aug 29 16:36:21 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/yuri_korzunov-through-wait-for_spring-384kHz-24bit.flac in service mpd Aug 29 16:36:21 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=Yuri%20Korzunov/Through/extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2Fyuri_korzunov-through-wait-for_spring-384kHz-24bit.flac&metadata=false Aug 29 16:36:21 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/yuri_korzunov-through-wait-for_spring-384kHz-24bit.flac Aug 29 16:36:21 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/yuri_korzunov-through-winter_jazz-96kHz-24bit.flac in service mpd Aug 29 16:36:21 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=Yuri%20Korzunov/Through/extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2Fyuri_korzunov-through-winter_jazz-96kHz-24bit.flac&metadata=false Aug 29 16:36:21 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/yuri_korzunov-through-winter_jazz-96kHz-24bit.flac Aug 29 16:36:21 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/yuri_korzunov-through-winter_jazz-96kHz-32bit.flac in service mpd Aug 29 16:36:21 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=Yuri%20Korzunov/Through/extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2Fyuri_korzunov-through-winter_jazz-96kHz-32bit.flac&metadata=false Aug 29 16:36:21 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/yuri_korzunov-through-winter_jazz-96kHz-32bit.flac Aug 29 16:36:21 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/01-01 Kanmanipoove.flac in service mpd Aug 29 16:36:21 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=Jakes%20Bejoy/Thudarum%20%20(Original%20Motion%20Picture%20Soundtrack)/extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2F01-01%20Kanmanipoove.flac&metadata=false Aug 29 16:36:21 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/01-01 Kanmanipoove.flac Aug 29 16:36:21 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/Symphony No.6 (1st movement).flac in service mpd Aug 29 16:36:21 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=Ludwig%20van%20Beethoven/www.mfiles.co.uk/extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2FSymphony%20No.6%20(1st%20movement).flac&metadata=false Aug 29 16:36:21 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/Symphony No.6 (1st movement).flac Aug 29 16:36:21 living-room volumio[1222]: info: Preload queue cleared Aug 29 16:36:21 living-room volumio[1222]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 29 16:36:21 living-room volumio[1222]: info: CoreStateMachine::ClearQueue Aug 29 16:36:21 living-room volumio[1222]: info: CoreStateMachine::stop Aug 29 16:36:21 living-room volumio[1222]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 16:36:21 living-room volumio[1222]: info: CorePlayQueue::clearPlayQueue Aug 29 16:36:21 living-room volumio[1222]: info: CorePlayQueue::saveQueue Aug 29 16:36:21 living-room volumio[1222]: info: CoreCommandRouter::volumioPushQueue Aug 29 16:36:21 living-room volumio[1222]: info: CoreStateMachine::addQueueItems Aug 29 16:36:21 living-room volumio[1222]: info: CorePlayQueue::addQueueItems Aug 29 16:36:21 living-room volumio[1222]: info: Preload queue cleared Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/24bit96_Pink-Noise_24_384.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/24bit96_Pink-Noise_24_384.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/Aham - Nirangale - High Quality Audio - Raveendran.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/Aham - Nirangale - High Quality Audio - Raveendran.flac Aug 29 16:36:21 living-room volumio[1222]: info: CoreCommandRouter::volumioPushQueue Aug 29 16:36:21 living-room volumio[1222]: info: CorePlayQueue::saveQueue Aug 29 16:36:21 living-room volumio[1222]: info: CoreStateMachine::updateTrackBlock Aug 29 16:36:21 living-room volumio[1222]: info: CorePlayQueue::getTrackBlock Aug 29 16:36:21 living-room volumio[1222]: info: CoreCommandRouter::volumioGetState Aug 29 16:36:21 living-room volumio[1222]: info: CorePlayQueue::getTrack 0 Aug 29 16:36:21 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Aug 29 16:36:21 living-room volumio[1222]: info: CoreCommandRouter::volumioPlay Aug 29 16:36:21 living-room volumio[1222]: info: CoreStateMachine::play index 1 Aug 29 16:36:21 living-room volumio[1222]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 16:36:21 living-room volumio[1222]: info: CoreStateMachine::addQueueItems Aug 29 16:36:21 living-room volumio[1222]: info: CorePlayQueue::addQueueItems Aug 29 16:36:21 living-room volumio[1222]: info: Preload queue cleared Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/FLAC-Testfile.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/FLAC-Testfile.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/Nadodi - Doore Doore - High Quality Audio - S.P Venkatesh.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/Nadodi - Doore Doore - High Quality Audio - S.P Venkatesh.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/No 1 Shehatheeram - Mele Mele Maanam - High Quality Audio - Jerry Amaldev.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/No 1 Shehatheeram - Mele Mele Maanam - High Quality Audio - Jerry Amaldev.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/Oru Vadakkan Veeragadha - Chandanalepa - High Quality Audio - Bombay Ravi.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/Oru Vadakkan Veeragadha - Chandanalepa - High Quality Audio - Bombay Ravi.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/Oru Vadakkan Veeragatha - Indulekha - Bombay Ravi - High Quality Audio.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/Oru Vadakkan Veeragatha - Indulekha - Bombay Ravi - High Quality Audio.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/Oru Vadakkan Veeragatha - Kalarivilakku - Bombay Ravi - High Quality Audio.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/Oru Vadakkan Veeragatha - Kalarivilakku - Bombay Ravi - High Quality Audio.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/Pappayude Swantham Appoose - Olathumbathirunnu - High Quality Audio - Ilaiyaraaja.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/Pappayude Swantham Appoose - Olathumbathirunnu - High Quality Audio - Ilaiyaraaja.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/sample-1.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/sample-1.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/sample-5.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/sample-5.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/sample1.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/sample1.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/sample2 (1).flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/sample2 (1).flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/sample2.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/sample2.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/sample3.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/sample3.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/sample4.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/sample4.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/Thoovanathumbikal - Megham Poothuthudangi - Perumbavoor G. Raveendranath - High Quality Audio.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/Thoovanathumbikal - Megham Poothuthudangi - Perumbavoor G. Raveendranath - High Quality Audio.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/Thumboli Kadappuram - Kaathil Thenmazhayayi - High Quality Audio - Salil Chowdhury.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/Thumboli Kadappuram - Kaathil Thenmazhayayi - High Quality Audio - Salil Chowdhury.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/Vaishali - Indupushpam - Bombay Ravi - High Quality Audio.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/Vaishali - Indupushpam - Bombay Ravi - High Quality Audio.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/TV Torso - Clear Lake Strangler.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/TV Torso - Clear Lake Strangler.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/1. A. R. Rahman - Vellai Pookal.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/1. A. R. Rahman - Vellai Pookal.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/01-01 Minnalvala (From _Narivetta_) (1).flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/01-01 Minnalvala (From _Narivetta_) (1).flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/01-01 Minnalvala (From _Narivetta_).flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/01-01 Minnalvala (From _Narivetta_).flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/Raaja Raaja Cholan.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/Raaja Raaja Cholan.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/04. Kun Faya Kun.wav Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/04. Kun Faya Kun.wav Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/sample-file-1.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/sample-file-1.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/sample-file-2.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/sample-file-2.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/07 - Thiruda Thiruda Theme (Instrumental).wav Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/07 - Thiruda Thiruda Theme (Instrumental).wav Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/2023-Yuri_Korzunov-Through-Purity_44kHz_24bit.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/2023-Yuri_Korzunov-Through-Purity_44kHz_24bit.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/2024-Yuri_Korzunov-Through-Sunset-384kHz-32bit.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/2024-Yuri_Korzunov-Through-Sunset-384kHz-32bit.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/yuri_korzunov-through-chill-192kHz-32bit.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/yuri_korzunov-through-chill-192kHz-32bit.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/yuri_korzunov-through-moon_ring-96kHz-32bit.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/yuri_korzunov-through-moon_ring-96kHz-32bit.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/yuri_korzunov-through-wait-for_spring-384kHz-24bit.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/yuri_korzunov-through-wait-for_spring-384kHz-24bit.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/yuri_korzunov-through-winter_jazz-96kHz-24bit.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/yuri_korzunov-through-winter_jazz-96kHz-24bit.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/yuri_korzunov-through-winter_jazz-96kHz-32bit.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/yuri_korzunov-through-winter_jazz-96kHz-32bit.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/01-01 Kanmanipoove.flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/01-01 Kanmanipoove.flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/Symphony No.6 (1st movement).flac Aug 29 16:36:21 living-room volumio[1222]: info: Using cached record of: music-library/USB/ESD-USB/Symphony No.6 (1st movement).flac Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/b-1.-hard-sun (1).zip Aug 29 16:36:21 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/b-1.-hard-sun (1).zip in service mpd Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/b-1.-hard-sun.zip Aug 29 16:36:21 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/b-1.-hard-sun.zip in service mpd Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/Derek-Jones_Julie_DSD-FLAC-WAV-MQA.zip Aug 29 16:36:21 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/Derek-Jones_Julie_DSD-FLAC-WAV-MQA.zip in service mpd Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/raaja-raaja-cholan.zip Aug 29 16:36:21 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/raaja-raaja-cholan.zip in service mpd Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/vaishali-indupushpam-bombay-ravi-high-quality-audio.zip Aug 29 16:36:21 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/vaishali-indupushpam-bombay-ravi-high-quality-audio.zip in service mpd Aug 29 16:36:21 living-room volumio[1222]: info: Adding Item to queue: music-library/USB/ESD-USB/vinay-tamil-songs.zip Aug 29 16:36:21 living-room volumio[1222]: info: Exploding uri music-library/USB/ESD-USB/vinay-tamil-songs.zip in service mpd Aug 29 16:36:21 living-room volumio[1222]: info: CoreStateMachine::stop Aug 29 16:36:21 living-room volumio[1222]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 16:36:21 living-room volumio[1222]: info: CoreStateMachine::play index undefined Aug 29 16:36:21 living-room volumio[1222]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 16:36:21 living-room volumio[1222]: info: CorePlayQueue::getTrack 1 Aug 29 16:36:21 living-room volumio[1222]: info: CoreStateMachine::startPlaybackTimer Aug 29 16:36:21 living-room volumio[1222]: info: CorePlayQueue::getTrack 1 Aug 29 16:36:21 living-room volumio[1222]: info: CoreCommandRouter::volumioGetVisibleSources Aug 29 16:36:21 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 29 16:36:21 living-room volumio[1222]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Aug 29 16:36:21 living-room volumio[1222]: verbose: ControllerMpd::clearAddPlayTracks USB/ESD-USB/Aham - Nirangale - High Quality Audio - Raveendran.flac Aug 29 16:36:21 living-room volumio[1222]: verbose: ControllerMpd::sendMpdCommand stop Aug 29 16:36:21 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=//extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2Fb-1.-hard-sun%20(1).zip&metadata=false Aug 29 16:36:21 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/b-1.-hard-sun (1).zip Aug 29 16:36:21 living-room volumio[1222]: info: ALBUMART /albumart?cacheid=856&web=//extralarge&path=%2Fmnt%2FUSB%2FESD-USB%2Fb-1.-hard-sun%20(1).zip&metadata=false Aug 29 16:36:21 living-room volumio[1222]: info: URI /mnt/USB/ESD-USB/b-1.-hard-sun (1).zip Aug 29 16:36:21 living-room volumio[1222]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 29 16:36:21 living-room volumio[1222]: Error: Unable to resolve or reject the same promise twice Aug 29 16:36:21 living-room volumio[1222]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Aug 29 16:36:21 living-room volumio[1222]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Aug 29 16:36:21 living-room volumio[1222]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Aug 29 16:36:21 living-room volumio[1222]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Aug 29 16:36:21 living-room volumio[1222]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Aug 29 16:36:21 living-room volumio[1222]: at Socket.emit (node:events:514:28) Aug 29 16:36:21 living-room volumio[1222]: at addChunk (node:internal/streams/readable:343:12) Aug 29 16:36:21 living-room volumio[1222]: at readableAddChunk (node:internal/streams/readable:312:11) Aug 29 16:36:21 living-room volumio[1222]: at Readable.push (node:internal/streams/readable:253:10) Aug 29 16:36:21 living-room volumio[1222]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Aug 29 16:36:21 living-room volumio[1222]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 29 16:36:25 living-room sudo[2261]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-29 16:35' Aug 29 16:36:25 living-room sudo[2261]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 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"