Feb 11 12:27:06 volumiotest volumio[1388]: verbose: New Socket.io Connection to 10.28.1.122 from 10.28.1.93 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Feb 11 12:27:09 volumiotest volumio[1388]: info: Discovery: Disconnected from remote: 10.28.1.41 Feb 11 12:27:09 volumiotest volumio[1388]: info: Discovery: Disconnected from remote: 10.28.1.41 Feb 11 12:27:09 volumiotest volumio[1388]: info: Discovery: Disconnected from remote: 10.28.1.41 Feb 11 12:27:13 volumiotest volumio[1388]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Feb 11 12:27:17 volumiotest volumio[1388]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Feb 11 12:27:20 volumiotest volumio[1388]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Feb 11 12:27:20 volumiotest volumio[1388]: info: Discovery: Remote connection error: 10.28.1.41 Feb 11 12:27:20 volumiotest volumio[1388]: info: Discovery: Remote connection error: 10.28.1.41 Feb 11 12:27:20 volumiotest volumio[1388]: info: Discovery: Remote connection error: 10.28.1.41 Feb 11 12:27:20 volumiotest volumio[1388]: info: Discovery: Remote connection timeout: 10.28.1.41 Feb 11 12:27:20 volumiotest volumio[1388]: info: Discovery: Remote connection timeout: 10.28.1.41 Feb 11 12:27:20 volumiotest volumio[1388]: info: Discovery: Remote connection timeout: 10.28.1.41 Feb 11 12:27:24 volumiotest volumio[1388]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Feb 11 12:27:27 volumiotest volumio[1388]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 Feb 11 12:27:31 volumiotest volumio[1388]: info: Discovery: Connected to remote: 10.28.1.41 Feb 11 12:27:35 volumiotest volumio[1388]: verbose: New Socket.io Connection to 10.28.1.122 from 10.28.1.93 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 15 Feb 11 12:27:47 volumiotest volumio[1388]: verbose: New Socket.io Connection to 10.28.1.122 from 10.28.1.93 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 15 Feb 11 12:27:47 volumiotest sudo[2462]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 11 12:27:47 volumiotest sudo[2464]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 11 12:27:47 volumiotest sudo[2462]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 12:27:47 volumiotest sudo[2464]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 12:27:47 volumiotest sudo[2462]: pam_unix(sudo:session): session closed for user root Feb 11 12:27:47 volumiotest sudo[2464]: pam_unix(sudo:session): session closed for user root Feb 11 12:27:48 volumiotest volumio[1388]: verbose: New Socket.io Connection to 10.28.1.122 from 10.28.1.93 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 16 Feb 11 12:27:49 volumiotest volumio[1388]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 17 Feb 11 12:27:50 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 11 12:27:50 volumiotest volumio[1388]: info: CoreCommandRouter::volumioGetVisibleSources Feb 11 12:27:50 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 11 12:27:50 volumiotest volumio[1388]: info: CoreCommandRouter::volumioGetState Feb 11 12:27:50 volumiotest volumio[1388]: info: CorePlayQueue::getTrack 0 Feb 11 12:27:50 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 11 12:27:50 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 11 12:27:50 volumiotest volumio[1388]: info: Received Get System Info Feb 11 12:27:50 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 11 12:27:50 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 11 12:27:50 volumiotest volumio[1388]: info: Discovery: Getting this device information Feb 11 12:27:50 volumiotest volumio[1388]: info: CoreCommandRouter::volumioGetState Feb 11 12:27:50 volumiotest volumio[1388]: info: CorePlayQueue::getTrack 0 Feb 11 12:27:50 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 11 12:27:50 volumiotest volumio[1388]: info: CoreCommandRouter::volumioGetState Feb 11 12:27:50 volumiotest volumio[1388]: info: CorePlayQueue::getTrack 0 Feb 11 12:27:50 volumiotest volumio[1388]: info: Listing playlists Feb 11 12:27:50 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 11 12:27:50 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 11 12:27:50 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 11 12:27:50 volumiotest volumio[1388]: info: Received Get System Info Feb 11 12:27:50 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 11 12:27:50 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 11 12:27:50 volumiotest volumio[1388]: info: Discovery: Getting this device information Feb 11 12:27:50 volumiotest volumio[1388]: info: CoreCommandRouter::volumioGetState Feb 11 12:27:50 volumiotest volumio[1388]: info: CorePlayQueue::getTrack 0 Feb 11 12:27:50 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 11 12:27:50 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 11 12:27:50 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Feb 11 12:27:50 volumiotest volumio[1388]: info: MyVolumio login type: Token Feb 11 12:27:50 volumiotest volumio[1388]: info: CoreCommandRouter::volumioGetState Feb 11 12:27:50 volumiotest volumio[1388]: info: CorePlayQueue::getTrack 0 Feb 11 12:27:50 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 11 12:27:51 volumiotest volumio[1388]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Feb 11 12:27:52 volumiotest volumio[1388]: info: MyVolumio token set successfully Feb 11 12:27:52 volumiotest volumio[1388]: info: MYVOLUMIO: Adding device Feb 11 12:27:52 volumiotest volumio[1388]: info: MYVOLUMIO: Evaluating Server Feb 11 12:27:52 volumiotest volumio[1388]: info: MyVolumio Plan changed: premium Feb 11 12:27:52 volumiotest volumio[1388]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Feb 11 12:27:52 volumiotest volumio[1388]: info: Removing browser output: myVolumio user plan is not superstar Feb 11 12:27:52 volumiotest volumio[1388]: info: Removing audio output: Feb 11 12:27:52 volumiotest volumio[1388]: info: MYVOLUMIO: Adding device Feb 11 12:27:52 volumiotest volumio[1388]: info: MYVOLUMIO: Evaluating Server Feb 11 12:27:52 volumiotest volumio[1388]: info: Remote config written successfully Feb 11 12:27:52 volumiotest volumio[1388]: info: Starting Tunnel 1 Feb 11 12:27:52 volumiotest volumio[1388]: info: Starting Tunnel Connection Checker Feb 11 12:27:52 volumiotest volumio[1388]: info: MYVolumio Device enabled Feb 11 12:27:52 volumiotest volumio[1388]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Feb 11 12:27:52 volumiotest volumio[1388]: info: MyVolumio status changed Feb 11 12:27:52 volumiotest volumio[1388]: info: Streaming services startup Feb 11 12:27:52 volumiotest volumio[1388]: info: Starting Streaming Daemon Feb 11 12:27:52 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 11 12:27:52 volumiotest sudo[2511]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 11 12:27:52 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 11 12:27:52 volumiotest volumio[1388]: info: Received Get System Info Feb 11 12:27:52 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 11 12:27:52 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 11 12:27:52 volumiotest volumio[1388]: info: Discovery: Getting this device information Feb 11 12:27:52 volumiotest volumio[1388]: info: CoreCommandRouter::volumioGetState Feb 11 12:27:52 volumiotest sudo[2511]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 12:27:52 volumiotest volumio[1388]: info: CorePlayQueue::getTrack 0 Feb 11 12:27:52 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 11 12:27:52 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Feb 11 12:27:53 volumiotest volumio[1388]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Feb 11 12:27:53 volumiotest sudo[2511]: pam_unix(sudo:session): session closed for user root Feb 11 12:27:54 volumiotest volumio[1388]: ------------------------------------ BT MESSAGE: [FUNC] onVolumioStart Feb 11 12:27:54 volumiotest volumio[1388]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Feb 11 12:27:57 volumiotest volumio[1388]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Feb 11 12:27:57 volumiotest sudo[2529]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Feb 11 12:27:57 volumiotest sudo[2529]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 12:27:57 volumiotest sudo[2529]: pam_unix(sudo:session): session closed for user root Feb 11 12:27:57 volumiotest volumio[1388]: info: MRS: MultiRoom plugin initialized Feb 11 12:27:57 volumiotest volumio[1388]: info: MRS: STOPPING SNAPCLIENT Feb 11 12:27:57 volumiotest volumio[1388]: info: MRS: Snap server stop Feb 11 12:27:57 volumiotest volumio[1388]: info: MRS: STOPPING volumioStreaming Feb 11 12:27:57 volumiotest sudo[2546]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Feb 11 12:27:57 volumiotest sudo[2546]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 12:27:57 volumiotest volumio[1388]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Feb 11 12:27:57 volumiotest sudo[2548]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Feb 11 12:27:57 volumiotest sudo[2548]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 12:27:57 volumiotest sudo[2550]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Feb 11 12:27:57 volumiotest sudo[2550]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 12:27:57 volumiotest sudo[2553]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Feb 11 12:27:57 volumiotest sudo[2553]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 12:27:57 volumiotest sudo[2553]: pam_unix(sudo:session): session closed for user root Feb 11 12:27:57 volumiotest volumio[1388]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Feb 11 12:27:57 volumiotest volumio[1388]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Feb 11 12:27:57 volumiotest volumio[1388]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Feb 11 12:27:57 volumiotest volumio[1388]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Feb 11 12:27:58 volumiotest volumio[1388]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Feb 11 12:27:58 volumiotest volumio[1388]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Feb 11 12:27:58 volumiotest volumio[1388]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Feb 11 12:27:58 volumiotest sudo[2546]: pam_unix(sudo:session): session closed for user root Feb 11 12:27:58 volumiotest volumio[1388]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Feb 11 12:27:58 volumiotest sudo[2548]: pam_unix(sudo:session): session closed for user root Feb 11 12:27:58 volumiotest volumio[1388]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... Feb 11 12:27:58 volumiotest sudo[2550]: pam_unix(sudo:session): session closed for user root Feb 11 12:27:58 volumiotest volumio[1388]: info: Preparing to generate the ALSA configuration file Feb 11 12:27:58 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 11 12:27:58 volumiotest volumio[1388]: info: Received Get System Info Feb 11 12:27:58 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 11 12:27:58 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 11 12:27:58 volumiotest volumio[1388]: info: Discovery: Getting this device information Feb 11 12:27:58 volumiotest volumio[1388]: info: CoreCommandRouter::volumioGetState Feb 11 12:27:58 volumiotest volumio[1388]: info: CorePlayQueue::getTrack 0 Feb 11 12:27:58 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 11 12:27:58 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 11 12:27:58 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 11 12:27:58 volumiotest volumio[1388]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Feb 11 12:27:58 volumiotest volumio[1388]: info: Reading ALSA contributions from plugins. Feb 11 12:27:58 volumiotest volumio[1388]: info: Setting Geolocation for MyVolumio to eu4 Feb 11 12:27:58 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 11 12:27:58 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 11 12:27:58 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 11 12:27:58 volumiotest volumio[1388]: info: MRS: Removed streaming files Feb 11 12:27:58 volumiotest volumio[1388]: info: MRS: volumioStreaming STOPPED Feb 11 12:27:58 volumiotest volumio[1388]: info: MRS: SNAPSERVER STOPPED Feb 11 12:27:58 volumiotest volumio[1388]: info: MRS: SNAPCLIENT STOPPED Feb 11 12:27:58 volumiotest volumio[1388]: error: Cannot start Volumio Streaming Daemon Feb 11 12:27:58 volumiotest volumio[1388]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 11 12:27:58 volumiotest volumio[1388]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 11 12:27:58 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 11 12:27:58 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 11 12:27:58 volumiotest volumio[1388]: info: Asound.conf file written Feb 11 12:27:59 volumiotest sudo[2565]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Feb 11 12:27:59 volumiotest sudo[2565]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 12:27:59 volumiotest sudo[2568]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Feb 11 12:27:59 volumiotest sudo[2568]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 12:27:59 volumiotest sudo[2568]: pam_unix(sudo:session): session closed for user root Feb 11 12:27:59 volumiotest systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 11 12:27:59 volumiotest systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 11 12:27:59 volumiotest systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Feb 11 12:27:59 volumiotest sudo[2565]: pam_unix(sudo:session): session closed for user root Feb 11 12:27:59 volumiotest volumio[1388]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Feb 11 12:27:59 volumiotest volumio[1388]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Feb 11 12:27:59 volumiotest volumio[1388]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Feb 11 12:27:59 volumiotest volumio[1388]: info: Output device has changed, restarting MPD Feb 11 12:27:59 volumiotest autossh[2575]: port set to 0, monitoring disabled Feb 11 12:27:59 volumiotest autossh[2575]: starting ssh (count 1) Feb 11 12:27:59 volumiotest autossh[2575]: ssh child pid is 2579 Feb 11 12:27:59 volumiotest volumio[1388]: info: Output device has changed, restarting Shairport Sync Feb 11 12:27:59 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 11 12:27:59 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 11 12:27:59 volumiotest sudo[2582]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 11 12:27:59 volumiotest sudo[2582]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 12:27:59 volumiotest sudo[2580]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 11 12:27:59 volumiotest sudo[2580]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 12:27:59 volumiotest sudo[2580]: pam_unix(sudo:session): session closed for user root Feb 11 12:27:59 volumiotest volumio[1388]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 11 12:27:59 volumiotest volumio[1388]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 11 12:27:59 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 11 12:27:59 volumiotest volumio[1388]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Feb 11 12:27:59 volumiotest volumio[1388]: ------------------------------------ BT MESSAGE: [FUNC] onStart Feb 11 12:27:59 volumiotest volumio[1388]: ------------------------------------ BT MESSAGE: Starting Volumio Bluetooth Service Feb 11 12:27:59 volumiotest systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 11 12:27:59 volumiotest volumio[1388]: ------------------------------------ BT MESSAGE: Boot config /etc/bluetooth/volumio.conf: cache mode = tmp Feb 11 12:27:59 volumiotest volumio[1388]: ------------------------------------ BT MESSAGE: [metaCache] Created directory: /tmp/bluetooth-cache/ Feb 11 12:27:59 volumiotest volumio[1388]: ------------------------------------ BT MESSAGE: [metaCache] Directory exists and is ready. Feb 11 12:27:59 volumiotest volumio[1388]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Feb 11 12:27:59 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Feb 11 12:27:59 volumiotest volumio[1388]: info: MRS: Pushing multiroomSync output for this device Feb 11 12:27:59 volumiotest volumio[1388]: info: MRS: Pushing multiroomSync output Feb 11 12:27:59 volumiotest volumio[1388]: info: Adding audio output: Feb 11 12:27:59 volumiotest volumio[1388]: info: Adding audio output: Feb 11 12:28:00 volumiotest volumio[1388]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 11 12:28:00 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 11 12:28:00 volumiotest volumio[1388]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Feb 11 12:28:00 volumiotest volumio[1388]: info: Adding METAVOLUMIO REST API Endpoints Feb 11 12:28:00 volumiotest volumio[1388]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Feb 11 12:28:00 volumiotest volumio[1388]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Feb 11 12:28:00 volumiotest volumio[1388]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Feb 11 12:28:00 volumiotest volumio[1388]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Feb 11 12:28:00 volumiotest volumio[1388]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Feb 11 12:28:00 volumiotest volumio[1388]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Feb 11 12:28:00 volumiotest volumio[1388]: info: Preparing CD Folders Feb 11 12:28:00 volumiotest volumio[1388]: info: Adding CD REST API Endpoints Feb 11 12:28:00 volumiotest volumio[1388]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Feb 11 12:28:00 volumiotest volumio[1388]: info: Starting UDEV Watcher for CD Feb 11 12:28:00 volumiotest volumiossh-tunnel[2579]: Warning: Permanently added '[eu1.myvolumio.org]:2222' (RSA) to the list of known hosts. Feb 11 12:28:00 volumiotest volumio[1388]: info: Detecting CD presence with UDEV Feb 11 12:28:00 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Feb 11 12:28:00 volumiotest bluetoothd[1061]: Path / reserved for Adv Monitor app :1.32 Feb 11 12:28:01 volumiotest bluetoothd[1061]: Adv Monitor app :1.32 disconnected from D-Bus Feb 11 12:28:05 volumiotest volumio[1388]: warn: [cd-plugin] cdspeedctl: device or media not ready Feb 11 12:28:05 volumiotest volumio[1388]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Feb 11 12:28:06 volumiotest volumio[1388]: info: Adding inputs REST Endpoints Feb 11 12:28:06 volumiotest volumio[1388]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Feb 11 12:28:06 volumiotest volumio[1388]: info: Scanning Audio Inputs Feb 11 12:28:06 volumiotest volumio[1388]: info: Checking against Known Cards name Feb 11 12:28:06 volumiotest volumio[1388]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 11 12:28:06 volumiotest volumio[1388]: info: [1770809286433] CoreMusicLibrary::Adding element HiFiBerry ADC Feb 11 12:28:06 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 11 12:28:06 volumiotest volumio[1388]: Cannot find translation for source HiFiBerry ADC Feb 11 12:28:06 volumiotest systemd[1]: mpd.service: Deactivated successfully. Feb 11 12:28:06 volumiotest volumio[1388]: info: Checking against Known Cards name Feb 11 12:28:06 volumiotest volumio[1388]: info: Adding Server instance for streaming Feb 11 12:28:06 volumiotest volumio[1388]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Feb 11 12:28:06 volumiotest volumio[1388]: error: Hi Res Audio Failed Login: Missing Login Data Feb 11 12:28:06 volumiotest volumio[1388]: info: Adding HIGHRESAUDIO REST API Endpoints Feb 11 12:28:06 volumiotest volumio[1388]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Feb 11 12:28:06 volumiotest volumio[1388]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Feb 11 12:28:06 volumiotest volumio[1388]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Feb 11 12:28:06 volumiotest volumio[1388]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Feb 11 12:28:06 volumiotest systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 11 12:28:06 volumiotest systemd[1]: mpd.service: Consumed 10.807s CPU time. Feb 11 12:28:06 volumiotest systemd[1]: mpd.socket: Deactivated successfully. Feb 11 12:28:06 volumiotest systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 11 12:28:06 volumiotest systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 11 12:28:06 volumiotest volumio[1388]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuzconnect Feb 11 12:28:06 volumiotest volumio[1388]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect Feb 11 12:28:06 volumiotest volumio[1388]: info: QobuzConnect: Starting Qobuz Connect socket and service Feb 11 12:28:06 volumiotest systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 11 12:28:06 volumiotest systemd[1]: Starting mpd.service - Music Player Daemon... Feb 11 12:28:06 volumiotest volumio[1388]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections Feb 11 12:28:06 volumiotest volumio[1388]: info: Adding TIDAL REST API Endpoints Feb 11 12:28:06 volumiotest volumio[1388]: info: Stopping AccessToken refresher cron for QOBUZ Feb 11 12:28:07 volumiotest sudo[2624]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 11 12:28:07 volumiotest sudo[2630]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Feb 11 12:28:07 volumiotest sudo[2630]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 12:28:07 volumiotest sudo[2624]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 12:28:07 volumiotest sudo[2631]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 11 12:28:07 volumiotest sudo[2631]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 11 12:28:07 volumiotest sudo[2631]: pam_unix(sudo:session): session closed for user root Feb 11 12:28:07 volumiotest sudo[2630]: pam_unix(sudo:session): session closed for user root Feb 11 12:28:07 volumiotest sudo[2636]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Feb 11 12:28:07 volumiotest sudo[2636]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 12:28:07 volumiotest systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Feb 11 12:28:07 volumiotest sudo[2636]: pam_unix(sudo:session): session closed for user root Feb 11 12:28:07 volumiotest sudo[2624]: pam_unix(sudo:session): session closed for user root Feb 11 12:28:08 volumiotest volumio[1388]: info: AccessToken refresher cron started for QOBUZ Feb 11 12:28:08 volumiotest volumio[1388]: info: Adding QOBUZ REST API Endpoints Feb 11 12:28:08 volumiotest volumio[1388]: info: Updating MyVolumio device info Feb 11 12:28:08 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 11 12:28:08 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 11 12:28:08 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 11 12:28:09 volumiotest volumio[1388]: info: Discovery: Disconnected from remote: 10.28.1.41 Feb 11 12:28:09 volumiotest volumio[1388]: info: Discovery: Disconnected from remote: 10.28.1.41 Feb 11 12:28:09 volumiotest volumio[1388]: info: Discovery: Disconnected from remote: 10.28.1.41 Feb 11 12:28:09 volumiotest volumio[1388]: info: Discovery: Disconnected from remote: 10.28.1.41 Feb 11 12:28:09 volumiotest volumio[1388]: info: MRS: Getting audio outputs on start Feb 11 12:28:09 volumiotest volumio[1388]: info: MRS: Requesting all other devices output Feb 11 12:28:10 volumiotest volumio[1388]: info: Successfully Added MyVolumio device Feb 11 12:28:10 volumiotest volumio[1388]: info: Setting Geolocation for MyVolumio to eu7 Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::volumioGetVisibleSources Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::volumioGetState Feb 11 12:28:10 volumiotest volumio[1388]: info: CorePlayQueue::getTrack 0 Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::volumioGetQueue Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreStateMachine::getQueue Feb 11 12:28:10 volumiotest volumio[1388]: info: CorePlayQueue::getQueue Feb 11 12:28:10 volumiotest volumio[1388]: info: Listing playlists Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 11 12:28:10 volumiotest volumio[1388]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 11 12:28:10 volumiotest volumio[1388]: info: Received Get System Info Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 11 12:28:10 volumiotest volumio[1388]: info: Discovery: Getting this device information Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::volumioGetState Feb 11 12:28:10 volumiotest volumio[1388]: info: CorePlayQueue::getTrack 0 Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::volumioGetState Feb 11 12:28:10 volumiotest volumio[1388]: info: CorePlayQueue::getTrack 0 Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 11 12:28:10 volumiotest volumio[1388]: info: Received Get System Info Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 11 12:28:10 volumiotest volumio[1388]: info: Discovery: Getting this device information Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::volumioGetState Feb 11 12:28:10 volumiotest volumio[1388]: info: CorePlayQueue::getTrack 0 Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 11 12:28:10 volumiotest volumio[1388]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 11 12:28:10 volumiotest volumio[1388]: info: Received Get System Version Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 11 12:28:10 volumiotest volumio[1388]: info: Received Get System Info Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 11 12:28:10 volumiotest volumio[1388]: info: Discovery: Getting this device information Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::volumioGetState Feb 11 12:28:10 volumiotest volumio[1388]: info: CorePlayQueue::getTrack 0 Feb 11 12:28:10 volumiotest volumio[1388]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 11 12:28:10 volumiotest volumio[1388]: ------------------------------------ BT MESSAGE: Bluetooth adapter powered on Feb 11 12:28:10 volumiotest volumio[1388]: info: MPD Permissions set Feb 11 12:28:10 volumiotest volumio[1388]: info: Remote SSH Started Feb 11 12:28:11 volumiotest sudo[2641]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Feb 11 12:28:11 volumiotest sudo[2641]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 12:28:11 volumiotest volumio[1388]: error: Cannot download Available plugins list: Error: ETIMEDOUT Feb 11 12:28:11 volumiotest volumio[1388]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 11 12:28:11 volumiotest volumio[1388]: Error [ERR_INTERNAL_ASSERTION]: This is caused by either a bug in Node.js or incorrect usage of Node.js internals. Feb 11 12:28:11 volumiotest volumio[1388]: Please open an issue with this stack trace at https://github.com/nodejs/node/issues Feb 11 12:28:11 volumiotest volumio[1388]: at new NodeError (node:internal/errors:405:5) Feb 11 12:28:11 volumiotest volumio[1388]: at assert (node:internal/assert:14:11) Feb 11 12:28:11 volumiotest volumio[1388]: at internalConnectMultiple (node:net:1118:3) Feb 11 12:28:11 volumiotest volumio[1388]: at Timeout.internalConnectMultipleTimeout (node:net:1687:3) Feb 11 12:28:11 volumiotest volumio[1388]: at listOnTimeout (node:internal/timers:575:11) Feb 11 12:28:11 volumiotest volumio[1388]: at process.processTimers (node:internal/timers:514:7) { Feb 11 12:28:11 volumiotest volumio[1388]: code: 'ERR_INTERNAL_ASSERTION' Feb 11 12:28:11 volumiotest volumio[1388]: } Feb 11 12:28:11 volumiotest volumio[1388]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 11 12:28:11 volumiotest systemd[1]: Started volumiobt.service - Volumio Bluetooth Module. Feb 11 12:28:11 volumiotest sudo[2641]: pam_unix(sudo:session): session closed for user root Feb 11 12:28:11 volumiotest volumiobt[2647]: INFO [BTSTART] Ensuring Bluetooth directory exists... Feb 11 12:28:11 volumiotest sudo[2648]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /var/lib/bluetooth Feb 11 12:28:11 volumiotest sudo[2648]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 12:28:11 volumiotest sudo[2648]: pam_unix(sudo:session): session closed for user root Feb 11 12:28:12 volumiotest sudo[2650]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth Feb 11 12:28:12 volumiotest sudo[2650]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 11 12:28:12 volumiotest sudo[2650]: pam_unix(sudo:session): session closed for user root Feb 11 12:28:12 volumiotest volumiobt[2652]: INFO [BTSTART] Powering on Bluetooth if needed... Feb 11 12:28:12 volumiotest bluetoothd[1061]: Path / reserved for Adv Monitor app :1.33 Feb 11 12:28:12 volumiotest bluetoothd[1061]: Adv Monitor app :1.33 disconnected from D-Bus Feb 11 12:28:12 volumiotest volumiobt[2663]: INFO [BTSTART] Making Bluetooth discoverable and pairable... Feb 11 12:28:12 volumiotest volumiobt[2664]: [193B blob data] Feb 11 12:28:12 volumiotest volumiobt[2664]: [157B blob data] Feb 11 12:28:12 volumiotest volumiobt[2664]: [157B blob data] Feb 11 12:28:12 volumiotest volumiobt[2664]: [157B blob data] Feb 11 12:28:12 volumiotest volumiobt[2664]: [171B blob data] Feb 11 12:28:12 volumiotest volumiobt[2664]: [182B blob data] Feb 11 12:28:12 volumiotest volumiobt[2664]: [182B blob data] Feb 11 12:28:12 volumiotest volumiobt[2664]: [154B blob data] Feb 11 12:28:12 volumiotest volumiobt[2664]: [154B blob data] Feb 11 12:28:12 volumiotest volumiobt[2664]: [154B blob data] Feb 11 12:28:12 volumiotest volumiobt[2664]: [154B blob data] Feb 11 12:28:12 volumiotest volumiobt[2664]: [154B blob data] Feb 11 12:28:12 volumiotest volumiobt[2664]: [154B blob data] Feb 11 12:28:12 volumiotest volumiobt[2664]: [159B blob data] Feb 11 12:28:12 volumiotest volumiobt[2664]: [113B blob data] Feb 11 12:28:12 volumiotest volumiobt[2664]: [Pixel 10 Pro]> discoverable on Feb 11 12:28:12 volumiotest volumiobt[2664]: Warning: setting discoverable while discoverable-timeout not set(0) is not recommended Feb 11 12:28:12 volumiotest bluetoothd[1061]: Path / reserved for Adv Monitor app :1.34 Feb 11 12:28:12 volumiotest volumiobt[2664]: [Pixel 10 Pro]> pairable on Feb 11 12:28:12 volumiotest volumiobt[2664]: [133B blob data] Feb 11 12:28:12 volumiotest volumiobt[2664]: [131B blob data] Feb 11 12:28:12 volumiotest bluetoothd[1061]: Adv Monitor app :1.34 disconnected from D-Bus Feb 11 12:28:12 volumiotest volumiobt[2664]: [Pixel 10 Pro]> Feb 11 12:28:12 volumiotest volumiobt[2665]: INFO [BTSTART] Registering Bluetooth agent... Feb 11 12:28:13 volumiotest volumiobt[2666]: [NEW] Media /org/bluez/hci0 Feb 11 12:28:13 volumiotest volumiobt[2666]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb Feb 11 12:28:13 volumiotest volumiobt[2666]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb Feb 11 12:28:13 volumiotest volumiobt[2666]: SupportedUUIDs: 0000FDF0-0000-1000-8000-00805f9b34fb Feb 11 12:28:13 volumiotest volumiobt[2666]: [NEW] Player /org/bluez/hci0/dev_30_E0_44_48_72_C3/avrcp/player0 [default] Feb 11 12:28:13 volumiotest volumiobt[2666]: [NEW] Item /org/bluez/hci0/dev_30_E0_44_48_72_C3/avrcp/player0/NowPlaying /NowPlaying Feb 11 12:28:13 volumiotest volumiobt[2666]: [NEW] Item /org/bluez/hci0/dev_30_E0_44_48_72_C3/avrcp/player0/Filesystem /Filesystem Feb 11 12:28:13 volumiotest volumiobt[2666]: [NEW] Endpoint /org/bluez/hci0/dev_30_E0_44_48_72_C3/sep6 Feb 11 12:28:13 volumiotest volumiobt[2666]: [NEW] Endpoint /org/bluez/hci0/dev_30_E0_44_48_72_C3/sep5 Feb 11 12:28:13 volumiotest volumiobt[2666]: [NEW] Endpoint /org/bluez/hci0/dev_30_E0_44_48_72_C3/sep4 Feb 11 12:28:13 volumiotest volumiobt[2666]: [NEW] Endpoint /org/bluez/hci0/dev_30_E0_44_48_72_C3/sep3 Feb 11 12:28:13 volumiotest volumiobt[2666]: [NEW] Endpoint /org/bluez/hci0/dev_30_E0_44_48_72_C3/sep2 Feb 11 12:28:13 volumiotest volumiobt[2666]: [NEW] Endpoint /org/bluez/hci0/dev_30_E0_44_48_72_C3/sep1 Feb 11 12:28:13 volumiotest volumiobt[2666]: [NEW] Transport /org/bluez/hci0/dev_30_E0_44_48_72_C3/sep1/fd0 Feb 11 12:28:13 volumiotest bluetoothd[1061]: Path / reserved for Adv Monitor app :1.35 Feb 11 12:28:13 volumiotest bluetoothd[1061]: Adv Monitor app :1.35 disconnected from D-Bus Feb 11 12:28:13 volumiotest volumiobt[2668]: No agent is registered Feb 11 12:28:13 volumiotest volumiobt[2668]: [NEW] Media /org/bluez/hci0 Feb 11 12:28:13 volumiotest volumiobt[2668]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb Feb 11 12:28:13 volumiotest volumiobt[2668]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb Feb 11 12:28:13 volumiotest volumiobt[2668]: SupportedUUIDs: 0000FDF0-0000-1000-8000-00805f9b34fb Feb 11 12:28:13 volumiotest volumiobt[2668]: [NEW] Player /org/bluez/hci0/dev_30_E0_44_48_72_C3/avrcp/player0 [default] Feb 11 12:28:13 volumiotest volumiobt[2668]: [NEW] Item /org/bluez/hci0/dev_30_E0_44_48_72_C3/avrcp/player0/NowPlaying /NowPlaying Feb 11 12:28:13 volumiotest volumiobt[2668]: [NEW] Item /org/bluez/hci0/dev_30_E0_44_48_72_C3/avrcp/player0/Filesystem /Filesystem Feb 11 12:28:13 volumiotest volumiobt[2668]: [NEW] Endpoint /org/bluez/hci0/dev_30_E0_44_48_72_C3/sep6 Feb 11 12:28:13 volumiotest volumiobt[2668]: [NEW] Endpoint /org/bluez/hci0/dev_30_E0_44_48_72_C3/sep5 Feb 11 12:28:13 volumiotest volumiobt[2668]: [NEW] Endpoint /org/bluez/hci0/dev_30_E0_44_48_72_C3/sep4 Feb 11 12:28:13 volumiotest volumiobt[2668]: [NEW] Endpoint /org/bluez/hci0/dev_30_E0_44_48_72_C3/sep3 Feb 11 12:28:13 volumiotest volumiobt[2668]: [NEW] Endpoint /org/bluez/hci0/dev_30_E0_44_48_72_C3/sep2 Feb 11 12:28:13 volumiotest volumiobt[2668]: [NEW] Endpoint /org/bluez/hci0/dev_30_E0_44_48_72_C3/sep1 Feb 11 12:28:13 volumiotest volumiobt[2668]: [NEW] Transport /org/bluez/hci0/dev_30_E0_44_48_72_C3/sep1/fd0 Feb 11 12:28:13 volumiotest bluetoothd[1061]: Path / reserved for Adv Monitor app :1.36 Feb 11 12:28:13 volumiotest bluetoothd[1061]: Adv Monitor app :1.36 disconnected from D-Bus Feb 11 12:28:13 volumiotest volumiobt[2669]: INFO [BTSTART] Agent registered successfully. Feb 11 12:28:13 volumiotest volumiobt[2672]: INFO [BTSTART] Starting A2DP agent (a2dp-agent)... Feb 11 12:28:14 volumiotest sudo[2676]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-11 12:27' Feb 11 12:28:14 volumiotest sudo[2676]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"