Mal wieder BLE Probleme

[Thomas Braun]

@tenor-0

libcap2 installiert?
Kommando dazu ausgeführt?
Siehe oben.

[Tenor 0]

@thomas-braun
ging wahrscheinlich wegen doppelpost unter, ja ich hatte das schon gemacht. leider kein Unterschied.
lescan geht, unter iobroker, kommen keinen neuen Geräte mehr dazu. (Haken in den Einstellungen ist gesetzt)

[Thomas Braun]

@tenor-0 sagte in Mal wieder BLE Probleme:

ja ich hatte das schon gemacht. l

Die Ausgaben dazu würde ich gerne sehen.

[Tenor 0]

@thomas-braun

matthias@server:/usr/libexec/bluetooth$ sudo apt update
OK:1 http://de.archive.ubuntu.com/ubuntu noble InRelease
OK:2 http://security.ubuntu.com/ubuntu noble-security InRelease
OK:3 http://de.archive.ubuntu.com/ubuntu noble-updates InRelease
OK:4 http://de.archive.ubuntu.com/ubuntu noble-backports InRelease
Paketlisten werden gelesen… Fertig
Abhängigkeitsbaum wird aufgebaut… Fertig
Statusinformationen werden eingelesen… Fertig
Alle Pakete sind aktuell.
matthias@server:/usr/libexec/bluetooth$ sudo apt install libcap2-bin
Paketlisten werden gelesen… Fertig
Abhängigkeitsbaum wird aufgebaut… Fertig
Statusinformationen werden eingelesen… Fertig
libcap2-bin ist schon die neueste Version (1:2.66-5ubuntu2).
Die folgenden Pakete wurden automatisch installiert und werden nicht mehr benötigt:
  mailcap wmdocker
Verwenden Sie »sudo apt autoremove«, um sie zu entfernen.
0 aktualisiert, 0 neu installiert, 0 zu entfernen und 0 nicht aktualisiert.
matthias@server:/usr/libexec/bluetooth$ sudo setcap cap_net_raw+eip $(eval readlink -f `which node`)
matthias@server:/usr/libexec/bluetooth$
matthias@server:/usr/libexec/bluetooth$

[Tenor 0]

ich stosse immer wieder auf die Meldung:
bluetoothd[3674]: Failed to set privacy: Rejected (0x0b)

