Anwesenheitserkennung Bluetooth PebbleBee

[forum-merlin]

Hallo Leute, Hi PatrickR (long time no see)

nach fast genau 1 Jahr ohne Probleme mit den GTAGs und lepresenced bin ich nun wieder hier im Thread geladet.

Ich habe versucht alle Threads seit meinem letzten Besuch hier im Thread nachzulesen, aber mein Problem wir nicht komplett Thematisiert oder später gelöst.

Daher kurz ein Abriss was diesmal mein Problem ist...

Voraussetzungen:
- 2 GTags von Gigaset
- neue CR2032 eingebaut weil die alten langsam müde wurden.
- RasPi3 mit on Board Bluetooth (FHEM Server, hier wird das ERDGESCHOSS auf die Presence der GTAGs geprüft)
- RasPi1 mit Jessie Lite und darauf nur lepresenced version 0.8-1, dieser prüft nur die GTAGs wenn sie KELLER sind.

- RasPi1 mit stretch lite und darauf (heute installiert) lepresenced version 0.82-1 > Dieser ist eine zusätzliche Installation wegen meines Problems und liegt derzeit im KELLER neben dem anderen Pi1.
- auf der FHEM (RasPi3) wird per Cron das Batteriescript ausgeführt (0 1 * * * /opt/fhem/script/Holger_GtAG_Batterie.sh >/dev/null 2>&1 ; /opt/fhem/script/Mirjam_GtAG_Batterie.sh >/dev/null 2>&1)

Problembeschreibung:
Ich habe seit kurzem das Problem, dass auf meinem FHEM Pi 3 wo also auch das lepresenced läuft, auf einmal meine GTags nicht mehr zuverlässig erkannt werden. Bedeutet, mal sind die present, mal absent, obwohl diese ca. 1,5 m weit weg liegen.
Schaue ich mir in FHEM dazu den selben Status gemessen über den Pi 1 mit Jessie an, ist dieser aber present. Hier wird stabil erkannt was der eigentliche Status ist.

Ich habe daraufhin heute einen weiteren Pi aufgesetzt und dort einen BT Stick dran.

In FHEM habe ich die Definition des bestehenden Holger_GtAG der vorher über den RasPi3 lokal abgefragt wurde umgestellt und diese geht nun auf den neuen Pi1 (mit Stretch) mit der aktuellen Version des lepresenced.
Trotzdem ist es so, dass der Holger_GtAG in FHEM nun über den Pi1 mit Stretch als absent angezeigt wird, und der andere Pi1 mit Jessie ihn present zeigt.

Nur um das mal kurz noch zu erwähnen...
DAS HAT JETZT LANGE, LANGE OHNE PROBLEME FUNKTIONIERT. Es kann also kein grundsätzliches Problem sein, dass sich die lepresenced oder die BT anfragen an dem Stick irgendwie stören.

Auffälligkeit:
Wenn ich das Batteriescript manuell triggere, dann geht der Status des absent detektierten GTags auf present.
Danach dann ist er gleich wieder maybe absent und schließlich dann absent.

Ich frage alle 10 Sekunden, und 11 Sekunden den Status der GTAGs ab.
Ich habe den presenceThreshold auf 1 und den absenceThreshold auf 20. Diese Settings haben sich bei mir aufgrund einer Alarmanlagensteuerung bewährt.

SideNote:
Ich habe die GTags nie mit einer App im Smartphone gekoppelt gehabt.
Ich habe aber beim Troubleshooting für meinen Kumpel (der das gleiche Problem hat) vorher bei mir getestet und ggf. mal per hcitools eine Verbindung hergestellt, später aber wieder gelöscht. Aber selbst wenn es so wäre, dass da noch etwas irgendwo als gepaart hängt, wieso zeigt dann der zweite lepresenced weiterhin present während der main lepresenced absent zeigt?
Ich habe keine OS Updates eingespielt, und auch keine FHEM Updates eingespielt.

