BLE - Gigaset Keeper ca. 30s present, dann dauerhaft absent

[zontorro]

Hallo zusammen,

ich habe basierend auf dieser Anleitung (http://reimann2.de/heimautomatisierung/fhem45.html) einen Gigaset Keeper eingerichtet mit lepresenced-0.83-3 und bluetoothctl.

Nach einem Raspberry-Reboot schaltet der PRESENCE-Zustand auf "present", der BLE-Tag wird also erkannt. Nach ca. 30s jedoch wechselt der Zustand auf "absent" und bleibt dort dauerhaft.

Wenn ich nochmals einen Reboot mache, schaltet er wieder auf present und kurz darauf wieder zurück. Mittels

Code Auswählen Erweitern

hcitool lescan und auch am Smartphone mit BLEScanner ist der Tag weiterhin zu finden.

Den Tag habe ich, wie in der Anleitung beschrieben, direkt mit dem Raspberry gepairt.

Kann mir jemand helfen das Problem zu lösen?

Technische Daten:
-Gigaset Keeper
-Raspberry Pi 3 Model B
-internes BT-Modul verwendet, kein USB-BT
-System ist auf aktuellem Stand
-lepresenced V0.9-1
-Homematic-CUL angeschlossen
-Elero-Stick angeschlossen
-sonst keine weiteren Funkmodule

Danke und Grüße
zontorro

PRESENCE-obj list

Code Auswählen Erweitern


Internals:
   ADDRESS    58:9E:C6:09:D5:45
   CHANGED   
   DEF        lan-bluetooth 58:9E:C6:09:D5:45 127.0.0.1:5333    10
   DeviceName 127.0.0.1:5333
   FD         22
   FUUID      5e0e1bc3-f33f-67bb-e40e-09ce7ed8bcb9d88e
   INTERVAL_NORMAL 10
   INTERVAL_PRESENT 10
   MODE       lan-bluetooth
   NAME       Keeper_Flo
   NOTIFYDEV  global
   NR         242
   NTFY_ORDER 50-Keeper_Flo
   PARTIAL   
   STATE      absent
   TYPE       PRESENCE
   Helper:
     DBLOG:
       model:
         DBLogging:
           TIME       1578322703.27523
           VALUE      lan-lepresenced
       presence:
         DBLogging:
           TIME       1578322758.05919
           VALUE      absent
       rssi:
         DBLogging:
           TIME       1578322758.05919
           VALUE      unreachable
       state:
         DBLogging:
           TIME       1578322758.05919
           VALUE      absent
   READINGS:
     2020-01-06 15:22:57   command_accepted yes
     2020-01-06 16:08:08   daemon          lepresenced V0.9
     2020-01-06 15:59:08   device_name     Gigaset keeper
     2020-01-06 16:08:08   model           lan-lepresenced
     2020-01-06 16:08:08   presence        absent
     2020-01-06 16:08:08   rssi            unreachable
     2020-01-06 16:08:08   state           absent
   helper:
     CURRENT_STATE present
     CURRENT_TIMEOUT normal
Attributes:
   event-on-change-reading .*

[PatrickR]

Deinstalliere mal die Bluetooth-Pakete aus dem Tutorial (blueman etc.) wieder und danach nur das lepresenced-Paket inkl. Abhängigkeiten.


Von unterwegs gesendet.

[mumpitzstuff]

Vielleicht ein Rechteproblem? lescan benötigt normalerweise root Rechte. lepresenced hat diese vielleicht nicht und kann deshalb den Service gar nicht starten. Was kommt denn bei:

Code Auswählen Erweitern

ps -aux | grep hcitool

Aktuell ist der present Status wahrscheinlich der Startwert und da lepresenced nie einen Status bekommt, geht der Status nach 30s auf absend.


Hier ist beschrieben, wie man das auch mal kurz ändern kann, um dieses Problem auszuschliessen:

https://forum.fhem.de/index.php/topic,68104.msg999291.html#msg999291

[zontorro]

@PatrickR:
Ich habe alles deinstalliert und lepresenced0.9-1 neu installiert, das Problem besteht immer noch...

@mumpitzstuff:
Der Tag wird richtig erkannt, wenn ich ihn in den Keller trage und anschließend reboote ist er direkt auf absent. Zurück damit in die Wohnung und nach dem Reboot startet er kurz mit present. Nichtsdestotrotz habe ich die Schritte im verlinkten Post ausgeführt:

ps -aux VOR Änderung:

Code Auswählen Erweitern

pi@fhempi:~ $ ps -aux | grep hcitool
root      1230  0.0  0.0   2552   624 ?        S    13:21   0:00 hcitool -i hci0 lescan --duplicates
pi        1575  0.0  0.0   4368   548 pts/0    S+   13:28   0:00 grep --color=auto hcitool

ps -aux NACH Änderung:

Code Auswählen Erweitern

pi@fhempi:~ $ ps -aux | grep hcitool
root      1297  0.0  0.0   2552   656 ?        S    13:36   0:00 hcitool -i hci0 lescan --duplicates
pi        2181  0.0  0.0   4368   536 pts/0    S+   14:30   0:00 grep --color=auto hcitool

Weiterhin ist es nicht möglich, hcitool lescan ohne "sudo" auszuführen

Code Auswählen Erweitern


pi@fhempi:~ $ hcitool lescan
Set scan parameters failed: Operation not permitted
pi@fhempi:~ $ sudo hcitool lescan
LE Scan ...
[...]
XX:XX:XX:XX:XX:XX Gigaset keeper
[...]


Der Keeper ist weiterhin über hcitool auffindbar währen fhem ihn als "absent" markiert.

Gibt es noch weitere Lösungsvorschläge?

[mumpitzstuff]

Der Zugriff ist exklusiv. Läuft lepresenced, dann darfst du mit diesem Bluetooth Dongle nichts mehr machen, sonst funktioniert lepresenced nur mit Aussetzern oder gar nicht mehr.
Hast du z.b. bletagbattery auf dem gleichen hci Device laufen, dann hast du die Ursache gefunden.

[PatrickR]

Guten Abend,

ok, lasst uns mal strukturiert vorgehen.

1.) Bitte mal die Ausgabe posten von dpkg -l|egrep '(hci|blue)'
2.) Benutzt Du noch irgendwelche andere Bluetooth-Funktionalitäten? (Das PRESENCE-Modul mit local-bluetooth etc.)?
3.) Kannst Du mal testweise das Batterieskript komplett deaktivieren?
4.) Bitte setze mal den Loglevel auf LOG_DEBUG und poste ein Log vom Start bis zum Auftreten des Problems.