2024-10-12T20:41:52.551245+02:00 server systemd[1]: bluetooth.service: Deactivated successfully.
2024-10-12T20:41:52.551384+02:00 server systemd[1]: Stopped bluetooth.service - Bluetooth service.
2024-10-12T20:41:54.589079+02:00 server systemd[1]: Configuration file /run/systemd/system/netplan-ovs-cleanup.service is marked world-inaccessible. This has no effect as configuration data is accessible via APIs without restrictions. Proceeding anyway.
2024-10-12T20:41:54.814941+02:00 server systemd[1]: Configuration file /run/systemd/system/systemd-networkd-wait-online.service.d/10-netplan.conf is marked world-inaccessible. This has no effect as configuration data is accessible via APIs without restrictions. Proceeding anyway.
2024-10-12T20:41:55.201508+02:00 server (uetoothd)[3674]: bluetooth.service: ConfigurationDirectory 'bluetooth' already exists but the mode is different. (File system: 755 ConfigurationDirectoryMode: 555)
2024-10-12T20:41:55.201632+02:00 server systemd[1]: Starting bluetooth.service - Bluetooth service...
2024-10-12T20:41:55.250612+02:00 server bluetoothd[3674]: Bluetooth daemon 5.72
2024-10-12T20:41:55.251545+02:00 server systemd[1]: Started bluetooth.service - Bluetooth service.
2024-10-12T20:41:55.251591+02:00 server bluetoothd[3674]: Starting SDP server
2024-10-12T20:41:55.251620+02:00 server bluetoothd[3674]: Excluding (cli) sap
2024-10-12T20:41:55.251891+02:00 server bluetoothd[3674]: src/plugin.c:plugin_init() System does not support csip plugin
2024-10-12T20:41:55.251945+02:00 server bluetoothd[3674]: profiles/audio/micp.c:micp_init() D-Bus experimental not enabled
2024-10-12T20:41:55.251988+02:00 server bluetoothd[3674]: src/plugin.c:plugin_init() System does not support micp plugin
2024-10-12T20:41:55.252020+02:00 server bluetoothd[3674]: src/plugin.c:plugin_init() System does not support vcp plugin
2024-10-12T20:41:55.252045+02:00 server bluetoothd[3674]: src/plugin.c:plugin_init() System does not support mcp plugin
2024-10-12T20:41:55.252070+02:00 server bluetoothd[3674]: src/plugin.c:plugin_init() System does not support bass plugin
2024-10-12T20:41:55.252095+02:00 server bluetoothd[3674]: src/plugin.c:plugin_init() System does not support bap plugin
2024-10-12T20:41:55.252554+02:00 server bluealsa: bluez.c:1199: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded()
2024-10-12T20:41:55.252690+02:00 server dbus-daemon[971]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.45' (uid=0 pid=3674 comm="/usr/libexec/bluetooth/bluetoothd --noplugin=sap" label="unconfined")
2024-10-12T20:41:55.252765+02:00 server bluetoothd[3674]: Bluetooth management interface 1.22 initialized
2024-10-12T20:41:55.252793+02:00 server bluetoothd[3674]: Battery Provider Manager created
2024-10-12T20:41:55.252889+02:00 server bluetoothd[3674]: Failed to set privacy: Rejected (0x0b)
2024-10-12T20:41:55.253179+02:00 server bluealsa: bluez.c:1199: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded()
2024-10-12T20:41:55.271225+02:00 server systemd[1]: Starting systemd-hostnamed.service - Hostname Service...
2024-10-12T20:41:55.347612+02:00 server dbus-daemon[971]: [system] Successfully activated service 'org.freedesktop.hostname1'
2024-10-12T20:41:55.347704+02:00 server systemd[1]: Started systemd-hostnamed.service - Hostname Service.
2024-10-12T20:41:55.356604+02:00 server bluealsa: bluez.c:783: Registering battery provider: /org/bluez/hci0/battery
2024-10-12T20:41:55.357266+02:00 server bluealsa: bluez.c:598: Creating media endpoint object: /org/bluez/hci0/A2DP/SBC/source/1
2024-10-12T20:41:55.357317+02:00 server bluealsa: bluez.c:509: Registering media endpoint: /org/bluez/hci0/A2DP/SBC/source/1
2024-10-12T20:41:55.357504+02:00 server bluetoothd[3674]: Endpoint registered: sender=:1.11 path=/org/bluez/hci0/A2DP/SBC/source/1
2024-10-12T20:41:55.357618+02:00 server bluealsa: bluez.c:598: Creating media endpoint object: /org/bluez/hci0/A2DP/SBC/source/2
2024-10-12T20:41:55.357670+02:00 server bluealsa: bluez.c:509: Registering media endpoint: /org/bluez/hci0/A2DP/SBC/source/2
2024-10-12T20:41:55.357785+02:00 server bluetoothd[3674]: Endpoint registered: sender=:1.11 path=/org/bluez/hci0/A2DP/SBC/source/2
2024-10-12T20:41:55.357890+02:00 server bluealsa: bluez.c:598: Creating media endpoint object: /org/bluez/hci0/A2DP/SBC/sink/1
2024-10-12T20:41:55.357930+02:00 server bluealsa: bluez.c:509: Registering media endpoint: /org/bluez/hci0/A2DP/SBC/sink/1
2024-10-12T20:41:55.358065+02:00 server bluetoothd[3674]: Endpoint registered: sender=:1.11 path=/org/bluez/hci0/A2DP/SBC/sink/1
2024-10-12T20:41:55.358135+02:00 server bluealsa: bluez.c:598: Creating media endpoint object: /org/bluez/hci0/A2DP/SBC/sink/2
2024-10-12T20:41:55.358155+02:00 server bluealsa: bluez.c:509: Registering media endpoint: /org/bluez/hci0/A2DP/SBC/sink/2
2024-10-12T20:41:55.358215+02:00 server bluetoothd[3674]: Endpoint registered: sender=:1.11 path=/org/bluez/hci0/A2DP/SBC/sink/2
2024-10-12T20:41:55.358275+02:00 server bluealsa: bluez.c:1199: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded()
2024-10-12T20:42:25.372785+02:00 server systemd[1]: systemd-hostnamed.service: Deactivated successfully.

