-- Logs begin at Thu 2019-02-14 20:11:58 AEST, end at Sat 2025-05-24 12:40:37 AEST. -- May 24 12:40:18 volumio systemd-timedated[1332]: Changed local time to Sat May 24 12:40:18 2025 May 24 12:40:18 volumio systemd[1]: Starting Daily apt download activities... May 24 12:40:18 volumio sudo[1330]: pam_unix(sudo:session): session closed for user root May 24 12:40:18 volumio volumio-time-update[807]: volumio-time-update-util: System time updated successfully. May 24 12:40:18 volumio systemd[1]: Started Volumio Time Update Utility. May 24 12:40:18 volumio systemd[1]: Reached target Multi-User System. May 24 12:40:18 volumio systemd[1]: Reached target Graphical Interface. May 24 12:40:18 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... May 24 12:40:18 volumio volumio[1055]: info: Discovery: A device disappeared from network May 24 12:40:18 volumio volumio[1055]: info: Discovery: Device volumio disappeared from network May 24 12:40:18 volumio volumio[1055]: info: Discovery: A device disappeared from network May 24 12:40:18 volumio sudo[1337]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 24 12:40:18 volumio sudo[1337]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:18 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. May 24 12:40:18 volumio sudo[1337]: pam_unix(sudo:session): session closed for user root May 24 12:40:18 volumio sudo[1339]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 24 12:40:18 volumio sudo[1339]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:18 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. May 24 12:40:18 volumio sudo[1339]: pam_unix(sudo:session): session closed for user root May 24 12:40:18 volumio volumio[1055]: info: Discovery: adding 4ebeba2f-c429-40d6-9330-92637be88d21 May 24 12:40:18 volumio volumio[1055]: info: Discovery: Found device Volumio May 24 12:40:18 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:18 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:18 volumio volumio[1055]: verbose: New Socket.io Connection to 192.168.1.39 from 192.168.1.6 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 May 24 12:40:18 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 24 12:40:18 volumio volumio[1055]: info: CoreCommandRouter::volumioGetVisibleSources May 24 12:40:18 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 24 12:40:18 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:18 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:18 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 24 12:40:18 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 24 12:40:18 volumio volumio[1055]: info: Received Get System Info May 24 12:40:18 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 24 12:40:18 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 24 12:40:18 volumio volumio[1055]: info: Discovery: Getting this device information May 24 12:40:18 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:18 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:18 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 24 12:40:18 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:18 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:18 volumio volumio[1055]: info: Listing playlists May 24 12:40:18 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 24 12:40:18 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 24 12:40:18 volumio volumio[1055]: info: Discovery: this is already registered, 4ebeba2f-c429-40d6-9330-92637be88d21 May 24 12:40:18 volumio volumio[1055]: info: Discovery: Found device Volumio May 24 12:40:18 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:18 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:18 volumio volumio[1055]: info: Volumio Network Manager: Network status updated: 1 May 24 12:40:18 volumio sudo[1379]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 24 12:40:18 volumio sudo[1379]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:18 volumio sudo[1379]: pam_unix(sudo:session): session closed for user root May 24 12:40:18 volumio sudo[1382]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 24 12:40:18 volumio sudo[1382]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:18 volumio sudo[1382]: pam_unix(sudo:session): session closed for user root May 24 12:40:18 volumio sudo[1385]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 24 12:40:18 volumio sudo[1385]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:18 volumio systemd[1]: Started UPnP Renderer front-end to MPD. May 24 12:40:18 volumio sudo[1385]: pam_unix(sudo:session): session closed for user root May 24 12:40:18 volumio volumio[1055]: info: Upmpdcli Daemon Started May 24 12:40:18 volumio volumio[1387]: Generating RSA private key, 4096 bit long modulus (2 primes) May 24 12:40:19 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:19 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:19 volumio systemd[1]: apt-daily.service: Succeeded. May 24 12:40:19 volumio systemd[1]: Started Daily apt download activities. May 24 12:40:19 volumio systemd[1]: Starting Daily apt upgrade and clean activities... May 24 12:40:19 volumio volumio[1055]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=3.812&uuid=bdb779c07d5551fa094de8e5d20f236c" http://updates.volumio.org/downloader-v1/track-device May 24 12:40:19 volumio volumio[1055]: % Total % Received % Xferd Average Speed Time Time Time Current May 24 12:40:19 volumio volumio[1055]: Dload Upload Total Spent Left Speed May 24 12:40:19 volumio volumio[1055]: [132B blob data] May 24 12:40:19 volumio volumio[1055]: retrying in 5 seconds, trial 0 May 24 12:40:19 volumio volumio[1055]: info: Volumio Calling Home May 24 12:40:19 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 24 12:40:20 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 24 12:40:20 volumio volumio[1055]: info: Received Get System Info May 24 12:40:20 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 24 12:40:20 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 24 12:40:20 volumio volumio[1055]: info: Discovery: Getting this device information May 24 12:40:20 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:20 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:20 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 24 12:40:20 volumio volumio[1055]: info: Volumio called home May 24 12:40:20 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. May 24 12:40:20 volumio systemd[1]: Started Daily apt upgrade and clean activities. May 24 12:40:20 volumio systemd[1]: Startup finished in 11.827s (kernel) + 19.705s (userspace) = 31.533s. May 24 12:40:20 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken May 24 12:40:21 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 24 12:40:21 volumio volumio[1055]: info: Received Get System Info May 24 12:40:21 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 24 12:40:21 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 24 12:40:21 volumio volumio[1055]: info: Discovery: Getting this device information May 24 12:40:21 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:21 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:21 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 24 12:40:21 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken May 24 12:40:21 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 24 12:40:24 volumio sudo[1431]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 24 12:40:24 volumio sudo[1431]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:24 volumio sudo[1431]: pam_unix(sudo:session): session closed for user root May 24 12:40:24 volumio sudo[1433]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 24 12:40:24 volumio sudo[1433]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:24 volumio sudo[1433]: pam_unix(sudo:session): session closed for user root May 24 12:40:24 volumio volumio[1055]: verbose: New Socket.io Connection to 192.168.1.39 from 192.168.1.6 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 May 24 12:40:24 volumio sudo[1437]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 24 12:40:24 volumio sudo[1437]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:24 volumio sudo[1437]: pam_unix(sudo:session): session closed for user root May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:24 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:24 volumio sudo[1439]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 24 12:40:24 volumio sudo[1439]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:24 volumio sudo[1439]: pam_unix(sudo:session): session closed for user root May 24 12:40:24 volumio volumio[1055]: info: Received Get System Info May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 24 12:40:24 volumio volumio[1055]: info: Discovery: Getting this device information May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:24 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:24 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::volumioGetVisibleSources May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:24 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:24 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 24 12:40:24 volumio volumio[1055]: info: Received Get System Info May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 24 12:40:24 volumio volumio[1055]: info: Discovery: Getting this device information May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:24 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:24 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:24 volumio volumio[1055]: info: Listing playlists May 24 12:40:24 volumio volumio[1055]: verbose: New Socket.io Connection to 192.168.1.39 from 192.168.1.6 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:24 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:24 volumio volumio[1055]: info: Received Get System Info May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 24 12:40:24 volumio volumio[1055]: info: Discovery: Getting this device information May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:24 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:24 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::volumioGetVisibleSources May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:24 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:24 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 24 12:40:24 volumio volumio[1055]: info: Received Get System Info May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 24 12:40:24 volumio volumio[1055]: info: Discovery: Getting this device information May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:24 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 24 12:40:24 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:24 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:24 volumio volumio[1055]: info: Listing playlists May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso May 24 12:40:26 volumio volumio[1055]: info: Adding plugin bluetooth to MyMusic Plugins May 24 12:40:26 volumio volumio[1055]: info: Adding plugin multiroom to MyMusic Plugins May 24 12:40:26 volumio volumio[1055]: info: Adding plugin metavolumio to MyMusic Plugins May 24 12:40:26 volumio volumio[1055]: info: Adding plugin cd_controller to MyMusic Plugins May 24 12:40:26 volumio volumio[1055]: info: Adding plugin qobuzconnect to MyMusic Plugins May 24 12:40:26 volumio volumio[1055]: info: Adding plugin smart_inputs to MyMusic Plugins May 24 12:40:26 volumio volumio[1055]: info: Adding plugin tidalconnect to MyMusic Plugins May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio May 24 12:40:26 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 24 12:40:26 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 24 12:40:26 volumio volumio[1055]: info: Starting MyVolumio Remote Streaming Endpoints May 24 12:40:26 volumio volumio[1055]: info: MyVolumio login type: Token May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... May 24 12:40:26 volumio volumio[1055]: info: Starting Streaming Service Transparent Proxy May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services May 24 12:40:26 volumio volumio[1055]: info: Streaming services startup May 24 12:40:26 volumio volumio[1055]: info: Starting Streaming Daemon May 24 12:40:26 volumio sudo[1449]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 24 12:40:26 volumio sudo[1449]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:26 volumio volumio[1055]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started May 24 12:40:26 volumio sudo[1449]: pam_unix(sudo:session): session closed for user root May 24 12:40:26 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 24 12:40:26 volumio volumio[1055]: info: Received Get System Info May 24 12:40:26 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 24 12:40:26 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 24 12:40:26 volumio volumio[1055]: info: Discovery: Getting this device information May 24 12:40:26 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:26 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:26 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 24 12:40:26 volumio volumio[1055]: error: Cannot start Volumio Streaming Daemon May 24 12:40:26 volumio volumio[1055]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 24 12:40:26 volumio volumio[1055]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 24 12:40:27 volumio volumio[1055]: STREAMING PROXY: Starting server on port 3245 May 24 12:40:27 volumio volumio[1055]: Node JS runtime: 14 May 24 12:40:27 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken May 24 12:40:27 volumio volumio[1055]: info: MyVolumio login type: Token May 24 12:40:28 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 24 12:40:28 volumio volumio[1055]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN May 24 12:40:28 volumio sudo[1457]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 24 12:40:28 volumio sudo[1457]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:28 volumio sudo[1457]: pam_unix(sudo:session): session closed for user root May 24 12:40:28 volumio sudo[1460]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 24 12:40:28 volumio sudo[1460]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:28 volumio sudo[1460]: pam_unix(sudo:session): session closed for user root May 24 12:40:28 volumio volumio[1055]: verbose: New Socket.io Connection to 192.168.1.39 from 192.168.1.6 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 May 24 12:40:28 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:28 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:28 volumio volumio[1055]: info: Received Get System Info May 24 12:40:28 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 24 12:40:28 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 24 12:40:28 volumio volumio[1055]: info: Discovery: Getting this device information May 24 12:40:28 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:28 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:28 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 24 12:40:28 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:28 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:28 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 24 12:40:28 volumio volumio[1055]: info: CoreCommandRouter::volumioGetVisibleSources May 24 12:40:28 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 24 12:40:28 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:28 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:28 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:28 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:28 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 24 12:40:28 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 24 12:40:28 volumio volumio[1055]: info: Received Get System Info May 24 12:40:28 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 24 12:40:28 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 24 12:40:28 volumio volumio[1055]: info: Discovery: Getting this device information May 24 12:40:28 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:28 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:28 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 24 12:40:28 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:28 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:28 volumio volumio[1055]: info: Listing playlists May 24 12:40:28 volumio volumio[1055]: info: Received Get System Info May 24 12:40:28 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 24 12:40:28 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 24 12:40:28 volumio volumio[1055]: info: Discovery: Getting this device information May 24 12:40:28 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:28 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:28 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 24 12:40:28 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:28 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:28 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 24 12:40:29 volumio volumio[1055]: info: MyVolumio token set successfully May 24 12:40:29 volumio volumio[1055]: info: MYVOLUMIO: Adding device May 24 12:40:29 volumio volumio[1055]: info: MYVOLUMIO: Evaluating Server May 24 12:40:29 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:29 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:29 volumio volumio[1055]: info: MyVolumio Plan changed: premium May 24 12:40:29 volumio volumio[1055]: info: [MyVolumio PluginManager] Subscribed plan changed to premium May 24 12:40:29 volumio volumio[1055]: info: Removing browser output: myVolumio user plan is not superstar May 24 12:40:29 volumio volumio[1055]: info: Removing audio output: May 24 12:40:29 volumio volumio[1055]: info: MYVOLUMIO: Adding device May 24 12:40:29 volumio volumio[1055]: info: MYVOLUMIO: Evaluating Server May 24 12:40:29 volumio volumio[1055]: info: Remote config written successfully May 24 12:40:29 volumio volumio[1055]: info: Starting Tunnel 1 May 24 12:40:29 volumio volumio[1055]: info: Starting Tunnel Connection Checker May 24 12:40:29 volumio volumio[1055]: info: Completed starting MyVolumio Plugin May 24 12:40:29 volumio volumio[1055]: info: MYVolumio Device enabled May 24 12:40:29 volumio volumio[1055]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... May 24 12:40:29 volumio volumio[1055]: info: MyVolumio status changed May 24 12:40:29 volumio volumio[1055]: info: Streaming services startup May 24 12:40:29 volumio volumio[1055]: info: Starting Streaming Daemon May 24 12:40:29 volumio sudo[1509]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 24 12:40:29 volumio sudo[1509]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:29 volumio volumio[1055]: info: Setting Geolocation for MyVolumio to au1 May 24 12:40:29 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 24 12:40:29 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 24 12:40:29 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 24 12:40:29 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid May 24 12:40:29 volumio volumio[1055]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... May 24 12:40:29 volumio sudo[1509]: pam_unix(sudo:session): session closed for user root May 24 12:40:29 volumio volumio[1055]: info: [1748054429912] Starting BluetoothController May 24 12:40:29 volumio volumio[1055]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... May 24 12:40:30 volumio volumio[1055]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom May 24 12:40:30 volumio sudo[1512]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom May 24 12:40:30 volumio sudo[1512]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:30 volumio sudo[1512]: pam_unix(sudo:session): session closed for user root May 24 12:40:30 volumio volumio[1055]: info: MRS: MultiRoom plugin initialized May 24 12:40:30 volumio volumio[1055]: info: MRS: STOPPING SNAPCLIENT May 24 12:40:30 volumio volumio[1055]: info: MRS: Snap server stop May 24 12:40:30 volumio sudo[1528]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient May 24 12:40:30 volumio sudo[1528]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:30 volumio volumio[1055]: info: MRS: STOPPING volumioStreaming May 24 12:40:30 volumio sudo[1531]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver May 24 12:40:30 volumio sudo[1531]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:30 volumio sudo[1528]: pam_unix(sudo:session): session closed for user root May 24 12:40:30 volumio sudo[1535]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming May 24 12:40:30 volumio sudo[1535]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:30 volumio volumio[1055]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... May 24 12:40:30 volumio sudo[1531]: pam_unix(sudo:session): session closed for user root May 24 12:40:30 volumio sudo[1536]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* May 24 12:40:30 volumio sudo[1536]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:30 volumio sudo[1536]: pam_unix(sudo:session): session closed for user root May 24 12:40:30 volumio sudo[1535]: pam_unix(sudo:session): session closed for user root May 24 12:40:30 volumio volumio[1055]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... May 24 12:40:30 volumio volumio[1055]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... May 24 12:40:30 volumio volumio[1055]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... May 24 12:40:30 volumio volumio[1055]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... May 24 12:40:30 volumio volumio[1055]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio May 24 12:40:30 volumio volumio[1055]: info: [MyVolumio PluginManager] Loading plugin "tidal"... May 24 12:40:30 volumio volumio[1055]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... May 24 12:40:30 volumio volumio[1055]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... May 24 12:40:30 volumio volumio[1055]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... May 24 12:40:30 volumio volumio[1055]: info: Preparing to generate the ALSA configuration file May 24 12:40:30 volumio volumio[1055]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf May 24 12:40:30 volumio volumio[1055]: info: Reading ALSA contributions from plugins. May 24 12:40:30 volumio volumio[1055]: info: Setting Geolocation for MyVolumio to au1 May 24 12:40:30 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 24 12:40:30 volumio volumio[1055]: info: MRS: Removed streaming files May 24 12:40:30 volumio volumio[1055]: info: MRS: volumioStreaming STOPPED May 24 12:40:30 volumio volumio[1055]: info: MRS: SNAPSERVER STOPPED May 24 12:40:30 volumio volumio[1055]: info: MRS: SNAPCLIENT STOPPED May 24 12:40:30 volumio volumio[1055]: error: Cannot start Volumio Streaming Daemon May 24 12:40:30 volumio volumio[1055]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 24 12:40:30 volumio volumio[1055]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 24 12:40:30 volumio volumio[1055]: error: Cannot write /etc/asound.conf: Error: ENOSPC: no space left on device, write May 24 12:40:30 volumio volumio[1055]: info: Output device has changed, restarting MPD May 24 12:40:30 volumio sudo[1540]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 24 12:40:30 volumio sudo[1540]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:30 volumio sudo[1540]: pam_unix(sudo:session): session closed for user root May 24 12:40:30 volumio volumio[1055]: info: Output device has changed, restarting Shairport Sync May 24 12:40:30 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:30 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 24 12:40:30 volumio sudo[1543]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 24 12:40:30 volumio sudo[1543]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:30 volumio systemd[1]: Stopping Music Player Daemon... May 24 12:40:30 volumio volumio[1055]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 24 12:40:30 volumio volumio[1055]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration May 24 12:40:30 volumio systemd[1]: mpd.service: Succeeded. May 24 12:40:30 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:30 volumio systemd[1]: Stopped Music Player Daemon. May 24 12:40:30 volumio volumio[1055]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth May 24 12:40:30 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 24 12:40:30 volumio volumio[1055]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom May 24 12:40:30 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus May 24 12:40:30 volumio volumio[1055]: info: MRS: Pushing multiroomSync output for this device May 24 12:40:30 volumio volumio[1055]: info: MRS: Pushing multiroomSync output May 24 12:40:30 volumio volumio[1055]: info: Adding audio output: May 24 12:40:30 volumio volumio[1055]: info: Adding audio output: May 24 12:40:30 volumio sudo[1552]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Volumio May 24 12:40:30 volumio sudo[1552]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:30 volumio systemd[1]: Starting Music Player Daemon... May 24 12:40:30 volumio sudo[1552]: pam_unix(sudo:session): session closed for user root May 24 12:40:30 volumio volumio[1055]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration May 24 12:40:30 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:30 volumio sudo[1549]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 24 12:40:30 volumio sudo[1549]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:30 volumio sudo[1549]: pam_unix(sudo:session): session closed for user root May 24 12:40:30 volumio volumio[1055]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio May 24 12:40:30 volumio volumio[1055]: info: Adding METAVOLUMIO REST API Endpoints May 24 12:40:30 volumio volumio[1055]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio May 24 12:40:30 volumio volumio[1055]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio May 24 12:40:30 volumio volumio[1055]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio May 24 12:40:30 volumio volumio[1055]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio May 24 12:40:30 volumio volumio[1055]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui May 24 12:40:30 volumio volumio[1055]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller May 24 12:40:30 volumio volumio[1055]: info: Preparing CD Folders May 24 12:40:30 volumio volumio[1055]: info: Adding CD REST API Endpoints May 24 12:40:30 volumio volumio[1055]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller May 24 12:40:30 volumio volumio[1055]: info: Starting UDEV Watcher for CD May 24 12:40:30 volumio volumio[1055]: info: Detecting CD presence with UDEV May 24 12:40:30 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices May 24 12:40:30 volumio volumio[1055]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs May 24 12:40:30 volumio volumio[1055]: info: Adding inputs REST Endpoints May 24 12:40:30 volumio volumio[1055]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs May 24 12:40:30 volumio volumio[1055]: info: Scanning Audio Inputs May 24 12:40:30 volumio volumio[1055]: info: Checking against Known Cards name May 24 12:40:30 volumio volumio[1055]: info: Adding Server instance for streaming May 24 12:40:30 volumio volumio[1055]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio May 24 12:40:30 volumio volumio[1055]: error: Hi Res Audio Failed Login: Missing Login Data May 24 12:40:30 volumio volumio[1055]: info: Adding HIGHRESAUDIO REST API Endpoints May 24 12:40:30 volumio volumio[1055]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio May 24 12:40:30 volumio volumio[1055]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal May 24 12:40:30 volumio volumio[1055]: info: Refreshing TIDAL token May 24 12:40:30 volumio volumio[1055]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz May 24 12:40:30 volumio volumio[1055]: info: Refreshing QOBUZ token May 24 12:40:30 volumio volumio[1055]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect May 24 12:40:30 volumio volumio[1055]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuzconnect May 24 12:40:30 volumio volumio[1055]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect May 24 12:40:30 volumio sudo[1562]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 24 12:40:30 volumio sudo[1562]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:30 volumio sudo[1562]: pam_unix(sudo:session): session closed for user root May 24 12:40:30 volumio volumio[1055]: info: QobuzConnect: Starting Qobuz Connect socket and service May 24 12:40:30 volumio volumio[1055]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections May 24 12:40:30 volumio sudo[1569]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service May 24 12:40:30 volumio sudo[1569]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:30 volumio volumio[1055]: info: Bluetooth name changed to Volumio May 24 12:40:30 volumio sudo[1569]: pam_unix(sudo:session): session closed for user root May 24 12:40:30 volumio volumio[1055]: info: MPD Permissions set May 24 12:40:30 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:30 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:30 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:30 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:30 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:30 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:30 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:30 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:30 volumio sudo[1571]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service May 24 12:40:30 volumio sudo[1571]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:30 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 24 12:40:30 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:30 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 24 12:40:30 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 24 12:40:30 volumio volumio[1055]: info: Starting Shairport Sync May 24 12:40:30 volumio systemd[1]: Started Volumio Qobuz Connect Service. May 24 12:40:30 volumio sudo[1579]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 24 12:40:30 volumio sudo[1579]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:30 volumio sudo[1571]: pam_unix(sudo:session): session closed for user root May 24 12:40:30 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 24 12:40:30 volumio systemd[1]: shairport-sync.service: Succeeded. May 24 12:40:30 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 24 12:40:30 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 24 12:40:30 volumio sudo[1579]: pam_unix(sudo:session): session closed for user root May 24 12:40:30 volumio volumio[1055]: info: Shairport-Sync Started May 24 12:40:30 volumio volumio[1055]: info: Executing endpoint qc_getconfig May 24 12:40:30 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig May 24 12:40:30 volumio qobuz-connect[1577]: 20250524 12:40:30.797 [1577.1577] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket May 24 12:40:30 volumio volumio[1055]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] May 24 12:40:30 volumio volumio[1055]: info: QobuzConnect: QOBUZ Connect daemon connected May 24 12:40:30 volumio qobuz-connect[1577]: 20250524 12:40:30.846 [1577.1577] INFO VolumeManager: [0x15343a0]: Setting new playback volume: 75 May 24 12:40:30 volumio qobuz-connect[1577]: 20250524 12:40:30.846 [1577.1577] INFO VolumeManager: [0x15343a0]: Setting new mute state: 0 May 24 12:40:30 volumio qobuz-connect[1577]: 20250524 12:40:30.846 [1577.1577] INFO QobuzConnect: [0x1534d70]: Client initialized! May 24 12:40:30 volumio qobuz-connect[1577]: 20250524 12:40:30.846 [1577.1577] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp May 24 12:40:30 volumio qobuz-connect[1577]: 20250524 12:40:30.848 [1577.1577] INFO LocalConfigManager: [0x1533c80]: Starting Local Configuration server May 24 12:40:30 volumio qobuz-connect[1577]: 20250524 12:40:30.848 [1577.1577] INFO SampleApp: Starting Local configuration server May 24 12:40:30 volumio qobuz-connect[1577]: 20250524 12:40:30.848 [1577.1577] INFO SampleApp: Connected to UNIX socket client 0x1529f60 May 24 12:40:30 volumio volumio[1055]: info: Updating MyVolumio device info May 24 12:40:30 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 24 12:40:30 volumio mpd[1558]: May 24 12:40 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 24 12:40:30 volumio systemd[1]: Started Music Player Daemon. May 24 12:40:30 volumio sudo[1543]: pam_unix(sudo:session): session closed for user root May 24 12:40:30 volumio volumio[1055]: error: updateQueue error: null May 24 12:40:30 volumio qobuz-connect[1577]: 20250524 12:40:30.948 [1577.1577] INFO SampleApp: Playback volume changed: 75 May 24 12:40:30 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:30 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:31 volumio volumio[1055]: info: Successfully Added MyVolumio device May 24 12:40:31 volumio volumio[1055]: info: Adding audio output: May 24 12:40:31 volumio volumio[1055]: info: Adding audio output: May 24 12:40:31 volumio volumio[1055]: info: Adding audio output: May 24 12:40:31 volumio volumio[1055]: info: Adding audio output: May 24 12:40:31 volumio volumio[1055]: info: Adding audio output: May 24 12:40:31 volumio volumio[1055]: info: Adding audio output: May 24 12:40:31 volumio volumio[1055]: info: Access Token successfully retrieved May 24 12:40:31 volumio volumio[1055]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 24 12:40:31 volumio volumio[1055]: info: [1748054431233] CoreMusicLibrary::Adding element QOBUZ May 24 12:40:31 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 24 12:40:31 volumio volumio[1055]: Cannot find translation for source QOBUZ May 24 12:40:31 volumio volumio[1055]: info: Stopping AccessToken refresher cron for QOBUZ May 24 12:40:31 volumio volumio[1055]: info: AccessToken refresher cron started for QOBUZ May 24 12:40:31 volumio volumio[1055]: info: Adding QOBUZ REST API Endpoints May 24 12:40:31 volumio volumio[1055]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz May 24 12:40:31 volumio volumio[1055]: info: Successfully Added MyVolumio device May 24 12:40:31 volumio volumio[1055]: info: Adding audio output: May 24 12:40:31 volumio volumio[1055]: info: Successfully Updated MyVolumio device May 24 12:40:31 volumio volumio[1055]: info: Updating MyVolumio device info May 24 12:40:31 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 24 12:40:31 volumio kernel: hwmon hwmon3: Undervoltage detected! May 24 12:40:31 volumio systemd[1]: systemd-fsckd.service: Succeeded. May 24 12:40:31 volumio volumio[1055]: info: Access Token successfully retrieved May 24 12:40:31 volumio volumio[1055]: info: Successfully Updated MyVolumio device May 24 12:40:32 volumio volumio[1055]: info: Successfully retrieved User Session From TIDAL May 24 12:40:32 volumio volumio[1055]: info: Successfully retrieved User Subscription From TIDAL May 24 12:40:32 volumio volumio[1055]: info: Adding TIDAL to Browse Sources May 24 12:40:32 volumio volumio[1055]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 24 12:40:32 volumio volumio[1055]: info: [1748054432467] CoreMusicLibrary::Adding element TIDAL May 24 12:40:32 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 24 12:40:32 volumio volumio[1055]: Cannot find translation for source QOBUZ May 24 12:40:32 volumio volumio[1055]: Cannot find translation for source TIDAL May 24 12:40:32 volumio volumio[1055]: info: Stopping AccessToken refresher cron May 24 12:40:32 volumio volumio[1055]: info: AccessToken refresher cron started May 24 12:40:32 volumio volumio[1055]: info: Adding TIDAL REST API Endpoints May 24 12:40:32 volumio volumio[1055]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal May 24 12:40:32 volumio systemd[1]: systemd-hostnamed.service: Succeeded. May 24 12:40:33 volumio kernel: hwmon hwmon3: Voltage normalised May 24 12:40:33 volumio sudo[1593]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service May 24 12:40:33 volumio sudo[1593]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:33 volumio systemd[1]: Started Volumio Bluetooth Module. May 24 12:40:33 volumio sudo[1593]: pam_unix(sudo:session): session closed for user root May 24 12:40:33 volumio volumio[1055]: info: Volumio BT Module successfully started May 24 12:40:33 volumio sudo[1596]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* May 24 12:40:33 volumio sudo[1596]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:33 volumio volumiobt[1595]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory May 24 12:40:33 volumio sudo[1596]: pam_unix(sudo:session): session closed for user root May 24 12:40:33 volumio volumio[1055]: info: TidalConnect service stoped! May 24 12:40:33 volumio volumio[1055]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect May 24 12:40:33 volumio volumio[1055]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect May 24 12:40:33 volumio volumio[1387]: ........................................................................................................................................................................................................................................................................................................................++++ May 24 12:40:33 volumio sudo[1608]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service May 24 12:40:33 volumio sudo[1608]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:33 volumio systemd[1]: Started Volumio Tidal Connect Service. May 24 12:40:33 volumio sudo[1608]: pam_unix(sudo:session): session closed for user root May 24 12:40:33 volumio volumio[1055]: info: Executing endpoint tc_getconfig May 24 12:40:33 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig May 24 12:40:33 volumio vtcs[1610]: STARTING TidalConnect services, version: 1.4.0.34 May 24 12:40:33 volumio vtcs[1610]: STARTED TidalConnect services. May 24 12:40:33 volumio volumio[1055]: info: Executing endpoint tc_connect May 24 12:40:33 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect May 24 12:40:33 volumio volumio[1055]: info: Connecting to TidalConnect May 24 12:40:33 volumio volumio[1055]: info: CoreCommandRouter::servicePushState May 24 12:40:33 volumio volumio[1055]: info: CoreStateMachine::pushState May 24 12:40:33 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:33 volumio volumio[1055]: info: CoreCommandRouter::volumioPushState May 24 12:40:33 volumio volumio[1055]: info: MRS: Pushing multiroomSync output update for this device May 24 12:40:33 volumio volumio[1055]: info: MRS: Pushing multiroomSync output May 24 12:40:33 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:33 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:33 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:33 volumio volumio[1055]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} May 24 12:40:33 volumio volumio[1055]: verbose: CURRENT POSITION 0 May 24 12:40:33 volumio volumio[1055]: info: CoreStateMachine::syncState stateService stop May 24 12:40:33 volumio volumio[1055]: info: CoreStateMachine::syncState currentStatus stop May 24 12:40:33 volumio volumio[1055]: info: CoreStateMachine::pushState May 24 12:40:33 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:33 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 24 12:40:33 volumio volumio[1055]: info: CoreCommandRouter::volumioPushState May 24 12:40:33 volumio volumio[1055]: info: MRS: Pushing multiroomSync output update for this device May 24 12:40:33 volumio volumio[1055]: info: MRS: Pushing multiroomSync output May 24 12:40:33 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:33 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:33 volumio volumio[1055]: info: No code May 24 12:40:33 volumio volumio[1055]: info: CoreStateMachine::pushState May 24 12:40:33 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:33 volumio volumio[1055]: info: CoreCommandRouter::volumioPushState May 24 12:40:33 volumio volumio[1055]: info: MRS: Pushing multiroomSync output update for this device May 24 12:40:33 volumio volumio[1055]: info: MRS: Pushing multiroomSync output May 24 12:40:33 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:33 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:33 volumio volumio[1055]: info: CoreCommandRouter::servicePushState May 24 12:40:33 volumio volumio[1055]: info: CoreStateMachine::pushState May 24 12:40:33 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:33 volumio volumio[1055]: info: CoreCommandRouter::volumioPushState May 24 12:40:33 volumio volumio[1055]: info: MRS: Pushing multiroomSync output update for this device May 24 12:40:33 volumio volumio[1055]: info: MRS: Pushing multiroomSync output May 24 12:40:33 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:33 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:33 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:33 volumio volumio[1055]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} May 24 12:40:33 volumio volumio[1055]: verbose: CURRENT POSITION 0 May 24 12:40:33 volumio volumio[1055]: info: CoreStateMachine::syncState stateService stop May 24 12:40:33 volumio volumio[1055]: info: CoreStateMachine::syncState currentStatus stop May 24 12:40:33 volumio volumio[1055]: info: CoreStateMachine::pushState May 24 12:40:33 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:33 volumio volumio[1055]: info: CoreCommandRouter::volumioPushState May 24 12:40:33 volumio volumio[1055]: info: MRS: Pushing multiroomSync output update for this device May 24 12:40:33 volumio volumio[1055]: info: MRS: Pushing multiroomSync output May 24 12:40:33 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:33 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:33 volumio volumio[1055]: info: No code May 24 12:40:33 volumio volumio[1055]: info: CoreStateMachine::pushState May 24 12:40:33 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:33 volumio volumio[1055]: info: CoreCommandRouter::volumioPushState May 24 12:40:33 volumio volumio[1055]: info: MRS: Pushing multiroomSync output update for this device May 24 12:40:33 volumio volumio[1055]: info: MRS: Pushing multiroomSync output May 24 12:40:33 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:33 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:34 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 24 12:40:34 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 24 12:40:34 volumio volumio[1055]: info: Enabling plugin fusiondsp May 24 12:40:34 volumio volumio[1055]: info: Loading plugin "fusiondsp"... May 24 12:40:34 volumio sudo[1633]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio May 24 12:40:34 volumio sudo[1633]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:34 volumio volumiobt[1595]: pulseaudio: no process found May 24 12:40:34 volumio sudo[1633]: pam_unix(sudo:session): session closed for user root May 24 12:40:34 volumio dbus-daemon[808]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.25' (uid=1000 pid=1637 comm="/usr/bin/pulseaudio --high-priority=true ") May 24 12:40:34 volumio systemd[1]: Starting RealtimeKit Scheduling Policy Service... May 24 12:40:34 volumio volumio[1055]: error: Could not copy default configuration to /data/configuration/audio_interface/fusiondsp/config.json May 24 12:40:34 volumio dbus-daemon[808]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' May 24 12:40:34 volumio systemd[1]: Started RealtimeKit Scheduling Policy Service. May 24 12:40:34 volumio rtkit-daemon[1638]: Successfully called chroot. May 24 12:40:34 volumio rtkit-daemon[1638]: Successfully dropped privileges. May 24 12:40:34 volumio rtkit-daemon[1638]: Successfully limited resources. May 24 12:40:34 volumio rtkit-daemon[1638]: Running. May 24 12:40:34 volumio rtkit-daemon[1638]: Watchdog thread running. May 24 12:40:34 volumio rtkit-daemon[1638]: Canary thread running. May 24 12:40:34 volumio dbus-daemon[808]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.26' (uid=0 pid=1638 comm="/usr/lib/rtkit/rtkit-daemon ") May 24 12:40:34 volumio systemd[1]: Starting Authorization Manager... May 24 12:40:34 volumio polkitd[1641]: started daemon version 0.105 using authority implementation `local' version `0.105' May 24 12:40:34 volumio dbus-daemon[808]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' May 24 12:40:34 volumio systemd[1]: Started Authorization Manager. May 24 12:40:34 volumio volumio[1055]: info: Preparing to generate the ALSA configuration file May 24 12:40:34 volumio volumio[1055]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf May 24 12:40:34 volumio volumio[1055]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf May 24 12:40:34 volumio volumio[1055]: info: Reading ALSA contributions from plugins. May 24 12:40:34 volumio volumio[1055]: ------------------------------------ BT MESSAGE: BT STATUS: running May 24 12:40:34 volumio volumio[1055]: ------------------------------------ BT MESSAGE: BT STATUS: running May 24 12:40:34 volumio sudo[1646]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service May 24 12:40:34 volumio sudo[1646]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:34 volumio volumio[1055]: error: Cannot write /etc/asound.conf: Error: ENOSPC: no space left on device, write May 24 12:40:34 volumio volumio[1055]: info: Output device has changed, restarting MPD May 24 12:40:34 volumio sudo[1650]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 24 12:40:34 volumio sudo[1650]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:34 volumio systemd[1]: Started MyVolumio SSH Tunnel. May 24 12:40:34 volumio volumio[1055]: info: Output device has changed, restarting Shairport Sync May 24 12:40:34 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:34 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 24 12:40:34 volumio sudo[1650]: pam_unix(sudo:session): session closed for user root May 24 12:40:34 volumio sudo[1653]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 24 12:40:34 volumio sudo[1653]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:34 volumio sudo[1646]: pam_unix(sudo:session): session closed for user root May 24 12:40:34 volumio systemd[1]: Stopping Music Player Daemon... May 24 12:40:34 volumio volumio[1055]: xcb_connection_has_error() returned true May 24 12:40:34 volumio volumio[1055]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 24 12:40:34 volumio volumio[1055]: xcb_connection_has_error() returned true May 24 12:40:34 volumio volumio[1055]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration May 24 12:40:34 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:34 volumio systemd[1]: mpd.service: Succeeded. May 24 12:40:34 volumio systemd[1]: Stopped Music Player Daemon. May 24 12:40:34 volumio systemd[1]: Starting Music Player Daemon... May 24 12:40:34 volumio volumio[1055]: info: QobuzConnect: setDeactiveState invoked May 24 12:40:34 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:34 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:34 volumio autossh[1658]: port set to 0, monitoring disabled May 24 12:40:34 volumio autossh[1658]: starting ssh (count 1) May 24 12:40:34 volumio autossh[1658]: ssh child pid is 1664 May 24 12:40:34 volumio vtcs[1610]: [2025-05-24 12:40:34.817] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected May 24 12:40:34 volumio vtcs[1610]: [2025-05-24 12:40:34.820] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE May 24 12:40:34 volumio volumio[1055]: info: PLUGIN START: fusiondsp May 24 12:40:34 volumio volumio[1055]: info: Loading i18n strings for locale en May 24 12:40:34 volumio sudo[1661]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 24 12:40:34 volumio sudo[1666]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 24 12:40:34 volumio sudo[1661]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:34 volumio sudo[1666]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:34 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile May 24 12:40:34 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:34 volumio volumio[1055]: info: FusionDsp - mixtype--------------------- Hardware May 24 12:40:34 volumio volumio[1055]: info: Preparing to generate the ALSA configuration file May 24 12:40:34 volumio sudo[1661]: pam_unix(sudo:session): session closed for user root May 24 12:40:34 volumio volumio[1055]: info: Done. May 24 12:40:34 volumio sudo[1672]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 24 12:40:34 volumio sudo[1672]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:34 volumio systemd[1]: Stopping Volumio Tidal Connect Service... May 24 12:40:34 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM May 24 12:40:34 volumio pulseaudio[1637]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 May 24 12:40:34 volumio pulseaudio[1637]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 May 24 12:40:34 volumio bluetoothd[953]: Endpoint registered: sender=:1.46 path=/MediaEndpoint/A2DPSource May 24 12:40:34 volumio bluetoothd[953]: Endpoint registered: sender=:1.46 path=/MediaEndpoint/A2DPSink May 24 12:40:34 volumio volumiobt[1595]: Applying permissions May 24 12:40:34 volumio volumiobt[1595]: Setting BT discoverable and pairable May 24 12:40:34 volumio systemd[1]: vtcs.service: Succeeded. May 24 12:40:34 volumio systemd[1]: Stopped Volumio Tidal Connect Service. May 24 12:40:34 volumio pulseaudio[1637]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files May 24 12:40:34 volumio sudo[1672]: pam_unix(sudo:session): session closed for user root May 24 12:40:34 volumio kernel: Bluetooth: RFCOMM TTY layer initialized May 24 12:40:34 volumio kernel: Bluetooth: RFCOMM socket layer initialized May 24 12:40:34 volumio kernel: Bluetooth: RFCOMM ver 1.11 May 24 12:40:34 volumio volumio[1055]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf May 24 12:40:34 volumio volumio[1055]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf May 24 12:40:34 volumio volumio[1055]: info: Reading ALSA contributions from plugins. May 24 12:40:34 volumio sudo[1666]: pam_unix(sudo:session): session closed for user root May 24 12:40:34 volumio sudo[1682]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service May 24 12:40:34 volumio sudo[1682]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:34 volumio volumiobt[1595]: [CHG] Controller 2C:CF:67:01:9D:F3 UUIDs: 00001112-0000-1000-8000-00805f9b34fb May 24 12:40:34 volumio volumiobt[1595]: [117B blob data] May 24 12:40:34 volumio volumiobt[1595]: [117B blob data] May 24 12:40:34 volumio volumiobt[1595]: [117B blob data] May 24 12:40:34 volumio volumiobt[1595]: [117B blob data] May 24 12:40:34 volumio volumiobt[1595]: [117B blob data] May 24 12:40:34 volumio volumiobt[1595]: [117B blob data] May 24 12:40:34 volumio volumiobt[1595]: [117B blob data] May 24 12:40:34 volumio volumiobt[1595]: [117B blob data] May 24 12:40:34 volumio volumiobt[1595]: [55B blob data] May 24 12:40:34 volumio volumiobt[1595]: [117B blob data] May 24 12:40:34 volumio volumiobt[1595]: [117B blob data] May 24 12:40:34 volumio volumiobt[1595]: [117B blob data] May 24 12:40:34 volumio volumiobt[1595]: [117B blob data] May 24 12:40:34 volumio volumiobt[1595]: [117B blob data] May 24 12:40:34 volumio volumiobt[1595]: [117B blob data] May 24 12:40:34 volumio volumiobt[1595]: [117B blob data] May 24 12:40:34 volumio volumiobt[1595]: [117B blob data] May 24 12:40:34 volumio volumiobt[1595]: [117B blob data] May 24 12:40:34 volumio volumiobt[1595]: [bluetooth]# -e power on May 24 12:40:34 volumio volumiobt[1595]: Invalid command in menu main: -e May 24 12:40:34 volumio volumiobt[1595]: May 24 12:40:34 volumio volumiobt[1595]: Use "help" for a list of available commands in a menu. May 24 12:40:34 volumio volumiobt[1595]: Use "menu " if you want to enter any submenu. May 24 12:40:34 volumio volumiobt[1595]: Use "back" if you want to return to menu main. May 24 12:40:34 volumio volumiobt[1595]: [bluetooth]# agent on May 24 12:40:34 volumio volumiobt[1595]: Agent is already registered May 24 12:40:34 volumio volumiobt[1595]: [bluetooth]# discoverable on May 24 12:40:34 volumio volumiobt[1595]: [bluetooth]# pairable on May 24 12:40:34 volumio volumiobt[1595]: [bluetooth]# agent NoInputNoOutput May 24 12:40:34 volumio volumiobt[1595]: Agent is already registered May 24 12:40:34 volumio volumiobt[1595]: [bluetooth]# default-agent May 24 12:40:34 volumio volumiobt[1595]: [bluetooth]# quit May 24 12:40:34 volumio volumiobt[1595]: [59B blob data] May 24 12:40:34 volumio sudo[1682]: pam_unix(sudo:session): session closed for user root May 24 12:40:34 volumio volumio[1055]: ------------------------------------ BT MESSAGE: BT STATUS: running May 24 12:40:34 volumio volumio[1055]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 24 12:40:34 volumio volumio[1055]: ------------------------------------ BT MESSAGE: BT STATUS: running May 24 12:40:34 volumio volumio[1055]: ------------------------------------ BT MESSAGE: BT STATUS: running May 24 12:40:34 volumio volumio[1055]: info: CoreCommandRouter::getUIConfigOnPlugin May 24 12:40:34 volumio sudo[1687]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service May 24 12:40:34 volumio sudo[1687]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:34 volumio volumio[1055]: info: CoreCommandRouter::getUIConfigOnPlugin May 24 12:40:34 volumio volumio[1055]: info: CoreCommandRouter::getUIConfigOnPlugin May 24 12:40:34 volumio volumio[1055]: info: MPD Permissions set May 24 12:40:34 volumio volumio[1055]: info: Remote SSH Started May 24 12:40:34 volumio systemd[1]: Stopping Volumio Qobuz Connect Service... May 24 12:40:34 volumio qobuz-connect[1577]: 20250524 12:40:34.985 [1577.1577] INFO SampleApp: Stopping Local configuration server May 24 12:40:34 volumio qobuz-connect[1577]: 20250524 12:40:34.995 [1577.1577] INFO SampleApp: shat down connection on UNIX socket May 24 12:40:34 volumio systemd[1]: qobuz-connect.service: Succeeded. May 24 12:40:34 volumio systemd[1]: Stopped Volumio Qobuz Connect Service. May 24 12:40:35 volumio systemd[1]: Started Volumio Qobuz Connect Service. May 24 12:40:35 volumio volumiossh-tunnel[1649]: Warning: Permanently added '[au1.myvolumio.org]:2222,[170.64.163.26]:2222' (RSA) to the list of known hosts. May 24 12:40:35 volumio sudo[1687]: pam_unix(sudo:session): session closed for user root May 24 12:40:35 volumio volumio[1055]: ------------------------------------ BT MESSAGE: BT STATUS: running May 24 12:40:35 volumio volumio[1055]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 24 12:40:35 volumio volumio[1055]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected May 24 12:40:35 volumio volumio[1055]: info: QobuzConnect: setDeactiveState invoked May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:35 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:35 volumio volumio[1055]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 May 24 12:40:35 volumio volumio[1055]: info: Executing endpoint qc_getconfig May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig May 24 12:40:35 volumio qobuz-connect[1689]: 20250524 12:40:35.056 [1689.1689] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket May 24 12:40:35 volumio qobuz-connect[1689]: 20250524 12:40:35.057 [1689.1689] INFO VolumeManager: [0x11d83a0]: Setting new playback volume: 75 May 24 12:40:35 volumio qobuz-connect[1689]: 20250524 12:40:35.057 [1689.1689] INFO VolumeManager: [0x11d83a0]: Setting new mute state: 0 May 24 12:40:35 volumio qobuz-connect[1689]: 20250524 12:40:35.057 [1689.1689] INFO QobuzConnect: [0x11d8d70]: Client initialized! May 24 12:40:35 volumio qobuz-connect[1689]: 20250524 12:40:35.057 [1689.1689] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp May 24 12:40:35 volumio qobuz-connect[1689]: 20250524 12:40:35.063 [1689.1689] INFO LocalConfigManager: [0x11d7c80]: Starting Local Configuration server May 24 12:40:35 volumio qobuz-connect[1689]: 20250524 12:40:35.063 [1689.1689] INFO SampleApp: Starting Local configuration server May 24 12:40:35 volumio qobuz-connect[1689]: 20250524 12:40:35.063 [1689.1689] INFO SampleApp: Connected to UNIX socket client 0x11cdf60 May 24 12:40:35 volumio volumio[1055]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] May 24 12:40:35 volumio volumio[1055]: info: QobuzConnect: QOBUZ Connect daemon connected May 24 12:40:35 volumio volumio[1055]: info: FusionDsp - May 24 12:40:35 volumio volumio[1055]: info: FusionDsp - Error: TypeError: Cannot read property 'split' of undefined May 24 12:40:35 volumio volumio[1055]: info: FusionDsp - May 24 12:40:35 volumio qobuz-connect[1689]: 20250524 12:40:35.206 [1689.1689] INFO SampleApp: Playback volume changed: 75 May 24 12:40:35 volumio mpd[1670]: May 24 12:40 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 24 12:40:35 volumio systemd[1]: Started Music Player Daemon. May 24 12:40:35 volumio volumio[1055]: info: FusionDsp - Error: TypeError: Cannot read property 'split' of undefined May 24 12:40:35 volumio sudo[1653]: pam_unix(sudo:session): session closed for user root May 24 12:40:35 volumio volumio[1055]: info: FusionDsp - May 24 12:40:35 volumio volumio[1055]: info: FusionDsp - Error: TypeError: Cannot read property 'split' of undefined May 24 12:40:35 volumio volumio[1055]: info: FusionDsp - undefined May 24 12:40:35 volumio volumio[1055]: info: FusionDsp - undefined May 24 12:40:35 volumio volumio[1055]: info: FusionDsp - undefined May 24 12:40:35 volumio volumio[1055]: info: Starting Shairport Sync May 24 12:40:35 volumio sudo[1699]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:35 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:35 volumio sudo[1699]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:35 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 24 12:40:35 volumio systemd[1]: shairport-sync.service: Succeeded. May 24 12:40:35 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:35 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:35 volumio volumio[1055]: ------------------------------------ BT MESSAGE: BT STATUS: running May 24 12:40:35 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 24 12:40:35 volumio sudo[1699]: pam_unix(sudo:session): session closed for user root May 24 12:40:35 volumio volumio[1055]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 24 12:40:35 volumio volumio[1055]: error: updateQueue error: null May 24 12:40:35 volumio volumio[1055]: info: Shairport-Sync Started May 24 12:40:35 volumio volumio[1055]: error: Cannot write /etc/asound.conf: Error: ENOSPC: no space left on device, write May 24 12:40:35 volumio volumio[1055]: info: Output device has changed, restarting MPD May 24 12:40:35 volumio sudo[1705]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 24 12:40:35 volumio volumio[1055]: info: Output device has changed, restarting Shairport Sync May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 24 12:40:35 volumio sudo[1705]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:35 volumio sudo[1705]: pam_unix(sudo:session): session closed for user root May 24 12:40:35 volumio sudo[1707]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 24 12:40:35 volumio sudo[1707]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:35 volumio systemd[1]: Stopping Music Player Daemon... May 24 12:40:35 volumio systemd[1]: mpd.service: Succeeded. May 24 12:40:35 volumio volumio[1055]: xcb_connection_has_error() returned true May 24 12:40:35 volumio volumio[1055]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 24 12:40:35 volumio volumio[1055]: xcb_connection_has_error() returned true May 24 12:40:35 volumio volumio[1055]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration May 24 12:40:35 volumio systemd[1]: Stopped Music Player Daemon. May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:35 volumio volumio[1055]: info: QobuzConnect: setDeactiveState invoked May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:35 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:35 volumio sudo[1717]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 24 12:40:35 volumio sudo[1717]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:35 volumio systemd[1]: Starting Music Player Daemon... May 24 12:40:35 volumio sudo[1720]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 24 12:40:35 volumio sudo[1720]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:35 volumio sudo[1717]: pam_unix(sudo:session): session closed for user root May 24 12:40:35 volumio sudo[1720]: pam_unix(sudo:session): session closed for user root May 24 12:40:35 volumio sudo[1713]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 24 12:40:35 volumio volumio[1055]: ------------------------------------ BT MESSAGE: BT STATUS: running May 24 12:40:35 volumio volumio[1055]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 24 12:40:35 volumio sudo[1713]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:35 volumio sudo[1728]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service May 24 12:40:35 volumio sudo[1728]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:35 volumio volumio[1055]: ------------------------------------ BT MESSAGE: BT STATUS: running May 24 12:40:35 volumio sudo[1713]: pam_unix(sudo:session): session closed for user root May 24 12:40:35 volumio volumio[1055]: info: MPD Permissions set May 24 12:40:35 volumio sudo[1728]: pam_unix(sudo:session): session closed for user root May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:35 volumio sudo[1732]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service May 24 12:40:35 volumio sudo[1732]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:35 volumio systemd[1]: Stopping Volumio Qobuz Connect Service... May 24 12:40:35 volumio qobuz-connect[1689]: 20250524 12:40:35.525 [1689.1689] INFO SampleApp: Stopping Local configuration server May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:35 volumio volumio[1055]: ------------------------------------ BT MESSAGE: BT STATUS: running May 24 12:40:35 volumio volumio[1055]: info: Starting Shairport Sync May 24 12:40:35 volumio qobuz-connect[1689]: 20250524 12:40:35.535 [1689.1689] INFO SampleApp: shat down connection on UNIX socket May 24 12:40:35 volumio systemd[1]: qobuz-connect.service: Succeeded. May 24 12:40:35 volumio systemd[1]: Stopped Volumio Qobuz Connect Service. May 24 12:40:35 volumio volumio[1055]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected May 24 12:40:35 volumio volumio[1055]: info: QobuzConnect: setDeactiveState invoked May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:35 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:35 volumio sudo[1739]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 24 12:40:35 volumio sudo[1739]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:35 volumio systemd[1]: Started Volumio Qobuz Connect Service. May 24 12:40:35 volumio volumio[1055]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 24 12:40:35 volumio sudo[1732]: pam_unix(sudo:session): session closed for user root May 24 12:40:35 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 24 12:40:35 volumio volumio[1055]: ------------------------------------ BT MESSAGE: BT STATUS: running May 24 12:40:35 volumio systemd[1]: shairport-sync.service: Succeeded. May 24 12:40:35 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 24 12:40:35 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 24 12:40:35 volumio sudo[1739]: pam_unix(sudo:session): session closed for user root May 24 12:40:35 volumio volumio[1055]: info: Executing endpoint qc_getconfig May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig May 24 12:40:35 volumio kernel: hwmon hwmon3: Undervoltage detected! May 24 12:40:35 volumio volumio[1055]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 24 12:40:35 volumio qobuz-connect[1740]: 20250524 12:40:35.566 [1740.1740] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket May 24 12:40:35 volumio qobuz-connect[1740]: 20250524 12:40:35.568 [1740.1740] INFO VolumeManager: [0x206b3a0]: Setting new playback volume: 75 May 24 12:40:35 volumio qobuz-connect[1740]: 20250524 12:40:35.568 [1740.1740] INFO VolumeManager: [0x206b3a0]: Setting new mute state: 0 May 24 12:40:35 volumio qobuz-connect[1740]: 20250524 12:40:35.568 [1740.1740] INFO QobuzConnect: [0x206bd70]: Client initialized! May 24 12:40:35 volumio qobuz-connect[1740]: 20250524 12:40:35.568 [1740.1740] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp May 24 12:40:35 volumio volumio[1055]: info: Shairport-Sync Started May 24 12:40:35 volumio volumio[1055]: info: MRS: Getting audio outputs on start May 24 12:40:35 volumio qobuz-connect[1740]: 20250524 12:40:35.572 [1740.1740] INFO LocalConfigManager: [0x206ac80]: Starting Local Configuration server May 24 12:40:35 volumio qobuz-connect[1740]: 20250524 12:40:35.573 [1740.1740] INFO SampleApp: Starting Local configuration server May 24 12:40:35 volumio qobuz-connect[1740]: 20250524 12:40:35.573 [1740.1740] INFO SampleApp: Connected to UNIX socket client 0x2060f60 May 24 12:40:35 volumio volumio[1055]: info: MRS: Requesting all other devices output May 24 12:40:35 volumio volumio[1055]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] May 24 12:40:35 volumio volumio[1055]: info: QobuzConnect: QOBUZ Connect daemon connected May 24 12:40:35 volumio qobuz-connect[1740]: 20250524 12:40:35.716 [1740.1740] INFO SampleApp: Playback volume changed: 75 May 24 12:40:35 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState May 24 12:40:35 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 May 24 12:40:35 volumio mpd[1731]: May 24 12:40 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 24 12:40:35 volumio systemd[1]: Started Music Player Daemon. May 24 12:40:35 volumio sudo[1707]: pam_unix(sudo:session): session closed for user root May 24 12:40:35 volumio volumio[1055]: error: updateQueue error: null May 24 12:40:35 volumio volumio[1055]: Configuration write error: Error: ENOENT: no such file or directory, open '/data/configuration/audio_interface/fusiondsp/config.json' May 24 12:40:36 volumio volumio[1055]: info: TidalConnect service started! May 24 12:40:36 volumio volumio[1055]: [Metrics] CommandRouter: 29s 243.36ms May 24 12:40:36 volumio volumio[1055]: info: CoreCommandRouter::volumiosetStartupVolume May 24 12:40:36 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:36 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 24 12:40:36 volumio volumio[1055]: info: CoreCommandRouter::Close All Modals sent May 24 12:40:36 volumio volumio[1055]: info: CoreCommandRouter::Close All Modals sent May 24 12:40:36 volumio volumio[1055]: info: camilladsp service started and running in background, instance 1 May 24 12:40:36 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 24 12:40:36 volumio volumio[1055]: /bin/sh: 1: cannot create /data/configuration/audio_interface/fusiondsp/hwinfo.json: Directory nonexistent May 24 12:40:36 volumio volumio[1055]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json May 24 12:40:36 volumio volumio[1055]: /bin/sh: 1: cannot create /data/configuration/audio_interface/fusiondsp/hwinfo.json: Directory nonexistent May 24 12:40:36 volumio volumio[1055]: info: FusionDsp loaded May 24 12:40:36 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 24 12:40:36 volumio sudo[1760]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service May 24 12:40:36 volumio sudo[1760]: pam_unix(sudo:session): session opened for user root by (uid=0) May 24 12:40:36 volumio volumio[1055]: info: FusionDsp - Reporting Fusion DSP Enabled May 24 12:40:36 volumio volumio[1055]: info: Adding Signal Path Element [object Object] May 24 12:40:36 volumio volumio[1055]: info: Adding fusiondspeq DSP Signal Path Element May 24 12:40:36 volumio volumio[1055]: info: FusionDsp - ---- installed callbackRead May 24 12:40:36 volumio volumio[1055]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 24 12:40:36 volumio sudo[1760]: pam_unix(sudo:session): session closed for user root May 24 12:40:36 volumio volumio[1055]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp EACCES May 24 12:40:36 volumio volumio[1055]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) May 24 12:40:36 volumio volumio[1055]: at onErrorNT (internal/child_process.js:465:16) May 24 12:40:36 volumio volumio[1055]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { May 24 12:40:36 volumio volumio[1055]: errno: -13, May 24 12:40:36 volumio volumio[1055]: code: 'EACCES', May 24 12:40:36 volumio volumio[1055]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', May 24 12:40:36 volumio volumio[1055]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', May 24 12:40:36 volumio volumio[1055]: spawnargs: [ May 24 12:40:36 volumio volumio[1055]: '-p', May 24 12:40:36 volumio volumio[1055]: 9876, May 24 12:40:36 volumio volumio[1055]: '-o', May 24 12:40:36 volumio volumio[1055]: '/tmp/camilladsp.log', May 24 12:40:36 volumio volumio[1055]: '-l', May 24 12:40:36 volumio volumio[1055]: 'warn', May 24 12:40:36 volumio volumio[1055]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' May 24 12:40:36 volumio volumio[1055]: ] May 24 12:40:36 volumio volumio[1055]: } May 24 12:40:36 volumio volumio[1055]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 24 12:40:37 volumio sudo[1771]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-24 12:39 May 24 12:40:37 volumio sudo[1771]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"