Patrick

/Edit: Update nach nochmaligem Lesen der verlinkten Anleitung.

[zontorro]

1)

Code Auswählen Erweitern

pi@fhempi:~ $ dpkg -l|egrep '(hci|blue)'
rc  bluealsa                              0.9                                armhf        Bluetooth ALSA Audio backend
ii  bluej                                 3.1.7b                             all          A simple but powerful Java IDE.
rc  blueman                               2.0.4-1+b4                         armhf        Graphical bluetooth manager
ii  bluetooth                             5.43-2+rpt2+deb9u2                 all          Bluetooth support
ii  bluez                                 5.43-2+rpt2+deb9u2                 armhf        Bluetooth tools and daemons
ii  bluez-firmware                        1.2-3+rpt7                         all          Firmware for Bluetooth devices
ii  bluez-hcidump                         5.43-2+rpt2+deb9u2                 armhf        Analyses Bluetooth HCI packets
ii  bluez-obexd                           5.43-2+rpt2+deb9u2                 armhf        bluez obex daemon
ii  libbluetooth3:armhf                   5.43-2+rpt2+deb9u2                 armhf        Library to use the BlueZ Linux Bluetooth stack
ii  lxplug-bluetooth                      0.6                                armhf        Bluetooth plugin for lxpanel
ii  pi-bluetooth                          0.1.10                             all          Raspberry Pi 3 bluetooth


2) Ich benutze das PRESENCE-Modul nur für den Gigaset Keeper, der Modus steht auf "lan-bluetooth", das vollständige device-list ist im ersten Post.
3) Da es bisher noch gar nicht richtig funktioniert hat mit dem presence-Status habe ich den Batterieteil noch gar nicht umgesetzt
4) Hier der Log ab Boot-Zeitpunkt bis zum dauerhaften "absent", dieses mal hat es 2x hin- und hergewechselt.
Der BT-Tag liegt einen knappen Meter vom Raspberry entfernt, an der Reichweite sollte es also nicht liegen...

Code Auswählen Erweitern

22:42:42 3: Opening Keeper_Flo device 127.0.0.1:5333
22:42:42 5: SW: 58:9E:C6:09:D5:45|10
22:42:42 3: Keeper_Flo device opened
22:42:42 0: Featurelevel: 5.9
22:42:42 0: Server started with 208 defined entities (fhem.pl:20415/2019-10-27 perl:5.024001 os:linux user:fhem pid:904)
22:42:42 5: PRESENCE (Keeper_Flo) - received data: command accepted
22:42:42 5: PRESENCE (Keeper_Flo) - received data: present;device_name=Gigaset keeper;rssi=-63;model=lan-lepresenced;daemon=lepresenced V0.9
22:42:59 5: PRESENCE (Keeper_Flo) - received data: absence;rssi=unreachable;model=lan-lepresenced;daemon=lepresenced V0.9
22:43:09 5: PRESENCE (Keeper_Flo) - received data: present;device_name=Gigaset keeper;rssi=-64;model=lan-lepresenced;daemon=lepresenced V0.9
22:43:19 5: PRESENCE (Keeper_Flo) - received data: absence;rssi=unreachable;model=lan-lepresenced;daemon=lepresenced V0.9
22:43:29 5: PRESENCE (Keeper_Flo) - received data: absence;rssi=unreachable;model=lan-lepresenced;daemon=lepresenced V0.9
22:43:39 5: PRESENCE (Keeper_Flo) - received data: absence;rssi=unreachable;model=lan-lepresenced;daemon=lepresenced V0.9
22:43:49 5: PRESENCE (Keeper_Flo) - received data: absence;rssi=unreachable;model=lan-lepresenced;daemon=lepresenced V0.9
22:43:59 5: PRESENCE (Keeper_Flo) - received data: absence;rssi=unreachable;model=lan-lepresenced;daemon=lepresenced V0.9
22:44:09 5: PRESENCE (Keeper_Flo) - received data: absence;rssi=unreachable;model=lan-lepresenced;daemon=lepresenced V0.9
22:44:19 5: PRESENCE (Keeper_Flo) - received data: absence;rssi=unreachable;model=lan-lepresenced;daemon=lepresenced V0.9
22:44:29 5: PRESENCE (Keeper_Flo) - received data: absence;rssi=unreachable;model=lan-lepresenced;daemon=lepresenced V0.9
22:44:39 5: PRESENCE (Keeper_Flo) - received data: absence;rssi=unreachable;model=lan-lepresenced;daemon=lepresenced V0.9
22:44:49 5: PRESENCE (Keeper_Flo) - received data: absence;rssi=unreachable;model=lan-lepresenced;daemon=lepresenced V0.9