Hier mal ein LIST der Devices, damit man besser versteht was ich mit zwei Pi`s und lepresenced mache:
Holger_GtAG Gerät welches erst lokal auf dme RasPi3 geprüft hatte und jetzt auf dem ganz neuen RasPi1 mit Strech prüfen sollte

Code Auswählen Erweitern


Holger_GtAG
============================
Internals:
   ADDRESS    7C:2F:XX:XX:YY:ZZ
   CHANGED
   DEF        lan-bluetooth 7C:2F:XX:XX:YY:ZZ ser2netwz.fritz.box:5333 11
   DeviceName ser2netwz.fritz.box:5333
   FD         87
   MODE       lan-bluetooth
   NAME       Holger_GtAG
   NOTIFYDEV  global
   NR         900
   NTFY_ORDER 50-Holger_GtAG
   PARTIAL
   STATE      absent
   TIMEOUT_NORMAL 11
   TIMEOUT_PRESENT 11
   TYPE       PRESENCE
   READINGS:
     2017-09-02 17:00:12   .absenceThresholdCounter 19
     2017-09-02 17:00:12   .presenceThresholdCounter 0
     2017-09-02 01:00:04   Batterie        100
     2017-09-02 16:20:36   command_accepted yes
     2017-09-02 17:00:12   daemon          lepresenced V0.82
     2017-09-02 16:25:22   device_name     Gigaset G-tag
     2017-09-02 17:00:12   model           lan-lepresenced
     2017-09-02 17:00:12   presence        absent
     2017-09-02 17:00:12   rssi            unreachable
     2017-09-02 17:00:12   state           absent
   helper:
     ABSENT_COUNT 19
     CURRENT_STATE present
     CURRENT_TIMEOUT normal
Attributes:
   absenceThreshold 20

   devStateIcon present:rc_GREEN absent:rc_RED maybe.*:rc_YELLOW
   event-on-change-reading presence,state
   fp_Grundriss_WZ 306,709,2,Holger
   group      Holger
   icon       bluetooth
   presenceThreshold 1
   room       2.3_Anwesenheit
   sortby     2
   verbose    0



Holger_GtAG_ser2netpi Gerät welches über den RasPi1 mit Jessie derzeit stabil den Status ermittelt.

Code Auswählen Erweitern


Holger_GtAG_ser2netpi
=======================
Internals:
   ADDRESS    7C:2F:XX:XX:YY:ZZ
   CHANGED
   DEF        lan-bluetooth 7C:2F:XX:XX:YY:ZZ ser2netpi.fritz.box:5333 10
   DeviceName ser2netpi.fritz.box:5333
   FD         98
   MODE       lan-bluetooth
   NAME       Holger_GtAG_ser2netpi
   NOTIFYDEV  global
   NR         1336
   NTFY_ORDER 50-Holger_GtAG_ser2netpi
   PARTIAL
   STATE      present
   TIMEOUT_NORMAL 10
   TIMEOUT_PRESENT 10
   TYPE       PRESENCE
   READINGS:
     2017-09-02 17:02:31   .absenceThresholdCounter 0
     2017-09-02 17:02:31   .presenceThresholdCounter 0
     2017-08-29 20:07:28   command_accepted yes
     2017-09-02 17:02:31   daemon          lepresenced V0.8
     2017-09-02 17:02:31   device_name     Gigaset G-tag
     2017-09-01 22:42:09   model           lan-bluetooth
     2017-09-02 17:02:31   presence        present
     2017-09-02 17:02:31   rssi            -85
     2017-09-02 17:02:31   state           present
   helper:
     CURRENT_STATE present
     CURRENT_TIMEOUT normal
Attributes:
   absenceThreshold 20
   devStateIcon present:rc_GREEN absent:rc_RED maybe.*:rc_YELLOW
   event-on-change-reading presence,state
   group      Holger
   icon       bluetooth
   presenceThreshold 1
   room       2.3_Anwesenheit
   sortby     3


Fragen
- Weiss hier jemand Rat?
- Weiss jemand wie ich die GTAGs resetten kann?
- Wie oft laufen bei Euch die Batteriescripte?


Danke und Gruß

Holger

[PatrickR]

Mahlzeit!

Anbei ein aktuelles Paket zum Testen.

Unter der Haube habe ich einiges geändert, u. a. jetzt einen offiziellen systemd-Service angelegt. Außerdem sollte sich jetzt lepresenced beim Reboot nicht mehr mit dem bluetooth-Service verhaken und es gibt in /etc/default/lepresenced jetzt eine Möglichkeit (MISC_OPTIONS), beliebige Kommandozeilenoptionen zu setzen, z. B. --rssithreshold. Das verbinde ich mit der Hoffnung, dass künftig weder lepresenced selbst noch die Startskripte verbogen werden

Patrick

[PatrickR]

Hallo Holger!

nach fast genau 1 Jahr ohne Probleme mit den GTAGs und lepresenced bin ich nun wieder hier im Thread geladet.

Da wäre es natürlich spannend, was Du genau getan hast zwischen Status "geht super" und Status "tut komische Dinge", z. B. Firmwareupdate, Paketupdate, lepresenced-Update etc. Aber ich lese heraus, dass Du den Zeitpunkt nicht genau eingrenzen kannst.

An Dein komplexes Setup kann ich mich nun wieder erinnern, das macht es aber für mich unübersichtlich. Ich verstehe Dein Problem so: Auf dem RPi3, wo auch die Batterieskripte laufen, wechselt der Present-Status, obwohl die Tags in Reichweite sind, auf den anderen Pis ist die Erkennung wie gewünscht.

Folgende Vorschläge:

• Deaktiviere doch mal alle Batterieskripte/-module, starte den RPi3 durch und schaue, ob das Problem noch auftritt
• Poste doch mal ein Log mit LOG_DEBUG auf dem RPi3 und Hinweisen, in welchem Zeitraum die Tags tatsächlich anwesend waren.

Ich selbst verwende übrigens keine Batterieskripte/-module, weil erstens die Batterielaufzeit der G-Tags sehr hoch ist (1,5 Jahre) und sie sich zweitens immer wieder verhaken.

Patrick

[forum-merlin]

Hi Partick,

ich weiss, dass das echt alles komisch klingt, und die Standardaussage immer ist, "Ich habe nichts gemacht, isch schwör' ", aber es ist wirklich so. Ich habe als es mir aufgefallen ist im Bett gelegen und vorher wochenlang nix an FHEM oder den Pi´s gedreht.

Ich habe inzwischen angefangen zu analysieren. Logfiles habe ich nur bedingt, ziehe ich aber wenn gewünscht nochmal ein diktiertes Scenario.

AKTUELLE Situation:
Von gestern auf heute habe ich das lepresenced welches auf dep Pi3 lief auf die aktuelle 0.82-1 gehoben.
Vorher war es nur das lepresenced Script in einer der ersten Versionen (v0.6). (Lief aber eben lange problemlos)

Diesmal habe ich das allerdings installiert, und so startet das lepresenced 0.82-1 als deamon und ich kann es per service lepresenced start/stop steuern.

Vielleicht wichtige BEOBACHTUNG:
Wenn das Batteriescript läuft, wird das gattool aufgerufen. Wenn das passiert, schmiert scheinbar irgendwas im I/O Bereich ab, und fängt sich nicht wieder.
Dann bleibt auch lepresenced quasi auf der Strecke und kann keinen Status mehr senden/empfangen.
Ich habe das jetzt inzwischen in CRON deaktiviert, läuft also jetzt nicht wieder. Lief aber nur 1x/Tag um 1:00 Uhr
Man kann es aber zumindest so nachstellen.
Ich habe auch mit dem Batteriescript lebattery getestet, da is es genau das gleiche, im code sehe ich aber auch dass das die selbe vorgehensweise ist, nur noch mit mehr drum rum zur identifizierung der Klarnamen der G-Tags.


Hier mal ein syslog von eben mit LOG_DEBUG vom RPi3 (Hauptserver mit Onboard BT)
Ich hoffe ich setze das Loglevel überhaupt richtig.
ich stoppe das Script und starte es dann so:

Code Auswählen Erweitern


sudo /usr/bin/perl /usr/sbin/lepresenced --daemon --device hci0 --listenaddress 0.0.0.0 --listenport 5333 --loglevel LOG_DEBUG

mich wundert nämlich das debug: 0 im dem folgenden logfile.

Code Auswählen Erweitern


Sep  3 15:12:09 fhempi3 lepresenced[5099]: [tid:0] main: Version 0.82 started (device: hci0, listen addr: 0.0.0.0, listen port: 5333, daemonize: 1, legacy mode: 0, rssi threshold: 10, log level: 7, debug: 0).
Sep  3 15:12:09 fhempi3 lepresenced[5099]: [tid:0] main::sanity_check: hciconfig found at '/bin/hciconfig'.
Sep  3 15:12:09 fhempi3 lepresenced[5099]: [tid:0] main::sanity_check: hcitool found at '/usr/bin/hcitool'.
Sep  3 15:12:09 fhempi3 lepresenced[5099]: [tid:0] main::sanity_check: hcidump found at '/usr/bin/hcidump'.
Sep  3 15:12:09 fhempi3 lepresenced[5106]: [tid:1] main::bluetooth_scan_thread: Received 'LE Scan ...'.
Sep  3 15:13:03 fhempi3 lepresenced[5106]: [tid:0] main: Connection from 127.0.0.1:41432. Connected clients: 1.
Sep  3 15:13:03 fhempi3 lepresenced[5106]: [tid:0] main::handle_command: Received query for mac address 7c:2f:CC:HO:LG:ER, interval: 12. Adding client 127.0.0.1:41432 to clients list.
Sep  3 15:13:03 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, ages: 1/1, max age: 12, rssi: -73, result: present.
Sep  3 15:13:15 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, ages: 1/1, max age: 12, rssi: -74, result: present.
Sep  3 15:13:27 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, ages: 1/1, max age: 12, rssi: -74, result: present.
Sep  3 15:13:39 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, ages: 0/1, max age: 12, rssi: -75, result: present.
Sep  3 15:13:51 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, ages: 0/0, max age: 12, rssi: -73, result: present.
Sep  3 15:14:03 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, ages: 0/1, max age: 12, rssi: -74, result: present.
Sep  3 15:14:15 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, ages: 1/1, max age: 12, rssi: -73, result: present.
Sep  3 15:14:27 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, ages: 1/1, max age: 12, rssi: -73, result: present.
Sep  3 15:14:39 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, ages: 1/2, max age: 12, rssi: -74, result: present.
Sep  3 15:14:51 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, ages: 1/1, max age: 12, rssi: -71, result: present.
Sep  3 15:15:03 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, ages: 1/1, max age: 12, rssi: -74, result: present.
Sep  3 15:15:15 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, ages: 1/1, max age: 12, rssi: -72, result: present.
Sep  3 15:15:27 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, ages: 1/1, max age: 12, rssi: -74, result: present.
Sep  3 15:15:39 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, ages: 1/1, max age: 12, rssi: -74, result: present.
Sep  3 15:15:51 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, ages: 1/1, max age: 12, rssi: -74, result: present.
Sep  3 15:16:03 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, ages: 1/1, max age: 12, rssi: -74, result: present.
Sep  3 15:16:08 fhempi3 systemd[1]: Starting Session c7 of user root.
Sep  3 15:16:08 fhempi3 systemd[1]: Started Session c7 of user root.
Sep  3 15:16:15 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, ages: 1/1, max age: 12, rssi: -75, result: present.
Sep  3 15:16:27 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, ages: 1/1, max age: 12, rssi: -74, result: present.
Sep  3 15:16:39 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, ages: 0/1, max age: 12, rssi: -76, result: present.
Sep  3 15:16:51 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, ages: 0/0, max age: 12, rssi: -75, result: present.
Sep  3 15:17:01 fhempi3 CRON[5580]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
Sep  3 15:17:03 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, ages: 0/0, max age: 12, rssi: -75, result: present.
Sep  3 15:17:11 fhempi3 lepresenced[5106]: [tid:0] main::stats_task: Active clients: 1, known devices: 3 (min/max age: 0/80)
Sep  3 15:17:15 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, ages: 0/1, max age: 12, rssi: -78, result: present.
Sep  3 15:17:27 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, ages: 1/2, max age: 12, rssi: -78, result: present.
Sep  3 15:17:39 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:17:51 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:18:03 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:18:15 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:18:27 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:18:39 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:18:51 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:19:03 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:19:15 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:19:27 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:19:39 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:19:51 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:20:03 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:20:15 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:20:27 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:20:39 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:20:51 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:21:03 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:21:15 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:21:27 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:21:39 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:21:51 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:22:03 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:22:12 fhempi3 lepresenced[5106]: [tid:0] main::stats_task: Active clients: 1, known devices: 3 (min/max age: 286/381)
Sep  3 15:22:15 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:22:27 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:22:39 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:22:51 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:23:03 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:23:15 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:23:27 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:23:39 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:23:51 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:24:03 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:24:15 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:24:27 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:24:39 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:24:51 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:25:03 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:25:15 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:25:27 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:25:39 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:25:51 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:26:03 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:26:15 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:26:27 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:26:39 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:26:51 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:27:03 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:27:11 fhempi3 lepresenced[5106]: [tid:0] main::cleanup_task: Cleanup finished, deleted 0 devices in 0 seconds.
Sep  3 15:27:13 fhempi3 lepresenced[5106]: [tid:0] main::stats_task: Active clients: 1, known devices: 3 (min/max age: 587/682)
Sep  3 15:27:15 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:27:27 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:27:39 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:27:51 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:28:03 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.
Sep  3 15:28:15 fhempi3 lepresenced[5106]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 12, result: absence.


Danke und Gruß,

Holger

[forum-merlin]

Hi Patrick.

So, habe nochmal ein komplettes Logging über alle drei lepresenced Instanzen gleichzzeitig gezogen und gemonitored.
Anbei die Logfiles und ein Screenshot der aufzeigen soll wie es sich darstellt.

Auf dem Pi3 (wo die Probleme so massiv sind) passiert irgendwas beim "bluetooth_scan_thread" dass ein I/O Error auftaucht.
Aber wenn man sich das syslog ansieht, dann passiert das auch schon beim Start des lepresenced.

Code Auswählen Erweitern


Sep  3 15:02:55 fhempi3 lepresenced[4232]: [tid:0] main: Version 0.82 started (device: hci0, listen addr: 0.0.0.0, listen port: 5333, daemonize: 1, legacy mode: 0, rssi threshold: 10, log level: 6, debug: 0).
Sep  3 15:02:55 fhempi3 lepresenced[4232]: [tid:0] main::sanity_check: hciconfig found at '/bin/hciconfig'.
Sep  3 15:02:55 fhempi3 lepresenced[4232]: [tid:0] main::sanity_check: hcitool found at '/usr/bin/hcitool'.
Sep  3 15:02:55 fhempi3 lepresenced[4232]: [tid:0] main::sanity_check: hcidump found at '/usr/bin/hcidump'.
Sep  3 15:02:55 fhempi3 lepresenced[4241]: [tid:1] main::bluetooth_scan_thread: Received 'Set scan parameters failed: Input/output error', resetting...
Sep  3 15:02:56 fhempi3 lepresenced[4241]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...
Sep  3 15:02:57 fhempi3 lepresenced[4241]: [tid:1] main::bluetooth_scan_thread: Received 'LE Scan ...'.
Sep  3 15:03:31 fhempi3 lepresenced[4241]: [tid:0] main: Connection from 127.0.0.1:40254. Connected clients: 1.
Sep  3 15:03:31 fhempi3 lepresenced[4241]: [tid:0] main::handle_command: Received query for mac address 7c:2f:CC:HO:LG:ER, interval: 12. Adding client 127.0.0.1:40254 to clients list.
Sep  3 15:07:56 fhempi3 lepresenced[4241]: [tid:0] main::stats_task: Active clients: 1, known devices: 2 (min/max age: 1/1)



Allerdings passiert das auch bei EINEM der beiden anderen lepresenced. (Stabilität OK, aber nicht perfekt; das ist die neueste Installation)
ser2netwz Pi

Code Auswählen Erweitern


Sep  3 15:48:32 ser2netwz lepresenced[601]: [tid:0] main: Version 0.82 started (device: hci0, listen addr: 0.0.0.0, listen port: 5333, daemonize: 1, legacy mode: 0, rssi threshold: 10, log level: 7, debug: 0).
Sep  3 15:48:32 ser2netwz lepresenced[601]: [tid:0] main::sanity_check: hciconfig found at '/bin/hciconfig'.
Sep  3 15:48:33 ser2netwz lepresenced[601]: [tid:0] main::sanity_check: hcitool found at '/usr/bin/hcitool'.
Sep  3 15:48:33 ser2netwz lepresenced[601]: [tid:0] main::sanity_check: hcidump found at '/usr/bin/hcidump'.
Sep  3 15:48:33 ser2netwz kernel: [ 3190.573302] Bluetooth: hci0 advertising data length corrected
Sep  3 15:48:33 ser2netwz kernel: [ 3190.576290] Bluetooth: hci0 advertising data length corrected
Sep  3 15:48:33 ser2netwz lepresenced[608]: [tid:1] main::bluetooth_scan_thread: Received 'Set scan parameters failed: Input/output error', resetting...
Sep  3 15:48:33 ser2netwz lepresenced[608]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...
Sep  3 15:48:35 ser2netwz lepresenced[608]: [tid:1] main::bluetooth_scan_thread: Received 'LE Scan ...'.
Sep  3 15:49:19 ser2netwz lepresenced[608]: [tid:0] main: Connection from fhempi3:51192. Connected clients: 1.
Sep  3 15:49:19 ser2netwz kernel: [ 3236.821417] Bluetooth: hci0 advertising data length corrected
Sep  3 15:49:19 ser2netwz lepresenced[608]: [tid:0] main::handle_command: Received query for mac address 7c:2f:CC:MI:RJ:AM, interval: 10. Adding client fhempi3:51192 to clients list.
Sep  3 15:49:19 ser2netwz lepresenced[608]: [tid:0] main: Connection from fhempi3:51200. Connected clients: 2.
Sep  3 15:49:19 ser2netwz lepresenced[608]: [tid:0] main: Sending update for mac address 7c:2f:CC:MI:RJ:AM, ages: 0/0, max age: 10, rssi: -73, result: present.
Sep  3 15:49:20 ser2netwz lepresenced[608]: [tid:0] main::handle_command: Received query for mac address 7c:2f:CC:HO:LG:ER, interval: 11. Adding client fhempi3:51200 to clients list.
Sep  3 15:49:20 ser2netwz lepresenced[608]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, max age: 11, result: absence.
Sep  3 15:49:29 ser2netwz lepresenced[608]: [tid:0] main: Sending update for mac address 7c:2f:CC:MI:RJ:AM, ages: 0/1, max age: 10, rssi: -76, result: present.




und hier beim alten (stabilsten) nicht.
ser2netpi

Code Auswählen Erweitern


Sep  3 16:10:39 ser2netpi lepresenced[4400]: [tid:0] main: Version 0.8 started (device: hci0, listen addr: 0.0.0.0, listen port: 5333, daemonize: 1, legacy mode: 0, rssi threshold: 10, log level: 7).
Sep  3 16:10:40 ser2netpi lepresenced[4401]: [tid:1] main::bluetooth_scan_thread: Received 'LE Scan ...'.
Sep  3 16:11:02 ser2netpi lepresenced[4401]: [tid:0] main: Connection from fhempi3:41660. Connected clients: 1.
Sep  3 16:11:03 ser2netpi lepresenced[4401]: [tid:0] main: Connection from fhempi3:41670. Connected clients: 2.
Sep  3 16:11:03 ser2netpi lepresenced[4401]: [tid:0] main::handle_command: Received query for mac address 7c:2f:CC:MI:RJ:AM, interval: 10. Adding client fhempi3:41660 to clients list.
Sep  3 16:11:03 ser2netpi lepresenced[4401]: [tid:0] main: Sending update for mac address 7c:2f:CC:MI:RJ:AM, age: 0, max age: 10, rssi: -69, result: present.
Sep  3 16:11:03 ser2netpi lepresenced[4401]: [tid:0] main::handle_command: Received query for mac address 7c:2f:CC:HO:LG:ER, interval: 10. Adding client fhempi3:41670 to clients list.
Sep  3 16:11:03 ser2netpi lepresenced[4401]: [tid:0] main: Sending update for mac address 7c:2f:CC:HO:LG:ER, age: 0, max age: 10, rssi: -80, result: present.
Sep  3 16:11:13 ser2netpi lepresenced[4401]: [tid:0] main: Sending update for mac address 7c:2f:CC:MI:RJ:AM, age: 1, max age: 10, rssi: -71, result: present.


Hast Du oder jemand anderes eine Idee was das sein kann?

Danke Euch,

Holger

[Amenophis86]

Hab eben mal Version 83-3 getestet es kommt beim Starten trotzdem:

Code Auswählen Erweitern


Sep 06 16:13:45 raspberrypi systemd[1]: Started lepresenced.
Sep 06 16:13:45 raspberrypi lepresenced[16010]: [tid:1] main::bluetooth_scan_thread: Received 'Set scan parameters failed: Input/output error', ...tting...
Sep 06 16:13:46 raspberrypi lepresenced[16010]: [tid:1] main::bluetooth_scan_thread: hcitool exited, retrying...


Scheint aber zu funktionieren.

Noch eine Frage zum Reading rooms mit collected:
Wie ist die Reihenfolge der gelisteten Räume? Ich frage, da ich an einer stelle beide Räume erhalte und gerne einen priorisieren möchte. Oder kann man irgendwie einstellen, dass ab einem bestimmten RSSI Wert dieser Room nicht mehr angezeigt werden soll, nur der stärkste Raum gezeigt wird?

[errazzor]

Gibt es irgendwo ein Schritt-für-Schritt-Howto wie man das Szenario mehrere PI's mit Bluetooth-Erkennung von Gtags (lepresenced / collectord) im Detail aufsetzt?

Und nein, alleine mit dem Wiki-Eintrag und der Commandref komme ich da nicht wirklich weit.

Falls es sowas nicht gibt, dann bitte ignorieren.

[Amenophis86]

- (le)presenced auf allen PI installieren
- collected auf dem HauptPI installieren
- die collected.conf entsprechend dem Wiki einrichten (Port 5111 bei presenced 5333 bei lepresenced)
- Auf jedem PI die GTags als Device anlegen. Den Port 5222 allerdings nehmen und bei IP immer auf den HauptPI verweisen

So mal auf die schnelle. Die restlichen Infos findest du im Wiki

[Amenophis86]

Hab eben mal Version 83-3 getestet es kommt beim Starten trotzdem:
Scheint aber zu funktionieren.

ok seit der neuen Version habe ich wieder Probleme mit meinem HMLan. Daher zurück auf 0.81 mal sehen, ob es etwas bringt.

[Devender]

ok seit der neuen Version habe ich wieder Probleme mit meinem HMLan. Daher zurück auf 0.81 mal sehen, ob es etwas bringt.

Hast du die 0.82 uebersprungen oder da auch Probleme ?

Wegen den rooms hatte ich in einem anderen Thema mal eine Vermutung geäußert.
Ich denke sortiert nach RSSI wird nicht. Es wird der zuerst angezeigt, der zuerst erkannt wird.
Du hast ja auch nur einen RSSI Wert im Reading. Der gehört dann zum ersten Raum.

Ich könnte mir aber vorstellen, dass man diese Infos aus dem collectord log zusammen bekommen kann.

[Devender]

Gibt es irgendwo ein Schritt-für-Schritt-Howto wie man das Szenario mehrere PI's mit Bluetooth-Erkennung von Gtags (lepresenced / collectord) im Detail aufsetzt?

Und nein, alleine mit dem Wiki-Eintrag und der Commandref komme ich da nicht wirklich weit.

Falls es sowas nicht gibt, dann bitte ignorieren.

Was fehlt dir? Das Wiki ist eigentlich mittlerweile recht Umfangreich geschrieben und viele Szenarios sind erklärt.
Eben auch der Aufbau lepresenced nebst collectord.
Ich passe an und erweitere gerne noch Passagen, um das Verständnis zu erleichtern aber dazu muesstest du sagen was du nicht verstehst.

Es wird auch nie ein All-in-One Loesung/Paket geben da jede Installation verschieden ist.

[Amenophis86]

Hast du die 0.82 uebersprungen oder da auch Probleme ?

Da ich die Probleme auch bei der 82 hatte, habe ich diese ausgelassen und nun die 83 getestet. Gleiches Problem und auch die Fehlermeldung zu Beginn. Siehe ein paar Posts weiter oben.

Zu Rooms, den Post hatte ich gelesen. Habe gehofft, dass es sich inzwischen geändert hat. Dürfte für collected ja eigentlich nicht schwer sein den Raum mit der besten RSSI als den anwesenden Raum auszugeben und nicht alle. Wobei ich noch nicht in den Code geschaut habe.

[PatrickR]

Die Fehlermeldung zu Beginn ist kein Beinbruch. lepresenced resettet dann und i. d. Regel ist alles ok. Du siehst es nur nicht im Log weil die erfolgreichen Meldungen nur bei höheren Logleveln angezeigt werden.


Von unterwegs gesendet.

[PatrickR]

ok seit der neuen Version habe ich wieder Probleme mit meinem HMLan. Daher zurück auf 0.81 mal sehen, ob es etwas bringt.

Ist PRESENCE überhaupt die Ursache? Was sagt denn apptime?


Von unterwegs gesendet.

[Amenophis86]

Kann ich noch nicht 100% sagen, aber außer, dass ich lepresenced ein Update ausgeführt habe, habe ich nichts geändert und seit Tagen keine Probleme gehabt. Die hatte ich immer erst nach einem Update von lepresenced.