-- Logs begin at Wed 2025-03-12 20:44:09 EDT, end at Wed 2025-03-12 21:14:59 EDT. -- Mar 12 21:13:11 volumiomain go-librespot[1296]: time="2025-03-12T21:13:11-04:00" level=trace msg="sent dealer ping" Mar 12 21:13:11 volumiomain go-librespot[1296]: time="2025-03-12T21:13:11-04:00" level=trace msg="received dealer pong" Mar 12 21:13:41 volumiomain go-librespot[1296]: time="2025-03-12T21:13:41-04:00" level=trace msg="received accesspoint ping" Mar 12 21:13:41 volumiomain go-librespot[1296]: time="2025-03-12T21:13:41-04:00" level=trace msg="received accesspoint pong ack" Mar 12 21:13:41 volumiomain go-librespot[1296]: time="2025-03-12T21:13:41-04:00" level=trace msg="sent dealer ping" Mar 12 21:13:41 volumiomain go-librespot[1296]: time="2025-03-12T21:13:41-04:00" level=trace msg="received dealer pong" Mar 12 21:13:42 volumiomain volumio[989]: verbose: New Socket.io Connection to 192.168.198.140 from 192.168.198.251 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_2 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7 Mar 12 21:13:42 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 12 21:13:42 volumiomain volumio[989]: info: CoreCommandRouter::volumioGetVisibleSources Mar 12 21:13:42 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 12 21:13:42 volumiomain volumio[989]: info: CoreCommandRouter::volumioGetState Mar 12 21:13:42 volumiomain volumio[989]: info: CorePlayQueue::getTrack 0 Mar 12 21:13:42 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 12 21:13:42 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 12 21:13:42 volumiomain volumio[989]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Mar 12 21:13:42 volumiomain volumio[989]: info: Received Get System Info Mar 12 21:13:42 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 12 21:13:42 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 12 21:13:42 volumiomain volumio[989]: info: Discovery: Getting this device information Mar 12 21:13:42 volumiomain volumio[989]: info: CoreCommandRouter::volumioGetState Mar 12 21:13:42 volumiomain volumio[989]: info: CorePlayQueue::getTrack 0 Mar 12 21:13:42 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 12 21:13:42 volumiomain volumio[989]: info: CoreCommandRouter::volumioGetState Mar 12 21:13:42 volumiomain volumio[989]: info: CorePlayQueue::getTrack 0 Mar 12 21:13:42 volumiomain volumio[989]: info: Listing playlists Mar 12 21:13:42 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 12 21:13:48 volumiomain volumio[989]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 12 21:13:48 volumiomain volumio[989]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 12 21:13:48 volumiomain volumio[989]: info: Retrieving Cloud Streaming UI Mar 12 21:13:48 volumiomain volumio[989]: info: Getting Tidal Cloud Configuration Mar 12 21:13:48 volumiomain volumio[989]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 12 21:13:48 volumiomain volumio[989]: info: Getting Qobuz Cloud Configuration Mar 12 21:13:48 volumiomain volumio[989]: info: Asking plugin for UI Config Mar 12 21:13:48 volumiomain volumio[989]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 12 21:13:48 volumiomain volumio[989]: info: Getting Spotify Cloud Configuration Mar 12 21:13:48 volumiomain volumio[989]: info: Asking plugin for UI Config Mar 12 21:13:48 volumiomain volumio[989]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 12 21:13:48 volumiomain volumio[989]: info: Saving Spotify Acccount Mar 12 21:13:48 volumiomain volumio[989]: info: Got it Mar 12 21:13:48 volumiomain volumio[989]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 12 21:13:48 volumiomain volumio[989]: info: Got Tidal Cloud Configuration Mar 12 21:13:48 volumiomain volumio[989]: info: Got it Mar 12 21:13:48 volumiomain volumio[989]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 12 21:13:48 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 12 21:13:48 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 12 21:13:48 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 12 21:13:48 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 12 21:13:48 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 12 21:13:48 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 12 21:13:48 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 12 21:13:49 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 12 21:13:49 volumiomain volumio[989]: info: CoreCommandRouter::volumioGetBrowseSources Mar 12 21:13:49 volumiomain volumio[989]: info: CoreCommandRouter::volumioGetBrowseSources Mar 12 21:13:49 volumiomain volumio[989]: info: CoreCommandRouter::volumioGetBrowseSources Mar 12 21:13:49 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 12 21:13:49 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 12 21:13:53 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 12 21:13:57 volumiomain volumio[989]: info: Disabling MyMusic plugin bluetooth Mar 12 21:13:57 volumiomain volumio[989]: info: [MyVolumio PluginManager] Disabling and stopping plugin audio_interface bluetooth Mar 12 21:13:57 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 12 21:13:57 volumiomain sudo[5484]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumiobt.service Mar 12 21:13:57 volumiomain sudo[5484]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 21:13:57 volumiomain systemd[1]: Stopping Volumio Bluetooth Module... Mar 12 21:13:57 volumiomain volumiobt[5486]: Killing pulse Mar 12 21:13:57 volumiomain volumiobt[5486]: Killing BT Pair agent Mar 12 21:13:57 volumiomain bluetoothd[778]: Endpoint unregistered: sender=:1.51 path=/MediaEndpoint/A2DPSource Mar 12 21:13:57 volumiomain bluetoothd[778]: Endpoint unregistered: sender=:1.51 path=/MediaEndpoint/A2DPSink Mar 12 21:13:57 volumiomain volumio[989]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 12 21:13:57 volumiomain systemd[1]: volumiobt.service: Main process exited, code=killed, status=15/TERM Mar 12 21:13:57 volumiomain systemd[1]: volumiobt.service: Succeeded. Mar 12 21:13:57 volumiomain systemd[1]: Stopped Volumio Bluetooth Module. Mar 12 21:13:57 volumiomain sudo[5484]: pam_unix(sudo:session): session closed for user root Mar 12 21:13:57 volumiomain volumio[989]: info: Volumio BT Module successfully stopped Mar 12 21:13:57 volumiomain volumio[989]: info: Disabling plugin bluetooth Mar 12 21:14:01 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 12 21:14:01 volumiomain volumio[989]: info: Disabling MyMusic plugin upnp_browser Mar 12 21:14:01 volumiomain volumio[989]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesMedia Servers Mar 12 21:14:01 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 12 21:14:01 volumiomain volumio[989]: Cannot find translation for source YouTube Music Mar 12 21:14:01 volumiomain volumio[989]: Cannot find translation for source LastFM Mar 12 21:14:01 volumiomain volumio[989]: Cannot find translation for source Spotify Mar 12 21:14:01 volumiomain volumio[989]: Cannot find translation for source TIDAL Mar 12 21:14:01 volumiomain volumio[989]: info: Disabling plugin upnp_browser Mar 12 21:14:01 volumiomain volumio[989]: info: Done. Mar 12 21:14:03 volumiomain volumio[989]: info: Disabling MyMusic plugin airplay_emulation Mar 12 21:14:03 volumiomain volumio[989]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesShairport-Sync Mar 12 21:14:03 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 12 21:14:03 volumiomain volumio[989]: Cannot find translation for source YouTube Music Mar 12 21:14:03 volumiomain volumio[989]: Cannot find translation for source LastFM Mar 12 21:14:03 volumiomain volumio[989]: Cannot find translation for source Spotify Mar 12 21:14:03 volumiomain volumio[989]: Cannot find translation for source TIDAL Mar 12 21:14:04 volumiomain volumio[989]: info: Disabling plugin airplay_emulation Mar 12 21:14:04 volumiomain volumio[989]: info: Done. Mar 12 21:14:04 volumiomain sudo[5491]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync Mar 12 21:14:04 volumiomain sudo[5491]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 21:14:04 volumiomain systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 12 21:14:04 volumiomain systemd[1]: shairport-sync.service: Succeeded. Mar 12 21:14:04 volumiomain systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 12 21:14:04 volumiomain volumio[989]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 12 21:14:04 volumiomain sudo[5491]: pam_unix(sudo:session): session closed for user root Mar 12 21:14:04 volumiomain volumio[989]: info: Shairport-Sync Stopped Mar 12 21:14:05 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 12 21:14:06 volumiomain volumio[989]: info: Enabling MyMusic plugin airplay_emulation Mar 12 21:14:06 volumiomain volumio[989]: info: Enabling plugin airplay_emulation Mar 12 21:14:06 volumiomain volumio[989]: info: Loading plugin "airplay_emulation"... Mar 12 21:14:06 volumiomain volumio[989]: info: Starting Shairport Sync Mar 12 21:14:06 volumiomain volumio[989]: info: PLUGIN START: airplay_emulation Mar 12 21:14:06 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 21:14:06 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 12 21:14:06 volumiomain volumio[989]: xcb_connection_has_error() returned true Mar 12 21:14:06 volumiomain volumio[989]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 12 21:14:06 volumiomain volumio[989]: xcb_connection_has_error() returned true Mar 12 21:14:06 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 12 21:14:06 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 12 21:14:06 volumiomain volumio[989]: xcb_connection_has_error() returned true Mar 12 21:14:06 volumiomain volumio[989]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 12 21:14:06 volumiomain volumio[989]: xcb_connection_has_error() returned true Mar 12 21:14:06 volumiomain volumio[989]: info: Done. Mar 12 21:14:06 volumiomain volumio[989]: info: Starting Shairport Sync Mar 12 21:14:06 volumiomain volumio[989]: info: Starting Shairport Sync Mar 12 21:14:06 volumiomain sudo[5516]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 12 21:14:06 volumiomain sudo[5516]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 21:14:06 volumiomain sudo[5519]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 12 21:14:06 volumiomain sudo[5519]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 21:14:06 volumiomain systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 12 21:14:06 volumiomain sudo[5516]: pam_unix(sudo:session): session closed for user root Mar 12 21:14:06 volumiomain volumio[989]: info: Shairport-Sync Started Mar 12 21:14:06 volumiomain systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 12 21:14:06 volumiomain systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Mar 12 21:14:06 volumiomain systemd[1]: shairport-sync.service: Succeeded. Mar 12 21:14:06 volumiomain systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 12 21:14:06 volumiomain volumio[989]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 12 21:14:06 volumiomain systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 12 21:14:06 volumiomain volumio[989]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 12 21:14:06 volumiomain sudo[5519]: pam_unix(sudo:session): session closed for user root Mar 12 21:14:06 volumiomain volumio[989]: info: Shairport-Sync Started Mar 12 21:14:08 volumiomain volumio[989]: info: Disabling MyMusic plugin upnp Mar 12 21:14:09 volumiomain sudo[5526]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Mar 12 21:14:09 volumiomain sudo[5526]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 21:14:09 volumiomain systemd[1]: Stopping UPnP Renderer front-end to MPD... Mar 12 21:14:09 volumiomain volumio[989]: error: Upnp client error: Error: This socket has been ended by the other party Mar 12 21:14:09 volumiomain volumio[989]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 12 21:14:09 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 12 21:14:11 volumiomain go-librespot[1296]: time="2025-03-12T21:14:11-04:00" level=trace msg="sent dealer ping" Mar 12 21:14:11 volumiomain go-librespot[1296]: time="2025-03-12T21:14:11-04:00" level=trace msg="received dealer pong" Mar 12 21:14:13 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 12 21:14:14 volumiomain volumio[989]: info: Disabling MyMusic plugin metavolumio Mar 12 21:14:14 volumiomain volumio[989]: info: [MyVolumio PluginManager] Disabling and stopping plugin miscellanea metavolumio Mar 12 21:14:14 volumiomain volumio[989]: info: Removing METAVOLUMIO REST API Endpoints Mar 12 21:14:14 volumiomain volumio[989]: info: Removing metavolumio REST Endpoint Mar 12 21:14:14 volumiomain volumio[989]: info: Removing getSimilarArtists REST Endpoint Mar 12 21:14:14 volumiomain volumio[989]: info: Removing getSimilarAlbums REST Endpoint Mar 12 21:14:14 volumiomain volumio[989]: info: Removing getSimilarTracks REST Endpoint Mar 12 21:14:14 volumiomain volumio[989]: info: Disabling plugin metavolumio Mar 12 21:14:16 volumiomain volumio[989]: info: Disabling MyMusic plugin cd_controller Mar 12 21:14:16 volumiomain volumio[989]: info: [MyVolumio PluginManager] Disabling and stopping plugin music_service cd_controller Mar 12 21:14:16 volumiomain volumio[989]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesAudio CD Mar 12 21:14:16 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 12 21:14:16 volumiomain volumio[989]: Cannot find translation for source YouTube Music Mar 12 21:14:16 volumiomain volumio[989]: Cannot find translation for source LastFM Mar 12 21:14:16 volumiomain volumio[989]: Cannot find translation for source Spotify Mar 12 21:14:16 volumiomain volumio[989]: Cannot find translation for source TIDAL Mar 12 21:14:16 volumiomain volumio[989]: info: Stopping UDEV Watcher for CD Mar 12 21:14:16 volumiomain volumio[989]: info: Disabling plugin cd_controller Mar 12 21:14:17 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 12 21:14:21 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 12 21:14:25 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 12 21:14:29 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 12 21:14:33 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 12 21:14:37 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 12 21:14:41 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 12 21:14:41 volumiomain go-librespot[1296]: time="2025-03-12T21:14:41-04:00" level=trace msg="sent dealer ping" Mar 12 21:14:41 volumiomain go-librespot[1296]: time="2025-03-12T21:14:41-04:00" level=trace msg="received dealer pong" Mar 12 21:14:45 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 12 21:14:49 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 12 21:14:49 volumiomain volumio[989]: info: Enabling MyMusic plugin metavolumio Mar 12 21:14:49 volumiomain volumio[989]: info: [MyVolumio PluginManager] Enabling and starting plugin miscellanea metavolumio Mar 12 21:14:49 volumiomain volumio[989]: info: Enabling plugin metavolumio Mar 12 21:14:49 volumiomain volumio[989]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Mar 12 21:14:49 volumiomain volumio[989]: info: Adding METAVOLUMIO REST API Endpoints Mar 12 21:14:49 volumiomain volumio[989]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Mar 12 21:14:49 volumiomain volumio[989]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Mar 12 21:14:49 volumiomain volumio[989]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Mar 12 21:14:49 volumiomain volumio[989]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Mar 12 21:14:49 volumiomain volumio[989]: info: Done. Mar 12 21:14:51 volumiomain volumio[989]: info: Enabling MyMusic plugin bluetooth Mar 12 21:14:51 volumiomain volumio[989]: info: [MyVolumio PluginManager] Enabling and starting plugin audio_interface bluetooth Mar 12 21:14:51 volumiomain volumio[989]: info: Enabling plugin bluetooth Mar 12 21:14:51 volumiomain volumio[989]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Mar 12 21:14:51 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 12 21:14:51 volumiomain volumio[989]: info: Done. Mar 12 21:14:51 volumiomain sudo[5632]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name VolumioMAIN Mar 12 21:14:51 volumiomain sudo[5632]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 21:14:51 volumiomain sudo[5632]: pam_unix(sudo:session): session closed for user root Mar 12 21:14:51 volumiomain volumio[989]: info: Bluetooth name changed to VolumioMAIN Mar 12 21:14:52 volumiomain volumio[989]: info: Enabling MyMusic plugin upnp_browser Mar 12 21:14:52 volumiomain volumio[989]: info: Enabling plugin upnp_browser Mar 12 21:14:52 volumiomain volumio[989]: info: Loading plugin "upnp_browser"... Mar 12 21:14:52 volumiomain volumio[989]: info: PLUGIN START: upnp_browser Mar 12 21:14:52 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 12 21:14:52 volumiomain volumio[989]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 12 21:14:52 volumiomain volumio[989]: info: [1741828492426] CoreMusicLibrary::Adding element Media Servers Mar 12 21:14:52 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 12 21:14:52 volumiomain volumio[989]: Cannot find translation for source YouTube Music Mar 12 21:14:52 volumiomain volumio[989]: Cannot find translation for source LastFM Mar 12 21:14:52 volumiomain volumio[989]: Cannot find translation for source Spotify Mar 12 21:14:52 volumiomain volumio[989]: Cannot find translation for source TIDAL Mar 12 21:14:52 volumiomain volumio[989]: info: Done. Mar 12 21:14:53 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 12 21:14:54 volumiomain sudo[5638]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Mar 12 21:14:54 volumiomain sudo[5638]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 21:14:54 volumiomain volumio[989]: info: Disabling MyMusic plugin upnp Mar 12 21:14:54 volumiomain systemd[1]: Started Volumio Bluetooth Module. Mar 12 21:14:54 volumiomain sudo[5642]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Mar 12 21:14:54 volumiomain sudo[5642]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 21:14:54 volumiomain sudo[5638]: pam_unix(sudo:session): session closed for user root Mar 12 21:14:54 volumiomain sudo[5643]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Mar 12 21:14:54 volumiomain sudo[5643]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 21:14:55 volumiomain volumiobt[5640]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Mar 12 21:14:55 volumiomain sudo[5643]: pam_unix(sudo:session): session closed for user root Mar 12 21:14:55 volumiomain volumio[989]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 12 21:14:55 volumiomain volumio[989]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 12 21:14:55 volumiomain volumio[989]: info: Volumio BT Module successfully started Mar 12 21:14:56 volumiomain sudo[5647]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Mar 12 21:14:56 volumiomain sudo[5647]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 12 21:14:56 volumiomain volumiobt[5640]: pulseaudio: no process found Mar 12 21:14:56 volumiomain sudo[5647]: pam_unix(sudo:session): session closed for user root Mar 12 21:14:56 volumiomain pulseaudio[5651]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Mar 12 21:14:56 volumiomain pulseaudio[5651]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Mar 12 21:14:56 volumiomain volumiobt[5640]: Applying permissions Mar 12 21:14:56 volumiomain volumiobt[5640]: Setting BT discoverable and pairable Mar 12 21:14:56 volumiomain bluetoothd[778]: Endpoint registered: sender=:1.76 path=/MediaEndpoint/A2DPSource Mar 12 21:14:56 volumiomain bluetoothd[778]: Endpoint registered: sender=:1.76 path=/MediaEndpoint/A2DPSink Mar 12 21:14:56 volumiomain pulseaudio[5651]: 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 12 21:14:56 volumiomain volumiobt[5640]: Agent registered Mar 12 21:14:56 volumiomain volumiobt[5640]: [bluetooth]# -e power on Mar 12 21:14:56 volumiomain volumiobt[5640]: Invalid command in menu main: -e Mar 12 21:14:56 volumiomain volumiobt[5640]: Mar 12 21:14:56 volumiomain volumiobt[5640]: Use "help" for a list of available commands in a menu. Mar 12 21:14:56 volumiomain volumiobt[5640]: Use "menu " if you want to enter any submenu. Mar 12 21:14:56 volumiomain volumiobt[5640]: Use "back" if you want to return to menu main. Mar 12 21:14:56 volumiomain volumiobt[5640]: [bluetooth]# agent on Mar 12 21:14:56 volumiomain volumiobt[5640]: Agent is already registered Mar 12 21:14:56 volumiomain volumiobt[5640]: [bluetooth]# discoverable on Mar 12 21:14:56 volumiomain volumiobt[5640]: [bluetooth]# pairable on Mar 12 21:14:56 volumiomain volumiobt[5640]: [bluetooth]# agent NoInputNoOutput Mar 12 21:14:56 volumiomain volumiobt[5640]: Agent is already registered Mar 12 21:14:56 volumiomain volumiobt[5640]: [bluetooth]# default-agent Mar 12 21:14:56 volumiomain volumiobt[5640]: [bluetooth]# quit Mar 12 21:14:56 volumiomain volumiobt[5640]: [59B blob data] Mar 12 21:14:57 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 12 21:14:58 volumiomain volumio[989]: info: Enabling MyMusic plugin upnp Mar 12 21:14:58 volumiomain volumio[989]: info: Enabling plugin upnp Mar 12 21:14:58 volumiomain volumio[989]: info: Loading plugin "upnp"... Mar 12 21:14:58 volumiomain volumio[989]: info: [1741828498216] Starting Upmpd Daemon Mar 12 21:14:58 volumiomain volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 12 21:14:58 volumiomain volumio[989]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 12 21:14:58 volumiomain volumio[989]: Error: listen EADDRINUSE: address already in use :::6599 Mar 12 21:14:58 volumiomain volumio[989]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Mar 12 21:14:58 volumiomain volumio[989]: at listenInCluster (net.js:1366:12) Mar 12 21:14:58 volumiomain volumio[989]: at Server.listen (net.js:1452:7) Mar 12 21:14:58 volumiomain volumio[989]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Mar 12 21:14:58 volumiomain volumio[989]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Mar 12 21:14:58 volumiomain volumio[989]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Mar 12 21:14:58 volumiomain volumio[989]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Mar 12 21:14:58 volumiomain volumio[989]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Mar 12 21:14:58 volumiomain volumio[989]: code: 'EADDRINUSE', Mar 12 21:14:58 volumiomain volumio[989]: errno: -98, Mar 12 21:14:58 volumiomain volumio[989]: syscall: 'listen', Mar 12 21:14:58 volumiomain volumio[989]: address: '::', Mar 12 21:14:58 volumiomain volumio[989]: port: 6599 Mar 12 21:14:58 volumiomain volumio[989]: } Mar 12 21:14:58 volumiomain volumio[989]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 12 21:14:59 volumiomain sudo[5680]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-12 21:13 Mar 12 21:14:59 volumiomain sudo[5680]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 11:42:54 AM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4049a67f1c09d4a94e033ba35a80a144"