Vielen Dank schon mal für die Unterstützung!

[PatrickR]

Hi!

1)

Code Auswählen Erweitern

pi@fhempi:~ $ dpkg -l|egrep '(hci|blue)'
rc  bluealsa                              0.9                                armhf        Bluetooth ALSA Audio backend
ii  bluej                                 3.1.7b                             all          A simple but powerful Java IDE.
rc  blueman                               2.0.4-1+b4                         armhf        Graphical bluetooth manager
ii  bluetooth                             5.43-2+rpt2+deb9u2                 all          Bluetooth support
ii  bluez                                 5.43-2+rpt2+deb9u2                 armhf        Bluetooth tools and daemons
ii  bluez-firmware                        1.2-3+rpt7                         all          Firmware for Bluetooth devices
ii  bluez-hcidump                         5.43-2+rpt2+deb9u2                 armhf        Analyses Bluetooth HCI packets
ii  bluez-obexd                           5.43-2+rpt2+deb9u2                 armhf        bluez obex daemon
ii  libbluetooth3:armhf                   5.43-2+rpt2+deb9u2                 armhf        Library to use the BlueZ Linux Bluetooth stack
ii  lxplug-bluetooth                      0.6                                armhf        Bluetooth plugin for lxpanel
ii  pi-bluetooth                          0.1.10                             all          Raspberry Pi 3 bluetooth


Da ist noch einiges installiert, was nicht (für lepresenced) benötigt wird und ggf. Nebenwirkungen verursacht.

Code Auswählen Erweitern

22:42:42 3: Opening Keeper_Flo device 127.0.0.1:5333
22:42:42 5: SW: 58:9E:C6:09:D5:45|10
22:42:42 3: Keeper_Flo device opened
22:42:42 0: Featurelevel: 5.9
22:42:42 0: Server started with 208 defined entities (fhem.pl:20415/2019-10-27 perl:5.024001 os:linux user:fhem pid:904)
22:42:42 5: PRESENCE (Keeper_Flo) - received data: command accepted
[...]


Das FHEM-Log ist leider keine gute Quelle für Informationen. lepresenced loggt ins Syslog:

Code Auswählen Erweitern


grep lepresenced /var/log/syslog

Bitte auf jeden Fall vorher den Loglevel auf LOG_DEBUG setzen. Dafür musst Du - wenn Du das Paket verwendest - in /etc/default/lepresenced die Zeile

Code Auswählen Erweitern


#SYSLOG_LEVEL="LOG_WARNING"

in

Code Auswählen Erweitern


SYSLOG_LEVEL="LOG_DEBUG"

ändern. Achtung, das Hashzeichen am Anfang muss auch weg. Dann lepresenced neu starten und ihn loggen lassen bis das Problem auftritt. Den Log-Level solltest Du auf jeden Fall später zurücksetzen, damit die SD-Karte nicht überstrapaziert wird.

Patrick

[zontorro]

So jetzt hab ich alles leergeräumt und anschließend lepresence0.9-1 neu installiert, da bei der Installation unerfüllte Abhängkeiten zu libnet-server-perl, bluez und bluez-hcidump anmeckert habe ich diese durch "apt --fix-broken install" installiert.
Jetzt sieht das dpkg-listing so aus:

Code Auswählen Erweitern

root@fhempi:/home/pi# dpkg -l|egrep '(hci|blue)'
ii  bluez                                 5.43-2+rpt2+deb9u2                 armhf        Bluetooth tools and daemons
ii  bluez-hcidump                         5.43-2+rpt2+deb9u2                 armhf        Analyses Bluetooth HCI packets

Jetzt ist der Keeper dauerhaft (auch direkt nach dem Reboot) auf absent.
Ein "hcitool lescan" wird mit "Could not open device: No such device" beantwortet.

Code Auswählen Erweitern

root@fhempi:/home/pi# hcitool lescan
Could not open device: No such device

Ausgabe im syslog:

Code Auswählen Erweitern