meistens verschwindet sie nach dem Neustart des Adapters, weiß aber nicht wie relevant sie ist.

[Thomas Braun]

@tenor-0

rfkill

sagt?

[Tenor 0]

@thomas-braun said in Mal wieder BLE Probleme:

rfkill

alles tuti

matthias@server:~$ rfkill
ID TYPE      DEVICE      SOFT      HARD
 0 bluetooth hci0   unblocked unblocked
 1 wlan      phy0   unblocked unblocked
matthias@server:~$ rfkill list
0: hci0: Bluetooth
        Soft blocked: no
        Hard blocked: no
1: phy0: Wireless LAN
        Soft blocked: no
        Hard blocked: no

[Thomas Braun]

@tenor-0

Den Haken bei 'Neue Gerät akzeptieren' im Adapter hattest du schon mal gesetzt?

[Tenor 0]

@thomas-braun
ja diverse male

[Thomas Braun]

@tenor-0

Dann weiß ich nix mehr dazu.

[Tenor 0]

@thomas-braun
Schade, aber Danke für deine Hilfe!

[haselchen]

@tenor-0

Was sagt

hciconfig --all

[Tenor 0]

matthias@server:~$ sudo hciconfig --all
[sudo] password for matthias:
hci0:   Type: Primary  Bus: USB
        BD Address: 8C:88:4B:05:62:63  ACL MTU: 1021:6  SCO MTU: 255:12
        UP RUNNING
        RX bytes:4613 acl:0 sco:0 events:349 errors:0
        TX bytes:38399 acl:0 sco:0 commands:353 errors:0
        Features: 0xff 0xff 0xff 0xfe 0xdb 0xfd 0x7b 0x87
        Packet type: DM1 DM3 DM5 DH1 DH3 DH5 HV1 HV2 HV3
        Link policy: RSWITCH HOLD SNIFF PARK
        Link mode: PERIPHERAL ACCEPT
        Name: 'RTK_BT_5.0'
        Class: 0x000000
        Service Classes: Unspecified
        Device Class: Miscellaneous,
        HCI Version: 5.1 (0xa)  Revision: 0xdfc6
        LMP Version: 5.1 (0xa)  Subversion: 0xd922
        Manufacturer: Realtek Semiconductor Corporation (93)

matthias@server:~$
matthias@server:~$
matthias@server:~$ sudo hciconfig hci0 down
matthias@server:~$ sudo hciconfig --all
hci0:   Type: Primary  Bus: USB
        BD Address: 8C:88:4B:05:62:63  ACL MTU: 1021:6  SCO MTU: 255:12
        DOWN
        RX bytes:4896 acl:0 sco:0 events:353 errors:0
        TX bytes:38411 acl:0 sco:0 commands:357 errors:0
        Features: 0xff 0xff 0xff 0xfe 0xdb 0xfd 0x7b 0x87
        Packet type: DM1 DM3 DM5 DH1 DH3 DH5 HV1 HV2 HV3
        Link policy: RSWITCH HOLD SNIFF PARK
        Link mode: PERIPHERAL ACCEPT

