-- Logs begin at Wed 2025-03-05 10:12:46 UTC, end at Wed 2025-03-05 15:20:11 UTC. -- Mar 05 15:19:26 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Mar 05 15:19:26 volumio volumio[867]: info: MyVolumio login type: Token Mar 05 15:19:27 volumio volumio[867]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Mar 05 15:19:27 volumio volumio[867]: info: MyVolumio token set successfully Mar 05 15:19:27 volumio volumio[867]: info: MYVOLUMIO: Adding device Mar 05 15:19:27 volumio volumio[867]: info: MYVOLUMIO: Evaluating Server Mar 05 15:19:27 volumio volumio[867]: info: MyVolumio Plan changed: premium Mar 05 15:19:27 volumio volumio[867]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Mar 05 15:19:27 volumio volumio[867]: info: Removing browser output: myVolumio user plan is not superstar Mar 05 15:19:27 volumio volumio[867]: info: Removing audio output: Mar 05 15:19:27 volumio volumio[867]: info: MYVOLUMIO: Adding device Mar 05 15:19:27 volumio volumio[867]: info: MYVOLUMIO: Evaluating Server Mar 05 15:19:27 volumio volumio[867]: info: Remote config written successfully Mar 05 15:19:27 volumio volumio[867]: info: Starting Tunnel 1 Mar 05 15:19:27 volumio volumio[867]: info: Starting Tunnel Connection Checker Mar 05 15:19:27 volumio volumio[867]: info: MYVolumio Device disabled Mar 05 15:19:27 volumio volumio[867]: info: MyVolumio status changed Mar 05 15:19:27 volumio volumio[867]: info: Streaming services startup Mar 05 15:19:27 volumio volumio[867]: info: Starting Streaming Daemon Mar 05 15:19:27 volumio sudo[4300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 05 15:19:27 volumio sudo[4300]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 15:19:27 volumio sudo[4300]: pam_unix(sudo:session): session closed for user root Mar 05 15:19:27 volumio volumio[867]: error: Cannot start Volumio Streaming Daemon Mar 05 15:19:27 volumio volumio[867]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 05 15:19:27 volumio volumio[867]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 05 15:19:27 volumio volumio[867]: info: Setting Geolocation for MyVolumio to us3 Mar 05 15:19:27 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 15:19:27 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 15:19:27 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 15:19:27 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 15:19:27 volumio volumio[867]: info: Setting Geolocation for MyVolumio to us3 Mar 05 15:19:27 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 15:19:27 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 15:19:28 volumio volumio[867]: info: MYVolumio Device enabled Mar 05 15:19:28 volumio volumio[867]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Mar 05 15:19:28 volumio volumio[867]: info: MyVolumio status changed Mar 05 15:19:28 volumio volumio[867]: info: Streaming services startup Mar 05 15:19:28 volumio volumio[867]: info: Starting Streaming Daemon Mar 05 15:19:28 volumio volumio[867]: error: [MyVolumio PluginManager] Could not read cache file: ENOENT: no such file or directory, open '/data/myvolumio/cache.data' Mar 05 15:19:28 volumio sudo[4303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 05 15:19:28 volumio sudo[4303]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 15:19:28 volumio volumio[867]: info: Successfully Added MyVolumio device Mar 05 15:19:28 volumio sudo[4303]: pam_unix(sudo:session): session closed for user root Mar 05 15:19:28 volumio volumio[867]: error: Cannot start Volumio Streaming Daemon Mar 05 15:19:28 volumio volumio[867]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 05 15:19:28 volumio volumio[867]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 05 15:19:28 volumio volumio[867]: info: Successfully Added MyVolumio device Mar 05 15:19:28 volumio volumio[867]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Mar 05 15:19:28 volumio volumio[867]: info: [1741187968748] Starting BluetoothController Mar 05 15:19:28 volumio volumio[867]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Mar 05 15:19:29 volumio sudo[4306]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Mar 05 15:19:29 volumio sudo[4306]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 15:19:29 volumio sudo[4306]: pam_unix(sudo:session): session closed for user root Mar 05 15:19:29 volumio volumio[867]: info: MRS: MultiRoom plugin initialized Mar 05 15:19:29 volumio volumio[867]: info: MRS: STOPPING SNAPCLIENT Mar 05 15:19:29 volumio volumio[867]: info: MRS: Snap server stop Mar 05 15:19:29 volumio sudo[4322]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Mar 05 15:19:29 volumio sudo[4322]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 15:19:29 volumio volumio[867]: info: MRS: STOPPING volumioStreaming Mar 05 15:19:29 volumio sudo[4325]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Mar 05 15:19:29 volumio sudo[4325]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 15:19:29 volumio sudo[4322]: pam_unix(sudo:session): session closed for user root Mar 05 15:19:29 volumio sudo[4328]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Mar 05 15:19:29 volumio sudo[4328]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 15:19:29 volumio volumio[867]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Mar 05 15:19:29 volumio sudo[4325]: pam_unix(sudo:session): session closed for user root Mar 05 15:19:29 volumio sudo[4331]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Mar 05 15:19:29 volumio sudo[4331]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 15:19:29 volumio sudo[4331]: pam_unix(sudo:session): session closed for user root Mar 05 15:19:29 volumio sudo[4328]: pam_unix(sudo:session): session closed for user root Mar 05 15:19:29 volumio volumio[867]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Mar 05 15:19:29 volumio volumio[867]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Mar 05 15:19:29 volumio volumio[867]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Mar 05 15:19:29 volumio volumio[867]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Mar 05 15:19:29 volumio volumio[867]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Mar 05 15:19:29 volumio volumio[867]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Mar 05 15:19:29 volumio volumio[867]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Mar 05 15:19:29 volumio volumio[867]: info: Preparing to generate the ALSA configuration file Mar 05 15:19:29 volumio volumio[867]: info: Updating MyVolumio device info Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: Updating MyVolumio device info Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: MRS: Removed streaming files Mar 05 15:19:29 volumio volumio[867]: info: MRS: volumioStreaming STOPPED Mar 05 15:19:29 volumio volumio[867]: info: MRS: SNAPSERVER STOPPED Mar 05 15:19:29 volumio volumio[867]: info: MRS: SNAPCLIENT STOPPED Mar 05 15:19:29 volumio volumio[867]: info: Asound.conf file unchanged, so no further update is needed Mar 05 15:19:29 volumio volumio[867]: info: Output device has changed, restarting MPD Mar 05 15:19:29 volumio sudo[4334]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 05 15:19:29 volumio sudo[4334]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 15:19:29 volumio volumio[867]: info: Output device has changed, restarting Shairport Sync Mar 05 15:19:29 volumio sudo[4334]: pam_unix(sudo:session): session closed for user root Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 15:19:29 volumio sudo[4337]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 05 15:19:29 volumio sudo[4337]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 15:19:29 volumio systemd[1]: Stopping Music Player Daemon... Mar 05 15:19:29 volumio volumio[867]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 05 15:19:29 volumio volumio[867]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 05 15:19:29 volumio systemd[1]: mpd.service: Succeeded. Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio systemd[1]: Stopped Music Player Daemon. Mar 05 15:19:29 volumio volumio[867]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 05 15:19:29 volumio volumio[867]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Mar 05 15:19:29 volumio volumio[867]: info: MRS: Pushing multiroomSync output for this device Mar 05 15:19:29 volumio volumio[867]: info: MRS: Pushing multiroomSync output Mar 05 15:19:29 volumio volumio[867]: info: Adding audio output: Mar 05 15:19:29 volumio volumio[867]: info: Adding audio output: Mar 05 15:19:29 volumio sudo[4346]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Volumio Mar 05 15:19:29 volumio sudo[4346]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 15:19:29 volumio systemd[1]: Starting Music Player Daemon... Mar 05 15:19:29 volumio volumio[867]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: Adding METAVOLUMIO REST API Endpoints Mar 05 15:19:29 volumio volumio[867]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Mar 05 15:19:29 volumio volumio[867]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Mar 05 15:19:29 volumio volumio[867]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Mar 05 15:19:29 volumio volumio[867]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Mar 05 15:19:29 volumio volumio[867]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Mar 05 15:19:29 volumio volumio[867]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Mar 05 15:19:29 volumio volumio[867]: info: Preparing CD Folders Mar 05 15:19:29 volumio volumio[867]: info: Adding CD REST API Endpoints Mar 05 15:19:29 volumio volumio[867]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Mar 05 15:19:29 volumio volumio[867]: info: Starting UDEV Watcher for CD Mar 05 15:19:29 volumio volumio[867]: info: Detecting CD presence with UDEV Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Mar 05 15:19:29 volumio volumio[867]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Mar 05 15:19:29 volumio volumio[867]: info: Adding inputs REST Endpoints Mar 05 15:19:29 volumio volumio[867]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Mar 05 15:19:29 volumio volumio[867]: info: Scanning Audio Inputs Mar 05 15:19:29 volumio sudo[4342]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 05 15:19:29 volumio sudo[4342]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 15:19:29 volumio sudo[4342]: pam_unix(sudo:session): session closed for user root Mar 05 15:19:29 volumio volumio[867]: info: Checking against Known Cards name Mar 05 15:19:29 volumio volumio[867]: info: Checking against Known Cards name Mar 05 15:19:29 volumio volumio[867]: info: Adding Server instance for streaming Mar 05 15:19:29 volumio volumio[867]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Mar 05 15:19:29 volumio volumio[867]: error: Hi Res Audio Failed Login: Missing Login Data Mar 05 15:19:29 volumio volumio[867]: info: Adding HIGHRESAUDIO REST API Endpoints Mar 05 15:19:29 volumio volumio[867]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Mar 05 15:19:29 volumio volumio[867]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Mar 05 15:19:29 volumio volumio[867]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Mar 05 15:19:29 volumio volumio[867]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Mar 05 15:19:29 volumio volumio[867]: info: Stopping AccessToken refresher cron Mar 05 15:19:29 volumio sudo[4356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 05 15:19:29 volumio sudo[4356]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 15:19:29 volumio volumio[867]: info: AccessToken refresher cron started Mar 05 15:19:29 volumio volumio[867]: info: Stopping AccessToken refresher cron for QOBUZ Mar 05 15:19:29 volumio sudo[4356]: pam_unix(sudo:session): session closed for user root Mar 05 15:19:29 volumio volumio[867]: info: AccessToken refresher cron started for QOBUZ Mar 05 15:19:29 volumio volumio[867]: info: Adding TIDAL REST API Endpoints Mar 05 15:19:29 volumio volumio[867]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Mar 05 15:19:29 volumio volumio[867]: info: Adding QOBUZ REST API Endpoints Mar 05 15:19:29 volumio volumio[867]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Mar 05 15:19:29 volumio volumio[867]: info: MRS: Adding multiroomSync output Mar 05 15:19:29 volumio volumio[867]: info: Adding audio output: Mar 05 15:19:29 volumio volumio[867]: info: MRS: Pushing multiroomSync output Mar 05 15:19:29 volumio volumio[867]: info: MPD Permissions set Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio sudo[4346]: pam_unix(sudo:session): session closed for user root Mar 05 15:19:29 volumio volumio[867]: info: Starting Shairport Sync Mar 05 15:19:29 volumio volumio[867]: info: Bluetooth name changed to Volumio Mar 05 15:19:29 volumio volumio[867]: info: Preparing to generate the ALSA configuration file Mar 05 15:19:29 volumio sudo[4371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 05 15:19:29 volumio sudo[4371]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 15:19:29 volumio volumio[867]: info: Asound.conf file unchanged, so no further update is needed Mar 05 15:19:29 volumio volumio[867]: info: Output device has changed, restarting MPD Mar 05 15:19:29 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 05 15:19:29 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 05 15:19:29 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 05 15:19:29 volumio sudo[4374]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 05 15:19:29 volumio sudo[4374]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 15:19:29 volumio volumio[867]: info: Output device has changed, restarting Shairport Sync Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 05 15:19:29 volumio volumio[867]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio sudo[4374]: pam_unix(sudo:session): session closed for user root Mar 05 15:19:29 volumio sudo[4378]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 05 15:19:29 volumio sudo[4378]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 15:19:29 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 05 15:19:29 volumio sudo[4371]: pam_unix(sudo:session): session closed for user root Mar 05 15:19:29 volumio volumio[867]: info: Preparing to generate the ALSA configuration file Mar 05 15:19:29 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Mar 05 15:19:29 volumio systemd[1]: mpd.service: Succeeded. Mar 05 15:19:29 volumio systemd[1]: Stopped Music Player Daemon. Mar 05 15:19:29 volumio volumio[867]: info: MRS: Found cast device: Chromecast-5b60da54659a7786527a415f384a8da2 Mar 05 15:19:29 volumio volumio[867]: info: Adding audio output: Mar 05 15:19:29 volumio systemd[1]: Starting Music Player Daemon... Mar 05 15:19:29 volumio volumio[867]: info: MRS: Found cast device: BRAVIA-4K-GB-ATV3-1650a0b096d15a518a33638bbf7bd2bf Mar 05 15:19:29 volumio volumio[867]: info: Adding audio output: Mar 05 15:19:29 volumio volumio[867]: info: MRS: Found cast device: Chromecast-Ultra-2175c550c1be95b928645d2797c7d2b5 Mar 05 15:19:29 volumio volumio[867]: info: Adding audio output: Mar 05 15:19:29 volumio volumio[867]: info: MRS: Found cast device: BRAVIA-4K-GB-ATV3-06b913d37d5a5e0d76ad160687988925 Mar 05 15:19:29 volumio volumio[867]: info: Adding audio output: Mar 05 15:19:29 volumio volumio[867]: info: MPD Permissions set Mar 05 15:19:29 volumio volumio[867]: info: Shairport-Sync Started Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio sudo[4386]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 05 15:19:29 volumio sudo[4386]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 15:19:29 volumio volumio[867]: info: Asound.conf file unchanged, so no further update is needed Mar 05 15:19:29 volumio volumio[867]: info: Output device has changed, restarting MPD Mar 05 15:19:29 volumio sudo[4386]: pam_unix(sudo:session): session closed for user root Mar 05 15:19:29 volumio sudo[4397]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 05 15:19:29 volumio sudo[4397]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 15:19:29 volumio volumio[867]: info: Output device has changed, restarting Shairport Sync Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 05 15:19:29 volumio volumio[867]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio sudo[4397]: pam_unix(sudo:session): session closed for user root Mar 05 15:19:29 volumio sudo[4400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 05 15:19:29 volumio sudo[4400]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 15:19:29 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Mar 05 15:19:29 volumio systemd[1]: mpd.service: Succeeded. Mar 05 15:19:29 volumio systemd[1]: Stopped Music Player Daemon. Mar 05 15:19:29 volumio systemd[1]: Starting Music Player Daemon... Mar 05 15:19:29 volumio volumio[867]: info: MPD Permissions set Mar 05 15:19:29 volumio volumio[867]: info: Starting Shairport Sync Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio sudo[4410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 05 15:19:29 volumio sudo[4410]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 05 15:19:29 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 05 15:19:29 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 05 15:19:29 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 05 15:19:29 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 05 15:19:29 volumio sudo[4407]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 05 15:19:29 volumio sudo[4407]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 15:19:29 volumio sudo[4410]: pam_unix(sudo:session): session closed for user root Mar 05 15:19:29 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 05 15:19:29 volumio sudo[4407]: pam_unix(sudo:session): session closed for user root Mar 05 15:19:29 volumio volumio[867]: info: Shairport-Sync Started Mar 05 15:19:29 volumio volumio[867]: info: Starting Shairport Sync Mar 05 15:19:29 volumio sudo[4423]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 05 15:19:29 volumio sudo[4423]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 15:19:29 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 05 15:19:29 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 05 15:19:29 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 05 15:19:29 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 05 15:19:29 volumio sudo[4423]: pam_unix(sudo:session): session closed for user root Mar 05 15:19:29 volumio volumio[867]: info: Shairport-Sync Started Mar 05 15:19:29 volumio volumio[867]: info: Successfully Updated MyVolumio device Mar 05 15:19:29 volumio mpd[4420]: Mar 05 15:19 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 05 15:19:29 volumio systemd[1]: Started Music Player Daemon. Mar 05 15:19:29 volumio sudo[4378]: pam_unix(sudo:session): session closed for user root Mar 05 15:19:29 volumio sudo[4337]: pam_unix(sudo:session): session closed for user root Mar 05 15:19:29 volumio sudo[4400]: pam_unix(sudo:session): session closed for user root Mar 05 15:19:29 volumio volumio[867]: error: MPD error: The expression evaluated to a falsy value: Mar 05 15:19:29 volumio volumio[867]: assert.ok(self.idling) Mar 05 15:19:29 volumio volumio[867]: error: The expression evaluated to a falsy value: Mar 05 15:19:29 volumio volumio[867]: assert.ok(self.idling) Mar 05 15:19:29 volumio volumio[867]: error: MPD error: The expression evaluated to a falsy value: Mar 05 15:19:29 volumio volumio[867]: assert.ok(self.idling) Mar 05 15:19:29 volumio volumio[867]: error: The expression evaluated to a falsy value: Mar 05 15:19:29 volumio volumio[867]: assert.ok(self.idling) Mar 05 15:19:29 volumio volumio[867]: error: updateQueue error: null Mar 05 15:19:30 volumio volumio[867]: info: Successfully Updated MyVolumio device Mar 05 15:19:32 volumio sudo[4435]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Mar 05 15:19:32 volumio sudo[4435]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 15:19:32 volumio systemd[1]: Started Volumio Bluetooth Module. Mar 05 15:19:32 volumio sudo[4435]: pam_unix(sudo:session): session closed for user root Mar 05 15:19:32 volumio volumio[867]: info: Volumio BT Module successfully started Mar 05 15:19:32 volumio sudo[4438]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Mar 05 15:19:32 volumio sudo[4438]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 15:19:32 volumio volumiobt[4437]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Mar 05 15:19:32 volumio sudo[4438]: pam_unix(sudo:session): session closed for user root Mar 05 15:19:32 volumio volumio[867]: info: TidalConnect service stoped! Mar 05 15:19:32 volumio volumio[867]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Mar 05 15:19:32 volumio volumio[867]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Mar 05 15:19:32 volumio sudo[4450]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Mar 05 15:19:32 volumio sudo[4450]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 15:19:32 volumio systemd[1]: Started Volumio Tidal Connect Service. Mar 05 15:19:32 volumio sudo[4450]: pam_unix(sudo:session): session closed for user root Mar 05 15:19:32 volumio volumio[867]: info: Executing endpoint tc_getconfig Mar 05 15:19:32 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Mar 05 15:19:32 volumio vtcs[4452]: STARTING TidalConnect services, version: 1.4.0.34 Mar 05 15:19:32 volumio sudo[4461]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Mar 05 15:19:32 volumio sudo[4461]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 15:19:32 volumio vtcs[4452]: [2025-03-05 15:19:32.611] [tisoc] [critical] [DeviceInfo.cpp:56] ioctl error. ret=-1, errno="No such device" Mar 05 15:19:32 volumio vtcs[4452]: [2025-03-05 15:19:32.611] [tisoc] [critical] [DeviceInfo.cpp:57] [ASSERT] generateDeviceId(0) Mar 05 15:19:32 volumio vtcs[4452]: STARTED TidalConnect services. Mar 05 15:19:32 volumio volumio[867]: info: Executing endpoint tc_connect Mar 05 15:19:32 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Mar 05 15:19:32 volumio volumio[867]: info: Connecting to TidalConnect Mar 05 15:19:32 volumio volumio[867]: info: CoreCommandRouter::servicePushState Mar 05 15:19:32 volumio volumio[867]: info: CoreStateMachine::pushState Mar 05 15:19:32 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Mar 05 15:19:32 volumio volumio[867]: info: CoreCommandRouter::volumioPushState Mar 05 15:19:32 volumio volumio[867]: info: MRS: Pushing multiroomSync output update for this device Mar 05 15:19:32 volumio volumio[867]: info: MRS: Pushing multiroomSync output Mar 05 15:19:32 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Mar 05 15:19:32 volumio volumio[867]: 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} Mar 05 15:19:32 volumio volumio[867]: verbose: CURRENT POSITION 0 Mar 05 15:19:32 volumio volumio[867]: info: CoreStateMachine::syncState stateService stop Mar 05 15:19:32 volumio volumio[867]: info: CoreStateMachine::syncState currentStatus stop Mar 05 15:19:32 volumio volumio[867]: info: CoreStateMachine::pushState Mar 05 15:19:32 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Mar 05 15:19:32 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 05 15:19:32 volumio volumio[867]: info: CoreCommandRouter::volumioPushState Mar 05 15:19:32 volumio volumio[867]: info: MRS: Pushing multiroomSync output update for this device Mar 05 15:19:32 volumio volumio[867]: info: MRS: Pushing multiroomSync output Mar 05 15:19:32 volumio volumio[867]: info: No code Mar 05 15:19:32 volumio volumio[867]: info: CoreStateMachine::pushState Mar 05 15:19:32 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Mar 05 15:19:32 volumio volumio[867]: info: CoreCommandRouter::volumioPushState Mar 05 15:19:32 volumio volumio[867]: info: MRS: Pushing multiroomSync output update for this device Mar 05 15:19:32 volumio volumio[867]: info: MRS: Pushing multiroomSync output Mar 05 15:19:32 volumio volumio[867]: info: CoreCommandRouter::servicePushState Mar 05 15:19:32 volumio volumio[867]: info: CoreStateMachine::pushState Mar 05 15:19:32 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Mar 05 15:19:32 volumio volumio[867]: info: CoreCommandRouter::volumioPushState Mar 05 15:19:32 volumio volumio[867]: info: MRS: Pushing multiroomSync output update for this device Mar 05 15:19:32 volumio volumio[867]: info: MRS: Pushing multiroomSync output Mar 05 15:19:32 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Mar 05 15:19:32 volumio volumio[867]: 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} Mar 05 15:19:32 volumio volumio[867]: verbose: CURRENT POSITION 0 Mar 05 15:19:32 volumio volumio[867]: info: CoreStateMachine::syncState stateService stop Mar 05 15:19:32 volumio volumio[867]: info: CoreStateMachine::syncState currentStatus stop Mar 05 15:19:32 volumio volumio[867]: info: CoreStateMachine::pushState Mar 05 15:19:32 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Mar 05 15:19:32 volumio volumio[867]: info: CoreCommandRouter::volumioPushState Mar 05 15:19:32 volumio volumio[867]: info: MRS: Pushing multiroomSync output update for this device Mar 05 15:19:32 volumio volumio[867]: info: MRS: Pushing multiroomSync output Mar 05 15:19:32 volumio volumio[867]: info: No code Mar 05 15:19:32 volumio volumio[867]: info: CoreStateMachine::pushState Mar 05 15:19:32 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Mar 05 15:19:32 volumio volumio[867]: info: CoreCommandRouter::volumioPushState Mar 05 15:19:32 volumio volumio[867]: info: MRS: Pushing multiroomSync output update for this device Mar 05 15:19:32 volumio volumio[867]: info: MRS: Pushing multiroomSync output Mar 05 15:19:32 volumio systemd[1]: Started MyVolumio SSH Tunnel. Mar 05 15:19:32 volumio sudo[4461]: pam_unix(sudo:session): session closed for user root Mar 05 15:19:32 volumio autossh[4479]: port set to 0, monitoring disabled Mar 05 15:19:32 volumio autossh[4479]: starting ssh (count 1) Mar 05 15:19:32 volumio autossh[4479]: ssh child pid is 4482 Mar 05 15:19:32 volumio volumio[867]: info: Remote SSH Started Mar 05 15:19:32 volumio volumio[867]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Mar 05 15:19:32 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Mar 05 15:19:32 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Mar 05 15:19:32 volumio volumiossh-tunnel[4463]: Warning: Permanently added '[us3.myvolumio.org]:2222,[159.203.57.91]:2222' (RSA) to the list of known hosts. Mar 05 15:19:33 volumio sudo[4483]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Mar 05 15:19:33 volumio sudo[4483]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 05 15:19:33 volumio volumiobt[4437]: pulseaudio: no process found Mar 05 15:19:33 volumio sudo[4483]: pam_unix(sudo:session): session closed for user root Mar 05 15:19:33 volumio dbus-daemon[717]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.43' (uid=1000 pid=4487 comm="/usr/bin/pulseaudio --high-priority=true ") Mar 05 15:19:33 volumio systemd[1]: Starting RealtimeKit Scheduling Policy Service... Mar 05 15:19:33 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 05 15:19:33 volumio dbus-daemon[717]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Mar 05 15:19:33 volumio systemd[1]: Started RealtimeKit Scheduling Policy Service. Mar 05 15:19:33 volumio rtkit-daemon[4488]: Successfully called chroot. Mar 05 15:19:33 volumio rtkit-daemon[4488]: Successfully dropped privileges. Mar 05 15:19:33 volumio rtkit-daemon[4488]: Successfully limited resources. Mar 05 15:19:33 volumio rtkit-daemon[4488]: Running. Mar 05 15:19:33 volumio rtkit-daemon[4488]: Canary thread running. Mar 05 15:19:33 volumio rtkit-daemon[4488]: Watchdog thread running. Mar 05 15:19:33 volumio dbus-daemon[717]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.44' (uid=0 pid=4488 comm="/usr/lib/rtkit/rtkit-daemon ") Mar 05 15:19:33 volumio systemd[1]: Starting Authorization Manager... Mar 05 15:19:33 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 05 15:19:33 volumio polkitd[4492]: started daemon version 0.105 using authority implementation `local' version `0.105' Mar 05 15:19:33 volumio dbus-daemon[717]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Mar 05 15:19:33 volumio systemd[1]: Started Authorization Manager. Mar 05 15:19:33 volumio pulseaudio[4487]: Failed to open cookie file '/home/volumio/.config/pulse/cookie': No such file or directory Mar 05 15:19:33 volumio pulseaudio[4487]: Failed to load authentication key '/home/volumio/.config/pulse/cookie': No such file or directory Mar 05 15:19:33 volumio pulseaudio[4487]: Failed to open cookie file '/home/volumio/.pulse-cookie': No such file or directory Mar 05 15:19:33 volumio pulseaudio[4487]: Failed to load authentication key '/home/volumio/.pulse-cookie': No such file or directory Mar 05 15:19:33 volumio pulseaudio[4487]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Mar 05 15:19:33 volumio pulseaudio[4487]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Mar 05 15:19:33 volumio volumiobt[4437]: Applying permissions Mar 05 15:19:33 volumio volumiobt[4437]: Setting BT discoverable and pairable Mar 05 15:19:33 volumio bluetoothd[1080]: Endpoint registered: sender=:1.64 path=/MediaEndpoint/A2DPSource Mar 05 15:19:33 volumio bluetoothd[1080]: Endpoint registered: sender=:1.64 path=/MediaEndpoint/A2DPSink Mar 05 15:19:33 volumio pulseaudio[4487]: 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 Mar 05 15:19:33 volumio kernel: Bluetooth: RFCOMM TTY layer initialized Mar 05 15:19:33 volumio kernel: Bluetooth: RFCOMM socket layer initialized Mar 05 15:19:33 volumio kernel: Bluetooth: RFCOMM ver 1.11 Mar 05 15:19:33 volumio volumiobt[4437]: Agent registered Mar 05 15:19:33 volumio volumiobt[4437]: [bluetooth]# -e power on Mar 05 15:19:33 volumio volumiobt[4437]: Invalid command in menu main: -e Mar 05 15:19:33 volumio volumiobt[4437]: Mar 05 15:19:33 volumio volumiobt[4437]: Use "help" for a list of available commands in a menu. Mar 05 15:19:33 volumio volumiobt[4437]: Use "menu " if you want to enter any submenu. Mar 05 15:19:33 volumio volumiobt[4437]: Use "back" if you want to return to menu main. Mar 05 15:19:33 volumio volumiobt[4437]: [bluetooth]# agent on Mar 05 15:19:33 volumio volumiobt[4437]: Agent is already registered Mar 05 15:19:33 volumio volumiobt[4437]: [bluetooth]# discoverable on Mar 05 15:19:33 volumio volumiobt[4437]: [bluetooth]# pairable on Mar 05 15:19:33 volumio volumiobt[4437]: [bluetooth]# agent NoInputNoOutput Mar 05 15:19:33 volumio volumiobt[4437]: Agent is already registered Mar 05 15:19:33 volumio volumiobt[4437]: [bluetooth]# default-agent Mar 05 15:19:33 volumio volumiobt[4437]: [bluetooth]# quit Mar 05 15:19:33 volumio volumiobt[4437]: [59B blob data] Mar 05 15:19:34 volumio volumio[867]: info: MRS: Getting audio outputs on start Mar 05 15:19:34 volumio volumio[867]: info: MRS: Requesting all other devices output Mar 05 15:19:35 volumio volumio[867]: info: TidalConnect service started! Mar 05 15:19:51 volumio volumio[867]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Mar 05 15:19:51 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Mar 05 15:19:51 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Mar 05 15:19:51 volumio volumio[867]: info: Received Get System Info Mar 05 15:19:51 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 05 15:19:51 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 05 15:19:51 volumio volumio[867]: info: Discovery: Getting this device information Mar 05 15:19:51 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Mar 05 15:19:51 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Mar 05 15:19:51 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 05 15:19:51 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Mar 05 15:19:51 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Mar 05 15:19:51 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 05 15:19:51 volumio volumio[867]: info: CoreCommandRouter::volumioGetVisibleSources Mar 05 15:19:51 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 05 15:19:51 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Mar 05 15:19:51 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Mar 05 15:19:51 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Mar 05 15:19:51 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Mar 05 15:19:51 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 05 15:19:51 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 05 15:19:51 volumio volumio[867]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Mar 05 15:19:51 volumio volumio[867]: info: Received Get System Info Mar 05 15:19:51 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 05 15:19:51 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 05 15:19:51 volumio volumio[867]: info: Discovery: Getting this device information Mar 05 15:19:51 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Mar 05 15:19:51 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Mar 05 15:19:51 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 05 15:19:51 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Mar 05 15:19:51 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Mar 05 15:19:51 volumio volumio[867]: info: Listing playlists Mar 05 15:19:51 volumio volumio[867]: info: Received Get System Info Mar 05 15:19:51 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 05 15:19:51 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 05 15:19:51 volumio volumio[867]: info: Discovery: Getting this device information Mar 05 15:19:51 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Mar 05 15:19:51 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Mar 05 15:19:51 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 05 15:19:51 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Mar 05 15:19:51 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Mar 05 15:19:51 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 05 15:19:52 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Mar 05 15:19:52 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Mar 05 15:19:55 volumio volumio[867]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 05 15:19:55 volumio volumio[867]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 05 15:19:55 volumio volumio[867]: info: Retrieving Cloud Streaming UI Mar 05 15:19:55 volumio volumio[867]: info: Getting Tidal Cloud Configuration Mar 05 15:19:55 volumio volumio[867]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 05 15:19:55 volumio volumio[867]: info: Getting Qobuz Cloud Configuration Mar 05 15:19:55 volumio volumio[867]: info: Asking plugin for UI Config Mar 05 15:19:55 volumio volumio[867]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 05 15:19:55 volumio volumio[867]: info: Getting Spotify Cloud Configuration Mar 05 15:19:55 volumio volumio[867]: info: Asking plugin for UI Config Mar 05 15:19:55 volumio volumio[867]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 05 15:19:55 volumio volumio[867]: info: Saving Spotify Acccount Mar 05 15:19:55 volumio volumio[867]: info: Got it Mar 05 15:19:55 volumio volumio[867]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 05 15:19:55 volumio volumio[867]: info: Got it Mar 05 15:19:55 volumio volumio[867]: info: Got Tidal Cloud Configuration Mar 05 15:19:55 volumio volumio[867]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 05 15:19:55 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 05 15:19:55 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 05 15:19:55 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 05 15:19:55 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 05 15:19:55 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 15:19:55 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 15:19:55 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 05 15:19:55 volumio volumio[867]: info: CoreCommandRouter::volumioGetBrowseSources Mar 05 15:19:55 volumio volumio[867]: info: CoreCommandRouter::volumioGetBrowseSources Mar 05 15:19:55 volumio volumio[867]: info: CoreCommandRouter::volumioGetBrowseSources Mar 05 15:19:55 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 05 15:19:55 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 05 15:19:59 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 05 15:20:01 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 05 15:20:03 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 05 15:20:06 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Mar 05 15:20:06 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Mar 05 15:20:07 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 05 15:20:11 volumio volumio[867]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 05 15:20:11 volumio volumio[867]: Error: dns service error: unknown Mar 05 15:20:11 volumio volumio[867]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Mar 05 15:20:11 volumio volumio[867]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Mar 05 15:20:11 volumio volumio[867]: errorCode: -65537 Mar 05 15:20:11 volumio volumio[867]: } Mar 05 15:20:11 volumio volumio[867]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 05 15:20:11 volumio sudo[4647]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-05 15:19 Mar 05 15:20:11 volumio sudo[4647]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"