root@fhempi:/home/pi# grep lepresenced /var/log/syslog
22:12:19 fhempi systemd[1]: Starting lepresenced...
22:12:29 fhempi systemd[1]: Started lepresenced.
22:12:29 fhempi lepresenced[1192]: [tid:0] main: Version 0.9 started (device: hci0, listen addr: 0.0.0.0, listen port: 5333, daemonize: 0, legacy mode: 0, rssi threshold: 10, log level: 7, debug: 0).
22:12:29 fhempi lepresenced[1192]: [tid:0] main::sanity_check: md5 digest of '/usr/sbin/lepresenced' is: efa3c9088eddd1bdbc428cf52c6562d1.
22:12:29 fhempi lepresenced[1192]: [tid:0] main::sanity_check: hciconfig found at '/bin/hciconfig'.
22:12:29 fhempi lepresenced[1192]: [tid:0] main::sanity_check: hcitool found at '/usr/bin/hcitool'.
22:12:29 fhempi lepresenced[1192]: [tid:0] main::sanity_check: hcidump found at '/usr/bin/hcidump'.
22:12:30 fhempi lepresenced[1192]: [tid:2] main::bluetooth_dump_thread: hcidump exited, retrying...
22:12:30 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: Received unknown output: 'Invalid device: No such device'!
22:12:30 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...
22:12:31 fhempi lepresenced[1192]: [tid:2] main::bluetooth_dump_thread: hcidump exited, retrying...
22:12:31 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: Received unknown output: 'Invalid device: No such device'!
22:12:31 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...
22:12:32 fhempi lepresenced[1192]: [tid:2] main::bluetooth_dump_thread: hcidump exited, retrying...
22:12:32 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: Received unknown output: 'Invalid device: No such device'!
22:12:32 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...
22:12:33 fhempi lepresenced[1192]: [tid:2] main::bluetooth_dump_thread: hcidump exited, retrying...
22:12:33 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: Received unknown output: 'Invalid device: No such device'!
22:12:33 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...
22:12:34 fhempi lepresenced[1192]: [tid:2] main::bluetooth_dump_thread: hcidump exited, retrying...
22:12:34 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: Received unknown output: 'Invalid device: No such device'!
22:12:34 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...
22:12:35 fhempi lepresenced[1192]: [tid:2] main::bluetooth_dump_thread: hcidump exited, retrying...
22:12:35 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: Received unknown output: 'Invalid device: No such device'!
22:12:35 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...
22:12:36 fhempi lepresenced[1192]: [tid:2] main::bluetooth_dump_thread: hcidump exited, retrying...
22:12:36 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: Received unknown output: 'Invalid device: No such device'!
22:12:36 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...
22:12:37 fhempi lepresenced[1192]: [tid:2] main::bluetooth_dump_thread: hcidump exited, retrying...
22:12:37 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: Received unknown output: 'Invalid device: No such device'!
22:12:37 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...
22:12:38 fhempi lepresenced[1192]: [tid:2] main::bluetooth_dump_thread: hcidump exited, retrying...
22:12:38 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: Received unknown output: 'Invalid device: No such device'!
22:12:38 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...
22:12:39 fhempi lepresenced[1192]: [tid:2] main::bluetooth_dump_thread: hcidump exited, retrying...
22:12:39 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: Received unknown output: 'Invalid device: No such device'!
22:12:39 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...
22:12:40 fhempi lepresenced[1192]: [tid:2] main::bluetooth_dump_thread: hcidump exited, retrying...
22:12:40 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: Received unknown output: 'Invalid device: No such device'!
22:12:40 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...
22:12:40 fhempi lepresenced[1192]: [tid:0] main: Connection from 127.0.0.1:38152. Connected clients: 1.
22:12:40 fhempi lepresenced[1192]: [tid:0] main::handle_command: Received query for mac address 58:9e:c6:09:d5:45, interval: 10. Adding client 127.0.0.1:38152 to clients list.
22:12:40 fhempi lepresenced[1192]: [tid:0] main: Connection from 127.0.0.1:38154. Connected clients: 2.
22:12:40 fhempi lepresenced[1192]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 10, result: absence.
22:12:41 fhempi lepresenced[1192]: [tid:2] main::bluetooth_dump_thread: hcidump exited, retrying...
22:12:41 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: Received unknown output: 'Invalid device: No such device'!
22:12:41 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...
22:12:42 fhempi lepresenced[1192]: [tid:2] main::bluetooth_dump_thread: hcidump exited, retrying...
22:12:42 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: Received unknown output: 'Invalid device: No such device'!
22:12:42 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...
22:12:43 fhempi lepresenced[1192]: [tid:2] main::bluetooth_dump_thread: hcidump exited, retrying...
22:12:43 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: Received unknown output: 'Invalid device: No such device'!
22:12:43 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...
22:12:44 fhempi lepresenced[1192]: [tid:2] main::bluetooth_dump_thread: hcidump exited, retrying...
22:12:44 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: Received unknown output: 'Invalid device: No such device'!
22:12:44 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...
22:12:45 fhempi lepresenced[1192]: [tid:2] main::bluetooth_dump_thread: hcidump exited, retrying...
22:12:45 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: Received unknown output: 'Invalid device: No such device'!
22:12:45 fhempi lepresenced[1192]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...

Ich vermute jetzt fehlt das pi-bluetooth Paket? Direkt nach Installieren des pi-bluetooth-Pakets wechselt der Keeper wieder wie bisher nach ~30s auf absent.

syslog:

Code Auswählen Erweitern