matthias@server:~$ sudo hciconfig hci0 up
Can't init device hci0: Connection timed out (110)
matthias@server:~$
matthias@server:~$ sudo hciconfig --all
hci0:   Type: Primary  Bus: USB
        BD Address: 8C:88:4B:05:62:63  ACL MTU: 1021:6  SCO MTU: 255:12
        DOWN
        RX bytes:4896 acl:0 sco:0 events:353 errors:0
        TX bytes:38414 acl:0 sco:0 commands:358 errors:0
        Features: 0xff 0xff 0xff 0xfe 0xdb 0xfd 0x7b 0x87
        Packet type: DM1 DM3 DM5 DH1 DH3 DH5 HV1 HV2 HV3
        Link policy: RSWITCH HOLD SNIFF PARK
        Link mode: PERIPHERAL ACCEPT

Nach einem Reboot und anschließendem Neustart des BT Dienstes (das musste wohl wegen dem intern deaktivierten BT Adapter immer gemacht werden) ist auf Linux ebene scheinbar alles ok.
Sobald ich den hci0 down nehme kommt er nicht mehr hoch. Das deutet wohl darauf hin, das es doch noch treiber Probleme o.ä, gibt.

[chris299]

Ich habe auch ein Problem mit BLE, seit ein paar Monaten empfange ich keine Daten mehr (wie ich grade erstaunt festgestellt habe).
mein IOBROKER System (auf Ubuntu 22.04 bare metal) läuft auch schon eine Weile unverändert (nicht zuletzt weil ich etwas Angst vor dem nächsten update habe...), so dass daher m.W. keine Veränderung kam, die das hätte auslösen können....

Der BLE adapter startet anscheinend einwandfrei und zeigt auch grün, aber in den Daten bekomme ich nur
"unknown" in "driverState"....

Der hier https://forum.iobroker.net/topic/30179/ble-adapter-grün-driverstate-unknown?_=1730753369874 dazu genannte Befehl hat nicht geholfen. Das betrifft anscheinend auch eher die "unauthorized" Meldung gem. https://github.com/AlCalzone/ioBroker.ble

Auf OS-Ebene scheint der bluetooth-stack einwandfrei zu funktionieren, z.B. arbeitet hcitool einfwandfrei und zeigt alles wie erwartet....

das Adapter-debug log sieht ein bisschen so aus, als würde der Adapter hängen bleiben, aber er wird ja "grün"...

Habt Ihr noch eine Idee, wo ich hingreifen könnte, um das wieder anzuwerfen?

2024-11-04 21:58:25.157 - info: ble.0 (802921) Got terminate signal TERMINATE_YOURSELF
2024-11-04 21:58:25.159 - info: ble.0 (802921) terminating
2024-11-04 21:58:25.161 - info: ble.0 (802921) Terminated (ADAPTER_REQUESTED_TERMINATION): Without reason
2024-11-04 21:58:25.195 - info: host.HP-EliteDesk-800-G3-DM-35W stopInstance system.adapter.ble.0 send kill signal
2024-11-04 21:58:25.664 - info: ble.0 (802921) terminating
2024-11-04 21:58:25.786 - info: host.HP-EliteDesk-800-G3-DM-35W instance system.adapter.ble.0 terminated with code 11 (ADAPTER_REQUESTED_TERMINATION)
2024-11-04 21:58:28.313 - info: host.HP-EliteDesk-800-G3-DM-35W instance system.adapter.ble.0 started with pid 870418
2024-11-04 21:58:28.706 - debug: ble.0 (870418) Redis Objects: Use Redis connection: 127.0.0.1:9001
2024-11-04 21:58:28.731 - debug: ble.0 (870418) Objects client ready ... initialize now
2024-11-04 21:58:28.732 - debug: ble.0 (870418) Objects create System PubSub Client
2024-11-04 21:58:28.732 - debug: ble.0 (870418) Objects create User PubSub Client
2024-11-04 21:58:28.773 - debug: ble.0 (870418) Objects client initialize lua scripts
2024-11-04 21:58:28.775 - debug: ble.0 (870418) Objects connected to redis: 127.0.0.1:9001
2024-11-04 21:58:28.803 - debug: ble.0 (870418) Redis States: Use Redis connection: 127.0.0.1:9000
2024-11-04 21:58:28.856 - debug: ble.0 (870418) States create System PubSub Client
2024-11-04 21:58:28.857 - debug: ble.0 (870418) States create User PubSub Client
2024-11-04 21:58:28.920 - debug: ble.0 (870418) States connected to redis: 127.0.0.1:9000
2024-11-04 21:58:28.986 - info: ble.0 (870418) starting. Version 0.14.0 in /opt/iobroker/node_modules/iobroker.ble, node: v18.20.4, js-controller: 5.0.19
2024-11-04 21:58:29.048 - info: ble.0 (870418) loaded plugins: Xiaomi, mi-flora, ruuvi-tag, BTHome, _default
2024-11-04 21:58:29.048 - info: ble.0 (870418) enabled plugins: Xiaomi, BTHome, _default
2024-11-04 21:58:29.048 - info: ble.0 (870418) monitoring all services
2024-11-04 21:58:29.097 - info: ble.0 (870418) starting scanner process...
2024-11-04 21:59:17.771 - info: admin.0 (1849) ==> Connected system.user.admin from ::ffff:192.168.246.129
2024-11-04 21:59:36.498 - info: ble.0 (870418) Now accepting new devices

