Mar 04 18:09:51 volumio ntpd[1050]: CLOCK: time stepped by 2343738.880066 Mar 04 18:09:51 volumio ntpd[1050]: CLOCK: time changed from 2026-02-05 to 2026-03-04 Mar 04 18:09:51 volumio ntpd[1050]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Mar 04 18:09:51 volumio systemd[1]: Starting dpkg-db-backup.service - Daily dpkg database backup service... Mar 04 18:09:51 volumio systemd[1]: Started ntpsec-rotate-stats.service - Rotate ntpd stats. Mar 04 18:09:51 volumio systemd[1]: ntpsec-rotate-stats.service: Deactivated successfully. Mar 04 18:09:52 volumio systemd[1]: dpkg-db-backup.service: Deactivated successfully. Mar 04 18:09:52 volumio systemd[1]: Finished dpkg-db-backup.service - Daily dpkg database backup service. Mar 04 18:09:52 volumio mpd[1566]: 2026-03-04T17:09:52 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 04 18:09:52 volumio systemd[1]: Started mpd.service - Music Player Daemon. Mar 04 18:09:52 volumio sudo[1505]: pam_unix(sudo:session): session closed for user root Mar 04 18:09:52 volumio sudo[1546]: pam_unix(sudo:session): session closed for user root Mar 04 18:09:53 volumio volumio[1291]: info: Volumio Network Manager: Network status updated: 1 Mar 04 18:09:53 volumio sudo[1665]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 04 18:09:53 volumio sudo[1665]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:09:53 volumio sudo[1665]: pam_unix(sudo:session): session closed for user root Mar 04 18:09:53 volumio sudo[1667]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 04 18:09:53 volumio sudo[1667]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:09:53 volumio sudo[1667]: pam_unix(sudo:session): session closed for user root Mar 04 18:09:54 volumio volumio[1291]: info: MPD Permissions set Mar 04 18:09:54 volumio volumio[1291]: info: Completed starting Core Plugins Mar 04 18:09:54 volumio volumio[1291]: info: ------------------------------------------- Mar 04 18:09:54 volumio volumio[1291]: info: ----- MyVolumio plugins startup ---- Mar 04 18:09:54 volumio volumio[1291]: info: ------------------------------------------- Mar 04 18:09:54 volumio volumio[1291]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 04 18:09:54 volumio volumio[1291]: info: MPD Permissions set Mar 04 18:09:54 volumio volumio[1291]: info: Discovery: A device disappeared from network Mar 04 18:09:54 volumio volumio[1291]: info: Discovery: Device volumio disappeared from network Mar 04 18:09:54 volumio volumio[1513]: Starting albumart workers Mar 04 18:09:54 volumio volumio[1508]: Starting albumart workers Mar 04 18:09:54 volumio volumio[1291]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Mar 04 18:09:54 volumio volumio[1291]: info: Volumio called home Mar 04 18:09:54 volumio volumio[1291]: info: Discovery: A device disappeared from network Mar 04 18:09:54 volumio volumio[1291]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Mar 04 18:09:54 volumio volumio[1291]: info: Received Get System Info Mar 04 18:09:54 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 04 18:09:54 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 04 18:09:54 volumio volumio[1291]: info: Discovery: Getting this device information Mar 04 18:09:54 volumio volumio[1291]: info: CoreCommandRouter::volumioGetState Mar 04 18:09:54 volumio volumio[1291]: info: CorePlayQueue::getTrack 0 Mar 04 18:09:54 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 04 18:09:54 volumio volumio5-onboarding[1551]: time=2026-03-04T17:09:54.584Z level=INFO msg="system info for 5bbd1a68764a7bf367183a33b300d95f" deviceName=Volumio deviceVariant=volumio deviceModel= softwareVersion=4.096 Mar 04 18:09:54 volumio volumio[1511]: Starting albumart workers Mar 04 18:09:56 volumio systemd[1]: systemd-fsckd.service: Deactivated successfully. Mar 04 18:09:56 volumio volumio[1291]: error: MPD error: The expression evaluated to a falsy value: Mar 04 18:09:56 volumio volumio[1291]: assert.ok(self.idling) Mar 04 18:09:56 volumio volumio[1291]: error: The expression evaluated to a falsy value: Mar 04 18:09:56 volumio volumio[1291]: assert.ok(self.idling) Mar 04 18:09:56 volumio systemd[1]: Starting e2scrub_all.service - Online ext4 Metadata Check for All Filesystems... Mar 04 18:09:56 volumio systemd[1]: e2scrub_all.service: Deactivated successfully. Mar 04 18:09:56 volumio systemd[1]: Finished e2scrub_all.service - Online ext4 Metadata Check for All Filesystems. Mar 04 18:09:57 volumio volumio[1291]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Mar 04 18:09:57 volumio volumio[1291]: info: MPD running with PID1566 Mar 04 18:09:57 volumio volumio[1291]: ,establishing connection Mar 04 18:09:57 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 18:09:57 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 18:09:57 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 18:09:57 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 18:09:57 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 18:09:57 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 18:09:57 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 18:09:57 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 18:09:57 volumio volumio-remote-updater[847]: [2026-03-04 17:09:57] [connect] Successful connection Mar 04 18:09:57 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 04 18:09:57 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 18:09:57 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 18:09:57 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 18:09:57 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 18:09:57 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 18:09:57 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 18:09:57 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 18:09:57 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 18:09:57 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 18:09:57 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 04 18:09:57 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 18:09:57 volumio volumio[1291]: info: Received Get System Info Mar 04 18:09:57 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 04 18:09:57 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 04 18:09:57 volumio volumio[1291]: info: Discovery: Getting this device information Mar 04 18:09:57 volumio volumio[1291]: info: CoreCommandRouter::volumioGetState Mar 04 18:09:57 volumio volumio[1291]: info: CorePlayQueue::getTrack 0 Mar 04 18:09:57 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 04 18:09:57 volumio volumio[1291]: error: updateQueue error: null Mar 04 18:09:57 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 04 18:09:57 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 04 18:09:57 volumio volumio[1291]: error: updateQueue error: null Mar 04 18:09:57 volumio volumio5-onboarding[1551]: time=2026-03-04T17:09:57.823Z level=INFO msg="enabling local network discovery" Mar 04 18:09:57 volumio volumio5-onboarding[1551]: time=2026-03-04T17:09:57.839Z level=INFO msg="enabling BLE discovery" Mar 04 18:09:57 volumio volumio-remote-updater[847]: [2026-03-04 17:09:57] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1772644197 101 Mar 04 18:09:57 volumio volumio[1291]: 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: 3 Mar 04 18:09:57 volumio volumio[1291]: info: Starting Shairport Sync Mar 04 18:09:57 volumio volumio5-onboarding[1551]: time=2026-03-04T17:09:57.906Z level=INFO msg="bootstrapping state" hasInternet=true Mar 04 18:09:57 volumio volumio[1291]: info: Starting Shairport Sync Mar 04 18:09:57 volumio sudo[1714]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 04 18:09:57 volumio sudo[1714]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:09:57 volumio volumio[1291]: info: Starting Shairport Sync Mar 04 18:09:58 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Mar 04 18:09:58 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Mar 04 18:09:58 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 04 18:09:58 volumio systemd[1]: shairport-sync.service: Consumed 1.408s CPU time. Mar 04 18:09:58 volumio sudo[1719]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 04 18:09:58 volumio sudo[1719]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:09:58 volumio sudo[1717]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 04 18:09:58 volumio sudo[1717]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:09:58 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 04 18:09:58 volumio sudo[1714]: pam_unix(sudo:session): session closed for user root Mar 04 18:09:58 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Mar 04 18:09:58 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Mar 04 18:09:58 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 04 18:09:58 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 04 18:09:58 volumio sudo[1717]: pam_unix(sudo:session): session closed for user root Mar 04 18:09:58 volumio volumio[1291]: info: Received Get System Info Mar 04 18:09:58 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 04 18:09:58 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 04 18:09:58 volumio volumio[1291]: info: Discovery: Getting this device information Mar 04 18:09:58 volumio volumio[1291]: info: CoreCommandRouter::volumioGetState Mar 04 18:09:58 volumio volumio[1291]: info: CorePlayQueue::getTrack 0 Mar 04 18:09:58 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 04 18:09:58 volumio volumio[1291]: info: Discovery: adding d9da5eb5-1ddc-4fc7-afa8-8d73f5f15d5c Mar 04 18:09:58 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Mar 04 18:09:58 volumio volumio[1291]: info: Discovery: Found device Volumio Mar 04 18:09:58 volumio volumio[1291]: info: CoreCommandRouter::volumioGetState Mar 04 18:09:58 volumio sudo[1725]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 04 18:09:58 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Mar 04 18:09:58 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 04 18:09:58 volumio volumio[1291]: info: CorePlayQueue::getTrack 0 Mar 04 18:09:58 volumio volumio[1291]: info: Discovery: this is already registered, d9da5eb5-1ddc-4fc7-afa8-8d73f5f15d5c Mar 04 18:09:58 volumio sudo[1725]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:09:58 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 04 18:09:58 volumio volumio[1291]: info: Discovery: Found device Volumio Mar 04 18:09:58 volumio volumio[1291]: info: CoreCommandRouter::volumioGetState Mar 04 18:09:58 volumio volumio[1291]: info: CorePlayQueue::getTrack 0 Mar 04 18:09:58 volumio sudo[1719]: pam_unix(sudo:session): session closed for user root Mar 04 18:09:58 volumio volumio[1291]: info: Shairport-Sync Started Mar 04 18:09:58 volumio volumio[1291]: Error adding Membership: Error: addMembership EINVAL Mar 04 18:09:58 volumio volumio-remote-updater[847]: Test mode disabled Mar 04 18:09:58 volumio volumio-remote-updater[847]: Alpha mode disabled Mar 04 18:09:58 volumio volumio-remote-updater[847]: Alpha legacy test mode disabled Mar 04 18:09:58 volumio volumio[1291]: info: Shairport-Sync Started Mar 04 18:09:58 volumio volumio[1291]: info: Shairport-Sync Started Mar 04 18:09:58 volumio volumio[1291]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 04 18:09:58 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 04 18:09:58 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 04 18:09:58 volumio volumio5-onboarding[1551]: time=2026-03-04T17:09:58.734Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=tidal error="could not open plugin config file for \"tidal\": open /data/configuration/music_service/tidal/config.json: no such file or directory" Mar 04 18:09:58 volumio volumio5-onboarding[1551]: time=2026-03-04T17:09:58.735Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=qobuz error="could not open plugin config file for \"qobuz\": open /data/configuration/music_service/qobuz/config.json: no such file or directory" Mar 04 18:09:58 volumio volumio5-onboarding[1551]: time=2026-03-04T17:09:58.735Z level=WARN msg="could not read username/password data for music provider" component=volumio provider=hi_res_audio error="could not open plugin config file for \"hi_res_audio\": open /data/configuration/music_service/hi_res_audio/config.json: no such file or directory" Mar 04 18:09:58 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 04 18:09:58 volumio volumio[1291]: info: CoreCommandRouter::volumioGetState Mar 04 18:09:58 volumio volumio[1291]: info: CorePlayQueue::getTrack 0 Mar 04 18:09:58 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 04 18:10:00 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2. Mar 04 18:10:00 volumio systemd[1]: systemd-hostnamed.service: Deactivated successfully. Mar 04 18:10:00 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 04 18:10:00 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 04 18:10:00 volumio sudo[1725]: pam_unix(sudo:session): session closed for user root Mar 04 18:10:00 volumio volumio[1291]: info: Upmpdcli Daemon Started Mar 04 18:10:01 volumio volumio[1291]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Mar 04 18:10:01 volumio sudo[1786]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 04 18:10:01 volumio sudo[1786]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:10:01 volumio sudo[1786]: pam_unix(sudo:session): session closed for user root Mar 04 18:10:01 volumio sudo[1788]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 04 18:10:01 volumio sudo[1788]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:10:02 volumio sudo[1788]: pam_unix(sudo:session): session closed for user root Mar 04 18:10:02 volumio volumio[1291]: verbose: New Socket.io Connection to 192.168.1.148 from 192.168.1.171 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/145.0.0.0 Safari/537.36 Edg/145.0.0.0 Engine version: 3 Transport: polling Total Clients: 4 Mar 04 18:10:02 volumio volumio[1291]: info: CoreCommandRouter::volumioGetVisibleSources Mar 04 18:10:02 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 04 18:10:02 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Mar 04 18:10:02 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Mar 04 18:10:02 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Mar 04 18:10:02 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Mar 04 18:10:02 volumio volumio[1291]: info: Received Get System Info Mar 04 18:10:02 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 04 18:10:02 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 04 18:10:02 volumio volumio[1291]: info: Discovery: Getting this device information Mar 04 18:10:02 volumio volumio[1291]: info: CoreCommandRouter::volumioGetState Mar 04 18:10:02 volumio volumio[1291]: info: CorePlayQueue::getTrack 0 Mar 04 18:10:02 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 04 18:10:02 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 04 18:10:02 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 04 18:10:02 volumio volumio[1291]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 18:10:02 volumio volumio-remote-updater[847]: Test mode disabled Mar 04 18:10:02 volumio volumio-remote-updater[847]: Alpha mode disabled Mar 04 18:10:02 volumio volumio-remote-updater[847]: Alpha legacy test mode disabled Mar 04 18:10:02 volumio volumio[1291]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 04 18:10:02 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 04 18:10:02 volumio volumio[1291]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Mar 04 18:10:02 volumio volumio[1291]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Mar 04 18:10:02 volumio volumio[1291]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Mar 04 18:10:02 volumio volumio[1291]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Mar 04 18:10:02 volumio volumio[1291]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Mar 04 18:10:02 volumio volumio[1291]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Mar 04 18:10:02 volumio volumio[1291]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Mar 04 18:10:02 volumio volumio[1291]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Mar 04 18:10:02 volumio volumio[1291]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Mar 04 18:10:02 volumio volumio[1291]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Mar 04 18:10:02 volumio volumio[1291]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Mar 04 18:10:02 volumio volumio[1291]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Mar 04 18:10:02 volumio volumio[1291]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Mar 04 18:10:02 volumio volumio[1291]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Mar 04 18:10:02 volumio volumio[1291]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Mar 04 18:10:02 volumio volumio[1291]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Mar 04 18:10:02 volumio volumio[1291]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Mar 04 18:10:02 volumio volumio[1291]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Mar 04 18:10:02 volumio volumio[1291]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Mar 04 18:10:02 volumio volumio[1291]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Mar 04 18:10:02 volumio volumio[1291]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Mar 04 18:10:02 volumio volumio[1291]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Mar 04 18:10:02 volumio volumio[1291]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Mar 04 18:10:02 volumio volumio[1291]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Mar 04 18:10:02 volumio volumio[1291]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Mar 04 18:10:02 volumio volumio[1291]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Mar 04 18:10:02 volumio volumio[1291]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Mar 04 18:10:02 volumio volumio[1291]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Mar 04 18:10:02 volumio volumio[1291]: info: Adding plugin bluetooth to MyMusic Plugins Mar 04 18:10:02 volumio volumio[1291]: info: Adding plugin multiroom to MyMusic Plugins Mar 04 18:10:03 volumio volumio[1291]: info: Adding plugin metavolumio to MyMusic Plugins Mar 04 18:10:03 volumio volumio[1291]: info: Adding plugin cd_controller to MyMusic Plugins Mar 04 18:10:03 volumio volumio[1291]: info: Adding plugin qobuzconnect to MyMusic Plugins Mar 04 18:10:03 volumio volumio[1291]: info: Adding plugin smart_inputs to MyMusic Plugins Mar 04 18:10:03 volumio volumio[1291]: info: Adding plugin tidalconnect to MyMusic Plugins Mar 04 18:10:03 volumio volumio[1291]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Mar 04 18:10:07 volumio upmpdcli[1809]: writing RSA key Mar 04 18:10:07 volumio volumio[1291]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Mar 04 18:10:07 volumio volumio[1291]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Mar 04 18:10:07 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 04 18:10:07 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 04 18:10:07 volumio volumio[1291]: info: Starting MyVolumio Remote Streaming Endpoints Mar 04 18:10:08 volumio volumio[1291]: info: MyVolumio not started Mar 04 18:10:08 volumio volumio[1291]: info: Initializing device activation check Mar 04 18:10:08 volumio volumio[1291]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Mar 04 18:10:08 volumio volumio[1291]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Mar 04 18:10:10 volumio volumio[1291]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Mar 04 18:10:10 volumio volumio[1291]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Mar 04 18:10:10 volumio volumio[1291]: info: Streaming services startup Mar 04 18:10:10 volumio volumio[1291]: info: Starting Streaming Daemon Mar 04 18:10:10 volumio volumio[1291]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Mar 04 18:10:10 volumio sudo[1817]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 04 18:10:10 volumio sudo[1817]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:10:10 volumio sudo[1817]: pam_unix(sudo:session): session closed for user root Mar 04 18:10:10 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 04 18:10:10 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Mar 04 18:10:10 volumio volumio[1291]: info: Loading i18n strings for locale de Mar 04 18:10:10 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Mar 04 18:10:10 volumio volumio[1291]: info: Setting timezone to Europe/Berlin Mar 04 18:10:11 volumio sudo[1825]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Mar 04 18:10:11 volumio sudo[1825]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:10:11 volumio sudo[1825]: pam_unix(sudo:session): session closed for user root Mar 04 18:10:11 volumio sudo[1829]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Berlin /etc/localtime Mar 04 18:10:11 volumio sudo[1829]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:10:11 volumio sudo[1829]: pam_unix(sudo:session): session closed for user root Mar 04 18:10:11 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Mar 04 18:10:11 volumio sudo[1834]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Mar 04 18:10:11 volumio sudo[1834]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:10:11 volumio sudo[1834]: pam_unix(sudo:session): session closed for user root Mar 04 18:10:11 volumio sudo[1851]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Berlin Mar 04 18:10:11 volumio sudo[1851]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:10:11 volumio dbus-daemon[833]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.22' (uid=0 pid=1852 comm="/usr/bin/timedatectl set-timezone Europe/Berlin") Mar 04 18:10:11 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Mar 04 18:10:12 volumio dbus-daemon[833]: [system] Successfully activated service 'org.freedesktop.timedate1' Mar 04 18:10:12 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Mar 04 18:10:12 volumio sudo[1851]: pam_unix(sudo:session): session closed for user root Mar 04 18:10:12 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Mar 04 18:10:12 volumio volumio[1291]: info: Loading i18n strings for locale de Mar 04 18:10:12 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Mar 04 18:10:12 volumio volumio[1291]: info: Setting timezone to Europe/Berlin Mar 04 18:10:12 volumio sudo[1858]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Mar 04 18:10:12 volumio sudo[1858]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:10:12 volumio sudo[1858]: pam_unix(sudo:session): session closed for user root Mar 04 18:10:12 volumio sudo[1862]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Berlin /etc/localtime Mar 04 18:10:12 volumio sudo[1862]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:10:12 volumio sudo[1862]: pam_unix(sudo:session): session closed for user root Mar 04 18:10:12 volumio sudo[1866]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Mar 04 18:10:12 volumio sudo[1866]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:10:12 volumio sudo[1866]: pam_unix(sudo:session): session closed for user root Mar 04 18:10:12 volumio sudo[1870]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Berlin Mar 04 18:10:12 volumio sudo[1870]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:10:12 volumio sudo[1870]: pam_unix(sudo:session): session closed for user root Mar 04 18:10:12 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Mar 04 18:10:12 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Mar 04 18:10:13 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Mar 04 18:10:13 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Mar 04 18:10:13 volumio sudo[1878]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 04 18:10:13 volumio sudo[1878]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:10:13 volumio volumio[1291]: info: Fetching Streaming Services browse cache Mar 04 18:10:13 volumio volumio[1291]: info: Fetching Streaming Services browse cache Mar 04 18:10:13 volumio volumio[1291]: error: Cannot start Volumio Streaming Daemon Mar 04 18:10:13 volumio volumio[1291]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 04 18:10:13 volumio volumio[1291]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 04 18:10:13 volumio volumio[1291]: Updating browse sources language Mar 04 18:10:13 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 04 18:10:13 volumio volumio[1291]: Updating browse sources language Mar 04 18:10:13 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 04 18:10:14 volumio sudo[1905]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 04 18:10:14 volumio sudo[1905]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:10:14 volumio sudo[1906]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 04 18:10:14 volumio sudo[1906]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:10:14 volumio sudo[1905]: pam_unix(sudo:session): session closed for user root Mar 04 18:10:14 volumio sudo[1906]: pam_unix(sudo:session): session closed for user root Mar 04 18:10:15 volumio volumio[1291]: verbose: New Socket.io Connection to 192.168.1.148 from 192.168.1.171 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/145.0.0.0 Safari/537.36 Edg/145.0.0.0 Engine version: 3 Transport: polling Total Clients: 5 Mar 04 18:10:15 volumio volumio[1291]: info: CoreCommandRouter::volumioGetVisibleSources Mar 04 18:10:15 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 04 18:10:15 volumio volumio[1291]: info: Received Get System Info Mar 04 18:10:15 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 04 18:10:15 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 04 18:10:15 volumio volumio[1291]: info: Discovery: Getting this device information Mar 04 18:10:15 volumio volumio[1291]: info: CoreCommandRouter::volumioGetState Mar 04 18:10:15 volumio volumio[1291]: info: CorePlayQueue::getTrack 0 Mar 04 18:10:15 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 04 18:10:15 volumio sudo[1878]: pam_unix(sudo:session): session closed for user root Mar 04 18:10:16 volumio volumio[1291]: info: Received Get System Info Mar 04 18:10:16 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 04 18:10:16 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 04 18:10:16 volumio volumio[1291]: info: Discovery: Getting this device information Mar 04 18:10:16 volumio volumio[1291]: info: CoreCommandRouter::volumioGetState Mar 04 18:10:16 volumio volumio[1291]: info: CorePlayQueue::getTrack 0 Mar 04 18:10:16 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 04 18:10:16 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 04 18:10:16 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 04 18:10:19 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 04 18:10:19 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 04 18:10:19 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 04 18:10:19 volumio sudo[1914]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 04 18:10:19 volumio sudo[1914]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:10:19 volumio sudo[1916]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 04 18:10:19 volumio sudo[1916]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:10:19 volumio sudo[1914]: pam_unix(sudo:session): session closed for user root Mar 04 18:10:19 volumio sudo[1916]: pam_unix(sudo:session): session closed for user root Mar 04 18:10:19 volumio volumio-remote-updater[847]: Test mode disabled Mar 04 18:10:19 volumio volumio-remote-updater[847]: Alpha mode disabled Mar 04 18:10:19 volumio volumio-remote-updater[847]: Alpha legacy test mode disabled Mar 04 18:10:19 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Mar 04 18:10:19 volumio volumio[1291]: verbose: New Socket.io Connection to 192.168.1.148 from 192.168.1.171 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/145.0.0.0 Safari/537.36 Edg/145.0.0.0 Engine version: 3 Transport: polling Total Clients: 5 Mar 04 18:10:19 volumio volumio[1291]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 04 18:10:19 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 04 18:10:19 volumio volumio[1291]: info: CoreCommandRouter::volumioGetVisibleSources Mar 04 18:10:19 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 04 18:10:19 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Mar 04 18:10:19 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Mar 04 18:10:20 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Mar 04 18:10:20 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Mar 04 18:10:20 volumio volumio[1291]: info: Received Get System Info Mar 04 18:10:20 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 04 18:10:20 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 04 18:10:20 volumio volumio[1291]: info: Discovery: Getting this device information Mar 04 18:10:20 volumio volumio[1291]: info: CoreCommandRouter::volumioGetState Mar 04 18:10:20 volumio volumio[1291]: info: CorePlayQueue::getTrack 0 Mar 04 18:10:20 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 04 18:10:20 volumio volumio-remote-updater[847]: Test mode disabled Mar 04 18:10:20 volumio volumio-remote-updater[847]: Alpha mode disabled Mar 04 18:10:20 volumio volumio-remote-updater[847]: Alpha legacy test mode disabled Mar 04 18:10:20 volumio volumio[1291]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 18:10:20 volumio volumio[1291]: info: Retrieving Cloud Streaming UI Mar 04 18:10:20 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 04 18:10:20 volumio volumio[1291]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 04 18:10:20 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 04 18:10:20 volumio volumio[1291]: info: Received Get System Version Mar 04 18:10:20 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 04 18:10:20 volumio volumio[1291]: info: Received Get System Info Mar 04 18:10:20 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 04 18:10:20 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 04 18:10:20 volumio volumio[1291]: info: Discovery: Getting this device information Mar 04 18:10:20 volumio volumio[1291]: info: CoreCommandRouter::volumioGetState Mar 04 18:10:20 volumio volumio[1291]: info: CorePlayQueue::getTrack 0 Mar 04 18:10:20 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 04 18:10:20 volumio volumio[1291]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 04 18:10:20 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 04 18:10:20 volumio volumio[1291]: info: Getting Tidal Cloud Configuration Mar 04 18:10:20 volumio volumio[1291]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 18:10:20 volumio volumio[1291]: info: Getting Qobuz Cloud Configuration Mar 04 18:10:20 volumio volumio[1291]: info: Asking plugin for UI Config Mar 04 18:10:20 volumio volumio[1291]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 18:10:20 volumio volumio[1291]: info: Getting Spotify Cloud Configuration Mar 04 18:10:20 volumio volumio[1291]: info: Asking plugin for UI Config Mar 04 18:10:20 volumio volumio[1291]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 18:10:20 volumio volumio[1291]: info: Saving Spotify Acccount Mar 04 18:10:20 volumio volumio[1291]: info: Got Tidal Cloud Configuration Mar 04 18:10:20 volumio volumio[1291]: info: Got it Mar 04 18:10:20 volumio volumio[1291]: info: Got it Mar 04 18:10:20 volumio volumio[1291]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 04 18:10:20 volumio volumio[1291]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 18:10:20 volumio volumio[1291]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Mar 04 18:10:21 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Mar 04 18:10:21 volumio volumio[1291]: info: Loading i18n strings for locale de Mar 04 18:10:21 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Mar 04 18:10:21 volumio volumio[1291]: info: Setting timezone to Europe/Berlin Mar 04 18:10:21 volumio sudo[1927]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Mar 04 18:10:21 volumio sudo[1927]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:10:21 volumio sudo[1927]: pam_unix(sudo:session): session closed for user root Mar 04 18:10:21 volumio sudo[1931]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Berlin /etc/localtime Mar 04 18:10:21 volumio sudo[1931]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:10:21 volumio sudo[1931]: pam_unix(sudo:session): session closed for user root Mar 04 18:10:21 volumio sudo[1935]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Mar 04 18:10:21 volumio sudo[1935]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:10:21 volumio sudo[1935]: pam_unix(sudo:session): session closed for user root Mar 04 18:10:21 volumio sudo[1939]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Berlin Mar 04 18:10:22 volumio sudo[1939]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:10:22 volumio sudo[1939]: pam_unix(sudo:session): session closed for user root Mar 04 18:10:22 volumio volumio[1291]: info: Fetching Streaming Services browse cache Mar 04 18:10:22 volumio volumio[1291]: Updating browse sources language Mar 04 18:10:22 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 04 18:10:22 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 04 18:10:23 volumio volumio[1291]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Mar 04 18:10:23 volumio volumio[1291]: info: CoreCommandRouter::volumioGetState Mar 04 18:10:23 volumio volumio[1291]: info: CorePlayQueue::getTrack 0 Mar 04 18:10:27 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 18:10:27 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 18:10:27 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 04 18:10:27 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 04 18:10:27 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 04 18:10:27 volumio volumio[1291]: info: CoreCommandRouter::volumioGetBrowseSources Mar 04 18:10:27 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 04 18:10:30 volumio volumio[1291]: error: MyVolumio Plugin failed to authenticate in a timely fashion Mar 04 18:10:30 volumio volumio[1291]: info: Completed starting MyVolumio Plugin Mar 04 18:10:30 volumio volumio[1291]: [Metrics] CommandRouter: 50s 451.82ms Mar 04 18:10:30 volumio volumio[1291]: info: CoreCommandRouter::volumiosetStartupVolume Mar 04 18:10:30 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 18:10:30 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 04 18:10:30 volumio volumio[1291]: info: CoreCommandRouter::Close All Modals sent Mar 04 18:10:30 volumio volumio[1291]: info: CoreCommandRouter::Close All Modals sent Mar 04 18:10:30 volumio volumio[1291]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 18:10:30 volumio volumio[1291]: info: Retrieving Cloud Streaming UI Mar 04 18:10:30 volumio volumio[1291]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 18:10:30 volumio volumio[1291]: info: Retrieving Cloud Streaming UI Mar 04 18:10:30 volumio volumio[1291]: info: Getting Tidal Cloud Configuration Mar 04 18:10:30 volumio volumio[1291]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 18:10:30 volumio volumio[1291]: info: Getting Qobuz Cloud Configuration Mar 04 18:10:30 volumio volumio[1291]: info: Asking plugin for UI Config Mar 04 18:10:30 volumio volumio[1291]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 18:10:30 volumio volumio[1291]: info: Getting Spotify Cloud Configuration Mar 04 18:10:30 volumio volumio[1291]: info: Asking plugin for UI Config Mar 04 18:10:30 volumio volumio[1291]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 18:10:30 volumio volumio[1291]: info: Saving Spotify Acccount Mar 04 18:10:30 volumio volumio[1291]: info: Got Tidal Cloud Configuration Mar 04 18:10:30 volumio volumio[1291]: info: Got it Mar 04 18:10:30 volumio volumio[1291]: info: Got it Mar 04 18:10:30 volumio volumio[1291]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 04 18:10:30 volumio volumio[1291]: info: Getting Tidal Cloud Configuration Mar 04 18:10:30 volumio volumio[1291]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 18:10:30 volumio volumio[1291]: info: Getting Qobuz Cloud Configuration Mar 04 18:10:30 volumio volumio[1291]: info: Asking plugin for UI Config Mar 04 18:10:30 volumio volumio[1291]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 18:10:30 volumio volumio[1291]: info: Getting Spotify Cloud Configuration Mar 04 18:10:30 volumio volumio[1291]: info: Asking plugin for UI Config Mar 04 18:10:30 volumio volumio[1291]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 18:10:30 volumio volumio[1291]: info: Saving Spotify Acccount Mar 04 18:10:30 volumio volumio[1291]: info: Got Tidal Cloud Configuration Mar 04 18:10:30 volumio volumio[1291]: info: Got it Mar 04 18:10:30 volumio volumio[1291]: info: Got it Mar 04 18:10:30 volumio volumio[1291]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 04 18:10:30 volumio volumio[1291]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 18:10:30 volumio volumio[1291]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Mar 04 18:10:30 volumio volumio[1291]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 18:10:30 volumio volumio[1291]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Mar 04 18:10:31 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 04 18:10:31 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 04 18:10:31 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 04 18:10:35 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Mar 04 18:10:35 volumio volumio[1291]: info: System name has changed, restarting Shairport Sync Mar 04 18:10:35 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 18:10:35 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 04 18:10:35 volumio volumio[1291]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 04 18:10:35 volumio volumio[1291]: info: Discovery: Restarting Advertising Mar 04 18:10:35 volumio volumio[1291]: info: Discovery: Stopping existing advertisement Mar 04 18:10:35 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Mar 04 18:10:35 volumio sudo[1980]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Mar 04 18:10:35 volumio sudo[1980]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:10:35 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 04 18:10:35 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 04 18:10:35 volumio volumio[1291]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 04 18:10:35 volumio sudo[1980]: pam_unix(sudo:session): session closed for user root Mar 04 18:10:35 volumio sudo[1986]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts Mar 04 18:10:35 volumio sudo[1986]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:10:35 volumio volumio[1291]: info: Starting Shairport Sync Mar 04 18:10:35 volumio sudo[1986]: pam_unix(sudo:session): session closed for user root Mar 04 18:10:35 volumio volumio[1291]: info: Permissions for /etc/hosts set Mar 04 18:10:35 volumio sudo[1989]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 04 18:10:35 volumio sudo[1989]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:10:35 volumio volumio[1291]: info: Hostname now is volumio-werkstatt Mar 04 18:10:35 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Mar 04 18:10:35 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Mar 04 18:10:35 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 04 18:10:35 volumio systemd[1]: shairport-sync.service: Consumed 1.609s CPU time. Mar 04 18:10:35 volumio sudo[1991]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/hostname volumio-werkstatt Mar 04 18:10:35 volumio sudo[1991]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:10:35 volumio-werkstatt sudo[1991]: pam_unix(sudo:session): session closed for user root Mar 04 18:10:36 volumio-werkstatt volumio[1291]: info: New hostname set Mar 04 18:10:36 volumio-werkstatt sudo[1996]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /etc/avahi/services/ Mar 04 18:10:36 volumio-werkstatt sudo[1996]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 04 18:10:36 volumio-werkstatt systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 04 18:10:36 volumio-werkstatt sudo[1989]: pam_unix(sudo:session): session closed for user root Mar 04 18:10:36 volumio-werkstatt systemd[1]: upmpdcli.service: Deactivated successfully. Mar 04 18:10:36 volumio-werkstatt systemd[1]: upmpdcli.service: Consumed 6.548s CPU time. Mar 04 18:10:36 volumio-werkstatt volumio[1291]: info: Shairport-Sync Started Mar 04 18:10:36 volumio-werkstatt sudo[1996]: pam_unix(sudo:session): session closed for user root Mar 04 18:10:36 volumio-werkstatt volumio[1291]: info: Permissions for /etc/avahi/services/volumio.service Mar 04 18:10:36 volumio-werkstatt avahi-daemon[832]: Files changed, reloading. Mar 04 18:10:36 volumio-werkstatt avahi-daemon[832]: Loading service file /services/volumio.service. Mar 04 18:10:36 volumio-werkstatt volumio[1291]: info: Avahi name changed to volumio-werkstatt Mar 04 18:10:36 volumio-werkstatt volumio[1291]: info: Discovery: A device disappeared from network Mar 04 18:10:36 volumio-werkstatt volumio[1291]: info: Discovery: Device volumio disappeared from network Mar 04 18:10:36 volumio-werkstatt volumio[1291]: info: Discovery: A device disappeared from network Mar 04 18:10:36 volumio-werkstatt avahi-daemon[832]: Service "Volumio Werkstatt" (/services/volumio.service) successfully established. Mar 04 18:10:37 volumio-werkstatt volumio[1291]: info: BOOT COMPLETED Mar 04 18:10:40 volumio-werkstatt volumio[1291]: info: Discovery: Started advertising with name: Volumio Werkstatt Mar 04 18:10:41 volumio-werkstatt volumio[1291]: compat.c: read() failed: Resource temporarily unavailable Mar 04 18:10:41 volumio-werkstatt volumio[1291]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 04 18:10:41 volumio-werkstatt volumio[1291]: Error: dns service error: unknown Mar 04 18:10:41 volumio-werkstatt volumio[1291]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Mar 04 18:10:41 volumio-werkstatt volumio[1291]: errorCode: -65537 Mar 04 18:10:41 volumio-werkstatt volumio[1291]: } Mar 04 18:10:41 volumio-werkstatt volumio[1291]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 04 18:10:44 volumio-werkstatt sudo[2042]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-04 18:09' Mar 04 18:10:44 volumio-werkstatt sudo[2042]: 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="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"