23:04:35 fhempi systemd[1]: Starting lepresenced...
23:04:45 fhempi systemd[1]: Started lepresenced.
23:04:45 fhempi lepresenced[1242]: [tid:0] main: Version 0.9 started (device: hci0, listen addr: 0.0.0.0, listen port: 5333, daemonize: 0, legacy mode: 0, rssi threshold: 10, log level: 7, debug: 0).
23:04:45 fhempi lepresenced[1242]: [tid:0] main::sanity_check: md5 digest of '/usr/sbin/lepresenced' is: 79a271f5171f90ef5b0e9f0e1258a431.
23:04:45 fhempi lepresenced[1242]: [tid:0] main::sanity_check: hciconfig found at '/bin/hciconfig'.
23:04:45 fhempi lepresenced[1242]: [tid:0] main::sanity_check: hcitool found at '/usr/bin/hcitool'.
23:04:45 fhempi lepresenced[1242]: [tid:0] main::sanity_check: hcidump found at '/usr/bin/hcidump'.
23:04:45 fhempi lepresenced[1242]: [tid:1] main::bluetooth_scan_thread: Received 'LE Scan ...'.
23:04:57 fhempi lepresenced[1242]: [tid:0] main: Connection from 127.0.0.1:36250. Connected clients: 1.
23:04:57 fhempi lepresenced[1242]: [tid:0] main::handle_command: Received query for mac address 58:9e:c6:09:d5:45, interval: 10. Adding client 127.0.0.1:36250 to clients list.
23:04:57 fhempi lepresenced[1242]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, ages: 0/1, max age: 10, rssi: -63, result: present.
23:05:12 fhempi lepresenced[1242]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, ages: 9/9, max age: 10, rssi: -62, result: present.
23:05:22 fhempi lepresenced[1242]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, ages: 4/4, max age: 10, rssi: -61, result: present.
23:05:32 fhempi lepresenced[1242]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 10, result: absence.
23:05:42 fhempi lepresenced[1242]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 10, result: absence.
[...]
23:09:42 fhempi lepresenced[1242]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 10, result: absence.
23:09:46 fhempi lepresenced[1242]: [tid:0] main::stats_task: Active clients: 1, known devices: 12 (min/max age: 267/273), received beacons (hcitool/hcidump/difference): 2945/393/2552
23:09:52 fhempi lepresenced[1242]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 10, result: absence.
23:10:02 fhempi lepresenced[1242]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 10, result: absence.


dpkg-list nach pi-bluetooth install:

Code Auswählen Erweitern

root@fhempi:/home/pi# dpkg -l|egrep '(hci|blue)'
ii  bluez                                 5.43-2+rpt2+deb9u2                 armhf        Bluetooth tools and daemons
ii  bluez-firmware                        1.2-3+rpt7                         all          Firmware for Bluetooth devices
ii  bluez-hcidump                         5.43-2+rpt2+deb9u2                 armhf        Analyses Bluetooth HCI packets
ii  pi-bluetooth                          0.1.10                             all          Raspberry Pi 3 bluetooth

[PatrickR]

Ich vermute jetzt fehlt das pi-bluetooth Paket? Direkt nach Installieren des pi-bluetooth-Pakets wechselt der Keeper wieder wie bisher nach ~30s auf absent.

[...]

dpkg-list nach pi-bluetooth install:

Code Auswählen Erweitern

root@fhempi:/home/pi# dpkg -l|egrep '(hci|blue)'
ii  bluez                                 5.43-2+rpt2+deb9u2                 armhf        Bluetooth tools and daemons
ii  bluez-firmware                        1.2-3+rpt7                         all          Firmware for Bluetooth devices
ii  bluez-hcidump                         5.43-2+rpt2+deb9u2                 armhf        Analyses Bluetooth HCI packets
ii  pi-bluetooth                          0.1.10                             all          Raspberry Pi 3 bluetooth

Du hast Recht. pi-bluetooth fehlt tatsächlich als Dependency im Paket. Jetzt sieht es aber gut aus.

syslog:

Code Auswählen Erweitern


23:04:35 fhempi systemd[1]: Starting lepresenced...
23:04:45 fhempi systemd[1]: Started lepresenced.
23:04:45 fhempi lepresenced[1242]: [tid:0] main: Version 0.9 started (device: hci0, listen addr: 0.0.0.0, listen port: 5333, daemonize: 0, legacy mode: 0, rssi threshold: 10, log level: 7, debug: 0).
[...]
23:09:42 fhempi lepresenced[1242]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 10, result: absence.
23:09:46 fhempi lepresenced[1242]: [tid:0] main::stats_task: Active clients: 1, known devices: 12 (min/max age: 267/273), received beacons (hcitool/hcidump/difference): 2945/393/2552
23:09:52 fhempi lepresenced[1242]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 10, result: absence.
23:10:02 fhempi lepresenced[1242]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 10, result: absence.


Was man auch gut sieht, ist, dass hcitool deutlich mehr (2945) Beacons sieht als hcidump (393). Das werde ich mal als weiteren Indikator für (D)ein Problem im Hinterkopf behalten. Tausche doch mal bitte bei sonst unverändertem System das lepresenced-Skript durch das hier angehängte aus und starte den Dienst (oder den Pi) neu:

Code Auswählen Erweitern


cp /usr/sbin/lepresenced{,.org}
cp lepresenced.0.91dev /usr/sbin
service lepresenced restart

Danach muss in FHEM das Reading "daemon" des PRESENCE-Devices "lepresenced V0.91dev1" sein. Dann bitte schauen, ob das Problem noch auftritt und sowohl bei ja als auch nein brauche ich ein Log mit LOG_DEBUG wie oben.