[Thomas Braun]

@chris299 sagte in Mal wieder BLE Probleme:

läuft auch schon eine Weile unverändert

Dann bring jetzt das Ding auf Stand...
Inkl. nodejs und z. B. dem js-controller.

[chris299]

@thomas-braun wenn ich nun den Controller hochziehe und danach die momentan laufenden Versionen diverser Adapter nicht mehr laufen, habe ich ein ernsthaftes Problem, weil die aktuellen Versionen einiger Adapter mit breaking changes daherkommen, und, wie man hier und da lesen kann, kleiner und grössere Problem mitbringen. Allen voran der Zigbee-Adapter, mit dem ich auch lange Schwierigkeiten hatte, bevor er in der nun von mir verwendeten Version für meine Usecases lief.
Insofern ist das für mich erst der letzte Schritt der Experimente.... Vorher würde ich gern erstmal analysieren, wo denn da das Problem eigentlich liegt, bevor ich es mit Expermimenten versuche zu lösen.

[Thomas Braun]

@chris299

Nicht rum schnacken, bring das Ding auf Stand.
Das ist die notwendige Basis für alles weitere.

[chris299]

@thomas-braun also node ist doch mit v18.20.4 auf einem aktuellen Stand. und was den Controller betrifft kann das nicht der Grund für mein Problem sein. Mit meiner derzeitigen Controller-Version und der Adapterversion von BLE lief es ja schon mal.
Und tut mir leid, aber PRODUKTIONS-Systeme updated man nicht mal eben auf Verdacht, besonders dann nicht, wenn man eine Indikation hat, dass andere bisher funktionierende Teile dann nicht mehr funktionieren.....

[Thomas Braun]

@chris299

Nein, nodejs@20 ist aktuell...

Tut mir leid, gerade PRODUKTIONS-Systeme hält man auf einem stabilen Stand.

[chris299]

@thomas-braun sagte in Mal wieder BLE Probleme:

@chris299

Nein, nodejs@20 ist aktuell...

Tut mir leid, gerade PRODUKTIONS-Systeme hält man auf einem stabilen Stand.

genau, und das ist eben oft nicht der neueste Stand.
Und ich würde gern wissen, was das eigentliche Problem ist. Alte Versionen sind nicht pauschal immer das Problem, besonders nicht, wenn sie stabil liefen....

Ich vermute hier eher ein Problem durch ein OS update im Bluetooth stack mit dem der BLE-Adapter nicht zurecht kommt. "undefined" ist IMHO schon ein starkes Indiz hierfür. mich würde dazu die Meinung von @AlCalzone sehr interssieren.... auch dazu, welche weiteren Analyse-möglichkeiten es gibt.