Patrick

[zontorro]

Der cp[...]{,.org} von dir hat nicht bewirkt, dass in fhem 0.91dev1 als daemon steht. Deswegen habe ich das existierende "lepresenced"-file gesichert und durch deines überschrieben. Anschließend kam irgendein access-denied-Fehler -> ich habe mit chmod die Berechtigungen von "-rw-r--r--" auf "-rwxr--r--" gedreht, so wie das Original-Skript war.

Funktioniert leider immer noch nicht, weiterhin kurz auf present und anschließend auf absent.

Code Auswählen Erweitern

21:40:20 fhempi systemd[1]: Starting lepresenced...
21:40:30 fhempi systemd[1]: Started lepresenced.
21:40:30 fhempi lepresenced[1221]: [tid:0] main: Version 0.91dev1 started (device: hci0, listen addr: 0.0.0.0, listen port: 5333, daemonize: 0, legacy mode: 0, rssi threshold: 10, log level: 7, debug: 0).
21:40:30 fhempi lepresenced[1221]: [tid:0] main::sanity_check: md5 digest of '/usr/sbin/lepresenced' is: 7d51ceee533bf831a61f5c69a34922c9.
21:40:30 fhempi lepresenced[1221]: [tid:0] main::sanity_check: hciconfig found at '/bin/hciconfig'.
21:40:30 fhempi lepresenced[1221]: [tid:0] main::sanity_check: hcitool found at '/usr/bin/hcitool'.
21:40:30 fhempi lepresenced[1221]: [tid:0] main::sanity_check: hcidump found at '/usr/bin/hcidump'.
21:40:30 fhempi lepresenced[1221]: [tid:1] main::bluetooth_scan_thread: Received 'LE Scan ...'.
21:40:41 fhempi lepresenced[1221]: [tid:0] main: Connection from 127.0.0.1:59196. Connected clients: 1.
21:40:41 fhempi lepresenced[1221]: [tid:0] main::handle_command: Received query for mac address 58:9e:c6:09:d5:45, interval: 10. Adding client 127.0.0.1:59196 to clients list.
21:40:41 fhempi lepresenced[1221]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, ages: 1/1, max age: 10, rssi: -64, result: present.
21:40:58 fhempi lepresenced[1221]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, ages: 10/10, max age: 10, rssi: -64, result: present.
21:41:08 fhempi lepresenced[1221]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, ages: 8/9, max age: 10, rssi: -63, result: present.
21:41:18 fhempi lepresenced[1221]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 10, result: absence.
21:41:28 fhempi lepresenced[1221]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 10, result: absence.
21:41:38 fhempi lepresenced[1221]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 10, result: absence.
21:41:48 fhempi lepresenced[1221]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 10, result: absence.
21:41:58 fhempi lepresenced[1221]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 10, result: absence.
21:42:08 fhempi lepresenced[1221]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 10, result: absence.

Kleine Anmerkung:
Ich habe den Keeper, wie in der Anleitung die ich gefunden habe beschrieben ist, mit dem Raspberry gepairt. Kann das Probleme verursachen? Ich hätte noch einen weiteren ungepairten Keeper rumliegen. Ich befürchte jedoch, dass sich der Keeper im ungepairten Zustand nach einer gewissen Zeit ausschaltet und er durch Drücken des Knopfes wieder gestartet werden muss. Zumindest verschwindet er im BLE Scanner nach 2min.
Der gepairte Keeper ist dauerhaft auffindbar.

[zontorro]

Nachtrag:
Den ungepairten Keeper habe ich jetzt im "wachen" Zustand in FHEM wiefolgt definiert:

Code Auswählen Erweitern

define Keeper_unpaired PRESENCE lan-bluetooth xx:xx:xx:xx:xx:xx 127.0.0.1:5333    60

Das Verhalten ist identisch wie beim gepairten Keeper.

[juemuc]

Hallo zontorro,

reicht ein

Code Auswählen Erweitern

PRESENCE local-bluetooth nicht aus?
Bei mir ist das Smartphone so eingebunden.

Viele Grüße
Jürgen

[PatrickR]

reicht ein

Code Auswählen Erweitern

PRESENCE local-bluetooth nicht aus?
Bei mir ist das Smartphone so eingebunden.

Dein Smartphone ist kein Bluetooth-LE-Gerät, der Keeper schon.

Patrick


Von unterwegs gesendet.

[PatrickR]

@Zontorro: Schaue mir das morgen nochmal näher an. Was noch helfen würde wäre ein Log, in dem mindestens eine stats_task-Zeile nach dem Problem auftaucht.

Ich habe auch einen Keeper, der aber nicht mit dem Pi gepaart ist. Weitere Erfahrungen habe ich leider nicht.


Von unterwegs gesendet.

[CoolTux]

War das nicht so das die Keeper gar nicht dauerhaft aktiv sind um ungepeerten Zustand sondern immer nur kurz beim Druck auf den Knopf???

[PatrickR]

War das nicht so das die Keeper gar nicht dauerhaft aktiv sind um ungepeerten Zustand sondern immer nur kurz beim Druck auf den Knopf???

Das habe ich auch immer geglaubt, aber mein Keeper sendet dauerhaft, was er anfangs nicht tat.


Von unterwegs gesendet.

[mumpitzstuff]

Ist dein Raspberry über wlan verbunden oder ethernet?

[PatrickR]

Code Auswählen Erweitern

21:40:20 fhempi systemd[1]: Starting lepresenced...
21:40:30 fhempi systemd[1]: Started lepresenced.
21:40:30 fhempi lepresenced[1221]: [tid:0] main: Version 0.91dev1 started (device: hci0, listen addr: 0.0.0.0, listen port: 5333, daemonize: 0, legacy mode: 0, rssi threshold: 10, log level: 7, debug: 0).
[...]
21:41:18 fhempi lepresenced[1221]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 10, result: absence.
21:41:28 fhempi lepresenced[1221]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 10, result: absence.
21:41:38 fhempi lepresenced[1221]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 10, result: absence.
21:41:48 fhempi lepresenced[1221]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 10, result: absence.
21:41:58 fhempi lepresenced[1221]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 10, result: absence.
21:42:08 fhempi lepresenced[1221]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 10, result: absence.


Ich bin gerade irgendwie etwas ratlos. Was Du noch probieren kannst, falls noch nicht gesehen: Beende mal sämtliche anderen Geräte, die auf den Keeper zugreifen, auch den BLE-Scanner (der eigentlich passiv sein sollte).

Wenn das nicht geht, könntest Du entweder einen externen Bluetooth-Stick probieren, einen "classic" G-Tag (also keinen Keeper), um das Problem einzugrenzen.

Falls Du auf die Ausgabe der RSSI verzichten kannst, kannst Du lepresenced auch testweise im legacy mode betreiben. Dazu in der Datei /etc/default/lepresenced die Zeile

Code Auswählen Erweitern


#MISC_OPTIONS=""

in

Code Auswählen Erweitern


MISC_OPTIONS="--legacy"

ändern und lepresenced durchstarten.

Patrick

[zontorro]

Hier kommt der Log mit einigen stats_task-Meldungen:

Code Auswählen Erweitern

root@fhempi:/home/pi# tail -f /var/log/syslog | grep lepresenced
Jan 10 19:44:11 fhempi lepresenced[1267]: [tid:0] main: Connection from 127.0.0.1:44722. Connected clients: 1.
Jan 10 19:44:11 fhempi lepresenced[1267]: [tid:0] main::handle_command: Received query for mac address 58:9e:c6:09:d5:45, interval: 30. Adding client 127.0.0.1:44722 to clients list.
Jan 10 19:44:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, ages: 1/1, max age: 30, rssi: -69, result: present.
Jan 10 19:44:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, ages: 8/8, max age: 30, rssi: -69, result: present.
Jan 10 19:45:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:45:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:46:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:46:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:47:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:47:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:48:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:48:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:49:01 fhempi lepresenced[1267]: [tid:0] main::stats_task: Active clients: 1, known devices: 14 (min/max age: 267/272), received beacons (hcitool/hcidump/difference): 334/332/2
Jan 10 19:49:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:49:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:50:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:50:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:51:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:51:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:52:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:52:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:53:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:53:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:54:02 fhempi lepresenced[1267]: [tid:0] main::stats_task: Active clients: 1, known devices: 14 (min/max age: 568/573), received beacons (hcitool/hcidump/difference): 334/332/2
Jan 10 19:54:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:54:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:55:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:55:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:56:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:56:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:57:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:57:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:58:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:58:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:59:01 fhempi lepresenced[1267]: [tid:0] main::cleanup_task: Cleanup finished, deleted 0 devices in 0 seconds.
Jan 10 19:59:03 fhempi lepresenced[1267]: [tid:0] main::stats_task: Active clients: 1, known devices: 14 (min/max age: 869/874), received beacons (hcitool/hcidump/difference): 334/332/2
Jan 10 19:59:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 19:59:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:00:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:00:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:01:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:01:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:02:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:02:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:03:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:03:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:04:04 fhempi lepresenced[1267]: [tid:0] main::stats_task: Active clients: 1, known devices: 14 (min/max age: 1170/1175), received beacons (hcitool/hcidump/difference): 334/332/2
Jan 10 20:04:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:04:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:05:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:05:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:06:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:06:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:07:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:07:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:08:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:08:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:09:05 fhempi lepresenced[1267]: [tid:0] main::stats_task: Active clients: 1, known devices: 14 (min/max age: 1471/1476), received beacons (hcitool/hcidump/difference): 334/332/2
Jan 10 20:09:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:09:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:10:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:10:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:11:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:11:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:12:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:12:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:13:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:13:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:14:02 fhempi lepresenced[1267]: [tid:0] main::cleanup_task: Cleanup finished, deleted 0 devices in 0 seconds.
Jan 10 20:14:06 fhempi lepresenced[1267]: [tid:0] main::stats_task: Active clients: 1, known devices: 14 (min/max age: 1772/1777), received beacons (hcitool/hcidump/difference): 334/332/2
Jan 10 20:14:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:14:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:15:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:15:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:16:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:16:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:17:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:17:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:18:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:18:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:19:07 fhempi lepresenced[1267]: [tid:0] main::stats_task: Active clients: 1, known devices: 14 (min/max age: 2073/2078), received beacons (hcitool/hcidump/difference): 334/332/2
Jan 10 20:19:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:19:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:20:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:20:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:21:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:21:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:22:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:22:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:23:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:23:41 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.
Jan 10 20:24:08 fhempi lepresenced[1267]: [tid:0] main::stats_task: Active clients: 1, known devices: 14 (min/max age: 2374/2379), received beacons (hcitool/hcidump/difference): 334/332/2
Jan 10 20:24:11 fhempi lepresenced[1267]: [tid:0] main: Sending update for mac address 58:9e:c6:09:d5:45, max age: 30, result: absence.


Also Workaround kann ich ja den Raspberry alle 30s neu starten 

[zontorro]

Ich bin gerade irgendwie etwas ratlos. Was Du noch probieren kannst, falls noch nicht gesehen: Beende mal sämtliche anderen Geräte, die auf den Keeper zugreifen, auch den BLE-Scanner (der eigentlich passiv sein sollte).

Den BLE-Scanner hatte ich nur ab und zu an, eigentlich sollte der ja nicht dazwischenfunken. Ich hab es auch schon getestet als das Handy komplett aus war.

RSSI brauch ich eigentlich nicht, ich werde es damit testen. Dankeschön schonmal

[zontorro]

War das nicht so das die Keeper gar nicht dauerhaft aktiv sind um ungepeerten Zustand sondern immer nur kurz beim Druck auf den Knopf???

Ja so verhält er sich bei mir auch, aber dadurch dass ich den Keeper mit dem Raspberry gepairt habe ist er dauerhaft an (Validiert durch BLEScanner-App am Smartphone)

[PatrickR]

Also den stats_task-Zeilen nach zu schließen kannst Du Dir den legacymode schenken. :/


Von unterwegs gesendet.

[zontorro]

Ich über trotzdem getestet, einziger Unterschied: "present" hält jetzt statt 30s ca. 2mun durch.

[PatrickR]

Hi!

Ich über trotzdem getestet, einziger Unterschied: "present" hält jetzt statt 30s ca. 2mun durch.

Tjo, dann bleibt nur noch BLE-Gerät tauschen, ggf. Tag tauschen. Falls Du zufällig im Umkreis Berlin wohnst könnte ich Dir aushelfen.

/Edit: mumpitzstuff hatte oben noch nach der Netzwerkverbindung Deines Raspi gefragt. Vielleicht hat er noch eine Idee.

Patrick

[zontorro]

Der Raspberry hängt am Netzwerkkabel.

Vielen Dank für das Angebot ich komme allerdings aus dem Raum Stuttgart...
Ich habe aber ein paar neue Philips Hue Birnen die neuerdings alle mit Bluetooth LE ausgestattet sind. Ich hab eine davon identisch zum Keeper eingerichtet.
Nach dem Reboot ist sowohl der Keeper als auch die Birne auf present, dieses mal hat es 5min gedauert und dann wechseln beide zeitgleich auf absent.
Es müsste also an der Konfiguration bzw. dem Raspberry liegen und nicht am Keeper.

Ich bestelle jetzt einen Bluetooth-Stick, vielleicht hilft das ja...
Edit: Gibt es geeignete und ungeeignete BT-Sticks für den Raspberry Model3 B?

[zontorro]

Eine weitere Erkenntnis:

Wenn ich über SSH

Code Auswählen Erweitern

sudo hcitool lescan --duplicates ausführe, schaltet der Keeper in fhem auf "present". Der Befehl schreibt jetzt fortlaufend alle BLE-Devices ins Terminal, bis er nach einiger Zeit einfach hängen bleibt, dann wechselt FHEM auch wieder auf "absent".
Ist das die Funktion die FHEM aufruft?

[mumpitzstuff]

WLAN im 2,4ghz Bereich stören sich erheblich und Bluetooth kann dadurch abstürzen. Da dein Pi aber am Kabel hängt, dürfte das nicht das Problem sein (es sei denn daneben steht dein wlan Router oder sowas). Das interne Bluetooth macht allerdings oft Probleme, dazu findet man viele Berichte im Internet. Bei manchen gehts problemlos und bei anderen kackt es immer wieder ab.
Was passiert eigentlich wenn du sudo hciconfig reset schickst oder down und dann up. Funktioniert er dann wieder kurze Zeit?
Kauf dir mal für weniger als 10€ einen externen Dongle, um einen Vergleich zu haben. Irgendeinen der einen CSR 4.0 Chip drauf hat, die machen die wenigsten Probleme.

[zontorro]

So, der BT-USB kam heute an:
1. Reingesteckt
2. internes pi-bluetooth entfernt
3. reboot
4. sucess

Ich verstehe nicht wieso es das interne BT-Modul nicht schafft, aber solange jetzt alles funktioniert ist es ja gut.

Danke an alle für die Unterstützung!

[gestein]

Hallo zontorro,

ich kämpfe auch immer wieder mit Problemen.
Wie hast Du denn das "interne pi-bluetooth" entfernt?
Gibt es Deine Probleme noch, wenn das interne pi-bluetooth noch läuft?

lg, Gerhard

[mumpitzstuff]

Code Auswählen Erweitern

echo "dtoverlay=pi3-disable-bt" | sudo tee -a /boot/config.txt

Für den Pi 3 so z.b.